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

Arik Hadas ahadas at redhat.com
Thu Dec 28 22:36:40 UTC 2017 

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-
> 31289b2d1d57'
> 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.utils.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.utils.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.utils.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.utils.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.utils.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.storage.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.
> storage.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.
> vdsbroker.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.
> vdsbroker.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.
> vdsbroker.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.
> vdsbroker.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.
> vdsbroker.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.
> vdsbroker.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515)
> [aa503a62-d439-4131-9b46-e161779847f4] ++ srcImageGUID=5499e522-db23-
> 4a71-b5a2-e30933d7d547
> 2017-12-28 16:21:32,760-06 INFO  [org.ovirt.engine.core.
> vdsbroker.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.
> vdsbroker.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515)
> [aa503a62-d439-4131-9b46-e161779847f4] ++ dstImageGUID=a2578b49-5edf-
> 47b8-a98a-12a20b47688c
> 2017-12-28 16:21:32,760-06 INFO  [org.ovirt.engine.core.
> vdsbroker.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.
> vdsbroker.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.
> vdsbroker.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515)
> [aa503a62-d439-4131-9b46-e161779847f4] ++ dstSdUUID=4108dd94-7538-4fdb-
> a01e-2eb51b9083b9
> 2017-12-28 16:21:32,858-06 INFO  [org.ovirt.engine.core.
> vdsbroker.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-d5e4479766a3'
> 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.
> dbbroker.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.
> ConcurrentChildCommandsExecutionCallback] (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.
> SerialChildCommandsExecutionCallback] (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.
> ConcurrentChildCommandsExecutionCallback] (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.
> SerialChildCommandsExecutionCallback] (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.
> ConcurrentChildCommandsExecutionCallback] (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.
> SerialChildCommandsExecutionCallback] (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.
> ConcurrentChildCommandsExecutionCallback] (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.
> SerialChildCommandsExecutionCallback] (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.
> ConcurrentChildCommandsExecutionCallback] (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.
> SerialChildCommandsExecutionCallback] (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.
> ConcurrentChildCommandsExecutionCallback] (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.
> SerialChildCommandsExecutionCallback] (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.
> ConcurrentChildCommandsExecutionCallback] (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.
> SerialChildCommandsExecutionCallback] (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.
> ConcurrentChildCommandsExecutionCallback] (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.
> SerialChildCommandsExecutionCallback] (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.
> ConcurrentChildCommandsExecutionCallback] (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.
> SerialChildCommandsExecutionCallback] (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.
> ConcurrentChildCommandsExecutionCallback] (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.
> SerialChildCommandsExecutionCallback] (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.
> storage.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.
> vdsbroker.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.
> vdsbroker.vdsbroker.HSMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15528)
> [aa503a62-d439-4131-9b46-e161779847f4] START, HSMClearTaskVDSCommand(HostName
> = reindeerHost, HSMTaskGuidBaseVDSCommandParam
> eters:{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.
> vdsbroker.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.
> vdsbroker.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.
> ConcurrentChildCommandsExecutionCallback] (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.
> SerialChildCommandsExecutionCallback] (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.storage.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.
> storage.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.
> vdsbroker.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.
> vdsbroker.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.
> vdsbroker.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
> [aa503a62-d439-4131-9b46-e161779847f4] FINISH, GetVolumeInfoVDSCommand,
> return: org.ovirt.engine.core.common.businessentities.storage.
> DiskImage at 95bb5b65, log id: c3fea19
> 2017-12-28 16:23:08,135-06 INFO  [org.ovirt.engine.core.
> vdsbroker.irsbroker.GetImageInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
> [aa503a62-d439-4131-9b46-e161779847f4] FINISH, GetImageInfoVDSCommand,
> return: org.ovirt.engine.core.common.businessentities.storage.
> DiskImage at 95bb5b65, log id: 2cec8f8
> 2017-12-28 16:23:08,232-06 INFO  [org.ovirt.engine.core.
> vdsbroker.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.
> vdsbroker.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.
> vdsbroker.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.
> vdsbroker.vdsbroker.GetQemuImageInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61)
> [aa503a62-d439-4131-9b46-e161779847f4] FINISH,
> GetQemuImageInfoVDSCommand, return: org.ovirt.engine.core.common.
> businessentities.storage.QemuImageInfo at 3412697c, log id: 1fb3c78e
> 2017-12-28 16:23:08,499-06 INFO  [org.ovirt.engine.core.
> vdsbroker.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.
> vdsbroker.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.
> vdsbroker.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.
> vdsbroker.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.
> vdsbroker.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.
> vdsbroker.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.
> SerialChildCommandsExecutionCallback] (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.
> SerialChildCommandsExecutionCallback] (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.
> dbbroker.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.
> storage.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.
> vdsbroker.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.
> vdsbroker.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.
> dbbroker.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.
> vdsbroker.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.
> vdsbroker.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.
> vdsbroker.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.
> vdsbroker.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-
> 83f04da2de73'
> 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/18377d21/attachment.html>

More information about the Users mailing list