[ovirt-users] Re: Failure to import a VM

On Mon, Jun 4, 2018 at 3:51 PM, Aziz <azizgstest(a)gmail.com&gt; wrote: > Hi, > > It's RedHat x64 ( The system is Palo Alto Firewall VM). > > > > > Note : I imported the VM to virtualbox and Vmware without any issues, so > I can confirm that the OVA file is working. > > Thanks > > On Mon, Jun 4, 2018 at 12:14 PM, Arik Hadas <ahadas(a)redhat.com&gt; wrote: > >> >> >> On Mon, Jun 4, 2018 at 2:53 PM, Aziz <azizgstest(a)gmail.com&gt; wrote: >> >>> Hi Arik, >>> >>> Please find attached the the HV2 logs as requested. Thanks >>> >> >> Adding Richard. >> > And now for real :) > Seems like the problem is: >> >> virt-v2v: error: no bootloader detected >> >> What operating system is installed in that image? >> >> >>> >>> Best regards >>> >>> On Fri, Jun 1, 2018 at 8:44 PM, Arik Hadas <ahadas(a)redhat.com&gt; wrote: >>> >>>> >>>> >>>> On Fri, Jun 1, 2018 at 4:12 PM, Aziz <azizgstest(a)gmail.com&gt; wrote: >>>> >>>>> Hi Arik, >>>>> >>>>> Thank you for your feedback, indeed the new version resolved my >>>>> problem, however I'm still unable to upload the OVA VM, in the new logs I'm >>>>> seeing a different error, any hints ? >>>>> >>>> >>>>> >>>> >>>>> ------------------------------------------------------------ >>>>> ------------------------------ >>>>> 2018-06-01 12:59:58,656Z INFO [org.ovirt.engine.core.dal.dbb >>>>> roker.auditloghandling.AuditLogDirector] >>>>> (EE-ManagedThreadFactory-engine-Thread-196) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] EVENT_ID: >>>>> ADD_DISK_INTERNAL(2,036), Add-Disk operation of 'vmdisk1' was initiated by >>>>> the system. >>>>> 2018-06-01 12:59:58,757Z INFO [org.ovirt.engine.core.dal.dbb >>>>> roker.auditloghandling.AuditLogDirector] >>>>> (EE-ManagedThreadFactory-engine-Thread-196) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] EVENT_ID: >>>>> IMPORTEXPORT_STARTING_IMPORT_VM(1,165), Starting to import Vm >>>>> PA-VM-8.0.0 to Data Center DC2, Cluster Cluster2 >>>>> 2018-06-01 13:00:00,292Z INFO [org.ovirt.engine.core.bll.Ser >>>>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-84) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] Command 'ImportVmFromOva' >>>>> (id: 'ba2a1ec9-36b3-451b-b6b9-2b2d698ed900') waiting on child >>>>> command id: 'f20e8e29-39be-48d4-aee9-de3cb4cd7751' type:'AddDisk' to >>>>> complete >>>>> 2018-06-01 13:00:00,297Z INFO [org.ovirt.engine.core.bll.Con >>>>> currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-84) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] Command 'AddDisk' (id: >>>>> 'f20e8e29-39be-48d4-aee9-de3cb4cd7751') waiting on child command id: >>>>> '698a4fae-9420-4ebb-afd3-ad16df881166' type:'AddImageFromScratch' to >>>>> complete >>>>> 2018-06-01 13:00:04,310Z INFO [org.ovirt.engine.core.bll.Ser >>>>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-19) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] Command 'ImportVmFromOva' >>>>> (id: 'ba2a1ec9-36b3-451b-b6b9-2b2d698ed900') waiting on child >>>>> command id: 'f20e8e29-39be-48d4-aee9-de3cb4cd7751' type:'AddDisk' to >>>>> complete >>>>> 2018-06-01 13:00:04,316Z INFO [org.ovirt.engine.core.bll.Con >>>>> currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-19) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] Command 'AddDisk' (id: >>>>> 'f20e8e29-39be-48d4-aee9-de3cb4cd7751') waiting on child command id: >>>>> '698a4fae-9420-4ebb-afd3-ad16df881166' type:'AddImageFromScratch' to >>>>> complete >>>>> 2018-06-01 13:00:06,418Z INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-26) [] Polling and >>>>> updating Async Tasks: 1 tasks, 1 tasks to poll now >>>>> 2018-06-01 13:00:06,424Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-26) [] >>>>> SPMAsyncTask::PollTask: Polling task 'fed324cf-c16b-41f0-a1b3-17f60a20f52e' >>>>> (Parent Command 'AddImageFromScratch', Parameters Type >>>>> 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') >>>>> returned status 'finished', result 'success'. >>>>> 2018-06-01 13:00:06,436Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-26) [] >>>>> BaseAsyncTask::onTaskEndSuccess: Task 'fed324cf-c16b-41f0-a1b3-17f60a20f52e' >>>>> (Parent Command 'AddImageFromScratch', Parameters Type >>>>> 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') ended >>>>> successfully. >>>>> 2018-06-01 13:00:06,437Z INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-26) [] >>>>> CommandAsyncTask::endActionIfNecessary: All tasks of command >>>>> '698a4fae-9420-4ebb-afd3-ad16df881166' has ended -> executing >>>>> 'endAction' >>>>> 2018-06-01 13:00:06,437Z INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-26) [] >>>>> CommandAsyncTask::endAction: Ending action for '1' tasks (command ID: >>>>> '698a4fae-9420-4ebb-afd3-ad16df881166'): calling endAction '. >>>>> 2018-06-01 13:00:06,437Z INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] >>>>> (EE-ManagedThreadFactory-engine-Thread-197) [] >>>>> CommandAsyncTask::endCommandAction [within thread] context: >>>>> Attempting to endAction 'AddImageFromScratch', >>>>> 2018-06-01 13:00:06,444Z INFO [org.ovirt.engine.core.bll.sto >>>>> rage.disk.image.AddImageFromScratchCommand] >>>>> (EE-ManagedThreadFactory-engine-Thread-197) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] Command >>>>> [id=698a4fae-9420-4ebb-afd3-ad16df881166]: Updating status to >>>>> 'SUCCEEDED', The command end method logic will be executed by one of its >>>>> parent commands. >>>>> 2018-06-01 13:00:06,444Z INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] >>>>> (EE-ManagedThreadFactory-engine-Thread-197) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] CommandAsyncTask::HandleEndActionResult >>>>> [within thread]: endAction for action type 'AddImageFromScratch' completed, >>>>> handling the result. >>>>> 2018-06-01 13:00:06,444Z INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] >>>>> (EE-ManagedThreadFactory-engine-Thread-197) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] CommandAsyncTask::HandleEndActionResult >>>>> [within thread]: endAction for action type 'AddImageFromScratch' succeeded, >>>>> clearing tasks. >>>>> 2018-06-01 13:00:06,444Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] >>>>> (EE-ManagedThreadFactory-engine-Thread-197) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] SPMAsyncTask::ClearAsyncTask: >>>>> Attempting to clear task 'fed324cf-c16b-41f0-a1b3-17f60a20f52e' >>>>> 2018-06-01 13:00:06,446Z INFO [org.ovirt.engine.core.vdsbrok >>>>> er.irsbroker.SPMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-197) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] START, >>>>> SPMClearTaskVDSCommand( SPMTaskGuidBaseVDSCommandParam >>>>> eters:{storagePoolId='ea6cc5f6-ed8f-40e5-8dd2-3924dc52bb82', >>>>> ignoreFailoverLimit='false', taskId='fed324cf-c16b-41f0-a1b3-17f60a20f52e'}), >>>>> log id: 743385d5 >>>>> 2018-06-01 13:00:06,446Z INFO [org.ovirt.engine.core.vdsbrok >>>>> er.vdsbroker.HSMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-197) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] START, >>>>> HSMClearTaskVDSCommand(HostName = HV2, HSMTaskGuidBaseVDSCommandParam >>>>> eters:{hostId='350ca910-32eb-41d2-8598-405951fb14a3', >>>>> taskId='fed324cf-c16b-41f0-a1b3-17f60a20f52e'}), log id: 43dabfa >>>>> 2018-06-01 13:00:06,457Z INFO [org.ovirt.engine.core.vdsbrok >>>>> er.vdsbroker.HSMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-197) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] FINISH, >>>>> HSMClearTaskVDSCommand, log id: 43dabfa >>>>> 2018-06-01 13:00:06,457Z INFO [org.ovirt.engine.core.vdsbrok >>>>> er.irsbroker.SPMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-197) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] FINISH, >>>>> SPMClearTaskVDSCommand, log id: 743385d5 >>>>> 2018-06-01 13:00:06,469Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] >>>>> (EE-ManagedThreadFactory-engine-Thread-197) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] BaseAsyncTask::removeTaskFromDB: >>>>> Removed task 'fed324cf-c16b-41f0-a1b3-17f60a20f52e' from DataBase >>>>> 2018-06-01 13:00:06,470Z INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] >>>>> (EE-ManagedThreadFactory-engine-Thread-197) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] CommandAsyncTask::HandleEndActionResult >>>>> [within thread]: Removing CommandMultiAsyncTasks object for entity >>>>> '698a4fae-9420-4ebb-afd3-ad16df881166' >>>>> 2018-06-01 13:00:12,330Z INFO [org.ovirt.engine.core.bll.Ser >>>>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-34) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] Command 'ImportVmFromOva' >>>>> (id: 'ba2a1ec9-36b3-451b-b6b9-2b2d698ed900') waiting on child >>>>> command id: 'f20e8e29-39be-48d4-aee9-de3cb4cd7751' type:'AddDisk' to >>>>> complete >>>>> 2018-06-01 13:00:12,336Z INFO [org.ovirt.engine.core.bll.Con >>>>> currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-34) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] Command 'AddDisk' id: >>>>> 'f20e8e29-39be-48d4-aee9-de3cb4cd7751' child commands >>>>> '[698a4fae-9420-4ebb-afd3-ad16df881166]' executions were completed, >>>>> status 'SUCCEEDED' >>>>> 2018-06-01 13:00:13,387Z INFO [org.ovirt.engine.core.bll.storage.disk.AddDiskCommand] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-65) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] Ending command >>>>> 'org.ovirt.engine.core.bll.storage.disk.AddDiskCommand' successfully. >>>>> 2018-06-01 13:00:13,431Z INFO [org.ovirt.engine.core.bll.sto >>>>> rage.disk.image.AddImageFromScratchCommand] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-65) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] Ending command >>>>> 'org.ovirt.engine.core.bll.storage.disk.image.AddImageFromScratchCommand' >>>>> successfully. >>>>> 2018-06-01 13:00:13,445Z INFO [org.ovirt.engine.core.vdsbrok >>>>> er.irsbroker.GetImageInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-65) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] START, >>>>> GetImageInfoVDSCommand( GetImageInfoVDSCommandParamete >>>>> rs:{storagePoolId='ea6cc5f6-ed8f-40e5-8dd2-3924dc52bb82', >>>>> ignoreFailoverLimit='false', storageDomainId='bea06b61-861d-498b-9ead-cf8f8aed69ab', >>>>> imageGroupId='65f8bb77-0c62-4a0e-95a6-f96228f466a6', >>>>> imageId='f86c72ea-3b6d-48ef-bb55-f2a99dc28995'}), log id: 65518c74 >>>>> 2018-06-01 13:00:13,448Z INFO [org.ovirt.engine.core.vdsbrok >>>>> er.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-65) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] START, >>>>> GetVolumeInfoVDSCommand(HostName = HV2, >>>>> GetVolumeInfoVDSCommandParameters:{hostId='350ca910-32eb-41d2-8598-405951fb14a3', >>>>> storagePoolId='ea6cc5f6-ed8f-40e5-8dd2-3924dc52bb82', >>>>> storageDomainId='bea06b61-861d-498b-9ead-cf8f8aed69ab', >>>>> imageGroupId='65f8bb77-0c62-4a0e-95a6-f96228f466a6', >>>>> imageId='f86c72ea-3b6d-48ef-bb55-f2a99dc28995'}), log id: 7f2c1e37 >>>>> 2018-06-01 13:00:13,460Z INFO [org.ovirt.engine.core.vdsbrok >>>>> er.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-65) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] FINISH, >>>>> GetVolumeInfoVDSCommand, return: org.ovirt.engine.core.common.b >>>>> usinessentities.storage.DiskImage@9005ff9a, log id: 7f2c1e37 >>>>> 2018-06-01 13:00:13,460Z INFO [org.ovirt.engine.core.vdsbrok >>>>> er.irsbroker.GetImageInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-65) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] FINISH, >>>>> GetImageInfoVDSCommand, return: org.ovirt.engine.core.common.b >>>>> usinessentities.storage.DiskImage@9005ff9a, log id: 65518c74 >>>>> 2018-06-01 13:00:13,612Z INFO [org.ovirt.engine.core.dal.dbb >>>>> roker.auditloghandling.AuditLogDirector] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-65) [] EVENT_ID: >>>>> USER_ADD_DISK_TO_VM_FINISHED_SUCCESS(97), The disk vmdisk1 was >>>>> successfully added to VM PA-VM-8.0.0. >>>>> 2018-06-01 13:00:14,797Z INFO [org.ovirt.engine.core.bll.exportimport.ConvertOvaCommand] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-77) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] Running command: >>>>> ConvertOvaCommand internal: true. Entities affected : ID: >>>>> 632fec81-6271-4ae7-866e-2aad43530594 Type: VM >>>>> 2018-06-01 13:00:14,800Z INFO [org.ovirt.engine.core.vdsbrok >>>>> er.vdsbroker.ConvertOvaVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-77) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] START, >>>>> ConvertOvaVDSCommand(HostName = HV2, ConvertOvaVDSParameters:{hostI >>>>> d='350ca910-32eb-41d2-8598-405951fb14a3', >>>>> ovaPath='/var/VDIEXPORTDOMAIN-HV2/PA-VM-ESX-8.0.0.ova', >>>>> vmName='PA-VM-8.0.0', storageDomainId='bea06b61-861d-498b-9ead-cf8f8aed69ab', >>>>> storagePoolId='ea6cc5f6-ed8f-40e5-8dd2-3924dc52bb82', >>>>> virtioIsoPath='null', Disk0='65f8bb77-0c62-4a0e-95a6-f96228f466a6'}), >>>>> log id: 5a78f1db >>>>> 2018-06-01 13:00:14,920Z INFO [org.ovirt.engine.core.vdsbrok >>>>> er.vdsbroker.ConvertOvaVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-77) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] FINISH, ConvertOvaVDSCommand, >>>>> return: 632fec81-6271-4ae7-866e-2aad43530594, log id: 5a78f1db >>>>> 2018-06-01 13:00:16,972Z INFO [org.ovirt.engine.core.bll.Ser >>>>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-83) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] Command 'ImportVmFromOva' >>>>> (id: 'ba2a1ec9-36b3-451b-b6b9-2b2d698ed900') waiting on child >>>>> command id: '55573f5f-6eb0-4d11-9a0f-d857117eb8d5' type:'ConvertOva' >>>>> to complete >>>>> 2018-06-01 13:00:20,990Z INFO [org.ovirt.engine.core.bll.Ser >>>>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-84) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] Command 'ImportVmFromOva' >>>>> (id: 'ba2a1ec9-36b3-451b-b6b9-2b2d698ed900') waiting on child >>>>> command id: '55573f5f-6eb0-4d11-9a0f-d857117eb8d5' type:'ConvertOva' >>>>> to complete >>>>> 2018-06-01 13:00:29,010Z INFO [org.ovirt.engine.core.bll.Ser >>>>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-6) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] Command 'ImportVmFromOva' >>>>> (id: 'ba2a1ec9-36b3-451b-b6b9-2b2d698ed900') waiting on child >>>>> command id: '55573f5f-6eb0-4d11-9a0f-d857117eb8d5' type:'ConvertOva' >>>>> to complete >>>>> 2018-06-01 13:00:39,024Z INFO [org.ovirt.engine.core.bll.Ser >>>>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-88) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] Command 'ImportVmFromOva' >>>>> (id: 'ba2a1ec9-36b3-451b-b6b9-2b2d698ed900') waiting on child >>>>> command id: '55573f5f-6eb0-4d11-9a0f-d857117eb8d5' type:'ConvertOva' >>>>> to complete >>>>> 2018-06-01 13:00:40,025Z INFO [org.ovirt.engine.core.bll.exportimport.ConvertVmCallback] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-86) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] Conversion of VM from >>>>> external environment failed: Job u'632fec81-6271-4ae7-866e-2aad43530594' >>>>> process failed exit-code: 1 >>>>> >>>> >>>> This failure means that virt-v2v failed to convert this OVA. >>>> To investigate this we need a different log that can be found on the >>>> host that executed virt-v2v, in this case it was HV2. You'll find the log >>>> in /var/log/vdsm/import. >>>> >>>> >>>>> 2018-06-01 13:00:41,109Z ERROR [org.ovirt.engine.core.bll.exportimport.ConvertOvaCommand] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-89) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] Ending command >>>>> 'org.ovirt.engine.core.bll.exportimport.ConvertOvaCommand' with >>>>> failure. >>>>> 2018-06-01 13:00:41,111Z INFO [org.ovirt.engine.core.vdsbrok >>>>> er.vdsbroker.DeleteV2VJobVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-89) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] START, >>>>> DeleteV2VJobVDSCommand(HostName = HV2, VdsAndVmIDVDSParametersBase:{h >>>>> ostId='350ca910-32eb-41d2-8598-405951fb14a3', >>>>> vmId='632fec81-6271-4ae7-866e-2aad43530594'}), log id: 1710d32c >>>>> 2018-06-01 13:00:41,115Z INFO [org.ovirt.engine.core.vdsbrok >>>>> er.vdsbroker.DeleteV2VJobVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-89) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] FINISH, >>>>> DeleteV2VJobVDSCommand, log id: 1710d32c >>>>> 2018-06-01 13:00:42,165Z INFO [org.ovirt.engine.core.bll.Ser >>>>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-92) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] Command 'ImportVmFromOva' id: >>>>> 'ba2a1ec9-36b3-451b-b6b9-2b2d698ed900' child commands >>>>> '[f20e8e29-39be-48d4-aee9-de3cb4cd7751, >>>>> 55573f5f-6eb0-4d11-9a0f-d857117eb8d5]' executions were completed, >>>>> status 'FAILED' >>>>> 2018-06-01 13:00:43,266Z ERROR [org.ovirt.engine.core.bll.exp >>>>> ortimport.ImportVmFromOvaCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-87) >>>>> [e0846352-12c0-4bff-bdff-43d1938ec9be] Ending command >>>>> 'org.ovirt.engine.core.bll.exportimport.ImportVmFromOvaCommand' with >>>>> failure. >>>>> 2018-06-01 13:00:43,352Z INFO [org.ovirt.engine.core.bll.sto >>>>> rage.disk.image.RemoveAllVmImagesCommand] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] >>>>> Running command: RemoveAllVmImagesCommand internal: true. Entities affected >>>>> : ID: 632fec81-6271-4ae7-866e-2aad43530594 Type: VM >>>>> 2018-06-01 13:00:43,371Z INFO [org.ovirt.engine.core.bll.sto >>>>> rage.disk.image.RemoveImageCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-87) >>>>> [36a1e4cd] Running command: RemoveImageCommand internal: true. Entities >>>>> affected : ID: 00000000-0000-0000-0000-000000000000 Type: Storage >>>>> 2018-06-01 13:00:43,431Z INFO [org.ovirt.engine.core.vdsbrok >>>>> er.irsbroker.DeleteImageGroupVDSCommand] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] >>>>> START, DeleteImageGroupVDSCommand( DeleteImageGroupVDSCommandPara >>>>> meters:{storagePoolId='ea6cc5f6-ed8f-40e5-8dd2-3924dc52bb82', >>>>> ignoreFailoverLimit='false', storageDomainId='bea06b61-861d-498b-9ead-cf8f8aed69ab', >>>>> imageGroupId='65f8bb77-0c62-4a0e-95a6-f96228f466a6', >>>>> postZeros='false', discard='false', forceDelete='false'}), log id: a727c35 >>>>> 2018-06-01 13:00:43,474Z INFO [org.ovirt.engine.core.vdsbrok >>>>> er.irsbroker.DeleteImageGroupVDSCommand] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] >>>>> FINISH, DeleteImageGroupVDSCommand, log id: a727c35 >>>>> 2018-06-01 13:00:43,477Z INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] >>>>> CommandAsyncTask::Adding CommandMultiAsyncTasks object for command >>>>> '505d63f7-bda1-4b72-8db9-980964d56a82' >>>>> 2018-06-01 13:00:43,477Z INFO [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] >>>>> CommandMultiAsyncTasks::attachTask: Attaching task >>>>> '0eee4fa8-16eb-4211-9ef1-9a8081952028' to command >>>>> '505d63f7-bda1-4b72-8db9-980964d56a82'. >>>>> 2018-06-01 13:00:43,509Z INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] >>>>> Adding task '0eee4fa8-16eb-4211-9ef1-9a8081952028' (Parent Command >>>>> 'RemoveAllVmImages', Parameters Type 'org.ovirt.engine.core.common. >>>>> asynctasks.AsyncTaskParameters'), polling hasn't started yet.. >>>>> 2018-06-01 13:00:43,643Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] >>>>> BaseAsyncTask::startPollingTask: Starting to poll task >>>>> '0eee4fa8-16eb-4211-9ef1-9a8081952028'. >>>>> 2018-06-01 13:00:43,645Z INFO [org.ovirt.engine.core.bll.CommandCompensator] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] >>>>> Command [id=ba2a1ec9-36b3-451b-b6b9-2b2d698ed900]: Compensating >>>>> NEW_ENTITY_ID of org.ovirt.engine.core.common.b >>>>> usinessentities.network.VmNetworkStatistics; snapshot: >>>>> 08b82af7-9eb8-46f2-8501-4b9b79f9d292. >>>>> 2018-06-01 13:00:43,646Z INFO [org.ovirt.engine.core.bll.CommandCompensator] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] >>>>> Command [id=ba2a1ec9-36b3-451b-b6b9-2b2d698ed900]: Compensating >>>>> NEW_ENTITY_ID of org.ovirt.engine.core.common.b >>>>> usinessentities.network.VmNetworkInterface; snapshot: >>>>> 08b82af7-9eb8-46f2-8501-4b9b79f9d292. >>>>> 2018-06-01 13:00:43,648Z INFO [org.ovirt.engine.core.bll.CommandCompensator] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] >>>>> Command [id=ba2a1ec9-36b3-451b-b6b9-2b2d698ed900]: Compensating >>>>> TRANSIENT_ENTITY of org.ovirt.engine.core.common.b >>>>> usinessentities.ReleaseMacsTransientCompensation; snapshot: >>>>> org.ovirt.engine.core.common.businessentities.ReleaseMacsTra >>>>> nsientCompensation@3306fa7b. >>>>> 2018-06-01 13:00:43,649Z INFO [org.ovirt.engine.core.bll.CommandCompensator] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] >>>>> Command [id=ba2a1ec9-36b3-451b-b6b9-2b2d698ed900]: Compensating >>>>> NEW_ENTITY_ID of org.ovirt.engine.core.common.b >>>>> usinessentities.network.VmNetworkStatistics; snapshot: >>>>> afafda74-57f4-4f79-83a4-d875461ab557. >>>>> 2018-06-01 13:00:43,649Z INFO [org.ovirt.engine.core.bll.CommandCompensator] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] >>>>> Command [id=ba2a1ec9-36b3-451b-b6b9-2b2d698ed900]: Compensating >>>>> NEW_ENTITY_ID of org.ovirt.engine.core.common.b >>>>> usinessentities.network.VmNetworkInterface; snapshot: >>>>> afafda74-57f4-4f79-83a4-d875461ab557. >>>>> 2018-06-01 13:00:43,650Z INFO [org.ovirt.engine.core.bll.CommandCompensator] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] >>>>> Command [id=ba2a1ec9-36b3-451b-b6b9-2b2d698ed900]: Compensating >>>>> TRANSIENT_ENTITY of org.ovirt.engine.core.common.b >>>>> usinessentities.ReleaseMacsTransientCompensation; snapshot: >>>>> org.ovirt.engine.core.common.businessentities.ReleaseMacsTra >>>>> nsientCompensation@53a4230e. >>>>> 2018-06-01 13:00:43,651Z INFO [org.ovirt.engine.core.bll.CommandCompensator] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] >>>>> Command [id=ba2a1ec9-36b3-451b-b6b9-2b2d698ed900]: Compensating >>>>> NEW_ENTITY_ID of org.ovirt.engine.core.common.businessentities.VmStatistics; >>>>> snapshot: 632fec81-6271-4ae7-866e-2aad43530594. >>>>> 2018-06-01 13:00:43,651Z INFO [org.ovirt.engine.core.bll.CommandCompensator] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] >>>>> Command [id=ba2a1ec9-36b3-451b-b6b9-2b2d698ed900]: Compensating >>>>> NEW_ENTITY_ID of org.ovirt.engine.core.common.businessentities.VmDynamic; >>>>> snapshot: 632fec81-6271-4ae7-866e-2aad43530594. >>>>> 2018-06-01 13:00:43,652Z INFO [org.ovirt.engine.core.bll.CommandCompensator] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] >>>>> Command [id=ba2a1ec9-36b3-451b-b6b9-2b2d698ed900]: Compensating >>>>> NEW_ENTITY_ID of org.ovirt.engine.core.common.businessentities.Snapshot; >>>>> snapshot: bf4518c0-1624-49f7-82be-2b079bfe0111. >>>>> 2018-06-01 13:00:43,653Z INFO [org.ovirt.engine.core.bll.CommandCompensator] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] >>>>> Command [id=ba2a1ec9-36b3-451b-b6b9-2b2d698ed900]: Compensating >>>>> NEW_ENTITY_ID of org.ovirt.engine.core.common.businessentities.VmStatic; >>>>> snapshot: 632fec81-6271-4ae7-866e-2aad43530594. >>>>> 2018-06-01 13:00:43,677Z INFO [org.ovirt.engine.core.bll.exp >>>>> ortimport.ImportVmFromOvaCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-87) >>>>> [36a1e4cd] Lock freed to object 'EngineLock:{exclusiveLocks='[PA-VM-8.0.0=VM_NAME, >>>>> 632fec81-6271-4ae7-866e-2aad43530594=VM]', sharedLocks=''}' >>>>> 2018-06-01 13:00:43,702Z ERROR [org.ovirt.engine.core.dal.dbb >>>>> roker.auditloghandling.AuditLogDirector] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] *EVENT_ID: >>>>> IMPORTEXPORT_IMPORT_VM_FAILED(1,153), Failed to import Vm PA-VM-8.0.0 to >>>>> Data Center DC2, Cluster Cluster2* >>>>> 2018-06-01 13:00:46,438Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-80) [] Task id >>>>> '0eee4fa8-16eb-4211-9ef1-9a8081952028' is in pre-polling period and >>>>> should not be polled. Pre-polling period is 60000 millis. >>>>> 2018-06-01 13:00:56,439Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-33) [] Task id >>>>> '0eee4fa8-16eb-4211-9ef1-9a8081952028' is in pre-polling period and >>>>> should not be polled. Pre-polling period is 60000 millis. >>>>> 2018-06-01 13:01:06,440Z INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-95) [] Task id >>>>> '0eee4fa8-16eb-4211-9ef1-9a8081952028' is in pre-polling period and >>>>> should not be polled. Pre-polling period is 60000 millis. >>>>> 2018-06-01 13:01:16,274Z INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] >>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-5) [] Setting new >>>>> tasks map. The map contains now 1 tasks >>>>> >>>>> ------------------------------------------------------------ >>>>> ----------------------------- >>>>> >>>>> >>>>> Best regards >>>>> >>>>> On Mon, May 28, 2018 at 5:57 PM, Arik Hadas <ahadas(a)redhat.com&gt; >>>>> wrote: >>>>> >>>>>> >>>>>> >>>>>> On Mon, May 28, 2018 at 7:55 PM, Aziz <azizgstest(a)gmail.com&gt; wrote: >>>>>> >>>>>>> Hi All, >>>>>>> >>>>>>> I'm getting an error when trying to import an OVA file to my oVirt. >>>>>>> It seems that a JAVA command is failing with an exception : >>>>>>> >>>>>>> Here are the logs from the engine.log file, while importing the OVA >>>>>>> file. >>>>>>> >>>>>>> 2018-05-28 16:47:09,491Z ERROR [org.ovirt.engine.core.bll.exp >>>>>>> ortimport.ImportVmFromOvaCommand] (EE-ManagedThreadFactory-engine-Thread-19767) >>>>>>> [e0306ff3-db73-4030-924b-57d86023db28] Command >>>>>>> 'org.ovirt.engine.core.bll.exportimport.ImportVmFromOvaCommand' >>>>>>> failed: For input string: "" >>>>>>> 2018-05-28 16:47:09,491Z ERROR [org.ovirt.engine.core.bll.exp >>>>>>> ortimport.ImportVmFromOvaCommand] (EE-ManagedThreadFactory-engine-Thread-19767) >>>>>>> [e0306ff3-db73-4030-924b-57d86023db28] Exception: >>>>>>> java.lang.NumberFormatException: For input string: "" >>>>>>> at java.lang.NumberFormatException.forInputString(NumberFormatException.java:65) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at java.lang.Long.parseLong(Long.java:601) [rt.jar:1.8.0_171] >>>>>>> at org.ovirt.engine.core.utils.MacAddressRangeUtils.macToLong(MacAddressRangeUtils.java:124) >>>>>>> [utils.jar:] >>>>>>> at org.ovirt.engine.core.bll.network.macpool.MacPoolUsingRanges >>>>>>> .isMacInRange(MacPoolUsingRanges.java:193) [bll.jar:] >>>>>>> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at java.lang.reflect.Method.invoke(Method.java:498) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at org.ovirt.engine.core.utils.lock.LockedObjectFactory$Locking >>>>>>> InvocationHandler.invoke(LockedObjectFactory.java:66) [utils.jar:] >>>>>>> at com.sun.proxy.$Proxy187.isMacInRange(Unknown Source) >>>>>>> at java.util.function.Predicate.lambda$negate$1(Predicate.java:80) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at java.util.stream.ReferencePipeline$2$1.accept(ReferencePipeline.java:174) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at java.util.stream.ReferencePipeline$2$1.accept(ReferencePipeline.java:175) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at java.util.stream.ReferencePipeline$3$1.accept(ReferencePipeline.java:193) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at java.util.ArrayList$ArrayListSpliterator.forEachRemaining(ArrayList.java:1382) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:481) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:471) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at java.util.stream.ReduceOps$ReduceOp.evaluateSequential(ReduceOps.java:708) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at java.util.stream.ReferencePipeline.collect(ReferencePipeline.java:499) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at org.ovirt.engine.core.bll.network.vm.ExternalVmMacsFinder.fi >>>>>>> ndExternalMacAddresses(ExternalVmMacsFinder.java:37) [bll.jar:] >>>>>>> at org.ovirt.engine.core.bll.exportimport.ImportVmCommandBase.r >>>>>>> eportExternalMacs(ImportVmCommandBase.java:512) [bll.jar:] >>>>>>> at org.ovirt.engine.core.bll.exportimport.ImportVmCommandBase.a >>>>>>> ddVmInterfaces(ImportVmCommandBase.java:640) [bll.jar:] >>>>>>> at org.ovirt.engine.core.bll.exportimport.ImportVmCommandBase.l >>>>>>> ambda$addVmToDb$2(ImportVmCommandBase.java:533) [bll.jar:] >>>>>>> at org.ovirt.engine.core.utils.transaction.TransactionSupport.e >>>>>>> xecuteInNewTransaction(TransactionSupport.java:202) [utils.jar:] >>>>>>> at org.ovirt.engine.core.bll.exportimport.ImportVmCommandBase.a >>>>>>> ddVmToDb(ImportVmCommandBase.java:529) [bll.jar:] >>>>>>> at org.ovirt.engine.core.bll.exportimport.ImportVmFromExternalP >>>>>>> roviderCommand.addVmToDb(ImportVmFromExternalProviderCommand.java:364) >>>>>>> [bll.jar:] >>>>>>> at org.ovirt.engine.core.bll.exportimport.ImportVmCommandBase.e >>>>>>> xecuteVmCommand(ImportVmCommandBase.java:474) [bll.jar:] >>>>>>> at org.ovirt.engine.core.bll.VmCommand.executeCommand(VmCommand.java:161) >>>>>>> [bll.jar:] >>>>>>> at org.ovirt.engine.core.bll.CommandBase.executeWithoutTransaction(CommandBase.java:1133) >>>>>>> [bll.jar:] >>>>>>> at org.ovirt.engine.core.bll.CommandBase.executeActionInTransac >>>>>>> tionScope(CommandBase.java:1285) [bll.jar:] >>>>>>> at org.ovirt.engine.core.bll.CommandBase.runInTransaction(CommandBase.java:1934) >>>>>>> [bll.jar:] >>>>>>> at org.ovirt.engine.core.utils.transaction.TransactionSupport.e >>>>>>> xecuteInSuppressed(TransactionSupport.java:164) [utils.jar:] >>>>>>> at org.ovirt.engine.core.utils.transaction.TransactionSupport.e >>>>>>> xecuteInScope(TransactionSupport.java:103) [utils.jar:] >>>>>>> at org.ovirt.engine.core.bll.CommandBase.execute(CommandBase.java:1345) >>>>>>> [bll.jar:] >>>>>>> at org.ovirt.engine.core.bll.CommandBase.executeAction(CommandBase.java:400) >>>>>>> [bll.jar:] >>>>>>> at org.ovirt.engine.core.bll.PrevalidatingMultipleActionsRunner >>>>>>> .executeValidatedCommand(PrevalidatingMultipleActionsRunner.java:204) >>>>>>> [bll.jar:] >>>>>>> at org.ovirt.engine.core.bll.PrevalidatingMultipleActionsRunner >>>>>>> .runCommands(PrevalidatingMultipleActionsRunner.java:176) >>>>>>> [bll.jar:] >>>>>>> at org.ovirt.engine.core.bll.PrevalidatingMultipleActionsRunner >>>>>>> .lambda$invokeCommands$3(PrevalidatingMultipleActionsRunner.java:182) >>>>>>> [bll.jar:] >>>>>>> at org.ovirt.engine.core.utils.threadpool.ThreadPoolUtil$Intern >>>>>>> alWrapperRunnable.run(ThreadPoolUtil.java:96) [utils.jar:] >>>>>>> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at java.util.concurrent.FutureTask.run(FutureTask.java:266) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) >>>>>>> [rt.jar:1.8.0_171] >>>>>>> at java.lang.Thread.run(Thread.java:748) [rt.jar:1.8.0_171] >>>>>>> at org.glassfish.enterprise.concurrent.ManagedThreadFactoryImpl >>>>>>> $ManagedThread.run(ManagedThreadFactoryImpl.java:250) >>>>>>> [javax.enterprise.concurrent-1.0.jar:] >>>>>>> at org.jboss.as.ee.concurrent.service.ElytronManagedThreadFacto >>>>>>> ry$ElytronManagedThread.run(ElytronManagedThreadFactory.java:78) >>>>>>> >>>>>>> 2018-05-28 16:47:09,515Z ERROR [org.ovirt.engine.core.dal.dbb >>>>>>> roker.auditloghandling.AuditLogDirector] >>>>>>> (EE-ManagedThreadFactory-engine-Thread-19767) >>>>>>> [e0306ff3-db73-4030-924b-57d86023db28] EVENT_ID: >>>>>>> IMPORTEXPORT_IMPORT_VM_FAILED(1,153), Failed to import Vm >>>>>>> PA-VM-8.0.0 to Data Center DC2, Cluster Cluster2 >>>>>>> 2018-05-28 16:47:09,523Z INFO [org.ovirt.engine.core.bll.exp >>>>>>> ortimport.ImportVmFromOvaCommand] (EE-ManagedThreadFactory-engine-Thread-19767) >>>>>>> [e0306ff3-db73-4030-924b-57d86023db28] Lock freed to object >>>>>>> 'EngineLock:{exclusiveLocks='[PA-VM-8.0.0=VM_NAME, >>>>>>> 2b384fab-2ddb-4069-b4ba-59d0fe4fc8c5=VM]', sharedLocks=''}' >>>>>>> 2018-05-28 16:47:11,057Z ERROR [org.ovirt.engine.core.vdsbroker.irsbroker.IrsBrokerCommand] >>>>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-81) [] >>>>>>> IrsBroker::Failed::GetStoragePoolInfoVDS >>>>>>> >>>>>>> Can anyone help to get this resolved ? >>>>>>> >>>>>> >>>>>> That is solved in 4.2.3 [1], please update ovirt-engine. >>>>>> >>>>>> [1] https://bugzilla.redhat.com/show_bug.cgi?id=1547936 >>>>>> >>>>>> >>>>>>> >>>>>>> Thanks >>>>>>> >>>>>>> _______________________________________________ >>>>>>> Users mailing list -- users(a)ovirt.org >>>>>>> To unsubscribe send an email to users-leave(a)ovirt.org >>>>>>> Privacy Statement: https://www.ovirt.org/site/privacy-policy/ >>>>>>> oVirt Code of Conduct: https://www.ovirt.org/communit >>>>>>> y/about/community-guidelines/ >>>>>>> List Archives: https://lists.ovirt.org/archiv >>>>>>> es/list/users(a)ovirt.org/message/DOK7CJH4LBHMP25FWXXQVBSKSEZEFIHR/ >>>>>>> >>>>>>> >>>>>> >>>>> >>>> >>> >> >