[ovirt-users] Exporting/Copying VM to another oVirt server

Arik Hadas ahadas at redhat.com
Thu Dec 28 22:57:37 UTC 2017


Thanks.
It seems that it fails at the same place it failed before [1]. The only
reason for this failure is that the disk's description is empty.
Are you sure that you set a description for the right disk? Can you attach
a screenshot of the VM's disk info?

[1]
https://github.com/oVirt/ovirt-engine/blob/ovirt-engine-4.2.0/backend/manager/modules/utils/src/main/java/org/ovirt/engine/core/utils/ovf/OvfOvaWriter.java#L55

On Fri, Dec 29, 2017 at 12:45 AM, Alex Bartonek <Alex at unix1337.com> wrote:

> shut down the engine, deleted engine.log, started up and attached entire
> log.  It does contain a java stack dump.
>
>
> -------- Original Message --------
> Subject: Re: [ovirt-users] Exporting/Copying VM to another oVirt server
> Local Time: December 28, 2017 4:36 PM
> UTC Time: December 28, 2017 10:36 PM
> From: ahadas at redhat.com
> To: Alex Bartonek <Alex at unix1337.com>
> users <users at ovirt.org>
>
> That's weird that we don't get the stacktrace for that NPE, I wonder if we
> encounter the problem that was discussed in this old thread: [1]
> Could you restart the engine and try again, hoping that then we'll get the
> stacktrace (it was shown previously in the engine,log and was related to
> that empty disk description)
>
> [1] https://stackoverflow.com/questions/2411487/
> nullpointerexception-in-java-with-no-stacktrace
>
> On Fri, Dec 29, 2017 at 12:25 AM, Alex Bartonek <Alex at unix1337.com> wrote:
>
>> 2017-12-28 16:14:59,452-06 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15462) [10f0e6a5]
>> BaseAsyncTask::removeTaskFromDB: Removed task
>> '3e1cfaa1-07a5-49cb-a9bc-8937c7cc75b2' from DataBase
>> 2017-12-28 16:14:59,452-06 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15462) [10f0e6a5]
>> CommandAsyncTask::HandleEndActionResult [within thread]: Removing
>> CommandMultiAsyncTasks object for entity '84686e92-7ca6-4228-9d3c-31289
>> b2d1d57'
>> 2017-12-28 16:15:48,805-06 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-45) [] Setting new tasks
>> map. The map contains now 1 tasks
>> 2017-12-28 16:16:18,805-06 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-5) [] Setting new tasks
>> map. The map contains now 0 tasks
>> 2017-12-28 16:16:18,805-06 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-5) [] Cleared all tasks
>> of pool '3bb4edf8-be27-42e4-b860-a1f1f293b81c'.
>> 2017-12-28 16:21:17,538-06 INFO  [org.ovirt.engine.core.bll.uti
>> ls.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1)
>> [] Thread pool 'default' is using 0 threads out of 1 and 5 tasks are
>> waiting in the queue.
>> 2017-12-28 16:21:17,538-06 INFO  [org.ovirt.engine.core.bll.uti
>> ls.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1)
>> [] Thread pool 'engine' is using 0 threads out of 500, 8 threads waiting
>> for tasks and 0 tasks in queue.
>> 2017-12-28 16:21:17,538-06 INFO  [org.ovirt.engine.core.bll.uti
>> ls.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1)
>> [] Thread pool 'engineScheduled' is using 0 threads out of 100 and 100
>> tasks are waiting in the queue.
>> 2017-12-28 16:21:17,538-06 INFO  [org.ovirt.engine.core.bll.uti
>> ls.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1)
>> [] Thread pool 'engineThreadMonitoring' is using 1 threads out of 1 and 0
>> tasks are waiting in the queue.
>> 2017-12-28 16:21:17,538-06 INFO  [org.ovirt.engine.core.bll.uti
>> ls.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1)
>> [] Thread pool 'hostUpdatesChecker' is using 0 threads out of 5 and 2 tasks
>> are waiting in the queue.
>> 2017-12-28 16:21:28,068-06 INFO  [org.ovirt.engine.core.bll.exportimport.ExportOvaCommand]
>> (default task-39) [aa503a62-d439-4131-9b46-e161779847f4] Lock Acquired
>> to object 'EngineLock:{exclusiveLocks='[43c82580-6c7a-4319-97f6-6cfb17a4445a=VM]',
>> sharedLocks=''}'
>> 2017-12-28 16:21:28,082-06 INFO  [org.ovirt.engine.core.common.utils.ansible.AnsibleExecutor]
>> (default task-39) [aa503a62-d439-4131-9b46-e161779847f4] Executing
>> Ansible command:  [/usr/bin/ansible-playbook, --private-key=/etc/pki/ovirt-engine/keys/engine_id_rsa,
>> --inventory=/tmp/ansible-inventory8939720115375947799,
>> --extra-vars=target_directory=/media/primary/extra_space,
>> --extra-vars=validate_only=True, /usr/share/ovirt-engine/playbooks/ovirt-ova-export.yml]
>> [Logfile: /var/log/ovirt-engine/ova/ovirt-export-ova-validate-ansible-
>> 20171228162128-reindeer.themagicm.com-aa503a62-d439-
>> 4131-9b46-e161779847f4.log]
>> 2017-12-28 16:21:32,496-06 INFO  [org.ovirt.engine.core.common.utils.ansible.AnsibleExecutor]
>> (default task-39) [aa503a62-d439-4131-9b46-e161779847f4] Ansible
>> playbook command has exited with value: 0
>> 2017-12-28 16:21:32,548-06 INFO  [org.ovirt.engine.core.bll.exportimport.ExportOvaCommand]
>> (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] Running command: ExportOvaCommand
>> internal: false. Entities affected :  ID: 43c82580-6c7a-4319-97f6-6cfb17a4445a
>> Type: VMAction group IMPORT_EXPORT_VM with role type ADMIN
>> 2017-12-28 16:21:32,584-06 INFO  [org.ovirt.engine.core.bll.sto
>> rage.disk.CreateAllOvaDisksCommand] (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] Running command:
>> CreateAllOvaDisksCommand internal: true.
>> 2017-12-28 16:21:32,645-06 INFO  [org.ovirt.engine.core.bll.sto
>> rage.disk.image.CopyImageGroupCommand] (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] Running command:
>> CopyImageGroupCommand internal: true. Entities affected :  ID:
>> 4108dd94-7538-4fdb-a01e-2eb51b9083b9 Type: Storage
>> 2017-12-28 16:21:32,757-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] START, CopyImageVDSCommand(
>> CopyImageVDSCommandParameters:{storagePoolId='3bb4edf8-be27-42e4-b860-a1f1f293b81c',
>> ignoreFailoverLimit='false', storageDomainId='4108dd94-7538-4fdb-a01e-2eb51b9083b9',
>> imageGroupId='5499e522-db23-4a71-b5a2-e30933d7d547',
>> imageId='5770b269-f98f-4d12-b627-e960b9e295b4',
>> dstImageGroupId='a2578b49-5edf-47b8-a98a-12a20b47688c',
>> vmId='43c82580-6c7a-4319-97f6-6cfb17a4445a',
>> dstImageId='34885dca-e1c6-4e92-9f06-957a63c0ae56', imageDescription='',
>> dstStorageDomainId='4108dd94-7538-4fdb-a01e-2eb51b9083b9',
>> copyVolumeType='LeafVol', volumeFormat='COW', preallocate='Sparse',
>> postZero='false', discard='false', force='true'}), log id: 40b6c4b9
>> 2017-12-28 16:21:32,760-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] -- executeIrsBrokerCommand:
>> calling 'copyImage' with two new parameters: description and UUID.
>> Parameters:
>> 2017-12-28 16:21:32,760-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] ++ sdUUID=4108dd94-7538-4fdb-a01e
>> -2eb51b9083b9
>> 2017-12-28 16:21:32,760-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] ++ spUUID=3bb4edf8-be27-42e4-b860
>> -a1f1f293b81c
>> 2017-12-28 16:21:32,760-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] ++ vmGUID=43c82580-6c7a-4319-97f6
>> -6cfb17a4445a
>> 2017-12-28 16:21:32,760-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] ++ srcImageGUID=5499e522-db23-4a7
>> 1-b5a2-e30933d7d547
>> 2017-12-28 16:21:32,760-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] ++ srcVolUUID=5770b269-f98f-4d12-
>> b627-e960b9e295b4
>> 2017-12-28 16:21:32,760-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] ++ dstImageGUID=a2578b49-5edf-47b
>> 8-a98a-12a20b47688c
>> 2017-12-28 16:21:32,760-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] ++ dstVolUUID=34885dca-e1c6-4e92-
>> 9f06-957a63c0ae56
>> 2017-12-28 16:21:32,760-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] ++ descr=
>> 2017-12-28 16:21:32,760-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] ++ dstSdUUID=4108dd94-7538-4fdb-a
>> 01e-2eb51b9083b9
>> 2017-12-28 16:21:32,858-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] FINISH, CopyImageVDSCommand,
>> return: f543383a-f369-488a-b625-73706b871a51, log id: 40b6c4b9
>> 2017-12-28 16:21:32,875-06 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] CommandAsyncTask::Adding
>> CommandMultiAsyncTasks object for command 'd8db5f12-cf59-40d2-b1b9-d5e44
>> 79766a3'
>> 2017-12-28 16:21:32,876-06 INFO  [org.ovirt.engine.core.bll.CommandMultiAsyncTasks]
>> (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] CommandMultiAsyncTasks::attachTask:
>> Attaching task 'f543383a-f369-488a-b625-73706b871a51' to command
>> 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3'.
>> 2017-12-28 16:21:32,906-06 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
>> (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] Adding task
>> 'f543383a-f369-488a-b625-73706b871a51' (Parent Command 'CopyImageGroup',
>> Parameters Type 'org.ovirt.engine.core.common.
>> asynctasks.AsyncTaskParameters'), polling hasn't started yet..
>> 2017-12-28 16:21:32,948-06 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] BaseAsyncTask::startPollingTask:
>> Starting to poll task 'f543383a-f369-488a-b625-73706b871a51'.
>> 2017-12-28 16:21:32,991-06 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] BaseAsyncTask::startPollingTask:
>> Starting to poll task 'f543383a-f369-488a-b625-73706b871a51'.
>> 2017-12-28 16:21:33,054-06 INFO  [org.ovirt.engine.core.dal.dbb
>> roker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engine-Thread-15515)
>> [aa503a62-d439-4131-9b46-e161779847f4] EVENT_ID:
>> IMPORTEXPORT_STARTING_EXPORT_VM_TO_OVA(1,223), Starting to export Vm
>> CentOS7 as a Virtual Appliance
>> 2017-12-28 16:21:34,769-06 INFO  [org.ovirt.engine.core.bll.Con
>> currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-29)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id:
>> 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete
>> 2017-12-28 16:21:34,865-06 INFO  [org.ovirt.engine.core.bll.Ser
>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-29)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id:
>> '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to
>> complete
>> 2017-12-28 16:21:38,872-06 INFO  [org.ovirt.engine.core.bll.Con
>> currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-77)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id:
>> 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete
>> 2017-12-28 16:21:38,883-06 INFO  [org.ovirt.engine.core.bll.Ser
>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-77)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id:
>> '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to
>> complete
>> 2017-12-28 16:21:39,355-06 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-64) [] Polling and
>> updating Async Tasks: 1 tasks, 1 tasks to poll now
>> 2017-12-28 16:21:39,366-06 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-64) []
>> SPMAsyncTask::PollTask: Polling task 'f543383a-f369-488a-b625-73706b871a51'
>> (Parent Command 'CopyImageGroup', Parameters Type
>> 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') returned
>> status 'running'.
>> 2017-12-28 16:21:39,367-06 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-64) [] Finished polling
>> Tasks, will poll again in 10 seconds.
>> 2017-12-28 16:21:46,893-06 INFO  [org.ovirt.engine.core.bll.Con
>> currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-7)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id:
>> 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete
>> 2017-12-28 16:21:46,903-06 INFO  [org.ovirt.engine.core.bll.Ser
>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-7)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id:
>> '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to
>> complete
>> 2017-12-28 16:21:56,916-06 INFO  [org.ovirt.engine.core.bll.Con
>> currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-92)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id:
>> 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete
>> 2017-12-28 16:21:56,926-06 INFO  [org.ovirt.engine.core.bll.Ser
>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-92)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id:
>> '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to
>> complete
>> 2017-12-28 16:22:06,935-06 INFO  [org.ovirt.engine.core.bll.Con
>> currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-38)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id:
>> 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete
>> 2017-12-28 16:22:06,945-06 INFO  [org.ovirt.engine.core.bll.Ser
>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-38)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id:
>> '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to
>> complete
>> 2017-12-28 16:22:16,956-06 INFO  [org.ovirt.engine.core.bll.Con
>> currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-15)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id:
>> 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete
>> 2017-12-28 16:22:16,966-06 INFO  [org.ovirt.engine.core.bll.Ser
>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-15)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id:
>> '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to
>> complete
>> 2017-12-28 16:22:26,974-06 INFO  [org.ovirt.engine.core.bll.Con
>> currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-58)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id:
>> 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete
>> 2017-12-28 16:22:26,995-06 INFO  [org.ovirt.engine.core.bll.Ser
>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-58)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id:
>> '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to
>> complete
>> 2017-12-28 16:22:37,004-06 INFO  [org.ovirt.engine.core.bll.Con
>> currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-2)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id:
>> 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete
>> 2017-12-28 16:22:37,016-06 INFO  [org.ovirt.engine.core.bll.Ser
>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-2)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id:
>> '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to
>> complete
>> 2017-12-28 16:22:47,023-06 INFO  [org.ovirt.engine.core.bll.Con
>> currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-5)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id:
>> 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete
>> 2017-12-28 16:22:47,036-06 INFO  [org.ovirt.engine.core.bll.Ser
>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-5)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id:
>> '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to
>> complete
>> 2017-12-28 16:22:57,045-06 INFO  [org.ovirt.engine.core.bll.Con
>> currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-77)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id:
>> 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete
>> 2017-12-28 16:22:57,055-06 INFO  [org.ovirt.engine.core.bll.Ser
>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-77)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id:
>> '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to
>> complete
>> 2017-12-28 16:22:59,497-06 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-23) []
>> SPMAsyncTask::PollTask: Polling task 'f543383a-f369-488a-b625-73706b871a51'
>> (Parent Command 'CopyImageGroup', Parameters Type
>> 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') returned
>> status 'finished', result 'success'.
>> 2017-12-28 16:22:59,503-06 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-23) []
>> BaseAsyncTask::onTaskEndSuccess: Task 'f543383a-f369-488a-b625-73706b871a51'
>> (Parent Command 'CopyImageGroup', Parameters Type
>> 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') ended
>> successfully.
>> 2017-12-28 16:22:59,504-06 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-23) []
>> CommandAsyncTask::endActionIfNecessary: All tasks of command
>> 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' has ended -> executing 'endAction'
>> 2017-12-28 16:22:59,505-06 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-23) []
>> CommandAsyncTask::endAction: Ending action for '1' tasks (command ID:
>> 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3'): calling endAction '.
>> 2017-12-28 16:22:59,505-06 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15528) []
>> CommandAsyncTask::endCommandAction [within thread] context: Attempting
>> to endAction 'CopyImageGroup',
>> 2017-12-28 16:22:59,515-06 INFO  [org.ovirt.engine.core.bll.sto
>> rage.disk.image.CopyImageGroupCommand] (EE-ManagedThreadFactory-engine-Thread-15528)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command
>> [id=d8db5f12-cf59-40d2-b1b9-d5e4479766a3]: Updating status to
>> 'SUCCEEDED', The command end method logic will be executed by one of its
>> parent commands.
>> 2017-12-28 16:22:59,516-06 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15528)
>> [aa503a62-d439-4131-9b46-e161779847f4] CommandAsyncTask::HandleEndActionResult
>> [within thread]: endAction for action type 'CopyImageGroup' completed,
>> handling the result.
>> 2017-12-28 16:22:59,516-06 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15528)
>> [aa503a62-d439-4131-9b46-e161779847f4] CommandAsyncTask::HandleEndActionResult
>> [within thread]: endAction for action type 'CopyImageGroup' succeeded,
>> clearing tasks.
>> 2017-12-28 16:22:59,516-06 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15528)
>> [aa503a62-d439-4131-9b46-e161779847f4] SPMAsyncTask::ClearAsyncTask:
>> Attempting to clear task 'f543383a-f369-488a-b625-73706b871a51'
>> 2017-12-28 16:22:59,518-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.SPMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15528)
>> [aa503a62-d439-4131-9b46-e161779847f4] START, SPMClearTaskVDSCommand(
>> SPMTaskGuidBaseVDSCommandParameters:{storagePoolId='3bb4edf8-be27-42e4-b860-a1f1f293b81c',
>> ignoreFailoverLimit='false', taskId='f543383a-f369-488a-b625-73706b871a51'}),
>> log id: 2e9c1d1
>> 2017-12-28 16:22:59,521-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.vdsbroker.HSMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15528)
>> [aa503a62-d439-4131-9b46-e161779847f4] START,
>> HSMClearTaskVDSCommand(HostName = reindeerHost,
>> HSMTaskGuidBaseVDSCommandParameters:{hostId='4f344875-08d8-49d8-b2ee-5ca3e1810051',
>> taskId='f543383a-f369-488a-b625-73706b871a51'}), log id: 4ad7abb5
>> 2017-12-28 16:22:59,535-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.vdsbroker.HSMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15528)
>> [aa503a62-d439-4131-9b46-e161779847f4] FINISH, HSMClearTaskVDSCommand,
>> log id: 4ad7abb5
>> 2017-12-28 16:22:59,535-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.SPMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15528)
>> [aa503a62-d439-4131-9b46-e161779847f4] FINISH, SPMClearTaskVDSCommand,
>> log id: 2e9c1d1
>> 2017-12-28 16:22:59,545-06 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15528)
>> [aa503a62-d439-4131-9b46-e161779847f4] BaseAsyncTask::removeTaskFromDB:
>> Removed task 'f543383a-f369-488a-b625-73706b871a51' from DataBase
>> 2017-12-28 16:22:59,546-06 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15528)
>> [aa503a62-d439-4131-9b46-e161779847f4] CommandAsyncTask::HandleEndActionResult
>> [within thread]: Removing CommandMultiAsyncTasks object for entity
>> 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3'
>> 2017-12-28 16:23:07,064-06 INFO  [org.ovirt.engine.core.bll.Con
>> currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-45)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69' child commands
>> '[d8db5f12-cf59-40d2-b1b9-d5e4479766a3]' executions were completed,
>> status 'SUCCEEDED'
>> 2017-12-28 16:23:07,078-06 INFO  [org.ovirt.engine.core.bll.Ser
>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-45)
>> [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id:
>> '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id:
>> '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to
>> complete
>> 2017-12-28 16:23:08,089-06 INFO  [org.ovirt.engine.core.bll.sto
>> rage.disk.CreateAllOvaDisksCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
>> [aa503a62-d439-4131-9b46-e161779847f4] Ending command
>> 'org.ovirt.engine.core.bll.storage.disk.CreateAllOvaDisksCommand'
>> successfully.
>> 2017-12-28 16:23:08,106-06 INFO  [org.ovirt.engine.core.bll.sto
>> rage.disk.image.CopyImageGroupCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
>> [aa503a62-d439-4131-9b46-e161779847f4] Ending command
>> 'org.ovirt.engine.core.bll.storage.disk.image.CopyImageGroupCommand'
>> successfully.
>> 2017-12-28 16:23:08,118-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.GetImageInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
>> [aa503a62-d439-4131-9b46-e161779847f4] START, GetImageInfoVDSCommand(
>> GetImageInfoVDSCommandParameters:{storagePoolId='3bb4edf8-be27-42e4-b860-a1f1f293b81c',
>> ignoreFailoverLimit='false', storageDomainId='4108dd94-7538-4fdb-a01e-2eb51b9083b9',
>> imageGroupId='a2578b49-5edf-47b8-a98a-12a20b47688c',
>> imageId='34885dca-e1c6-4e92-9f06-957a63c0ae56'}), log id: 2cec8f8
>> 2017-12-28 16:23:08,122-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
>> [aa503a62-d439-4131-9b46-e161779847f4] START,
>> GetVolumeInfoVDSCommand(HostName = reindeerHost,
>> GetVolumeInfoVDSCommandParameters:{hostId='4f344875-08d8-49d8-b2ee-5ca3e1810051',
>> storagePoolId='3bb4edf8-be27-42e4-b860-a1f1f293b81c',
>> storageDomainId='4108dd94-7538-4fdb-a01e-2eb51b9083b9',
>> imageGroupId='a2578b49-5edf-47b8-a98a-12a20b47688c',
>> imageId='34885dca-e1c6-4e92-9f06-957a63c0ae56'}), log id: c3fea19
>> 2017-12-28 16:23:08,135-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
>> [aa503a62-d439-4131-9b46-e161779847f4] FINISH, GetVolumeInfoVDSCommand,
>> return: org.ovirt.engine.core.common.businessentities.storage.DiskIm
>> age at 95bb5b65, log id: c3fea19
>> 2017-12-28 16:23:08,135-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.GetImageInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
>> [aa503a62-d439-4131-9b46-e161779847f4] FINISH, GetImageInfoVDSCommand,
>> return: org.ovirt.engine.core.common.businessentities.storage.DiskIm
>> age at 95bb5b65, log id: 2cec8f8
>> 2017-12-28 16:23:08,232-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.vdsbroker.PrepareImageVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
>> [aa503a62-d439-4131-9b46-e161779847f4] START,
>> PrepareImageVDSCommand(HostName = reindeerHost,
>> PrepareImageVDSCommandParameters:{hostId='4f344875-08d8-49d8-b2ee-5ca3e1810051'}),
>> log id: 6824c68f
>> 2017-12-28 16:23:08,246-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.vdsbroker.PrepareImageVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
>> [aa503a62-d439-4131-9b46-e161779847f4] FINISH, PrepareImageVDSCommand,
>> return: PrepareImageReturn:{status='Status [code=0, message=Done]'}, log
>> id: 6824c68f
>> 2017-12-28 16:23:08,251-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.vdsbroker.GetQemuImageInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
>> [aa503a62-d439-4131-9b46-e161779847f4] START,
>> GetQemuImageInfoVDSCommand(HostName = reindeerHost,
>> GetVolumeInfoVDSCommandParameters:{hostId='4f344875-08d8-49d8-b2ee-5ca3e1810051',
>> storagePoolId='3bb4edf8-be27-42e4-b860-a1f1f293b81c',
>> storageDomainId='4108dd94-7538-4fdb-a01e-2eb51b9083b9',
>> imageGroupId='a2578b49-5edf-47b8-a98a-12a20b47688c',
>> imageId='34885dca-e1c6-4e92-9f06-957a63c0ae56'}), log id: 1fb3c78e
>> 2017-12-28 16:23:08,495-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.vdsbroker.GetQemuImageInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
>> [aa503a62-d439-4131-9b46-e161779847f4] FINISH,
>> GetQemuImageInfoVDSCommand, return: org.ovirt.engine.core.common.b
>> usinessentities.storage.QemuImageInfo at 3412697c, log id: 1fb3c78e
>> 2017-12-28 16:23:08,499-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.vdsbroker.TeardownImageVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
>> [aa503a62-d439-4131-9b46-e161779847f4] START,
>> TeardownImageVDSCommand(HostName = reindeerHost,
>> ImageActionsVDSCommandParameters:{hostId='4f344875-08d8-49d8-b2ee-5ca3e1810051'}),
>> log id: 6377d6a3
>> 2017-12-28 16:23:08,508-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.vdsbroker.TeardownImageVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
>> [aa503a62-d439-4131-9b46-e161779847f4] FINISH, TeardownImageVDSCommand,
>> return: StatusReturn:{status='Status [code=0, message=Done]'}, log id:
>> 6377d6a3
>> 2017-12-28 16:23:08,561-06 INFO  [org.ovirt.engine.core.bll.CreateOvaCommand]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-61) [436aa42a] Running
>> command: CreateOvaCommand internal: true.
>> 2017-12-28 16:23:08,564-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.vdsbroker.PrepareImageVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
>> [436aa42a] START, PrepareImageVDSCommand(HostName = reindeerHost,
>> PrepareImageVDSCommandParameters:{hostId='4f344875-08d8-49d8-b2ee-5ca3e1810051'}),
>> log id: 4490da3c
>> 2017-12-28 16:23:08,575-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.vdsbroker.PrepareImageVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
>> [436aa42a] FINISH, PrepareImageVDSCommand, return:
>> PrepareImageReturn:{status='Status [code=0, message=Done]'}, log id:
>> 4490da3c
>> 2017-12-28 16:23:08,580-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
>> [436aa42a] START, GetVolumeInfoVDSCommand(HostName = reindeerHost,
>> GetVolumeInfoVDSCommandParameters:{hostId='4f344875-08d8-49d8-b2ee-5ca3e1810051',
>> storagePoolId='3bb4edf8-be27-42e4-b860-a1f1f293b81c',
>> storageDomainId='4108dd94-7538-4fdb-a01e-2eb51b9083b9',
>> imageGroupId='a2578b49-5edf-47b8-a98a-12a20b47688c',
>> imageId='34885dca-e1c6-4e92-9f06-957a63c0ae56'}), log id: 60f52262
>> 2017-12-28 16:23:08,591-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
>> [436aa42a] FINISH, GetVolumeInfoVDSCommand, return:
>> org.ovirt.engine.core.common.businessentities.storage.DiskImage at 95bb5b65,
>> log id: 60f52262
>> 2017-12-28 16:23:08,596-06 ERROR [org.ovirt.engine.core.bll.CreateOvaCommand]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-61) [436aa42a] Command
>> 'org.ovirt.engine.core.bll.CreateOvaCommand' failed: null
>> 2017-12-28 16:23:08,596-06 ERROR [org.ovirt.engine.core.bll.CreateOvaCommand]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-61) [436aa42a]
>> Exception: java.lang.NullPointerException
>>
>> 2017-12-28 16:23:08,600-06 ERROR [org.ovirt.engine.core.bll.exportimport.ExportOvaCommand]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-61) [436aa42a] Failed to
>> create OVA file
>> 2017-12-28 16:23:08,600-06 INFO  [org.ovirt.engine.core.bll.Ser
>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
>> [436aa42a] Command 'ExportOva' id: '22e1df85-794b-4bb6-a6b6-a1679cbe2f78'
>> failed when attempting to perform the next operation, marking as FAILED
>> '[42331a77-2e38-4653-ba5f-29e5dccaea69]'
>> 2017-12-28 16:23:08,600-06 INFO  [org.ovirt.engine.core.bll.Ser
>> ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
>> [436aa42a] Command 'ExportOva' id: '22e1df85-794b-4bb6-a6b6-a1679cbe2f78'
>> child commands '[42331a77-2e38-4653-ba5f-29e5dccaea69]' executions were
>> completed, status 'FAILED'
>> 2017-12-28 16:23:09,628-06 ERROR [org.ovirt.engine.core.bll.exportimport.ExportOvaCommand]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-15)
>> [aa503a62-d439-4131-9b46-e161779847f4] Ending command
>> 'org.ovirt.engine.core.bll.exportimport.ExportOvaCommand' with failure.
>> 2017-12-28 16:23:09,637-06 INFO  [org.ovirt.engine.core.bll.exportimport.ExportOvaCommand]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-15)
>> [aa503a62-d439-4131-9b46-e161779847f4] Lock freed to object
>> 'EngineLock:{exclusiveLocks='[43c82580-6c7a-4319-97f6-6cfb17a4445a=VM]',
>> sharedLocks=''}'
>> 2017-12-28 16:23:09,667-06 ERROR [org.ovirt.engine.core.dal.dbb
>> roker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engineScheduled-Thread-15)
>> [aa503a62-d439-4131-9b46-e161779847f4] EVENT_ID:
>> IMPORTEXPORT_EXPORT_VM_TO_OVA_FAILED(1,225), Failed to export Vm CentOS7
>> as a Virtual Appliance to path /media/primary/extra_space/CentOS7.ova on
>> Host reindeerHost
>> 2017-12-28 16:23:09,716-06 INFO  [org.ovirt.engine.core.bll.storage.disk.RemoveDiskCommand]
>> (EE-ManagedThreadFactory-engine-Thread-15529) [31f8fbf6] Running
>> command: RemoveDiskCommand internal: true. Entities affected :  ID:
>> a2578b49-5edf-47b8-a98a-12a20b47688c Type: DiskAction group DELETE_DISK
>> with role type USER
>> 2017-12-28 16:23:09,734-06 INFO  [org.ovirt.engine.core.bll.sto
>> rage.disk.image.RemoveImageCommand] (EE-ManagedThreadFactory-engine-Thread-15529)
>> [31f8fbf6] Running command: RemoveImageCommand internal: true. Entities
>> affected :  ID: 4108dd94-7538-4fdb-a01e-2eb51b9083b9 Type: Storage
>> 2017-12-28 16:23:09,796-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.DeleteImageGroupVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15529)
>> [31f8fbf6] START, DeleteImageGroupVDSCommand( DeleteImageGroupVDSCommandPara
>> meters:{storagePoolId='3bb4edf8-be27-42e4-b860-a1f1f293b81c',
>> ignoreFailoverLimit='false', storageDomainId='4108dd94-7538-4fdb-a01e-2eb51b9083b9',
>> imageGroupId='a2578b49-5edf-47b8-a98a-12a20b47688c', postZeros='false',
>> discard='false', forceDelete='true'}), log id: 389abdf
>> 2017-12-28 16:23:09,845-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.DeleteImageGroupVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15529)
>> [31f8fbf6] FINISH, DeleteImageGroupVDSCommand, log id: 389abdf
>> 2017-12-28 16:23:09,860-06 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15529) [31f8fbf6]
>> CommandAsyncTask::Adding CommandMultiAsyncTasks object for command
>> 'f9ca5d6f-effe-41a2-835f-83f04da2de73'
>> 2017-12-28 16:23:09,860-06 INFO  [org.ovirt.engine.core.bll.CommandMultiAsyncTasks]
>> (EE-ManagedThreadFactory-engine-Thread-15529) [31f8fbf6]
>> CommandMultiAsyncTasks::attachTask: Attaching task
>> 'f2c7f5ec-b166-4cf2-97b6-b2cc02f715e1' to command
>> 'f9ca5d6f-effe-41a2-835f-83f04da2de73'.
>> 2017-12-28 16:23:09,888-06 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
>> (EE-ManagedThreadFactory-engine-Thread-15529) [31f8fbf6] Adding task
>> 'f2c7f5ec-b166-4cf2-97b6-b2cc02f715e1' (Parent Command 'RemoveDisk',
>> Parameters Type 'org.ovirt.engine.core.common.
>> asynctasks.AsyncTaskParameters'), polling hasn't started yet..
>> 2017-12-28 16:23:10,056-06 INFO  [org.ovirt.engine.core.dal.dbb
>> roker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engine-Thread-15529)
>> [31f8fbf6] EVENT_ID: USER_FINISHED_REMOVE_DISK(2,014), Disk
>> Debian7_Disk1 was successfully removed from domain data (User
>> admin at internal-authz).
>> 2017-12-28 16:23:10,057-06 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15529) [31f8fbf6]
>> BaseAsyncTask::startPollingTask: Starting to poll task
>> 'f2c7f5ec-b166-4cf2-97b6-b2cc02f715e1'.
>> 2017-12-28 16:23:10,057-06 WARN  [org.ovirt.engine.core.bll.lock.InMemoryLockManager]
>> (EE-ManagedThreadFactory-engine-Thread-15529) [31f8fbf6] Trying to
>> release exclusive lock which does not exist, lock key:
>> '43c82580-6c7a-4319-97f6-6cfb17a4445aVM'
>> 2017-12-28 16:23:10,057-06 INFO  [org.ovirt.engine.core.bll.storage.disk.RemoveDiskCommand]
>> (EE-ManagedThreadFactory-engine-Thread-15529) [31f8fbf6] Lock freed to
>> object 'EngineLock:{exclusiveLocks='[43c82580-6c7a-4319-97f6-6cfb17a4445a=VM]',
>> sharedLocks=''}'
>> 2017-12-28 16:23:19,505-06 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-31) [] Polling and
>> updating Async Tasks: 2 tasks, 1 tasks to poll now
>> 2017-12-28 16:23:19,519-06 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-31) []
>> SPMAsyncTask::PollTask: Polling task 'f2c7f5ec-b166-4cf2-97b6-b2cc02f715e1'
>> (Parent Command 'RemoveDisk', Parameters Type 'org.ovirt.engine.core.common.
>> asynctasks.AsyncTaskParameters') returned status 'finished', result
>> 'success'.
>> 2017-12-28 16:23:19,530-06 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-31) []
>> BaseAsyncTask::onTaskEndSuccess: Task 'f2c7f5ec-b166-4cf2-97b6-b2cc02f715e1'
>> (Parent Command 'RemoveDisk', Parameters Type 'org.ovirt.engine.core.common.
>> asynctasks.AsyncTaskParameters') ended successfully.
>> 2017-12-28 16:23:19,563-06 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-31) []
>> CommandAsyncTask::endActionIfNecessary: All tasks of command
>> 'f9ca5d6f-effe-41a2-835f-83f04da2de73' has ended -> executing 'endAction'
>> 2017-12-28 16:23:19,563-06 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-31) []
>> CommandAsyncTask::endAction: Ending action for '1' tasks (command ID:
>> 'f9ca5d6f-effe-41a2-835f-83f04da2de73'): calling endAction '.
>> 2017-12-28 16:23:19,564-06 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15532) []
>> CommandAsyncTask::endCommandAction [within thread] context: Attempting
>> to endAction 'RemoveDisk',
>> 2017-12-28 16:23:19,579-06 INFO  [org.ovirt.engine.core.bll.storage.disk.RemoveDiskCommand]
>> (EE-ManagedThreadFactory-engine-Thread-15532) [31f8fbf6] Ending command
>> 'org.ovirt.engine.core.bll.storage.disk.RemoveDiskCommand' successfully.
>> 2017-12-28 16:23:19,585-06 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15532) [31f8fbf6]
>> CommandAsyncTask::HandleEndActionResult [within thread]: endAction for
>> action type 'RemoveDisk' completed, handling the result.
>> 2017-12-28 16:23:19,585-06 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15532) [31f8fbf6]
>> CommandAsyncTask::HandleEndActionResult [within thread]: endAction for
>> action type 'RemoveDisk' succeeded, clearing tasks.
>> 2017-12-28 16:23:19,585-06 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15532) [31f8fbf6]
>> SPMAsyncTask::ClearAsyncTask: Attempting to clear task
>> 'f2c7f5ec-b166-4cf2-97b6-b2cc02f715e1'
>> 2017-12-28 16:23:19,588-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.SPMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15532)
>> [31f8fbf6] START, SPMClearTaskVDSCommand( SPMTaskGuidBaseVDSCommandParam
>> eters:{storagePoolId='3bb4edf8-be27-42e4-b860-a1f1f293b81c',
>> ignoreFailoverLimit='false', taskId='f2c7f5ec-b166-4cf2-97b6-b2cc02f715e1'}),
>> log id: 6c25b62
>> 2017-12-28 16:23:19,591-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.vdsbroker.HSMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15532)
>> [31f8fbf6] START, HSMClearTaskVDSCommand(HostName = reindeerHost,
>> HSMTaskGuidBaseVDSCommandParameters:{hostId='4f344875-08d8-49d8-b2ee-5ca3e1810051',
>> taskId='f2c7f5ec-b166-4cf2-97b6-b2cc02f715e1'}), log id: 4d4fcced
>> 2017-12-28 16:23:19,602-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.vdsbroker.HSMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15532)
>> [31f8fbf6] FINISH, HSMClearTaskVDSCommand, log id: 4d4fcced
>> 2017-12-28 16:23:19,602-06 INFO  [org.ovirt.engine.core.vdsbrok
>> er.irsbroker.SPMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15532)
>> [31f8fbf6] FINISH, SPMClearTaskVDSCommand, log id: 6c25b62
>> 2017-12-28 16:23:19,614-06 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15532) [31f8fbf6]
>> BaseAsyncTask::removeTaskFromDB: Removed task
>> 'f2c7f5ec-b166-4cf2-97b6-b2cc02f715e1' from DataBase
>> 2017-12-28 16:23:19,614-06 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask]
>> (EE-ManagedThreadFactory-engine-Thread-15532) [31f8fbf6]
>> CommandAsyncTask::HandleEndActionResult [within thread]: Removing
>> CommandMultiAsyncTasks object for entity 'f9ca5d6f-effe-41a2-835f-83f04
>> da2de73'
>> 2017-12-28 16:24:18,808-06 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager]
>> (EE-ManagedThreadFactory-engineScheduled-Thread-55) [] Setting new tasks
>> map. The map contains now 1 tasks
>>
>>
>>
>> Sent with ProtonMail <https://protonmail.com> Secure Email.
>>
>> -------- Original Message --------
>> Subject: Re: [ovirt-users] Exporting/Copying VM to another oVirt server
>> Local Time: December 28, 2017 4:20 PM
>> UTC Time: December 28, 2017 10:20 PM
>> From: ahadas at redhat.com
>> To: Alex Bartonek <Alex at unix1337.com>
>> users <users at ovirt.org>
>>
>> :/
>> Can you please attach the new log?
>>
>> On Fri, Dec 29, 2017 at 12:18 AM, Alex Bartonek <Alex at unix1337.com>
>> wrote:
>>
>>> Yes it was empty.  Tried again, same failure.
>>>
>>>
>>> Sent with ProtonMail <https://protonmail.com> Secure Email.
>>>
>>> -------- Original Message --------
>>> Subject: Re: [ovirt-users] Exporting/Copying VM to another oVirt server
>>> Local Time: December 28, 2017 4:11 PM
>>> UTC Time: December 28, 2017 10:11 PM
>>> From: ahadas at redhat.com
>>> To: Alex Bartonek <Alex at unix1337.com>
>>> users <users at ovirt.org>
>>>
>>> Thanks.
>>> Is the description of the disk of the VM empty?
>>> If it is, please type some description and then try again.
>>>
>>> On Fri, Dec 29, 2017 at 12:02 AM, Alex Bartonek <Alex at unix1337.com>
>>> wrote:
>>>
>>>> Attached.  Its 3.8 mb decompressed.
>>>>
>>>>
>>>> Sent with ProtonMail <https://protonmail.com> Secure Email.
>>>>
>>>> -------- Original Message --------
>>>> Subject: Re: [ovirt-users] Exporting/Copying VM to another oVirt server
>>>> Local Time: December 28, 2017 3:56 PM
>>>> UTC Time: December 28, 2017 9:56 PM
>>>> From: ahadas at redhat.com
>>>> To: Alex Bartonek <Alex at unix1337.com>
>>>> users <users at ovirt.org>
>>>>
>>>>
>>>>
>>>> On Thu, Dec 28, 2017 at 11:28 PM, Alex Bartonek <Alex at unix1337.com>
>>>> wrote:
>>>>
>>>>> That is the excerpt from the  engine log file.   There isnt any  more
>>>>> java stack dump in it other than what I captured.
>>>>>
>>>>
>>>> Can you please attach the entire engine.log to this thread or to a new
>>>> bug (https://bugzilla.redhat.com)?
>>>>
>>>>
>>>>>
>>>>>
>>>>>
>>>>> Sent with ProtonMail <https://protonmail.com> Secure Email.
>>>>>
>>>>> -------- Original Message --------
>>>>> Subject: Re: [ovirt-users] Exporting/Copying VM to another oVirt server
>>>>> Local Time: December 28, 2017 3:18 PM
>>>>> UTC Time: December 28, 2017 9:18 PM
>>>>> From: ahadas at redhat.com
>>>>> To: Alex Bartonek <Alex at unix1337.com>
>>>>> users <users at ovirt.org>
>>>>>
>>>>>
>>>>>
>>>>> On Thu, Dec 28, 2017 at 10:46 PM, Alex Bartonek <Alex at unix1337.com>
>>>>> wrote:
>>>>>
>>>>>> Log uploaded to:
>>>>>>
>>>>>> http://textuploader.com/dc2be
>>>>>>
>>>>>>
>>>>> Thanks!
>>>>> Exporting and importing as OVA files is the new shiny way of doing
>>>>> that as from 4.2 but unfortunately, there seems to be an error while
>>>>> generating OVF for the VM you're trying to export.
>>>>> I see NullPointerException in the log and an empty line afterwards,
>>>>> can you please check if there is a stacktrace right below in the engine.log
>>>>> that was not copied? It should be below:
>>>>> 2017-12-28 14:45:03,728-06 ERROR [org.ovirt.engine.core.bll.CreateOvaCommand]
>>>>> (EE-ManagedThreadFactory-engineScheduled-Thread-22) [38896e98]
>>>>> Exception: java.lang.NullPointerException
>>>>>
>>>>>
>>>>>>
>>>>>>
>>>>>>
>>>>>>
>>>>>> -------- Original Message --------
>>>>>> Subject: Re: [ovirt-users] Exporting/Copying VM to another oVirt
>>>>>> server
>>>>>> Local Time: December 28, 2017 2:41 PM
>>>>>> UTC Time: December 28, 2017 8:41 PM
>>>>>> From: ahadas at redhat.com
>>>>>> To: Alex Bartonek <Alex at unix1337.com>
>>>>>> users <users at ovirt.org>
>>>>>>
>>>>>>
>>>>>>
>>>>>> בתאריך 28 בדצמ׳ 2017 10:38 PM,‏ "Alex Bartonek" <Alex at unix1337.com>
>>>>>> כתב:
>>>>>>
>>>>>> After the success of getting my VM's working on my test server, I
>>>>>> decided to wipe out another server I had and wanted to move my VMs to it.
>>>>>> I tried the "Export" as ova and it seems to work but in the Tasks its red:
>>>>>>
>>>>>> "Exporting VM CentOS7 as an OVA to /ovirt_data/CentOS7.ova on Host
>>>>>> junkHost".
>>>>>>
>>>>>> The .ova is never created.   Is there another way to do this?  Both
>>>>>> servers are running 4.2.
>>>>>>
>>>>>> Googling hasnt helped me find a solution yet...
>>>>>>
>>>>>>
>>>>>> Can you please share engine.log?
>>>>>>
>>>>>>
>>>>>>
>>>>>> _______________________________________________
>>>>>> Users mailing list
>>>>>> Users at ovirt.org
>>>>>> http://lists.ovirt.org/mailman/listinfo/users
>>>>>>
>>>>>>
>>>>>>
>>>>>
>>>>
>>>
>>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.ovirt.org/pipermail/users/attachments/20171229/df3ea49f/attachment.html>


More information about the Users mailing list