Cool, glad to hear that it works now :) Filed a bug about that NPE [1] [1] https://bugzilla.redhat.com/show_bug.cgi?id=1529607
On Fri, Dec 29, 2017 at 1:09 AM, Alex Bartonek <[email protected]> wrote: > geez... yes, you were correct. I added the description to the VM not the > *disk*. :-/ > Sorry about that. That took care of it. Simple. Very cool!! Thank you > very much! > > > 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:57 PM > UTC Time: December 28, 2017 10:57 PM > From: [email protected] > To: Alex Bartonek <[email protected]> > users <[email protected]> > > 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 <[email protected]> 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: [email protected] >> To: Alex Bartonek <[email protected]> >> users <[email protected]> >> >> 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/nullpointere >> xception-in-java-with-no-stacktrace >> >> On Fri, Dec 29, 2017 at 12:25 AM, Alex Bartonek <[email protected]> >> 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@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@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@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@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@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: [email protected] >>> To: Alex Bartonek <[email protected]> >>> users <[email protected]> >>> >>> :/ >>> Can you please attach the new log? >>> >>> On Fri, Dec 29, 2017 at 12:18 AM, Alex Bartonek <[email protected]> >>> 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: [email protected] >>>> To: Alex Bartonek <[email protected]> >>>> users <[email protected]> >>>> >>>> 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 <[email protected]> >>>> 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: [email protected] >>>>> To: Alex Bartonek <[email protected]> >>>>> users <[email protected]> >>>>> >>>>> >>>>> >>>>> On Thu, Dec 28, 2017 at 11:28 PM, Alex Bartonek <[email protected]> >>>>> 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: [email protected] >>>>>> To: Alex Bartonek <[email protected]> >>>>>> users <[email protected]> >>>>>> >>>>>> >>>>>> >>>>>> On Thu, Dec 28, 2017 at 10:46 PM, Alex Bartonek <[email protected]> >>>>>> 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: [email protected] >>>>>>> To: Alex Bartonek <[email protected]> >>>>>>> users <[email protected]> >>>>>>> >>>>>>> >>>>>>> >>>>>>> בתאריך 28 בדצמ׳ 2017 10:38 PM, "Alex Bartonek" <[email protected]> >>>>>>> כתב: >>>>>>> >>>>>>> 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 >>>>>>> [email protected] >>>>>>> http://lists.ovirt.org/mailman/listinfo/users >>>>>>> >>>>>>> >>>>>>> >>>>>> >>>>> >>>> >>> >> >
_______________________________________________ Users mailing list [email protected] http://lists.ovirt.org/mailman/listinfo/users
