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/manage... On Fri, Dec 29, 2017 at 12:45 AM, Alex Bartonek <Alex@unix1337.com> wrote:
shut down the engine, deleted engine.log, started up and attached entire log. It does contain a java stack dump.
-------- Original Message -------- Subject: Re: [ovirt-users] Exporting/Copying VM to another oVirt server Local Time: December 28, 2017 4:36 PM UTC Time: December 28, 2017 10:36 PM From: ahadas@redhat.com To: Alex Bartonek <Alex@unix1337.com> users <users@ovirt.org>
That's weird that we don't get the stacktrace for that NPE, I wonder if we encounter the problem that was discussed in this old thread: [1] Could you restart the engine and try again, hoping that then we'll get the stacktrace (it was shown previously in the engine,log and was related to that empty disk description)
[1] https://stackoverflow.com/questions/2411487/ nullpointerexception-in-java-with-no-stacktrace
On Fri, Dec 29, 2017 at 12:25 AM, Alex Bartonek <Alex@unix1337.com> wrote:
2017-12-28 16:14:59,452-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engine-Thread-15462) [10f0e6a5] BaseAsyncTask::removeTaskFromDB: Removed task '3e1cfaa1-07a5-49cb-a9bc-8937c7cc75b2' from DataBase 2017-12-28 16:14:59,452-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-15462) [10f0e6a5] CommandAsyncTask::HandleEndActionResult [within thread]: Removing CommandMultiAsyncTasks object for entity '84686e92-7ca6-4228-9d3c-31289 b2d1d57' 2017-12-28 16:15:48,805-06 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory-engineScheduled-Thread-45) [] Setting new tasks map. The map contains now 1 tasks 2017-12-28 16:16:18,805-06 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory-engineScheduled-Thread-5) [] Setting new tasks map. The map contains now 0 tasks 2017-12-28 16:16:18,805-06 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory-engineScheduled-Thread-5) [] Cleared all tasks of pool '3bb4edf8-be27-42e4-b860-a1f1f293b81c'. 2017-12-28 16:21:17,538-06 INFO [org.ovirt.engine.core.bll.uti ls.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'default' is using 0 threads out of 1 and 5 tasks are waiting in the queue. 2017-12-28 16:21:17,538-06 INFO [org.ovirt.engine.core.bll.uti ls.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engine' is using 0 threads out of 500, 8 threads waiting for tasks and 0 tasks in queue. 2017-12-28 16:21:17,538-06 INFO [org.ovirt.engine.core.bll.uti ls.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engineScheduled' is using 0 threads out of 100 and 100 tasks are waiting in the queue. 2017-12-28 16:21:17,538-06 INFO [org.ovirt.engine.core.bll.uti ls.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'engineThreadMonitoring' is using 1 threads out of 1 and 0 tasks are waiting in the queue. 2017-12-28 16:21:17,538-06 INFO [org.ovirt.engine.core.bll.uti ls.ThreadPoolMonitoringService] (EE-ManagedThreadFactory-engineThreadMonitoring-Thread-1) [] Thread pool 'hostUpdatesChecker' is using 0 threads out of 5 and 2 tasks are waiting in the queue. 2017-12-28 16:21:28,068-06 INFO [org.ovirt.engine.core.bll.exportimport.ExportOvaCommand] (default task-39) [aa503a62-d439-4131-9b46-e161779847f4] Lock Acquired to object 'EngineLock:{exclusiveLocks='[43c82580-6c7a-4319-97f6-6cfb17a4445a=VM]', sharedLocks=''}' 2017-12-28 16:21:28,082-06 INFO [org.ovirt.engine.core.common.utils.ansible.AnsibleExecutor] (default task-39) [aa503a62-d439-4131-9b46-e161779847f4] Executing Ansible command: [/usr/bin/ansible-playbook, --private-key=/etc/pki/ovirt-engine/keys/engine_id_rsa, --inventory=/tmp/ansible-inventory8939720115375947799, --extra-vars=target_directory=/media/primary/extra_space, --extra-vars=validate_only=True, /usr/share/ovirt-engine/playbooks/ovirt-ova-export.yml] [Logfile: /var/log/ovirt-engine/ova/ovirt-export-ova-validate-ansible- 20171228162128-reindeer.themagicm.com-aa503a62-d439- 4131-9b46-e161779847f4.log] 2017-12-28 16:21:32,496-06 INFO [org.ovirt.engine.core.common.utils.ansible.AnsibleExecutor] (default task-39) [aa503a62-d439-4131-9b46-e161779847f4] Ansible playbook command has exited with value: 0 2017-12-28 16:21:32,548-06 INFO [org.ovirt.engine.core.bll.exportimport.ExportOvaCommand] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] Running command: ExportOvaCommand internal: false. Entities affected : ID: 43c82580-6c7a-4319-97f6-6cfb17a4445a Type: VMAction group IMPORT_EXPORT_VM with role type ADMIN 2017-12-28 16:21:32,584-06 INFO [org.ovirt.engine.core.bll.sto rage.disk.CreateAllOvaDisksCommand] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] Running command: CreateAllOvaDisksCommand internal: true. 2017-12-28 16:21:32,645-06 INFO [org.ovirt.engine.core.bll.sto rage.disk.image.CopyImageGroupCommand] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] Running command: CopyImageGroupCommand internal: true. Entities affected : ID: 4108dd94-7538-4fdb-a01e-2eb51b9083b9 Type: Storage 2017-12-28 16:21:32,757-06 INFO [org.ovirt.engine.core.vdsbrok er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] START, CopyImageVDSCommand( CopyImageVDSCommandParameters:{storagePoolId='3bb4edf8-be27-42e4-b860-a1f1f293b81c', ignoreFailoverLimit='false', storageDomainId='4108dd94-7538-4fdb-a01e-2eb51b9083b9', imageGroupId='5499e522-db23-4a71-b5a2-e30933d7d547', imageId='5770b269-f98f-4d12-b627-e960b9e295b4', dstImageGroupId='a2578b49-5edf-47b8-a98a-12a20b47688c', vmId='43c82580-6c7a-4319-97f6-6cfb17a4445a', dstImageId='34885dca-e1c6-4e92-9f06-957a63c0ae56', imageDescription='', dstStorageDomainId='4108dd94-7538-4fdb-a01e-2eb51b9083b9', copyVolumeType='LeafVol', volumeFormat='COW', preallocate='Sparse', postZero='false', discard='false', force='true'}), log id: 40b6c4b9 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbrok er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] -- executeIrsBrokerCommand: calling 'copyImage' with two new parameters: description and UUID. Parameters: 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbrok er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] ++ sdUUID=4108dd94-7538-4fdb-a01e -2eb51b9083b9 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbrok er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] ++ spUUID=3bb4edf8-be27-42e4-b860 -a1f1f293b81c 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbrok er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] ++ vmGUID=43c82580-6c7a-4319-97f6 -6cfb17a4445a 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbrok er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] ++ srcImageGUID=5499e522-db23-4a7 1-b5a2-e30933d7d547 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbrok er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] ++ srcVolUUID=5770b269-f98f-4d12- b627-e960b9e295b4 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbrok er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] ++ dstImageGUID=a2578b49-5edf-47b 8-a98a-12a20b47688c 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbrok er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] ++ dstVolUUID=34885dca-e1c6-4e92- 9f06-957a63c0ae56 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbrok er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] ++ descr= 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbrok er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] ++ dstSdUUID=4108dd94-7538-4fdb-a 01e-2eb51b9083b9 2017-12-28 16:21:32,858-06 INFO [org.ovirt.engine.core.vdsbrok er.irsbroker.CopyImageVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] FINISH, CopyImageVDSCommand, return: f543383a-f369-488a-b625-73706b871a51, log id: 40b6c4b9 2017-12-28 16:21:32,875-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] CommandAsyncTask::Adding CommandMultiAsyncTasks object for command 'd8db5f12-cf59-40d2-b1b9-d5e44 79766a3' 2017-12-28 16:21:32,876-06 INFO [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] CommandMultiAsyncTasks::attachTask: Attaching task 'f543383a-f369-488a-b625-73706b871a51' to command 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3'. 2017-12-28 16:21:32,906-06 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] Adding task 'f543383a-f369-488a-b625-73706b871a51' (Parent Command 'CopyImageGroup', Parameters Type 'org.ovirt.engine.core.common. asynctasks.AsyncTaskParameters'), polling hasn't started yet.. 2017-12-28 16:21:32,948-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] BaseAsyncTask::startPollingTask: Starting to poll task 'f543383a-f369-488a-b625-73706b871a51'. 2017-12-28 16:21:32,991-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] BaseAsyncTask::startPollingTask: Starting to poll task 'f543383a-f369-488a-b625-73706b871a51'. 2017-12-28 16:21:33,054-06 INFO [org.ovirt.engine.core.dal.dbb roker.auditloghandling.AuditLogDirector] (EE-ManagedThreadFactory-engine-Thread-15515) [aa503a62-d439-4131-9b46-e161779847f4] EVENT_ID: IMPORTEXPORT_STARTING_EXPORT_VM_TO_OVA(1,223), Starting to export Vm CentOS7 as a Virtual Appliance 2017-12-28 16:21:34,769-06 INFO [org.ovirt.engine.core.bll.Con currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-29) [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id: '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id: 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete 2017-12-28 16:21:34,865-06 INFO [org.ovirt.engine.core.bll.Ser ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-29) [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id: '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id: '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to complete 2017-12-28 16:21:38,872-06 INFO [org.ovirt.engine.core.bll.Con currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-77) [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id: '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id: 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete 2017-12-28 16:21:38,883-06 INFO [org.ovirt.engine.core.bll.Ser ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-77) [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id: '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id: '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to complete 2017-12-28 16:21:39,355-06 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory-engineScheduled-Thread-64) [] Polling and updating Async Tasks: 1 tasks, 1 tasks to poll now 2017-12-28 16:21:39,366-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engineScheduled-Thread-64) [] SPMAsyncTask::PollTask: Polling task 'f543383a-f369-488a-b625-73706b871a51' (Parent Command 'CopyImageGroup', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') returned status 'running'. 2017-12-28 16:21:39,367-06 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory-engineScheduled-Thread-64) [] Finished polling Tasks, will poll again in 10 seconds. 2017-12-28 16:21:46,893-06 INFO [org.ovirt.engine.core.bll.Con currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-7) [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id: '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id: 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete 2017-12-28 16:21:46,903-06 INFO [org.ovirt.engine.core.bll.Ser ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-7) [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id: '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id: '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to complete 2017-12-28 16:21:56,916-06 INFO [org.ovirt.engine.core.bll.Con currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-92) [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id: '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id: 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete 2017-12-28 16:21:56,926-06 INFO [org.ovirt.engine.core.bll.Ser ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-92) [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id: '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id: '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to complete 2017-12-28 16:22:06,935-06 INFO [org.ovirt.engine.core.bll.Con currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-38) [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id: '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id: 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete 2017-12-28 16:22:06,945-06 INFO [org.ovirt.engine.core.bll.Ser ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-38) [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id: '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id: '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to complete 2017-12-28 16:22:16,956-06 INFO [org.ovirt.engine.core.bll.Con currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-15) [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id: '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id: 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete 2017-12-28 16:22:16,966-06 INFO [org.ovirt.engine.core.bll.Ser ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-15) [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id: '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id: '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to complete 2017-12-28 16:22:26,974-06 INFO [org.ovirt.engine.core.bll.Con currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-58) [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id: '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id: 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete 2017-12-28 16:22:26,995-06 INFO [org.ovirt.engine.core.bll.Ser ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-58) [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id: '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id: '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to complete 2017-12-28 16:22:37,004-06 INFO [org.ovirt.engine.core.bll.Con currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-2) [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id: '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id: 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete 2017-12-28 16:22:37,016-06 INFO [org.ovirt.engine.core.bll.Ser ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-2) [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id: '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id: '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to complete 2017-12-28 16:22:47,023-06 INFO [org.ovirt.engine.core.bll.Con currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-5) [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id: '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id: 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete 2017-12-28 16:22:47,036-06 INFO [org.ovirt.engine.core.bll.Ser ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-5) [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id: '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id: '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to complete 2017-12-28 16:22:57,045-06 INFO [org.ovirt.engine.core.bll.Con currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-77) [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' (id: '42331a77-2e38-4653-ba5f-29e5dccaea69') waiting on child command id: 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' type:'CopyImageGroup' to complete 2017-12-28 16:22:57,055-06 INFO [org.ovirt.engine.core.bll.Ser ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-77) [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id: '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id: '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to complete 2017-12-28 16:22:59,497-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engineScheduled-Thread-23) [] SPMAsyncTask::PollTask: Polling task 'f543383a-f369-488a-b625-73706b871a51' (Parent Command 'CopyImageGroup', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') returned status 'finished', result 'success'. 2017-12-28 16:22:59,503-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engineScheduled-Thread-23) [] BaseAsyncTask::onTaskEndSuccess: Task 'f543383a-f369-488a-b625-73706b871a51' (Parent Command 'CopyImageGroup', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') ended successfully. 2017-12-28 16:22:59,504-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engineScheduled-Thread-23) [] CommandAsyncTask::endActionIfNecessary: All tasks of command 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' has ended -> executing 'endAction' 2017-12-28 16:22:59,505-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engineScheduled-Thread-23) [] CommandAsyncTask::endAction: Ending action for '1' tasks (command ID: 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3'): calling endAction '. 2017-12-28 16:22:59,505-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-15528) [] CommandAsyncTask::endCommandAction [within thread] context: Attempting to endAction 'CopyImageGroup', 2017-12-28 16:22:59,515-06 INFO [org.ovirt.engine.core.bll.sto rage.disk.image.CopyImageGroupCommand] (EE-ManagedThreadFactory-engine-Thread-15528) [aa503a62-d439-4131-9b46-e161779847f4] Command [id=d8db5f12-cf59-40d2-b1b9-d5e4479766a3]: Updating status to 'SUCCEEDED', The command end method logic will be executed by one of its parent commands. 2017-12-28 16:22:59,516-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-15528) [aa503a62-d439-4131-9b46-e161779847f4] CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type 'CopyImageGroup' completed, handling the result. 2017-12-28 16:22:59,516-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-15528) [aa503a62-d439-4131-9b46-e161779847f4] CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type 'CopyImageGroup' succeeded, clearing tasks. 2017-12-28 16:22:59,516-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engine-Thread-15528) [aa503a62-d439-4131-9b46-e161779847f4] SPMAsyncTask::ClearAsyncTask: Attempting to clear task 'f543383a-f369-488a-b625-73706b871a51' 2017-12-28 16:22:59,518-06 INFO [org.ovirt.engine.core.vdsbrok er.irsbroker.SPMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15528) [aa503a62-d439-4131-9b46-e161779847f4] START, SPMClearTaskVDSCommand( SPMTaskGuidBaseVDSCommandParameters:{storagePoolId='3bb4edf8-be27-42e4-b860-a1f1f293b81c', ignoreFailoverLimit='false', taskId='f543383a-f369-488a-b625-73706b871a51'}), log id: 2e9c1d1 2017-12-28 16:22:59,521-06 INFO [org.ovirt.engine.core.vdsbrok er.vdsbroker.HSMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15528) [aa503a62-d439-4131-9b46-e161779847f4] START, HSMClearTaskVDSCommand(HostName = reindeerHost, HSMTaskGuidBaseVDSCommandParameters:{hostId='4f344875-08d8-49d8-b2ee-5ca3e1810051', taskId='f543383a-f369-488a-b625-73706b871a51'}), log id: 4ad7abb5 2017-12-28 16:22:59,535-06 INFO [org.ovirt.engine.core.vdsbrok er.vdsbroker.HSMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15528) [aa503a62-d439-4131-9b46-e161779847f4] FINISH, HSMClearTaskVDSCommand, log id: 4ad7abb5 2017-12-28 16:22:59,535-06 INFO [org.ovirt.engine.core.vdsbrok er.irsbroker.SPMClearTaskVDSCommand] (EE-ManagedThreadFactory-engine-Thread-15528) [aa503a62-d439-4131-9b46-e161779847f4] FINISH, SPMClearTaskVDSCommand, log id: 2e9c1d1 2017-12-28 16:22:59,545-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory-engine-Thread-15528) [aa503a62-d439-4131-9b46-e161779847f4] BaseAsyncTask::removeTaskFromDB: Removed task 'f543383a-f369-488a-b625-73706b871a51' from DataBase 2017-12-28 16:22:59,546-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory-engine-Thread-15528) [aa503a62-d439-4131-9b46-e161779847f4] CommandAsyncTask::HandleEndActionResult [within thread]: Removing CommandMultiAsyncTasks object for entity 'd8db5f12-cf59-40d2-b1b9-d5e4479766a3' 2017-12-28 16:23:07,064-06 INFO [org.ovirt.engine.core.bll.Con currentChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-45) [aa503a62-d439-4131-9b46-e161779847f4] Command 'CreateAllOvaDisks' id: '42331a77-2e38-4653-ba5f-29e5dccaea69' child commands '[d8db5f12-cf59-40d2-b1b9-d5e4479766a3]' executions were completed, status 'SUCCEEDED' 2017-12-28 16:23:07,078-06 INFO [org.ovirt.engine.core.bll.Ser ialChildCommandsExecutionCallback] (EE-ManagedThreadFactory-engineScheduled-Thread-45) [aa503a62-d439-4131-9b46-e161779847f4] Command 'ExportOva' (id: '22e1df85-794b-4bb6-a6b6-a1679cbe2f78') waiting on child command id: '42331a77-2e38-4653-ba5f-29e5dccaea69' type:'CreateAllOvaDisks' to complete 2017-12-28 16:23:08,089-06 INFO [org.ovirt.engine.core.bll.sto rage.disk.CreateAllOvaDisksCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61) [aa503a62-d439-4131-9b46-e161779847f4] Ending command 'org.ovirt.engine.core.bll.storage.disk.CreateAllOvaDisksCommand' successfully. 2017-12-28 16:23:08,106-06 INFO [org.ovirt.engine.core.bll.sto rage.disk.image.CopyImageGroupCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61) [aa503a62-d439-4131-9b46-e161779847f4] Ending command 'org.ovirt.engine.core.bll.storage.disk.image.CopyImageGroupCommand' successfully. 2017-12-28 16:23:08,118-06 INFO [org.ovirt.engine.core.vdsbrok er.irsbroker.GetImageInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61) [aa503a62-d439-4131-9b46-e161779847f4] START, GetImageInfoVDSCommand( GetImageInfoVDSCommandParameters:{storagePoolId='3bb4edf8-be27-42e4-b860-a1f1f293b81c', ignoreFailoverLimit='false', storageDomainId='4108dd94-7538-4fdb-a01e-2eb51b9083b9', imageGroupId='a2578b49-5edf-47b8-a98a-12a20b47688c', imageId='34885dca-e1c6-4e92-9f06-957a63c0ae56'}), log id: 2cec8f8 2017-12-28 16:23:08,122-06 INFO [org.ovirt.engine.core.vdsbrok er.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61) [aa503a62-d439-4131-9b46-e161779847f4] START, GetVolumeInfoVDSCommand(HostName = reindeerHost, GetVolumeInfoVDSCommandParameters:{hostId='4f344875-08d8-49d8-b2ee-5ca3e1810051', storagePoolId='3bb4edf8-be27-42e4-b860-a1f1f293b81c', storageDomainId='4108dd94-7538-4fdb-a01e-2eb51b9083b9', imageGroupId='a2578b49-5edf-47b8-a98a-12a20b47688c', imageId='34885dca-e1c6-4e92-9f06-957a63c0ae56'}), log id: c3fea19 2017-12-28 16:23:08,135-06 INFO [org.ovirt.engine.core.vdsbrok er.vdsbroker.GetVolumeInfoVDSCommand] (EE-ManagedThreadFactory-engineScheduled-Thread-61) [aa503a62-d439-4131-9b46-e161779847f4] FINISH, GetVolumeInfoVDSCommand, return: org.ovirt.engine.core.common.businessentities.storage.DiskIm age@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: ahadas@redhat.com To: Alex Bartonek <Alex@unix1337.com> users <users@ovirt.org>
:/ Can you please attach the new log?
On Fri, Dec 29, 2017 at 12:18 AM, Alex Bartonek <Alex@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@redhat.com To: Alex Bartonek <Alex@unix1337.com> users <users@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@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@redhat.com To: Alex Bartonek <Alex@unix1337.com> users <users@ovirt.org>
On Thu, Dec 28, 2017 at 11:28 PM, Alex Bartonek <Alex@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@redhat.com To: Alex Bartonek <Alex@unix1337.com> users <users@ovirt.org>
On Thu, Dec 28, 2017 at 10:46 PM, Alex Bartonek <Alex@unix1337.com> wrote:
Log uploaded to:
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@redhat.com To: Alex Bartonek <Alex@unix1337.com> users <users@ovirt.org>
בתאריך 28 בדצמ׳ 2017 10:38 PM, "Alex Bartonek" <Alex@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@ovirt.org http://lists.ovirt.org/mailman/listinfo/users