Importing VM from OVA/OVF that was exported from VSphere fails ConvertOvaCommand - ImportVmFromOvaCommand
10:26 a.m.
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_Re...
xmlns:vmw="http://www.vmware.com/schema/ovf"
xmlns:vssd="http://schemas.dmtf.org/wbem/wscim/1/cim-schema/2/CIM_Vi...
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.htm...
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.htm...
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??
5:44 p.m.
New subject: Importing VM from OVA/OVF that was exported from VSphere fails ConvertOvaCommand - ImportVmFromOvaCommand
Fixed
The full path must have permissions for vdsm kvm. I was failing at this. The folder above
did not have these permissions.
revised log:
tail -f /var/log/vdsm/import/import-*
423
days inactive
423
days old
1 comments
1 participants
participants (1)
-
wcordero8＠gmail.com