Importing Windows VM from OVA/OVF that was exported from VSphere fails
by wcordero8@gmail.com
Description of problem: when importing Windows VM from OVA/OVF import fails:
Cannot import VM. Invalid time zone for given OS type.
Attribute: vm.vmStatic
Infrastructure:
VMware ESXi, 7.0.3, 19193900
oVirt Version 4.5.4-1.el8
oVirt self-hosted engine
Steps to Reproduce:
1.Export Windows VM Microsoft Windows Server 2019 (64-bit) to OVA/OVF from VSphere that have SA Pacific Standard Time timezone (UTC-05:00) Bogotá, Lima, Quito) with ovftool.
2. import the VM in oVirt
import fails with:
Cannot import VM. Invalid time zone for given OS type.
Attribute: vm.vmStatic
[org.ovirt.engine.core.bll.exportimport.ImportVmFromOvaCommand] (default task-2) [72bb230a-bc1c-41c6-b87f-3891764b9fdd] Validation of action 'ImportVmFromOva' failed for user Reasons: VAR__ACTION__IMPORT,VAR__TYPE__VM,ACTION_TYPE_FAILED_INVALID_TIMEZONE,$groups [Ljava.lang.Class;@746306ef,$message ACTION_TYPE_FAILED_INVALID_TIMEZONE,$payload [Ljava.lang.Class;@2d685ee5,ACTION_TYPE_FAILED_ATTRIBUTE_PATH,$path vm.vmStatic,$validatedValue
# cat Implementacion_02-2.ovf
<?xml version='1.0' encoding='UTF-8'?>
<Envelope xmlns="http://schemas.dmtf.org/ovf/envelope/1" xmlns:ovf="http://schemas.dmtf.org/ovf/envelope/1" xmlns:vmw="http://www.vmware.com/schema/ovf" xmlns:rasd="http://schemas.dmtf.org/wbem/wscim/1/cim-schema/2/CIM_ResourceAllocationS..." xmlns:vssd="http://schemas.dmtf.org/wbem/wscim/1/cim-schema/2/CIM_VirtualSystemSettin...">
<References>
<File ovf:id="file1" ovf:href="Implementacion_02-2-1.vmdk"/>
<File ovf:id="file2" ovf:href="Implementacion_02-2-2.vmdk"/>
<File ovf:id="file3" ovf:href="Implementacion_02-2-3.nvram" ovf:size="270840"/>
</References>
<DiskSection>
<Info>List of the virtual disks</Info>
<Disk ovf:capacityAllocationUnits="byte" ovf:format="http://www.vmware.com/interfaces/specifications/vmdk.html#streamOptimized" ovf:diskId="vmdisk1" ovf:capacity="161061273600" ovf:fileRef="file1"/>
<Disk ovf:capacityAllocationUnits="byte" ovf:format="http://www.vmware.com/interfaces/specifications/vmdk.html#streamOptimized" ovf:diskId="vmdisk2" ovf:capacity="161061273600" ovf:fileRef="file2"/>
</DiskSection>
<NetworkSection>
<Info>The list of logical networks</Info>
<Network ovf:name="DVPG_102">
<Description>The DVPG_102 network</Description>
</Network>
</NetworkSection>
<VirtualSystem ovf:id="Implementacion_02-2">
<Info>A Virtual system</Info>
<Name>Implementacion_02-2</Name>
<OperatingSystemSection ovf:id="112" vmw:osType="windows2019srv_64Guest">
<Info>The operating system installed</Info>
<Description>Microsoft Windows Server 2019 (64-bit)</Description>
</OperatingSystemSection>
<VirtualHardwareSection>
<Info>Virtual hardware requirements</Info>
<System>
<vssd:ElementName>Virtual Hardware Family</vssd:ElementName>
<vssd:InstanceID>0</vssd:InstanceID>
<vssd:VirtualSystemType>vmx-18</vssd:VirtualSystemType>
</System>
<Item>
<rasd:AllocationUnits>hertz * 10^6</rasd:AllocationUnits>
<rasd:Description>Number of Virtual CPUs</rasd:Description>
<rasd:ElementName>2 virtual CPU(s)</rasd:ElementName>
<rasd:InstanceID>1</rasd:InstanceID>
<rasd:ResourceType>3</rasd:ResourceType>
<rasd:VirtualQuantity>2</rasd:VirtualQuantity>
<vmw:CoresPerSocket ovf:required="false">1</vmw:CoresPerSocket>
</Item>
<Item>
<rasd:AllocationUnits>byte * 2^20</rasd:AllocationUnits>
<rasd:Description>Memory Size</rasd:Description>
<rasd:ElementName>4096MB of memory</rasd:ElementName>
<rasd:InstanceID>2</rasd:InstanceID>
<rasd:ResourceType>4</rasd:ResourceType>
<rasd:VirtualQuantity>4096</rasd:VirtualQuantity>
</Item>
<Item>
<rasd:Address>0</rasd:Address>
<rasd:Description>SCSI Controller</rasd:Description>
<rasd:ElementName>SCSI Controller 1</rasd:ElementName>
<rasd:InstanceID>3</rasd:InstanceID>
<rasd:ResourceSubType>lsilogicsas</rasd:ResourceSubType>
<rasd:ResourceType>6</rasd:ResourceType>
<vmw:Config ovf:required="false" vmw:key="slotInfo.pciSlotNumber" vmw:value="160"/>
</Item>
<Item>
<rasd:Address>0</rasd:Address>
<rasd:Description>SATA Controller</rasd:Description>
<rasd:ElementName>SATA Controller 1</rasd:ElementName>
<rasd:InstanceID>4</rasd:InstanceID>
<rasd:ResourceSubType>vmware.sata.ahci</rasd:ResourceSubType>
<rasd:ResourceType>20</rasd:ResourceType>
<vmw:Config ovf:required="false" vmw:key="slotInfo.pciSlotNumber" vmw:value="33"/>
</Item>
<Item>
<rasd:Description>USB Controller (XHCI)</rasd:Description>
<rasd:ElementName>USB controller</rasd:ElementName>
<rasd:InstanceID>5</rasd:InstanceID>
<rasd:ResourceSubType>vmware.usb.xhci</rasd:ResourceSubType>
<rasd:ResourceType>23</rasd:ResourceType>
<vmw:Config ovf:required="false" vmw:key="slotInfo.pciSlotNumber" vmw:value="224"/>
</Item>
<Item>
<rasd:AddressOnParent>0</rasd:AddressOnParent>
<rasd:ElementName>Hard Disk 1</rasd:ElementName>
<rasd:HostResource>ovf:/disk/vmdisk1</rasd:HostResource>
<rasd:InstanceID>6</rasd:InstanceID>
<rasd:Parent>3</rasd:Parent>
<rasd:ResourceType>17</rasd:ResourceType>
</Item>
<Item>
<rasd:AddressOnParent>1</rasd:AddressOnParent>
<rasd:ElementName>Hard Disk 2</rasd:ElementName>
<rasd:HostResource>ovf:/disk/vmdisk2</rasd:HostResource>
<rasd:InstanceID>7</rasd:InstanceID>
<rasd:Parent>3</rasd:Parent>
<rasd:ResourceType>17</rasd:ResourceType>
</Item>
<Item>
<rasd:AddressOnParent>0</rasd:AddressOnParent>
<rasd:AutomaticAllocation>false</rasd:AutomaticAllocation>
<rasd:ElementName>CD/DVD Drive 1</rasd:ElementName>
<rasd:InstanceID>8</rasd:InstanceID>
<rasd:Parent>4</rasd:Parent>
<rasd:ResourceSubType>vmware.cdrom.remoteatapi</rasd:ResourceSubType>
<rasd:ResourceType>15</rasd:ResourceType>
</Item>
<Item>
<rasd:AddressOnParent>0</rasd:AddressOnParent>
<rasd:AutomaticAllocation>true</rasd:AutomaticAllocation>
<rasd:Connection>DVPG_102</rasd:Connection>
<rasd:ElementName>Network adapter 1</rasd:ElementName>
<rasd:InstanceID>9</rasd:InstanceID>
<rasd:ResourceSubType>VmxNet3</rasd:ResourceSubType>
<rasd:ResourceType>10</rasd:ResourceType>
<vmw:Config ovf:required="false" vmw:key="slotInfo.pciSlotNumber" vmw:value="192"/>
<vmw:Config ovf:required="false" vmw:key="connectable.allowGuestControl" vmw:value="true"/>
<vmw:Config ovf:required="false" vmw:key="wakeOnLanEnabled" vmw:value="true"/>
<vmw:Config ovf:required="false" vmw:key="uptCompatibilityEnabled" vmw:value="true"/>
</Item>
<Item ovf:required="false">
<rasd:ElementName>Video card</rasd:ElementName>
<rasd:InstanceID>10</rasd:InstanceID>
<rasd:ResourceType>24</rasd:ResourceType>
<vmw:Config ovf:required="false" vmw:key="enable3DSupport" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="useAutoDetect" vmw:value="true"/>
<vmw:Config ovf:required="false" vmw:key="graphicsMemorySizeInKB" vmw:value="262144"/>
<vmw:Config ovf:required="false" vmw:key="use3dRenderer" vmw:value="automatic"/>
<vmw:Config ovf:required="false" vmw:key="numDisplays" vmw:value="1"/>
<vmw:Config ovf:required="false" vmw:key="videoRamSizeInKB" vmw:value="16384"/>
</Item>
<vmw:Config ovf:required="false" vmw:key="cpuHotAddEnabled" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="sgxInfo.epcSize" vmw:value="0"/>
<vmw:Config ovf:required="false" vmw:key="nestedHVEnabled" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="virtualSMCPresent" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="flags.vvtdEnabled" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="cpuHotRemoveEnabled" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="sgxInfo.flcMode" vmw:value="unlocked"/>
<vmw:Config ovf:required="false" vmw:key="sevEnabled" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="virtualICH7MPresent" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="flags.vbsEnabled" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="memoryHotAddEnabled" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="bootOptions.efiSecureBootEnabled" vmw:value="true"/>
<vmw:Config ovf:required="false" vmw:key="firmware" vmw:value="efi"/>
<vmw:ExtraConfig ovf:required="false" vmw:key="nvram" vmw:value="ovf:/file/file3"/>
<vmw:ExtraConfig ovf:required="false" vmw:key="svga.autodetect" vmw:value="TRUE"/>
</VirtualHardwareSection>
</VirtualSystem>
# cat /etc/ovirt-engine/timezones/00-defaults.properties | grep -ie bogota
America/Bogota=SA Pacific Standard Time
any suggestions for me??
1 year, 9 months
Importing VM from OVA/OVF that was exported from VSphere fails ConvertOvaCommand - ImportVmFromOvaCommand
by wcordero8@gmail.com
Description of problem: when importing Windows VM from OVA/OVF import fails:
EVENT_ID: IMPORTEXPORT_IMPORT_VM_FAILED(1,153), Failed to import Vm Implementacion_02-2 to Data Center dc_rcloud, Cluster cl_rcloud
Infrastructure:
VMware ESXi, 7.0.3, 19193900
oVirt Version 4.5.4-1.el8
oVirt self-hosted engine
Steps to Reproduce:
1.Export Windows to OVA/OVF from VSphere that with ovftool.
2. import the VM in oVirt
I'm getting some alerts just selected the VM
2023-02-27 11:09:00,676-05 WARN [org.ovirt.engine.core.utils.ovf.OvfReader] (default task-38) [3eba88b2-7b98-48d4-8488-2f3331fb41e6] could not retrieve volume id of file1 from ovf, generating new guid
2023-02-27 11:09:00,676-05 WARN [org.ovirt.engine.core.utils.ovf.OvfReader] (default task-38) [3eba88b2-7b98-48d4-8488-2f3331fb41e6] could not retrieve disk id of vmdisk1 from ovf, generating new guid
2023-02-27 11:09:00,677-05 WARN [org.ovirt.engine.core.utils.ovf.OvfReader] (default task-38) [3eba88b2-7b98-48d4-8488-2f3331fb41e6] could not retrieve volume id of file2 from ovf, generating new guid
2023-02-27 11:09:00,677-05 WARN [org.ovirt.engine.core.utils.ovf.OvfReader] (default task-38) [3eba88b2-7b98-48d4-8488-2f3331fb41e6] could not retrieve disk id of vmdisk2 from ovf, generating new guid
then I start the import process and the first Errors that appear is:
2023-02-27 11:09:42,353-05 ERROR [org.ovirt.engine.core.bll.exportimport.ConvertOvaCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-18) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Ending command 'org.ovirt.engine.core.bll.exportimport.ConvertOvaCommand' with failure.
2023-02-27 11:09:43,639-05 ERROR [org.ovirt.engine.core.bll.exportimport.ImportVmFromOvaCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Ending command 'org.ovirt.engine.core.bll.exportimport.ImportVmFromOvaCommand' with failure.
2023-02-27 11:09:44,409-05 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] EVENT_ID: IMPORTEXPORT_IMPORT_VM_FAILED(1,153), Failed to import Vm Implementacion_02-2 to Data Center dc_rcloud, Cluster cl_rcloud
# ls -l Implementacion_02-2/
total 234998648
-rw-rw-rw-. 1 vdsm kvm 111599878656 Feb 27 10:15 Implementacion_02-2-disk1.vmdk
-rw-rw-rw-. 1 vdsm kvm 129038421504 Feb 27 10:22 Implementacion_02-2-disk2.vmdk
-rw-rw-rw-. 1 vdsm kvm 270840 Feb 27 10:22 Implementacion_02-2-file1.nvram
-rw-rw-rw-. 1 vdsm kvm 414 Feb 27 10:22 Implementacion_02-2.mf
-rw-rw-rw-. 1 vdsm kvm 10891 Feb 27 10:26 Implementacion_02-2.ovf
# cat Implementacion_02-2.ovf
<?xml version="1.0" encoding="UTF-8"?>
<!--Generated by VMware VirtualCenter Server, User: VSPHERE.LOCAL\Administrator, UTC time: 2023-02-25T21:32:50.888437Z-->
<Envelope vmw:buildId="build-19480866" xmlns="http://schemas.dmtf.org/ovf/envelope/1" xmlns:cim="http://schemas.dmtf.org/wbem/wscim/1/common" xmlns:ovf="http://schemas.dmtf.org/ovf/envelope/1" xmlns:rasd="http://schemas.dmtf.org/wbem/wscim/1/cim-schema/2/CIM_ResourceAllocationS..." xmlns:vmw="http://www.vmware.com/schema/ovf" xmlns:vssd="http://schemas.dmtf.org/wbem/wscim/1/cim-schema/2/CIM_VirtualSystemSettin..." xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance">
<References>
<File ovf:href="Implementacion_02-2-disk1.vmdk" ovf:id="file1" ovf:size="111599878656"/>
<File ovf:href="Implementacion_02-2-disk2.vmdk" ovf:id="file2" ovf:size="129038421504"/>
<File ovf:href="Implementacion_02-2-file1.nvram" ovf:id="file3" ovf:size="270840"/>
</References>
<DiskSection>
<Info>Virtual disk information</Info>
<Disk ovf:capacity="150" ovf:capacityAllocationUnits="byte * 2^30" ovf:diskId="vmdisk1" ovf:fileRef="file1" ovf:format="http://www.vmware.com/interfaces/specifications/vmdk.html#streamOptimized" ovf:populatedSize="117837135872"/>
<Disk ovf:capacity="150" ovf:capacityAllocationUnits="byte * 2^30" ovf:diskId="vmdisk2" ovf:fileRef="file2" ovf:format="http://www.vmware.com/interfaces/specifications/vmdk.html#streamOptimized" ovf:populatedSize="148116078592"/>
</DiskSection>
<NetworkSection>
<Info>The list of logical networks</Info>
<Network ovf:name="DVPG_102">
<Description>The DVPG_102 network</Description>
</Network>
</NetworkSection>
<VirtualSystem ovf:id="Implementacion_02-2">
<Info>A virtual machine</Info>
<Name>Implementacion_02-2</Name>
<OperatingSystemSection ovf:id="122" vmw:osType="windows2019srv_64Guest">
<Info>The kind of installed guest operating system</Info>
<Description>Microsoft Windows Server 2019 (64-bit)</Description>
</OperatingSystemSection>
<VirtualHardwareSection>
<Info>Virtual hardware requirements</Info>
<System>
<vssd:ElementName>Virtual Hardware Family</vssd:ElementName>
<vssd:InstanceID>0</vssd:InstanceID>
<vssd:VirtualSystemIdentifier>Implementacion_02-2</vssd:VirtualSystemIdentifier>
<vssd:VirtualSystemType>vmx-18</vssd:VirtualSystemType>
</System>
<Item>
<rasd:AllocationUnits>hertz * 10^6</rasd:AllocationUnits>
<rasd:Description>Number of Virtual CPUs</rasd:Description>
<rasd:ElementName>2 virtual CPU(s)</rasd:ElementName>
<rasd:InstanceID>1</rasd:InstanceID>
<rasd:ResourceType>3</rasd:ResourceType>
<rasd:VirtualQuantity>2</rasd:VirtualQuantity>
</Item>
<Item>
<rasd:AllocationUnits>byte * 2^20</rasd:AllocationUnits>
<rasd:Description>Memory Size</rasd:Description>
<rasd:ElementName>4096MB of memory</rasd:ElementName>
<rasd:InstanceID>2</rasd:InstanceID>
<rasd:ResourceType>4</rasd:ResourceType>
<rasd:VirtualQuantity>4096</rasd:VirtualQuantity>
</Item>
<Item>
<rasd:Address>0</rasd:Address>
<rasd:Description>SATA Controller</rasd:Description>
<rasd:ElementName>SATA controller 0</rasd:ElementName>
<rasd:InstanceID>3</rasd:InstanceID>
<rasd:ResourceSubType>vmware.sata.ahci</rasd:ResourceSubType>
<rasd:ResourceType>20</rasd:ResourceType>
<vmw:Config ovf:required="false" vmw:key="slotInfo.pciSlotNumber" vmw:value="33"/>
</Item>
<Item>
<rasd:Address>0</rasd:Address>
<rasd:Description>SCSI Controller</rasd:Description>
<rasd:ElementName>SCSI controller 0</rasd:ElementName>
<rasd:InstanceID>4</rasd:InstanceID>
<rasd:ResourceSubType>lsilogicsas</rasd:ResourceSubType>
<rasd:ResourceType>6</rasd:ResourceType>
<vmw:Config ovf:required="false" vmw:key="slotInfo.pciSlotNumber" vmw:value="160"/>
</Item>
<Item ovf:required="false">
<rasd:Address>0</rasd:Address>
<rasd:Description>USB Controller (XHCI)</rasd:Description>
<rasd:ElementName>USB xHCI controller</rasd:ElementName>
<rasd:InstanceID>5</rasd:InstanceID>
<rasd:ResourceSubType>vmware.usb.xhci</rasd:ResourceSubType>
<rasd:ResourceType>23</rasd:ResourceType>
<vmw:Config ovf:required="false" vmw:key="slotInfo.pciSlotNumber" vmw:value="224"/>
</Item>
<Item>
<rasd:Address>1</rasd:Address>
<rasd:Description>IDE Controller</rasd:Description>
<rasd:ElementName>IDE 1</rasd:ElementName>
<rasd:InstanceID>6</rasd:InstanceID>
<rasd:ResourceType>5</rasd:ResourceType>
</Item>
<Item>
<rasd:Address>0</rasd:Address>
<rasd:Description>IDE Controller</rasd:Description>
<rasd:ElementName>IDE 0</rasd:ElementName>
<rasd:InstanceID>7</rasd:InstanceID>
<rasd:ResourceType>5</rasd:ResourceType>
</Item>
<Item ovf:required="false">
<rasd:AutomaticAllocation>false</rasd:AutomaticAllocation>
<rasd:ElementName>Video card</rasd:ElementName>
<rasd:InstanceID>8</rasd:InstanceID>
<rasd:ResourceType>24</rasd:ResourceType>
<vmw:Config ovf:required="false" vmw:key="useAutoDetect" vmw:value="true"/>
<vmw:Config ovf:required="false" vmw:key="videoRamSizeInKB" vmw:value="16384"/>
<vmw:Config ovf:required="false" vmw:key="enable3DSupport" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="use3dRenderer" vmw:value="automatic"/>
<vmw:Config ovf:required="false" vmw:key="graphicsMemorySizeInKB" vmw:value="262144"/>
</Item>
<Item ovf:required="false">
<rasd:AutomaticAllocation>false</rasd:AutomaticAllocation>
<rasd:ElementName>VMCI device</rasd:ElementName>
<rasd:InstanceID>9</rasd:InstanceID>
<rasd:ResourceSubType>vmware.vmci</rasd:ResourceSubType>
<rasd:ResourceType>1</rasd:ResourceType>
<vmw:Config ovf:required="false" vmw:key="slotInfo.pciSlotNumber" vmw:value="32"/>
<vmw:Config ovf:required="false" vmw:key="allowUnrestrictedCommunication" vmw:value="false"/>
</Item>
<Item ovf:required="false">
<rasd:AddressOnParent>0</rasd:AddressOnParent>
<rasd:AutomaticAllocation>false</rasd:AutomaticAllocation>
<rasd:ElementName>CD/DVD drive 1</rasd:ElementName>
<rasd:InstanceID>10</rasd:InstanceID>
<rasd:Parent>3</rasd:Parent>
<rasd:ResourceSubType>vmware.cdrom.remoteatapi</rasd:ResourceSubType>
<rasd:ResourceType>15</rasd:ResourceType>
<vmw:Config ovf:required="false" vmw:key="connectable.allowGuestControl" vmw:value="true"/>
</Item>
<Item>
<rasd:AddressOnParent>1</rasd:AddressOnParent>
<rasd:ElementName>Hard disk 1</rasd:ElementName>
<rasd:HostResource>ovf:/disk/vmdisk1</rasd:HostResource>
<rasd:InstanceID>11</rasd:InstanceID>
<rasd:Parent>4</rasd:Parent>
<rasd:ResourceType>17</rasd:ResourceType>
<vmw:Config ovf:required="false" vmw:key="backing.writeThrough" vmw:value="false"/>
</Item>
<Item>
<rasd:AddressOnParent>0</rasd:AddressOnParent>
<rasd:ElementName>Hard disk 2</rasd:ElementName>
<rasd:HostResource>ovf:/disk/vmdisk2</rasd:HostResource>
<rasd:InstanceID>12</rasd:InstanceID>
<rasd:Parent>4</rasd:Parent>
<rasd:ResourceType>17</rasd:ResourceType>
<vmw:Config ovf:required="false" vmw:key="backing.writeThrough" vmw:value="false"/>
</Item>
<Item>
<rasd:AddressOnParent>7</rasd:AddressOnParent>
<rasd:AutomaticAllocation>true</rasd:AutomaticAllocation>
<rasd:Connection>DVPG_102</rasd:Connection>
<rasd:Description>VmxNet3 ethernet adapter on "DVPG_102"</rasd:Description>
<rasd:ElementName>Network adapter 1</rasd:ElementName>
<rasd:InstanceID>13</rasd:InstanceID>
<rasd:ResourceSubType>VmxNet3</rasd:ResourceSubType>
<rasd:ResourceType>10</rasd:ResourceType>
<vmw:Config ovf:required="false" vmw:key="slotInfo.pciSlotNumber" vmw:value="192"/>
<vmw:Config ovf:required="false" vmw:key="wakeOnLanEnabled" vmw:value="true"/>
<vmw:Config ovf:required="false" vmw:key="connectable.allowGuestControl" vmw:value="true"/>
</Item>
<vmw:Config ovf:required="false" vmw:key="cpuHotAddEnabled" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="cpuHotRemoveEnabled" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="memoryHotAddEnabled" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="firmware" vmw:value="efi"/>
<vmw:Config ovf:required="false" vmw:key="cpuAllocation.shares.shares" vmw:value="2000"/>
<vmw:Config ovf:required="false" vmw:key="cpuAllocation.shares.level" vmw:value="normal"/>
<vmw:Config ovf:required="false" vmw:key="tools.syncTimeWithHost" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="tools.syncTimeWithHostAllowed" vmw:value="true"/>
<vmw:Config ovf:required="false" vmw:key="tools.afterPowerOn" vmw:value="true"/>
<vmw:Config ovf:required="false" vmw:key="tools.afterResume" vmw:value="true"/>
<vmw:Config ovf:required="false" vmw:key="tools.beforeGuestShutdown" vmw:value="true"/>
<vmw:Config ovf:required="false" vmw:key="tools.beforeGuestStandby" vmw:value="true"/>
<vmw:Config ovf:required="false" vmw:key="tools.toolsUpgradePolicy" vmw:value="manual"/>
<vmw:Config ovf:required="false" vmw:key="powerOpInfo.powerOffType" vmw:value="soft"/>
<vmw:Config ovf:required="false" vmw:key="powerOpInfo.resetType" vmw:value="soft"/>
<vmw:Config ovf:required="false" vmw:key="powerOpInfo.suspendType" vmw:value="soft"/>
<vmw:Config ovf:required="false" vmw:key="nestedHVEnabled" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="vPMCEnabled" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="virtualICH7MPresent" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="virtualSMCPresent" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="flags.vvtdEnabled" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="flags.vbsEnabled" vmw:value="false"/>
<vmw:Config ovf:required="false" vmw:key="bootOptions.efiSecureBootEnabled" vmw:value="true"/>
<vmw:Config ovf:required="false" vmw:key="powerOpInfo.standbyAction" vmw:value="checkpoint"/>
<vmw:ExtraConfig ovf:required="false" vmw:key="nvram" vmw:value="ovf:/file/file3"/>
<vmw:ExtraConfig ovf:required="false" vmw:key="svga.autodetect" vmw:value="TRUE"/>
</VirtualHardwareSection>
</VirtualSystem>
</Envelope>
the complete log is:
2023-02-27 11:08:57,658-05 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-38) [3eba88b2-7b98-48d4-8488-2f3331fb41e6] EVENT_ID: ANSIBLE_RUNNER_EVENT_NOTIFICATION(559), Query OVA info. Run query script.
2023-02-27 11:08:57,665-05 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-38) [3eba88b2-7b98-48d4-8488-2f3331fb41e6] EVENT_ID: ANSIBLE_RUNNER_EVENT_NOTIFICATION(559), Query OVA info. Remove temp directory.
2023-02-27 11:09:00,676-05 WARN [org.ovirt.engine.core.utils.ovf.OvfReader] (default task-38) [3eba88b2-7b98-48d4-8488-2f3331fb41e6] could not retrieve volume id of file1 from ovf, generating new guid
2023-02-27 11:09:00,676-05 WARN [org.ovirt.engine.core.utils.ovf.OvfReader] (default task-38) [3eba88b2-7b98-48d4-8488-2f3331fb41e6] could not retrieve disk id of vmdisk1 from ovf, generating new guid
2023-02-27 11:09:00,677-05 WARN [org.ovirt.engine.core.utils.ovf.OvfReader] (default task-38) [3eba88b2-7b98-48d4-8488-2f3331fb41e6] could not retrieve volume id of file2 from ovf, generating new guid
2023-02-27 11:09:00,677-05 WARN [org.ovirt.engine.core.utils.ovf.OvfReader] (default task-38) [3eba88b2-7b98-48d4-8488-2f3331fb41e6] could not retrieve disk id of vmdisk2 from ovf, generating new guid
2023-02-27 11:09:19,408-05 INFO [org.ovirt.engine.core.bll.exportimport.ImportVmFromOvaCommand] (default task-38) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Lock Acquired to object 'EngineLock:{exclusiveLocks='[557421e0-d5f8-4caa-a84c-d1df24cb5a08=VM, 8e4c49b1-5078-4c89-9ccc-237b95b5dce4=DISK, Implementacion_02-2=VM_NAME]', sharedLocks=''}'
2023-02-27 11:09:19,493-05 INFO [org.ovirt.engine.core.bll.exportimport.ImportVmFromOvaCommand] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Running command: ImportVmFromOvaCommand internal: false. Entities affected : ID: 5d22cf63-93e3-4d4d-9e53-395608923d6d Type: ClusterAction group CREATE_VM with role type USER, ID: 588d888c-ff14-4191-a5bc-a38f65dc29e9 Type: StorageAction group IMPORT_EXPORT_VM with role type ADMIN
2023-02-27 11:09:19,603-05 INFO [org.ovirt.engine.core.bll.storage.disk.AddDiskCommand] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Running command: AddDiskCommand internal: true. Entities affected : ID: 557421e0-d5f8-4caa-a84c-d1df24cb5a08 Type: VMAction group CONFIGURE_VM_STORAGE with role type USER, ID: 588d888c-ff14-4191-a5bc-a38f65dc29e9 Type: StorageAction group CREATE_DISK with role type USER
2023-02-27 11:09:19,619-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Running command: AddImageFromScratchCommand internal: true. Entities affected : ID: 588d888c-ff14-4191-a5bc-a38f65dc29e9 Type: Storage
2023-02-27 11:09:19,636-05 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CreateVolumeVDSCommand] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, CreateVolumeVDSCommand( CreateVolumeVDSCommandParameters:{storagePoolId='26a41fba-0334-4b87-9b87-4ac6e86d32f7', ignoreFailoverLimit='false', storageDomainId='588d888c-ff14-4191-a5bc-a38f65dc29e9', imageGroupId='096444a2-0f21-4ea0-b4c3-3a4604d232bf', imageSizeInBytes='161061273600', volumeFormat='COW', newImageId='213d572b-c37f-484e-ad50-b513ae68d455', imageType='Sparse', newImageDescription='{"DiskAlias":"vmdisk1","DiskDescription":""}', imageInitialSizeInBytes='117837135872', imageId='00000000-0000-0000-0000-000000000000', sourceImageGroupId='00000000-0000-0000-0000-000000000000', shouldAddBitmaps='false', legal='true', sequenceNumber='1', bitmap='null'}), log id: 50719fb2
2023-02-27 11:09:19,673-05 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CreateVolumeVDSCommand] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, CreateVolumeVDSCommand, return: 213d572b-c37f-484e-ad50-b513ae68d455, log id: 50719fb2
2023-02-27 11:09:19,678-05 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] CommandAsyncTask::Adding CommandMultiAsyncTasks object for command '9850b22f-13fd-4c17-afef-83483140d670'
2023-02-27 11:09:19,678-05 INFO [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] CommandMultiAsyncTasks::attachTask: Attaching task 'b168c512-9335-405d-b239-05b6e663aaa5' to command '9850b22f-13fd-4c17-afef-83483140d670'.
2023-02-27 11:09:19,689-05 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Adding task 'b168c512-9335-405d-b239-05b6e663aaa5' (Parent Command 'AddImageFromScratch', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters'), polling hasn't started yet..
2023-02-27 11:09:19,697-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] BaseAsyncTask::startPollingTask: Starting to poll task 'b168c512-9335-405d-b239-05b6e663aaa5'.
2023-02-27 11:09:19,718-05 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] EVENT_ID: ADD_DISK_INTERNAL(2,036), Add-Disk operation of 'vmdisk1' was initiated by the system.
2023-02-27 11:09:19,800-05 INFO [org.ovirt.engine.core.bll.storage.disk.AddDiskCommand] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Running command: AddDiskCommand internal: true. Entities affected : ID: 557421e0-d5f8-4caa-a84c-d1df24cb5a08 Type: VMAction group CONFIGURE_VM_STORAGE with role type USER, ID: 588d888c-ff14-4191-a5bc-a38f65dc29e9 Type: StorageAction group CREATE_DISK with role type USER
2023-02-27 11:09:19,813-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Running command: AddImageFromScratchCommand internal: true. Entities affected : ID: 588d888c-ff14-4191-a5bc-a38f65dc29e9 Type: Storage
2023-02-27 11:09:19,822-05 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CreateVolumeVDSCommand] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, CreateVolumeVDSCommand( CreateVolumeVDSCommandParameters:{storagePoolId='26a41fba-0334-4b87-9b87-4ac6e86d32f7', ignoreFailoverLimit='false', storageDomainId='588d888c-ff14-4191-a5bc-a38f65dc29e9', imageGroupId='7ae5ded5-d0c8-41f8-ab30-401aef4a0e93', imageSizeInBytes='161061273600', volumeFormat='COW', newImageId='482e7dc2-faf9-480b-bbf9-2ece1a12cc5a', imageType='Sparse', newImageDescription='{"DiskAlias":"vmdisk2","DiskDescription":""}', imageInitialSizeInBytes='148116078592', imageId='00000000-0000-0000-0000-000000000000', sourceImageGroupId='00000000-0000-0000-0000-000000000000', shouldAddBitmaps='false', legal='true', sequenceNumber='1', bitmap='null'}), log id: 7ca68b15
2023-02-27 11:09:19,846-05 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.CreateVolumeVDSCommand] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, CreateVolumeVDSCommand, return: 482e7dc2-faf9-480b-bbf9-2ece1a12cc5a, log id: 7ca68b15
2023-02-27 11:09:19,850-05 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] CommandAsyncTask::Adding CommandMultiAsyncTasks object for command 'c75cb919-ba4b-481c-8dcd-733573abe129'
2023-02-27 11:09:19,850-05 INFO [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] CommandMultiAsyncTasks::attachTask: Attaching task '9c06a6b6-d2e4-4fe6-a370-d871fc312a16' to command 'c75cb919-ba4b-481c-8dcd-733573abe129'.
2023-02-27 11:09:19,861-05 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Adding task '9c06a6b6-d2e4-4fe6-a370-d871fc312a16' (Parent Command 'AddImageFromScratch', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters'), polling hasn't started yet..
2023-02-27 11:09:19,867-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] BaseAsyncTask::startPollingTask: Starting to poll task '9c06a6b6-d2e4-4fe6-a370-d871fc312a16'.
2023-02-27 11:09:19,888-05 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] EVENT_ID: ADD_DISK_INTERNAL(2,036), Add-Disk operation of 'vmdisk2' was initiated by the system.
2023-02-27 11:09:19,890-05 INFO [org.ovirt.engine.core.bll.storage.disk.AddDiskCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-91) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Command 'AddDisk' (id: 'bd6a7f06-1aeb-407a-8dbc-837280be9fb6') waiting on child command id: 'c75cb919-ba4b-481c-8dcd-733573abe129' type:'AddImageFromScratch' to complete
2023-02-27 11:09:19,891-05 INFO [org.ovirt.engine.core.bll.storage.disk.AddDiskCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-91) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Command 'AddDisk' (id: 'd0158085-44c8-4dae-8108-6704c16154f7') waiting on child command id: '9850b22f-13fd-4c17-afef-83483140d670' type:'AddImageFromScratch' to complete
2023-02-27 11:09:19,909-05 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engine-Thread-31181) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] EVENT_ID: IMPORTEXPORT_STARTING_IMPORT_VM(1,165), Starting to import Vm Implementacion_02-2 to Data Center dc_rcloud, Cluster cl_rcloud
2023-02-27 11:09:21,857-05 INFO [org.ovirt.engine.core.bll.provider.network.SyncNetworkProviderCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-46) [7346ec67] Lock Acquired to object 'EngineLock:{exclusiveLocks='[0eddd27f-e2d0-4e5f-9fbb-00fd7409c165=PROVIDER]', sharedLocks=''}'
2023-02-27 11:09:21,873-05 INFO [org.ovirt.engine.core.bll.provider.network.SyncNetworkProviderCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-46) [7346ec67] Running command: SyncNetworkProviderCommand internal: true.
2023-02-27 11:09:21,877-05 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-46) [7346ec67] EVENT_ID: PROVIDER_SYNCHRONIZATION_STARTED(223), Provider ovirt-provider-ovn synchronization started.
2023-02-27 11:09:21,893-05 INFO [org.ovirt.engine.core.bll.SerialChildCommandsExecutionCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-100) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Command 'ImportVmFromOva' (id: 'f94e159b-a638-4f81-8af0-8b1fb8653170') waiting on child command id: 'd0158085-44c8-4dae-8108-6704c16154f7' type:'AddDisk' to complete
2023-02-27 11:09:21,894-05 INFO [org.ovirt.engine.core.bll.storage.disk.AddDiskCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-100) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Command 'AddDisk' (id: 'bd6a7f06-1aeb-407a-8dbc-837280be9fb6') waiting on child command id: 'c75cb919-ba4b-481c-8dcd-733573abe129' type:'AddImageFromScratch' to complete
2023-02-27 11:09:21,894-05 INFO [org.ovirt.engine.core.bll.storage.disk.AddDiskCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-100) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Command 'AddDisk' (id: 'd0158085-44c8-4dae-8108-6704c16154f7') waiting on child command id: '9850b22f-13fd-4c17-afef-83483140d670' type:'AddImageFromScratch' to complete
2023-02-27 11:09:22,029-05 INFO [org.ovirt.engine.core.sso.service.ExternalOIDCService] (default task-38) [] User admin@ovirt@internalkeycloak-authz with profile [internalsso] successfully logged into external OP with scopes: ovirt-app-api ovirt-ext=token-info:authz-search ovirt-ext=token-info:public-authz-search ovirt-ext=token-info:validate ovirt-ext=token:password-access
2023-02-27 11:09:22,142-05 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-46) [7346ec67] EVENT_ID: PROVIDER_SYNCHRONIZATION_ENDED(224), Provider ovirt-provider-ovn synchronization ended.
2023-02-27 11:09:22,143-05 INFO [org.ovirt.engine.core.bll.provider.network.SyncNetworkProviderCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-46) [7346ec67] Lock freed to object 'EngineLock:{exclusiveLocks='[0eddd27f-e2d0-4e5f-9fbb-00fd7409c165=PROVIDER]', sharedLocks=''}'
2023-02-27 11:09:25,899-05 INFO [org.ovirt.engine.core.bll.SerialChildCommandsExecutionCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-94) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Command 'ImportVmFromOva' (id: 'f94e159b-a638-4f81-8af0-8b1fb8653170') waiting on child command id: 'd0158085-44c8-4dae-8108-6704c16154f7' type:'AddDisk' to complete
2023-02-27 11:09:25,899-05 INFO [org.ovirt.engine.core.bll.storage.disk.AddDiskCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-94) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Command 'AddDisk' (id: 'bd6a7f06-1aeb-407a-8dbc-837280be9fb6') waiting on child command id: 'c75cb919-ba4b-481c-8dcd-733573abe129' type:'AddImageFromScratch' to complete
2023-02-27 11:09:25,900-05 INFO [org.ovirt.engine.core.bll.storage.disk.AddDiskCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-94) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Command 'AddDisk' (id: 'd0158085-44c8-4dae-8108-6704c16154f7') waiting on child command id: '9850b22f-13fd-4c17-afef-83483140d670' type:'AddImageFromScratch' to complete
2023-02-27 11:09:26,075-05 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-20) [] Polling and updating Async Tasks: 2 tasks, 2 tasks to poll now
2023-02-27 11:09:26,082-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-20) [] SPMAsyncTask::PollTask: Polling task '9c06a6b6-d2e4-4fe6-a370-d871fc312a16' (Parent Command 'AddImageFromScratch', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') returned status 'finished', result 'success'.
2023-02-27 11:09:26,088-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-20) [] BaseAsyncTask::onTaskEndSuccess: Task '9c06a6b6-d2e4-4fe6-a370-d871fc312a16' (Parent Command 'AddImageFromScratch', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') ended successfully.
2023-02-27 11:09:26,090-05 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-20) [] CommandAsyncTask::endActionIfNecessary: All tasks of command 'c75cb919-ba4b-481c-8dcd-733573abe129' has ended -> executing 'endAction'
2023-02-27 11:09:26,090-05 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-20) [] CommandAsyncTask::endAction: Ending action for '1' tasks (command ID: 'c75cb919-ba4b-481c-8dcd-733573abe129'): calling endAction '.
2023-02-27 11:09:26,091-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-20) [] SPMAsyncTask::PollTask: Polling task 'b168c512-9335-405d-b239-05b6e663aaa5' (Parent Command 'AddImageFromScratch', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') returned status 'finished', result 'success'.
2023-02-27 11:09:26,091-05 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-31184) [] CommandAsyncTask::endCommandAction [within thread] context: Attempting to endAction 'AddImageFromScratch',
2023-02-27 11:09:26,095-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-20) [] BaseAsyncTask::onTaskEndSuccess: Task 'b168c512-9335-405d-b239-05b6e663aaa5' (Parent Command 'AddImageFromScratch', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') ended successfully.
2023-02-27 11:09:26,096-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand] (EE-ManagedThreadFactory-engine-Thread-31184) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Command [id=c75cb919-ba4b-481c-8dcd-733573abe129]: Updating status to 'SUCCEEDED', The command end method logic will be executed by one of its parent commands.
2023-02-27 11:09:26,096-05 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-31184) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type 'AddImageFromScratch' completed, handling the result.
2023-02-27 11:09:26,096-05 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-31184) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type 'AddImageFromScratch' succeeded, clearing tasks.
2023-02-27 11:09:26,096-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engine-Thread-31184) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] SPMAsyncTask::ClearAsyncTask: Attempting to clear task '9c06a6b6-d2e4-4fe6-a370-d871fc312a16'
2023-02-27 11:09:26,096-05 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-20) [] CommandAsyncTask::endActionIfNecessary: All tasks of command '9850b22f-13fd-4c17-afef-83483140d670' has ended -> executing 'endAction'
2023-02-27 11:09:26,096-05 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-31184) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, SPMClearTaskVDSCommand( SPMTaskGuidBaseVDSCommandParameters:{storagePoolId='26a41fba-0334-4b87-9b87-4ac6e86d32f7', ignoreFailoverLimit='false', taskId='9c06a6b6-d2e4-4fe6-a370-d871fc312a16'}), log id: 5fe37e69
2023-02-27 11:09:26,096-05 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-20) [] CommandAsyncTask::endAction: Ending action for '1' tasks (command ID: '9850b22f-13fd-4c17-afef-83483140d670'): calling endAction '.
2023-02-27 11:09:26,097-05 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-31185) [] CommandAsyncTask::endCommandAction [within thread] context: Attempting to endAction 'AddImageFromScratch',
2023-02-27 11:09:26,097-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-31184) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, HSMClearTaskVDSCommand(HostName = ovirtnodo01.redsiscloud.loc, HSMTaskGuidBaseVDSCommandParameters:{hostId='2b47d08d-16f6-4d5b-bdcd-8c8ac6f30629', taskId='9c06a6b6-d2e4-4fe6-a370-d871fc312a16'}), log id: 3673d24
2023-02-27 11:09:26,099-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand] (EE-ManagedThreadFactory-engine-Thread-31185) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Command [id=9850b22f-13fd-4c17-afef-83483140d670]: Updating status to 'SUCCEEDED', The command end method logic will be executed by one of its parent commands.
2023-02-27 11:09:26,099-05 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-31185) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type 'AddImageFromScratch' completed, handling the result.
2023-02-27 11:09:26,099-05 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-31185) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type 'AddImageFromScratch' succeeded, clearing tasks.
2023-02-27 11:09:26,099-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engine-Thread-31185) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] SPMAsyncTask::ClearAsyncTask: Attempting to clear task 'b168c512-9335-405d-b239-05b6e663aaa5'
2023-02-27 11:09:26,100-05 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-31185) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, SPMClearTaskVDSCommand( SPMTaskGuidBaseVDSCommandParameters:{storagePoolId='26a41fba-0334-4b87-9b87-4ac6e86d32f7', ignoreFailoverLimit='false', taskId='b168c512-9335-405d-b239-05b6e663aaa5'}), log id: 20d1c555
2023-02-27 11:09:26,105-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-31184) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, HSMClearTaskVDSCommand, return: , log id: 3673d24
2023-02-27 11:09:26,105-05 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-31184) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, SPMClearTaskVDSCommand, return: , log id: 5fe37e69
2023-02-27 11:09:26,106-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-31185) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, HSMClearTaskVDSCommand(HostName = ovirtnodo01.redsiscloud.loc, HSMTaskGuidBaseVDSCommandParameters:{hostId='2b47d08d-16f6-4d5b-bdcd-8c8ac6f30629', taskId='b168c512-9335-405d-b239-05b6e663aaa5'}), log id: 162b7940
2023-02-27 11:09:26,107-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engine-Thread-31184) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] BaseAsyncTask::removeTaskFromDB: Removed task '9c06a6b6-d2e4-4fe6-a370-d871fc312a16' from DataBase
2023-02-27 11:09:26,107-05 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-31184) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] CommandAsyncTask::HandleEndActionResult [within thread]: Removing CommandMultiAsyncTasks object for entity 'c75cb919-ba4b-481c-8dcd-733573abe129'
2023-02-27 11:09:26,117-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-31185) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, HSMClearTaskVDSCommand, return: , log id: 162b7940
2023-02-27 11:09:26,118-05 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.SPMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-31185) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, SPMClearTaskVDSCommand, return: , log id: 20d1c555
2023-02-27 11:09:26,120-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engine-Thread-31185) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] BaseAsyncTask::removeTaskFromDB: Removed task 'b168c512-9335-405d-b239-05b6e663aaa5' from DataBase
2023-02-27 11:09:26,120-05 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-31185) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] CommandAsyncTask::HandleEndActionResult [within thread]: Removing CommandMultiAsyncTasks object for entity '9850b22f-13fd-4c17-afef-83483140d670'
2023-02-27 11:09:33,905-05 INFO [org.ovirt.engine.core.bll.SerialChildCommandsExecutionCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-78) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Command 'ImportVmFromOva' (id: 'f94e159b-a638-4f81-8af0-8b1fb8653170') waiting on child command id: 'd0158085-44c8-4dae-8108-6704c16154f7' type:'AddDisk' to complete
2023-02-27 11:09:33,906-05 INFO [org.ovirt.engine.core.bll.storage.disk.AddDiskCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-78) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Getting volume info for image '7ae5ded5-d0c8-41f8-ab30-401aef4a0e93/482e7dc2-faf9-480b-bbf9-2ece1a12cc5a'
2023-02-27 11:09:33,918-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-78) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, GetVolumeInfoVDSCommand(HostName = ovirtnodo01.redsiscloud.loc, GetVolumeInfoVDSCommandParameters:{hostId='2b47d08d-16f6-4d5b-bdcd-8c8ac6f30629', storagePoolId='26a41fba-0334-4b87-9b87-4ac6e86d32f7', storageDomainId='588d888c-ff14-4191-a5bc-a38f65dc29e9', imageGroupId='7ae5ded5-d0c8-41f8-ab30-401aef4a0e93', imageId='482e7dc2-faf9-480b-bbf9-2ece1a12cc5a'}), log id: 576590a3
2023-02-27 11:09:34,065-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-78) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, GetVolumeInfoVDSCommand, return: org.ovirt.engine.core.common.businessentities.storage.DiskImage@e712ba11, log id: 576590a3
2023-02-27 11:09:34,065-05 INFO [org.ovirt.engine.core.bll.storage.disk.AddDiskCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-78) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Command 'AddDisk' id: 'bd6a7f06-1aeb-407a-8dbc-837280be9fb6' child commands '[c75cb919-ba4b-481c-8dcd-733573abe129]' executions were completed, status 'SUCCEEDED'
2023-02-27 11:09:34,070-05 INFO [org.ovirt.engine.core.bll.storage.disk.AddDiskCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-78) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Getting volume info for image '096444a2-0f21-4ea0-b4c3-3a4604d232bf/213d572b-c37f-484e-ad50-b513ae68d455'
2023-02-27 11:09:34,083-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-78) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, GetVolumeInfoVDSCommand(HostName = ovirtnodo01.redsiscloud.loc, GetVolumeInfoVDSCommandParameters:{hostId='2b47d08d-16f6-4d5b-bdcd-8c8ac6f30629', storagePoolId='26a41fba-0334-4b87-9b87-4ac6e86d32f7', storageDomainId='588d888c-ff14-4191-a5bc-a38f65dc29e9', imageGroupId='096444a2-0f21-4ea0-b4c3-3a4604d232bf', imageId='213d572b-c37f-484e-ad50-b513ae68d455'}), log id: 7cc26313
2023-02-27 11:09:34,108-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-78) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, GetVolumeInfoVDSCommand, return: org.ovirt.engine.core.common.businessentities.storage.DiskImage@ed015f5c, log id: 7cc26313
2023-02-27 11:09:34,108-05 INFO [org.ovirt.engine.core.bll.storage.disk.AddDiskCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-78) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Command 'AddDisk' id: 'd0158085-44c8-4dae-8108-6704c16154f7' child commands '[9850b22f-13fd-4c17-afef-83483140d670]' executions were completed, status 'SUCCEEDED'
2023-02-27 11:09:35,113-05 INFO [org.ovirt.engine.core.bll.storage.disk.AddDiskCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Ending command 'org.ovirt.engine.core.bll.storage.disk.AddDiskCommand' successfully.
2023-02-27 11:09:35,119-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Ending command 'org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand' successfully.
2023-02-27 11:09:35,131-05 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, GetImageInfoVDSCommand( GetImageInfoVDSCommandParameters:{storagePoolId='26a41fba-0334-4b87-9b87-4ac6e86d32f7', ignoreFailoverLimit='false', storageDomainId='588d888c-ff14-4191-a5bc-a38f65dc29e9', imageGroupId='7ae5ded5-d0c8-41f8-ab30-401aef4a0e93', imageId='482e7dc2-faf9-480b-bbf9-2ece1a12cc5a'}), log id: 57b964f4
2023-02-27 11:09:35,132-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, GetVolumeInfoVDSCommand(HostName = ovirtnodo01.redsiscloud.loc, GetVolumeInfoVDSCommandParameters:{hostId='2b47d08d-16f6-4d5b-bdcd-8c8ac6f30629', storagePoolId='26a41fba-0334-4b87-9b87-4ac6e86d32f7', storageDomainId='588d888c-ff14-4191-a5bc-a38f65dc29e9', imageGroupId='7ae5ded5-d0c8-41f8-ab30-401aef4a0e93', imageId='482e7dc2-faf9-480b-bbf9-2ece1a12cc5a'}), log id: 598fc554
2023-02-27 11:09:35,159-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, GetVolumeInfoVDSCommand, return: org.ovirt.engine.core.common.businessentities.storage.DiskImage@e712ba11, log id: 598fc554
2023-02-27 11:09:35,159-05 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, GetImageInfoVDSCommand, return: org.ovirt.engine.core.common.businessentities.storage.DiskImage@e712ba11, log id: 57b964f4
2023-02-27 11:09:35,221-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, PrepareImageVDSCommand(HostName = ovirtnodo01.redsiscloud.loc, PrepareImageVDSCommandParameters:{hostId='2b47d08d-16f6-4d5b-bdcd-8c8ac6f30629'}), log id: 673ef63a
2023-02-27 11:09:35,661-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, PrepareImageVDSCommand, return: PrepareImageReturn:{status='Status [code=0, message=Done]'}, log id: 673ef63a
2023-02-27 11:09:35,662-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetQemuImageInfoVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, GetQemuImageInfoVDSCommand(HostName = ovirtnodo01.redsiscloud.loc, GetVolumeInfoVDSCommandParameters:{hostId='2b47d08d-16f6-4d5b-bdcd-8c8ac6f30629', storagePoolId='26a41fba-0334-4b87-9b87-4ac6e86d32f7', storageDomainId='588d888c-ff14-4191-a5bc-a38f65dc29e9', imageGroupId='7ae5ded5-d0c8-41f8-ab30-401aef4a0e93', imageId='482e7dc2-faf9-480b-bbf9-2ece1a12cc5a'}), log id: 75196914
2023-02-27 11:09:35,682-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetQemuImageInfoVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, GetQemuImageInfoVDSCommand, return: org.ovirt.engine.core.common.businessentities.storage.QemuImageInfo@203d7f68, log id: 75196914
2023-02-27 11:09:35,683-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.TeardownImageVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, TeardownImageVDSCommand(HostName = ovirtnodo01.redsiscloud.loc, ImageActionsVDSCommandParameters:{hostId='2b47d08d-16f6-4d5b-bdcd-8c8ac6f30629'}), log id: 41ad864
2023-02-27 11:09:35,935-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.TeardownImageVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, TeardownImageVDSCommand, return: StatusReturn:{status='Status [code=0, message=Done]'}, log id: 41ad864
2023-02-27 11:09:36,003-05 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [] EVENT_ID: USER_ADD_DISK_TO_VM_FINISHED_SUCCESS(97), The disk vmdisk2 was successfully added to VM Implementacion_02-2.
2023-02-27 11:09:36,005-05 INFO [org.ovirt.engine.core.bll.storage.disk.AddDiskCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Ending command 'org.ovirt.engine.core.bll.storage.disk.AddDiskCommand' successfully.
2023-02-27 11:09:36,009-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Ending command 'org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand' successfully.
2023-02-27 11:09:36,010-05 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, GetImageInfoVDSCommand( GetImageInfoVDSCommandParameters:{storagePoolId='26a41fba-0334-4b87-9b87-4ac6e86d32f7', ignoreFailoverLimit='false', storageDomainId='588d888c-ff14-4191-a5bc-a38f65dc29e9', imageGroupId='096444a2-0f21-4ea0-b4c3-3a4604d232bf', imageId='213d572b-c37f-484e-ad50-b513ae68d455'}), log id: 1393bd54
2023-02-27 11:09:36,011-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, GetVolumeInfoVDSCommand(HostName = ovirtnodo01.redsiscloud.loc, GetVolumeInfoVDSCommandParameters:{hostId='2b47d08d-16f6-4d5b-bdcd-8c8ac6f30629', storagePoolId='26a41fba-0334-4b87-9b87-4ac6e86d32f7', storageDomainId='588d888c-ff14-4191-a5bc-a38f65dc29e9', imageGroupId='096444a2-0f21-4ea0-b4c3-3a4604d232bf', imageId='213d572b-c37f-484e-ad50-b513ae68d455'}), log id: 3d6a9c56
2023-02-27 11:09:36,038-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, GetVolumeInfoVDSCommand, return: org.ovirt.engine.core.common.businessentities.storage.DiskImage@ed015f5c, log id: 3d6a9c56
2023-02-27 11:09:36,039-05 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, GetImageInfoVDSCommand, return: org.ovirt.engine.core.common.businessentities.storage.DiskImage@ed015f5c, log id: 1393bd54
2023-02-27 11:09:36,052-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, PrepareImageVDSCommand(HostName = ovirtnodo01.redsiscloud.loc, PrepareImageVDSCommandParameters:{hostId='2b47d08d-16f6-4d5b-bdcd-8c8ac6f30629'}), log id: 700e12bc
2023-02-27 11:09:36,473-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, PrepareImageVDSCommand, return: PrepareImageReturn:{status='Status [code=0, message=Done]'}, log id: 700e12bc
2023-02-27 11:09:36,474-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetQemuImageInfoVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, GetQemuImageInfoVDSCommand(HostName = ovirtnodo01.redsiscloud.loc, GetVolumeInfoVDSCommandParameters:{hostId='2b47d08d-16f6-4d5b-bdcd-8c8ac6f30629', storagePoolId='26a41fba-0334-4b87-9b87-4ac6e86d32f7', storageDomainId='588d888c-ff14-4191-a5bc-a38f65dc29e9', imageGroupId='096444a2-0f21-4ea0-b4c3-3a4604d232bf', imageId='213d572b-c37f-484e-ad50-b513ae68d455'}), log id: 4ac0f47b
2023-02-27 11:09:36,494-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.GetQemuImageInfoVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, GetQemuImageInfoVDSCommand, return: org.ovirt.engine.core.common.businessentities.storage.QemuImageInfo@44b063f5, log id: 4ac0f47b
2023-02-27 11:09:36,495-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.TeardownImageVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, TeardownImageVDSCommand(HostName = ovirtnodo01.redsiscloud.loc, ImageActionsVDSCommandParameters:{hostId='2b47d08d-16f6-4d5b-bdcd-8c8ac6f30629'}), log id: 5615381f
2023-02-27 11:09:36,727-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.TeardownImageVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, TeardownImageVDSCommand, return: StatusReturn:{status='Status [code=0, message=Done]'}, log id: 5615381f
2023-02-27 11:09:36,750-05 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-54) [] EVENT_ID: USER_ADD_DISK_TO_VM_FINISHED_SUCCESS(97), The disk vmdisk1 was successfully added to VM Implementacion_02-2.
2023-02-27 11:09:37,798-05 INFO [org.ovirt.engine.core.bll.exportimport.ConvertOvaCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-51) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Running command: ConvertOvaCommand internal: true. Entities affected : ID: 557421e0-d5f8-4caa-a84c-d1df24cb5a08 Type: VM
2023-02-27 11:09:37,829-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-51) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, PrepareImageVDSCommand(HostName = ovirtnodo01.redsiscloud.loc, PrepareImageVDSCommandParameters:{hostId='2b47d08d-16f6-4d5b-bdcd-8c8ac6f30629'}), log id: 649bcef9
2023-02-27 11:09:38,286-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.PrepareImageVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-51) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, PrepareImageVDSCommand, return: PrepareImageReturn:{status='Status [code=0, message=Done]'}, log id: 649bcef9
2023-02-27 11:09:38,288-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConvertOvaVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-51) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, ConvertOvaVDSCommand(HostName = ovirtnodo01.redsiscloud.loc, ConvertOvaVDSParameters:{hostId='2b47d08d-16f6-4d5b-bdcd-8c8ac6f30629', ovaPath='/root/w2_ovfs/ovf/Implementacion_02-2', vmName='Implementacion_02-2', storageDomainId='588d888c-ff14-4191-a5bc-a38f65dc29e9', storagePoolId='26a41fba-0334-4b87-9b87-4ac6e86d32f7', virtioIsoPath='/rhev/data-center/mnt/blockSD/7f20ff07-e000-462e-9471-7efe882687c6/images/8e4c49b1-5078-4c89-9ccc-237b95b5dce4/5d21a9de-5a4d-40e9-93e0-989174dcb912', Disk0='096444a2-0f21-4ea0-b4c3-3a4604d232bf', Disk1='7ae5ded5-d0c8-41f8-ab30-401aef4a0e93'}), log id: 780d2b61
2023-02-27 11:09:38,326-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.ConvertOvaVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-51) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, ConvertOvaVDSCommand, return: 557421e0-d5f8-4caa-a84c-d1df24cb5a08, log id: 780d2b61
2023-02-27 11:09:40,344-05 INFO [org.ovirt.engine.core.bll.SerialChildCommandsExecutionCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-35) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Command 'ImportVmFromOva' (id: 'f94e159b-a638-4f81-8af0-8b1fb8653170') waiting on child command id: '02556fe8-58c7-438f-8fd1-29a0df677b51' type:'ConvertOva' to complete
2023-02-27 11:09:41,345-05 INFO [org.ovirt.engine.core.bll.exportimport.ConvertVmCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-59) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Conversion of VM from external environment failed: Job '557421e0-d5f8-4caa-a84c-d1df24cb5a08' process failed exit-code: 1
2023-02-27 11:09:42,353-05 ERROR [org.ovirt.engine.core.bll.exportimport.ConvertOvaCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-18) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Ending command 'org.ovirt.engine.core.bll.exportimport.ConvertOvaCommand' with failure.
2023-02-27 11:09:42,354-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DeleteV2VJobVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-18) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, DeleteV2VJobVDSCommand(HostName = ovirtnodo01.redsiscloud.loc, VdsAndVmIDVDSParametersBase:{hostId='2b47d08d-16f6-4d5b-bdcd-8c8ac6f30629', vmId='557421e0-d5f8-4caa-a84c-d1df24cb5a08'}), log id: 65e6b22b
2023-02-27 11:09:42,360-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.DeleteV2VJobVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-18) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, DeleteV2VJobVDSCommand, return: , log id: 65e6b22b
2023-02-27 11:09:42,374-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.TeardownImageVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-18) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] START, TeardownImageVDSCommand(HostName = ovirtnodo01.redsiscloud.loc, ImageActionsVDSCommandParameters:{hostId='2b47d08d-16f6-4d5b-bdcd-8c8ac6f30629'}), log id: 5cc711f5
2023-02-27 11:09:42,608-05 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.TeardownImageVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-18) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] FINISH, TeardownImageVDSCommand, return: StatusReturn:{status='Status [code=0, message=Done]'}, log id: 5cc711f5
2023-02-27 11:09:42,622-05 INFO [org.ovirt.engine.core.bll.SerialChildCommandsExecutionCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-18) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Command 'ImportVmFromOva' id: 'f94e159b-a638-4f81-8af0-8b1fb8653170' child commands '[d0158085-44c8-4dae-8108-6704c16154f7, bd6a7f06-1aeb-407a-8dbc-837280be9fb6, 02556fe8-58c7-438f-8fd1-29a0df677b51]' executions were completed, status 'FAILED'
2023-02-27 11:09:43,639-05 ERROR [org.ovirt.engine.core.bll.exportimport.ImportVmFromOvaCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [90ee1c89-6cfb-4632-837b-781d5a32ed4c] Ending command 'org.ovirt.engine.core.bll.exportimport.ImportVmFromOvaCommand' with failure.
2023-02-27 11:09:43,661-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.RemoveAllVmImagesCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] Running command: RemoveAllVmImagesCommand internal: true. Entities affected : ID: 557421e0-d5f8-4caa-a84c-d1df24cb5a08 Type: VM
2023-02-27 11:09:43,684-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] Running command: RemoveImageCommand internal: true. Entities affected : ID: 00000000-0000-0000-0000-000000000000 Type: Storage
2023-02-27 11:09:43,693-05 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] START, DeleteImageGroupVDSCommand( DeleteImageGroupVDSCommandParameters:{storagePoolId='26a41fba-0334-4b87-9b87-4ac6e86d32f7', ignoreFailoverLimit='false', storageDomainId='588d888c-ff14-4191-a5bc-a38f65dc29e9', imageGroupId='096444a2-0f21-4ea0-b4c3-3a4604d232bf', postZeros='false', discard='true', forceDelete='false'}), log id: 6ae771f2
2023-02-27 11:09:43,938-05 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] FINISH, DeleteImageGroupVDSCommand, return: , log id: 6ae771f2
2023-02-27 11:09:43,940-05 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] CommandAsyncTask::Adding CommandMultiAsyncTasks object for command '1fc4fb29-5034-49f2-a991-9eb10a4f3f63'
2023-02-27 11:09:43,940-05 INFO [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] CommandMultiAsyncTasks::attachTask: Attaching task '002baef1-b642-49b4-9eea-065c311d57b1' to command '1fc4fb29-5034-49f2-a991-9eb10a4f3f63'.
2023-02-27 11:09:43,949-05 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] Adding task '002baef1-b642-49b4-9eea-065c311d57b1' (Parent Command 'RemoveImage', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters'), polling hasn't started yet..
2023-02-27 11:09:43,953-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] BaseAsyncTask::startPollingTask: Starting to poll task '002baef1-b642-49b4-9eea-065c311d57b1'.
2023-02-27 11:09:43,954-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] BaseAsyncTask::startPollingTask: Starting to poll task '002baef1-b642-49b4-9eea-065c311d57b1'.
2023-02-27 11:09:43,972-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] Running command: RemoveImageCommand internal: true. Entities affected : ID: 00000000-0000-0000-0000-000000000000 Type: Storage
2023-02-27 11:09:43,980-05 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] START, DeleteImageGroupVDSCommand( DeleteImageGroupVDSCommandParameters:{storagePoolId='26a41fba-0334-4b87-9b87-4ac6e86d32f7', ignoreFailoverLimit='false', storageDomainId='588d888c-ff14-4191-a5bc-a38f65dc29e9', imageGroupId='7ae5ded5-d0c8-41f8-ab30-401aef4a0e93', postZeros='false', discard='true', forceDelete='false'}), log id: 3f49936
2023-02-27 11:09:44,317-05 INFO [org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] FINISH, DeleteImageGroupVDSCommand, return: , log id: 3f49936
2023-02-27 11:09:44,319-05 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] CommandAsyncTask::Adding CommandMultiAsyncTasks object for command 'c2f34732-9878-4cbf-bca3-1511ce145e34'
2023-02-27 11:09:44,319-05 INFO [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] CommandMultiAsyncTasks::attachTask: Attaching task '3679c4b7-aea9-4fbd-804a-20f479aed410' to command 'c2f34732-9878-4cbf-bca3-1511ce145e34'.
2023-02-27 11:09:44,342-05 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] Adding task '3679c4b7-aea9-4fbd-804a-20f479aed410' (Parent Command 'RemoveImage', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters'), polling hasn't started yet..
2023-02-27 11:09:44,352-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] BaseAsyncTask::startPollingTask: Starting to poll task '3679c4b7-aea9-4fbd-804a-20f479aed410'.
2023-02-27 11:09:44,352-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] BaseAsyncTask::startPollingTask: Starting to poll task '3679c4b7-aea9-4fbd-804a-20f479aed410'.
2023-02-27 11:09:44,371-05 INFO [org.ovirt.engine.core.bll.CommandCompensator] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] Command [id=f94e159b-a638-4f81-8af0-8b1fb8653170]: Compensating NEW_ENTITY_ID of org.ovirt.engine.core.common.businessentities.network.VmNetworkStatistics; snapshot: 56850e5f-79f5-4414-8381-62ea2f81bf94.
2023-02-27 11:09:44,372-05 INFO [org.ovirt.engine.core.bll.CommandCompensator] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] Command [id=f94e159b-a638-4f81-8af0-8b1fb8653170]: Compensating NEW_ENTITY_ID of org.ovirt.engine.core.common.businessentities.network.VmNetworkInterface; snapshot: 56850e5f-79f5-4414-8381-62ea2f81bf94.
2023-02-27 11:09:44,373-05 INFO [org.ovirt.engine.core.bll.CommandCompensator] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] Command [id=f94e159b-a638-4f81-8af0-8b1fb8653170]: Compensating TRANSIENT_ENTITY of org.ovirt.engine.core.common.businessentities.ReleaseMacsTransientCompensation; snapshot: org.ovirt.engine.core.common.businessentities.ReleaseMacsTransientCompensation@2a96e51.
2023-02-27 11:09:44,374-05 INFO [org.ovirt.engine.core.bll.CommandCompensator] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] Command [id=f94e159b-a638-4f81-8af0-8b1fb8653170]: Compensating NEW_ENTITY_ID of org.ovirt.engine.core.common.businessentities.VmStatistics; snapshot: 557421e0-d5f8-4caa-a84c-d1df24cb5a08.
2023-02-27 11:09:44,375-05 INFO [org.ovirt.engine.core.bll.CommandCompensator] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] Command [id=f94e159b-a638-4f81-8af0-8b1fb8653170]: Compensating NEW_ENTITY_ID of org.ovirt.engine.core.common.businessentities.VmDynamic; snapshot: 557421e0-d5f8-4caa-a84c-d1df24cb5a08.
2023-02-27 11:09:44,375-05 INFO [org.ovirt.engine.core.bll.CommandCompensator] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] Command [id=f94e159b-a638-4f81-8af0-8b1fb8653170]: Compensating NEW_ENTITY_ID of org.ovirt.engine.core.common.businessentities.Snapshot; snapshot: f3661ecd-0965-4099-87fa-b341fb934628.
2023-02-27 11:09:44,377-05 INFO [org.ovirt.engine.core.bll.CommandCompensator] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] Command [id=f94e159b-a638-4f81-8af0-8b1fb8653170]: Compensating NEW_ENTITY_ID of org.ovirt.engine.core.common.businessentities.VmStatic; snapshot: 557421e0-d5f8-4caa-a84c-d1df24cb5a08.
2023-02-27 11:09:44,385-05 INFO [org.ovirt.engine.core.bll.exportimport.ImportVmFromOvaCommand] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] Lock freed to object 'EngineLock:{exclusiveLocks='[557421e0-d5f8-4caa-a84c-d1df24cb5a08=VM, 8e4c49b1-5078-4c89-9ccc-237b95b5dce4=DISK, Implementacion_02-2=VM_NAME]', sharedLocks=''}'
2023-02-27 11:09:44,409-05 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] EVENT_ID: IMPORTEXPORT_IMPORT_VM_FAILED(1,153), Failed to import Vm Implementacion_02-2 to Data Center dc_rcloud, Cluster cl_rcloud
2023-02-27 11:09:45,435-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-50) [17e97345] Waiting on remove image command to complete the task '3679c4b7-aea9-4fbd-804a-20f479aed410'
2023-02-27 11:09:45,437-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-50) [17e97345] Waiting on remove image command to complete the task '002baef1-b642-49b4-9eea-065c311d57b1'
2023-02-27 11:09:45,439-05 INFO [org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-50) [17e97345] Command 'RemoveAllVmImages' (id: 'e8fcae23-dbaa-4ac8-8bd0-251aad0e9a04') waiting on child command id: '1fc4fb29-5034-49f2-a991-9eb10a4f3f63' type:'RemoveImage' to complete
2023-02-27 11:09:46,097-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-100) [] Task id '002baef1-b642-49b4-9eea-065c311d57b1' is in pre-polling period and should not be polled. Pre-polling period is 60000 millis.
2023-02-27 11:09:46,097-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-100) [] Task id '3679c4b7-aea9-4fbd-804a-20f479aed410' is in pre-polling period and should not be polled. Pre-polling period is 60000 millis.
2023-02-27 11:09:47,443-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-76) [17e97345] Waiting on remove image command to complete the task '3679c4b7-aea9-4fbd-804a-20f479aed410'
2023-02-27 11:09:47,445-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-76) [17e97345] Waiting on remove image command to complete the task '002baef1-b642-49b4-9eea-065c311d57b1'
2023-02-27 11:09:47,447-05 INFO [org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-76) [17e97345] Command 'RemoveAllVmImages' (id: 'e8fcae23-dbaa-4ac8-8bd0-251aad0e9a04') waiting on child command id: '1fc4fb29-5034-49f2-a991-9eb10a4f3f63' type:'RemoveImage' to complete
2023-02-27 11:09:51,451-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-63) [17e97345] Waiting on remove image command to complete the task '3679c4b7-aea9-4fbd-804a-20f479aed410'
2023-02-27 11:09:51,453-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-63) [17e97345] Waiting on remove image command to complete the task '002baef1-b642-49b4-9eea-065c311d57b1'
2023-02-27 11:09:51,455-05 INFO [org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-63) [17e97345] Command 'RemoveAllVmImages' (id: 'e8fcae23-dbaa-4ac8-8bd0-251aad0e9a04') waiting on child command id: '1fc4fb29-5034-49f2-a991-9eb10a4f3f63' type:'RemoveImage' to complete
2023-02-27 11:09:56,098-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-71) [] Task id '002baef1-b642-49b4-9eea-065c311d57b1' is in pre-polling period and should not be polled. Pre-polling period is 60000 millis.
2023-02-27 11:09:56,098-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-71) [] Task id '3679c4b7-aea9-4fbd-804a-20f479aed410' is in pre-polling period and should not be polled. Pre-polling period is 60000 millis.
2023-02-27 11:09:59,460-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-11) [17e97345] Waiting on remove image command to complete the task '3679c4b7-aea9-4fbd-804a-20f479aed410'
2023-02-27 11:09:59,463-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-11) [17e97345] Waiting on remove image command to complete the task '002baef1-b642-49b4-9eea-065c311d57b1'
2023-02-27 11:09:59,465-05 INFO [org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-11) [17e97345] Command 'RemoveAllVmImages' (id: 'e8fcae23-dbaa-4ac8-8bd0-251aad0e9a04') waiting on child command id: '1fc4fb29-5034-49f2-a991-9eb10a4f3f63' type:'RemoveImage' to complete
2023-02-27 11:10:06,098-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-59) [] Task id '002baef1-b642-49b4-9eea-065c311d57b1' is in pre-polling period and should not be polled. Pre-polling period is 60000 millis.
2023-02-27 11:10:06,098-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-59) [] Task id '3679c4b7-aea9-4fbd-804a-20f479aed410' is in pre-polling period and should not be polled. Pre-polling period is 60000 millis.
2023-02-27 11:10:08,215-05 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-38) [16fe44b7-87c1-4419-a1f1-7a7b1b0c2584] EVENT_ID: ANSIBLE_RUNNER_EVENT_NOTIFICATION(559), Query OVA info. Run import yaml on py3.
2023-02-27 11:10:08,222-05 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-38) [16fe44b7-87c1-4419-a1f1-7a7b1b0c2584] EVENT_ID: ANSIBLE_RUNNER_EVENT_NOTIFICATION(559), Query OVA info. Set facts.
2023-02-27 11:10:08,229-05 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-38) [16fe44b7-87c1-4419-a1f1-7a7b1b0c2584] EVENT_ID: ANSIBLE_RUNNER_EVENT_NOTIFICATION(559), Query OVA info. Create temporary directory.
2023-02-27 11:10:09,470-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] Waiting on remove image command to complete the task '3679c4b7-aea9-4fbd-804a-20f479aed410'
2023-02-27 11:10:09,472-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] Waiting on remove image command to complete the task '002baef1-b642-49b4-9eea-065c311d57b1'
2023-02-27 11:10:09,474-05 INFO [org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-29) [17e97345] Command 'RemoveAllVmImages' (id: 'e8fcae23-dbaa-4ac8-8bd0-251aad0e9a04') waiting on child command id: '1fc4fb29-5034-49f2-a991-9eb10a4f3f63' type:'RemoveImage' to complete
2023-02-27 11:10:11,240-05 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-38) [16fe44b7-87c1-4419-a1f1-7a7b1b0c2584] EVENT_ID: ANSIBLE_RUNNER_EVENT_NOTIFICATION(559), Query OVA info. Copy query_ova.py to temp directory.
2023-02-27 11:10:16,099-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-22) [] Task id '002baef1-b642-49b4-9eea-065c311d57b1' is in pre-polling period and should not be polled. Pre-polling period is 60000 millis.
2023-02-27 11:10:16,099-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-22) [] Task id '3679c4b7-aea9-4fbd-804a-20f479aed410' is in pre-polling period and should not be polled. Pre-polling period is 60000 millis.
2023-02-27 11:10:19,479-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-17) [17e97345] Waiting on remove image command to complete the task '3679c4b7-aea9-4fbd-804a-20f479aed410'
2023-02-27 11:10:19,482-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-17) [17e97345] Waiting on remove image command to complete the task '002baef1-b642-49b4-9eea-065c311d57b1'
2023-02-27 11:10:19,484-05 INFO [org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-17) [17e97345] Command 'RemoveAllVmImages' (id: 'e8fcae23-dbaa-4ac8-8bd0-251aad0e9a04') waiting on child command id: '1fc4fb29-5034-49f2-a991-9eb10a4f3f63' type:'RemoveImage' to complete
2023-02-27 11:10:26,099-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-83) [] Task id '002baef1-b642-49b4-9eea-065c311d57b1' is in pre-polling period and should not be polled. Pre-polling period is 60000 millis.
2023-02-27 11:10:26,099-05 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-83) [] Task id '3679c4b7-aea9-4fbd-804a-20f479aed410' is in pre-polling period and should not be polled. Pre-polling period is 60000 millis.
2023-02-27 11:10:26,255-05 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-38) [16fe44b7-87c1-4419-a1f1-7a7b1b0c2584] EVENT_ID: ANSIBLE_RUNNER_EVENT_NOTIFICATION(559), Query OVA info. Run query script.
2023-02-27 11:10:26,264-05 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (default task-38) [16fe44b7-87c1-4419-a1f1-7a7b1b0c2584] EVENT_ID: ANSIBLE_RUNNER_EVENT_NOTIFICATION(559), Query OVA info. Remove temp directory.
2023-02-27 11:10:29,273-05 WARN [org.ovirt.engine.core.utils.ovf.OvfReader] (default task-38) [16fe44b7-87c1-4419-a1f1-7a7b1b0c2584] could not retrieve volume id of file1 from ovf, generating new guid
2023-02-27 11:10:29,274-05 WARN [org.ovirt.engine.core.utils.ovf.OvfReader] (default task-38) [16fe44b7-87c1-4419-a1f1-7a7b1b0c2584] could not retrieve disk id of vmdisk2 from ovf, generating new guid
2023-02-27 11:10:29,274-05 WARN [org.ovirt.engine.core.utils.ovf.OvfReader] (default task-38) [16fe44b7-87c1-4419-a1f1-7a7b1b0c2584] didn't find disk provisioned size thus allocating the virtual size
2023-02-27 11:10:29,498-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-95) [17e97345] Waiting on remove image command to complete the task '3679c4b7-aea9-4fbd-804a-20f479aed410'
2023-02-27 11:10:29,500-05 INFO [org.ovirt.engine.core.bll.storage.disk.image.RemoveImageCommandCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-95) [17e97345] Waiting on remove image command to complete the task '002baef1-b642-49b4-9eea-065c311d57b1'
2023-02-27 11:10:29,502-05 INFO [org.ovirt.engine.core.bll.ConcurrentChildCommandsExecutionCallback] (EE-ManagedScheduledExecutorService-engineScheduledThreadPool-Thread-95) [17e97345] Command 'RemoveAllVmImages' (id: 'e8fcae23-dbaa-4ac8-8bd0-251aad0e9a04') waiting on child command id: '1fc4fb29-5034-49f2-a991-9eb10a4f3f63' type:'RemoveImage' to complete
any suggestions for me??
1 year, 9 months
Host Reboot Timeout of 10 Minutes
by Peter H
I'm working in a group that maintains a large oVirt setup based on 4.4.1
which works very well. We are afraid of upgrading and prefer setting up a
new installation and gradually enlist the hosts one by one into the new
installation.
We have tried 4.4.10 and 4.5.1 - 4.5.4 based on CentOS Stream 8, Rocky 8,
Alma Linux 9.1 with various problems. Worst was the problem that the rpm db
ended up in a catch-22 state.
Using Alma Linux 9.1 and current oVirt 4.5.4 seems promising as no rpm
problems are present after installation. We have only one nuisance left
which we have seen in all installation attempts we have made since 4.4.10.
When rebooting a host it takes 10 minutes before it's activated again. In
4.4.1 the hosts are activated a few seconds after they have booted up.
I have found the following in the engine log:
2023-01-24 23:01:57,564+01 INFO
[org.ovirt.engine.core.bll.SshHostRebootCommand]
(EE-ManagedThreadFactory-engine-Thread-1513) [2bb08d20] Waiting 600
seconds, for server to finish reboot process.
Our ansible playbooks for deployment times out and we could increase the
timeout but how come that this 10 minutes delay has been introduced?
Does a config file exist where this timeout can be set to a lower value?
BR
Peter H.
1 year, 9 months
Out-of-sync networks can only be detached
by Sakhi Hadebe
Hi,
I have a 3-node oVirt cluster. I have configured 2 logical networks:
ovirtmgmt and public. Public logical network is attached in only 2 nodes
and failing to attach on the 3rd node with the below error
Invalid operation, out-of-sync network 'public' can only be detached.
Please have been stuck on this for almost the whole day now. How do I fix
this error?
--
Regards,
Sakhi Hadebe
1 year, 9 months
Create VM with Python SDK
by Alan G
Hi,
Trying to create a VM while attaching an existing disk. I can create the VM then attach the disk with an additional call, but I thought it should be possible to do it in one hit?
My code is
vm = vms_service.add(
types.Vm(
name='alma8.7',
description='AlmaLinux 8.7 CIS Packer image',
cluster=types.Cluster(
name='Default',
),
type=types.VmType('server'),
template=types.Template(
name='Blank',
),
disk_attachments=[types.DiskAttachment(
disk=types.Disk(id = "0532e728-a1fb-4ff8-a4f3-0702fc876fce"),
bootable=True,
active=True,
interface=types.DiskInterface.VIRTIO,
)]
),
)
This request returns no error but the disk isn't actually attached to the created VM.
1 year, 9 months
4.3 -> 4.4 upgrade failed
by KSNull Zero
Hello!
Trying to upgrade old 4.3 installation to 4.4 using this documentation:
https://www.ovirt.org/documentation/upgrade_guide/#Upgrading_the_Manager_...
On the target engine service host got this error during restore operation:
Start of engine-backup with mode 'restore'
scope: all
archive file: backup.bck
log file: /var/log/ovirt-engine-backup/ovirt-engine-restore-20230224162609.log
Preparing to restore:
- Unpacking file 'backup.bck'
Restoring:
- Files
------------------------------------------------------------------------------
Please note:
Operating system is different from the one used during backup.
Current operating system: redhat8
Operating system at backup: redhat7
Apache httpd configuration will not be restored.
You will be asked about it on the next engine-setup run.
------------------------------------------------------------------------------
Provisioning PostgreSQL users/databases:
- user 'engine', database 'engine'
- user 'engine', database 'engine_history'
FATAL: Existing database 'engine_history' or user 'engine' found and temporary ones created - Please clean up everything and try again
One more log is here:
https://pastebin.com/Rg2kaNnM
Can you, please, help and provide some information how this can be fixed ?
1 year, 10 months
Re: [External] : Configure HA.
by Anthony Bustillos Gonzalez
Hi Marcos,
It’s possible have VM’s in HA. Because when I does this test, I see this issue.
“Highly Available VM failed. It will be restarted automatically.”
Also, this is a HA, what happen when I brute downtime in any host?
I need have my VM's in HA.
1 year, 10 months
Configure HA.
by Anthony Bustillos Gonzalez
Configure HA.
hello team,
I'm working to create a cluster, I've 2 host with the same spectifications. I'm using ISCSI to conect 2 host to my storage.
Today everithing it's okay... but i have this issue.
Test.
When i migrated a vm to other Hosts this working.
when change the host active a maintance, the ovirt move de the vm's a other hosts.
Issue.
when turn off the host with idrac... the VM's in the host change the status active to unknow, then the hypervisor move the vms a other hosts but the vms are rebooted
any idea?
1 year, 10 months