9:12 a.m.
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.dbbroker.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.dbbroker.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.SerialChildCommandsExecutionCallback]
(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.ConcurrentChildCommandsExecutionCallback]
(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.SerialChildCommandsExecutionCallback]
(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.ConcurrentChildCommandsExecutionCallback]
(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.storage.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.vdsbroker.irsbroker.SPMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-197)
[e0846352-12c0-4bff-bdff-43d1938ec9be] START, SPMClearTaskVDSCommand(
SPMTaskGuidBaseVDSCommandParameters:{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.vdsbroker.vdsbroker.HSMClearTaskVDSCommand]
(EE-ManagedThreadFactory-engine-Thread-197)
[e0846352-12c0-4bff-bdff-43d1938ec9be] START,
HSMClearTaskVDSCommand(HostName = HV2,
HSMTaskGuidBaseVDSCommandParameters:{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.vdsbroker.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.vdsbroker.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.SerialChildCommandsExecutionCallback]
(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.ConcurrentChildCommandsExecutionCallback]
(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.storage.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.vdsbroker.irsbroker.GetImageInfoVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-65)
[e0846352-12c0-4bff-bdff-43d1938ec9be] START, GetImageInfoVDSCommand(
GetImageInfoVDSCommandParameters:{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.vdsbroker.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.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-65)
[e0846352-12c0-4bff-bdff-43d1938ec9be] FINISH, GetVolumeInfoVDSCommand,
return:
org.ovirt.engine.core.common.businessentities.storage.DiskImage@9005ff9a,
log id: 7f2c1e37
2018-06-01 13:00:13,460Z INFO
[org.ovirt.engine.core.vdsbroker.irsbroker.GetImageInfoVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-65)
[e0846352-12c0-4bff-bdff-43d1938ec9be] FINISH, GetImageInfoVDSCommand,
return:
org.ovirt.engine.core.common.businessentities.storage.DiskImage@9005ff9a,
log id: 65518c74
2018-06-01 13:00:13,612Z INFO
[org.ovirt.engine.core.dal.dbbroker.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.vdsbroker.vdsbroker.ConvertOvaVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-77)
[e0846352-12c0-4bff-bdff-43d1938ec9be] START, ConvertOvaVDSCommand(HostName
= HV2,
ConvertOvaVDSParameters:{hostId='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.vdsbroker.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.SerialChildCommandsExecutionCallback]
(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.SerialChildCommandsExecutionCallback]
(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.SerialChildCommandsExecutionCallback]
(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.SerialChildCommandsExecutionCallback]
(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
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.vdsbroker.vdsbroker.DeleteV2VJobVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-89)
[e0846352-12c0-4bff-bdff-43d1938ec9be] START,
DeleteV2VJobVDSCommand(HostName = HV2,
VdsAndVmIDVDSParametersBase:{hostId='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.vdsbroker.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.SerialChildCommandsExecutionCallback]
(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.exportimport.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.storage.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.storage.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.vdsbroker.irsbroker.DeleteImageGroupVDSCommand]
(EE-ManagedThreadFactory-engineScheduled-Thread-87) [36a1e4cd] START,
DeleteImageGroupVDSCommand(
DeleteImageGroupVDSCommandParameters:{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.vdsbroker.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.businessentities.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.businessentities.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.businessentities.ReleaseMacsTransientCompensation;
snapshot:
org.ovirt.engine.core.common.businessentities.ReleaseMacsTransientCompensation@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.businessentities.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.businessentities.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.businessentities.ReleaseMacsTransientCompensation;
snapshot:
org.ovirt.engine.core.common.businessentities.ReleaseMacsTransientCompensation@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.exportimport.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.dbbroker.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> wrote:
On Mon, May 28, 2018 at 7:55 PM, Aziz <azizgstest(a)gmail.com> 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.
> lambda$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.
> addVmToDb(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/
>
>