2017-12-28 16:14:59,452-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15462) [10f0e6a5] BaseAsyncTask:: removeTaskFromDB: Removed task '3e1cfaa1-07a5-49cb-a9bc- 8937c7cc75b2' from DataBase 2017-12-28 16:14:59,452-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15462) [10f0e6a5] CommandAsyncTask:: HandleEndActionResult [within thread]: Removing CommandMultiAsyncTasks object for entity '84686e92-7ca6-4228-9d3c- 31289b2d1d57' 2017-12-28 16:15:48,805-06 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory- engineScheduled-Thread-45) [] Setting new tasks map. The map contains now 1 tasks 2017-12-28 16:16:18,805-06 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory- engineScheduled-Thread-5) [] Setting new tasks map. The map contains now 0 tasks 2017-12-28 16:16:18,805-06 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory- engineScheduled-Thread-5) [] Cleared all tasks of pool '3bb4edf8-be27-42e4-b860- a1f1f293b81c'. 2017-12-28 16:21:17,538-06 INFO [org.ovirt.engine.core.bll.utils. ThreadPoolMonitoringService] (EE-ManagedThreadFactory- engineThreadMonitoring-Thread- 1) [] Thread pool 'default' is using 0 threads out of 1 and 5 tasks are waiting in the queue. 2017-12-28 16:21:17,538-06 INFO [org.ovirt.engine.core.bll.utils. ThreadPoolMonitoringService] (EE-ManagedThreadFactory- engineThreadMonitoring-Thread- 1) [] Thread pool 'engine' is using 0 threads out of 500, 8 threads waiting for tasks and 0 tasks in queue. 2017-12-28 16:21:17,538-06 INFO [org.ovirt.engine.core.bll.utils. ThreadPoolMonitoringService] (EE-ManagedThreadFactory- engineThreadMonitoring-Thread- 1) [] Thread pool 'engineScheduled' is using 0 threads out of 100 and 100 tasks are waiting in the queue. 2017-12-28 16:21:17,538-06 INFO [org.ovirt.engine.core.bll.utils. ThreadPoolMonitoringService] (EE-ManagedThreadFactory- engineThreadMonitoring-Thread- 1) [] Thread pool 'engineThreadMonitoring' is using 1 threads out of 1 and 0 tasks are waiting in the queue. 2017-12-28 16:21:17,538-06 INFO [org.ovirt.engine.core.bll.utils. ThreadPoolMonitoringService] (EE-ManagedThreadFactory- engineThreadMonitoring-Thread- 1) [] Thread pool 'hostUpdatesChecker' is using 0 threads out of 5 and 2 tasks are waiting in the queue. 2017-12-28 16:21:28,068-06 INFO [org.ovirt.engine.core.bll.exportimport.ExportOvaCommand] (default task-39) [aa503a62-d439-4131-9b46- e161779847f4] Lock Acquired to object 'EngineLock:{exclusiveLocks='[ 43c82580-6c7a-4319-97f6- 6cfb17a4445a=VM]', sharedLocks=''}' 2017-12-28 16:21:28,082-06 INFO [org.ovirt.engine.core.common.utils.ansible.AnsibleExecutor] (default task-39) [aa503a62-d439-4131-9b46- e161779847f4] Executing Ansible command: [/usr/bin/ansible-playbook, --private-key=/etc/pki/ovirt- engine/keys/engine_id_rsa, --inventory=/tmp/ansible- inventory8939720115375947799, --extra-vars=target_directory= /media/primary/extra_space, --extra-vars=validate_only= True, /usr/share/ovirt-engine/ playbooks/ovirt-ova-export. yml] [Logfile: /var/log/ovirt-engine/ova/ ovirt-export-ova-validate- ansible-20171228162128- reindeer.themagicm.com- aa503a62-d439-4131-9b46- e161779847f4.log] 2017-12-28 16:21:32,496-06 INFO [org.ovirt.engine.core.common.utils.ansible.AnsibleExecutor] (default task-39) [aa503a62-d439-4131-9b46- e161779847f4] Ansible playbook command has exited with value: 0 2017-12-28 16:21:32,548-06 INFO [org.ovirt.engine.core.bll.exportimport.ExportOvaCommand] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] Running command: ExportOvaCommand internal: false. Entities affected : ID: 43c82580-6c7a-4319-97f6- 6cfb17a4445a Type: VMAction group IMPORT_EXPORT_VM with role type ADMIN 2017-12-28 16:21:32,584-06 INFO [org.ovirt.engine.core.bll.storage.disk. CreateAllOvaDisksCommand] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] Running command: CreateAllOvaDisksCommand internal: true. 2017-12-28 16:21:32,645-06 INFO [org.ovirt.engine.core.bll.storage.disk.image. CopyImageGroupCommand] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] Running command: CopyImageGroupCommand internal: true. Entities affected : ID: 4108dd94-7538-4fdb-a01e- 2eb51b9083b9 Type: Storage 2017-12-28 16:21:32,757-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. CopyImageVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] START, CopyImageVDSCommand( CopyImageVDSCommandParameters: {storagePoolId='3bb4edf8-be27- 42e4-b860-a1f1f293b81c', ignoreFailoverLimit='false', storageDomainId='4108dd94- 7538-4fdb-a01e-2eb51b9083b9', imageGroupId='5499e522-db23- 4a71-b5a2-e30933d7d547', imageId='5770b269-f98f-4d12- b627-e960b9e295b4', dstImageGroupId='a2578b49- 5edf-47b8-a98a-12a20b47688c', vmId='43c82580-6c7a-4319-97f6- 6cfb17a4445a', dstImageId='34885dca-e1c6- 4e92-9f06-957a63c0ae56', imageDescription='', dstStorageDomainId='4108dd94- 7538-4fdb-a01e-2eb51b9083b9', copyVolumeType='LeafVol', volumeFormat='COW', preallocate='Sparse', postZero='false', discard='false', force='true'}), log id: 40b6c4b9 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. CopyImageVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] -- executeIrsBrokerCommand: calling 'copyImage' with two new parameters: description and UUID. Parameters: 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. CopyImageVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] ++ sdUUID=4108dd94-7538-4fdb- a01e-2eb51b9083b9 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. CopyImageVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] ++ spUUID=3bb4edf8-be27-42e4- b860-a1f1f293b81c 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. CopyImageVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] ++ vmGUID=43c82580-6c7a-4319- 97f6-6cfb17a4445a 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. CopyImageVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] ++ srcImageGUID=5499e522-db23- 4a71-b5a2-e30933d7d547 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. CopyImageVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] ++ srcVolUUID=5770b269-f98f-4d12- b627-e960b9e295b4 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. CopyImageVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] ++ dstImageGUID=a2578b49-5edf- 47b8-a98a-12a20b47688c 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. CopyImageVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] ++ dstVolUUID=34885dca-e1c6-4e92- 9f06-957a63c0ae56 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. CopyImageVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] ++ descr= 2017-12-28 16:21:32,760-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. CopyImageVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] ++ dstSdUUID=4108dd94-7538-4fdb- a01e-2eb51b9083b9 2017-12-28 16:21:32,858-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. CopyImageVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] FINISH, CopyImageVDSCommand, return: f543383a-f369-488a-b625- 73706b871a51, log id: 40b6c4b9 2017-12-28 16:21:32,875-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] CommandAsyncTask::Adding CommandMultiAsyncTasks object for command 'd8db5f12-cf59-40d2-b1b9- d5e4479766a3' 2017-12-28 16:21:32,876-06 INFO [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] CommandMultiAsyncTasks:: attachTask: Attaching task 'f543383a-f369-488a-b625- 73706b871a51' to command 'd8db5f12-cf59-40d2-b1b9- d5e4479766a3'. 2017-12-28 16:21:32,906-06 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] Adding task 'f543383a-f369-488a-b625- 73706b871a51' (Parent Command 'CopyImageGroup', Parameters Type 'org.ovirt.engine.core.common. asynctasks. AsyncTaskParameters'), polling hasn't started yet.. 2017-12-28 16:21:32,948-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] BaseAsyncTask:: startPollingTask: Starting to poll task 'f543383a-f369-488a-b625- 73706b871a51'. 2017-12-28 16:21:32,991-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] BaseAsyncTask:: startPollingTask: Starting to poll task 'f543383a-f369-488a-b625- 73706b871a51'. 2017-12-28 16:21:33,054-06 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling. AuditLogDirector] (EE-ManagedThreadFactory- engine-Thread-15515) [aa503a62-d439-4131-9b46- e161779847f4] EVENT_ID: IMPORTEXPORT_STARTING_EXPORT_ VM_TO_OVA(1,223), Starting to export Vm CentOS7 as a Virtual Appliance 2017-12-28 16:21:34,769-06 INFO [org.ovirt.engine.core.bll.ConcurrentChildCommandsExecuti onCallback] (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.SerialChildCommandsExecutionCa llback] (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.ConcurrentChildCommandsExecuti onCallback] (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.SerialChildCommandsExecutionCa llback] (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.ConcurrentChildCommandsExecuti onCallback] (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.SerialChildCommandsExecutionCa llback] (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.ConcurrentChildCommandsExecuti onCallback] (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.SerialChildCommandsExecutionCa llback] (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.ConcurrentChildCommandsExecuti onCallback] (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.SerialChildCommandsExecutionCa llback] (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.ConcurrentChildCommandsExecuti onCallback] (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.SerialChildCommandsExecutionCa llback] (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.ConcurrentChildCommandsExecuti onCallback] (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.SerialChildCommandsExecutionCa llback] (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.ConcurrentChildCommandsExecuti onCallback] (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.SerialChildCommandsExecutionCa llback] (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.ConcurrentChildCommandsExecuti onCallback] (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.SerialChildCommandsExecutionCa llback] (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.ConcurrentChildCommandsExecuti onCallback] (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.SerialChildCommandsExecutionCa llback] (EE-ManagedThreadFactory- engineScheduled-Thread-77) [aa503a62-d439-4131-9b46- e161779847f4] Command 'ExportOva' (id: '22e1df85-794b-4bb6-a6b6- a1679cbe2f78') waiting on child command id: '42331a77-2e38-4653-ba5f- 29e5dccaea69' type:'CreateAllOvaDisks' to complete 2017-12-28 16:22:59,497-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory- engineScheduled-Thread-23) [] SPMAsyncTask::PollTask: Polling task 'f543383a-f369-488a-b625- 73706b871a51' (Parent Command 'CopyImageGroup', Parameters Type 'org.ovirt.engine.core.common. asynctasks. AsyncTaskParameters') returned status 'finished', result 'success'. 2017-12-28 16:22:59,503-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory- engineScheduled-Thread-23) [] BaseAsyncTask:: onTaskEndSuccess: Task 'f543383a-f369-488a-b625- 73706b871a51' (Parent Command 'CopyImageGroup', Parameters Type 'org.ovirt.engine.core.common. asynctasks. AsyncTaskParameters') ended successfully. 2017-12-28 16:22:59,504-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory- engineScheduled-Thread-23) [] CommandAsyncTask:: endActionIfNecessary: All tasks of command 'd8db5f12-cf59-40d2-b1b9- d5e4479766a3' has ended -> executing 'endAction' 2017-12-28 16:22:59,505-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory- engineScheduled-Thread-23) [] CommandAsyncTask::endAction: Ending action for '1' tasks (command ID: 'd8db5f12-cf59-40d2-b1b9- d5e4479766a3'): calling endAction '. 2017-12-28 16:22:59,505-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15528) [] CommandAsyncTask:: endCommandAction [within thread] context: Attempting to endAction 'CopyImageGroup', 2017-12-28 16:22:59,515-06 INFO [org.ovirt.engine.core.bll.storage.disk.image. CopyImageGroupCommand] (EE-ManagedThreadFactory- engine-Thread-15528) [aa503a62-d439-4131-9b46- e161779847f4] Command [id=d8db5f12-cf59-40d2-b1b9- d5e4479766a3]: Updating status to 'SUCCEEDED', The command end method logic will be executed by one of its parent commands. 2017-12-28 16:22:59,516-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15528) [aa503a62-d439-4131-9b46- e161779847f4] CommandAsyncTask:: HandleEndActionResult [within thread]: endAction for action type 'CopyImageGroup' completed, handling the result. 2017-12-28 16:22:59,516-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15528) [aa503a62-d439-4131-9b46- e161779847f4] CommandAsyncTask:: HandleEndActionResult [within thread]: endAction for action type 'CopyImageGroup' succeeded, clearing tasks. 2017-12-28 16:22:59,516-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15528) [aa503a62-d439-4131-9b46- e161779847f4] SPMAsyncTask::ClearAsyncTask: Attempting to clear task 'f543383a-f369-488a-b625- 73706b871a51' 2017-12-28 16:22:59,518-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. SPMClearTaskVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15528) [aa503a62-d439-4131-9b46- e161779847f4] START, SPMClearTaskVDSCommand( SPMTaskGuidBaseVDSCommandParam eters:{storagePoolId=' 3bb4edf8-be27-42e4-b860- a1f1f293b81c', ignoreFailoverLimit='false', taskId='f543383a-f369-488a- b625-73706b871a51'}), log id: 2e9c1d1 2017-12-28 16:22:59,521-06 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker. HSMClearTaskVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15528) [aa503a62-d439-4131-9b46- e161779847f4] START, HSMClearTaskVDSCommand( HostName = reindeerHost, HSMTaskGuidBaseVDSCommandParam eters:{hostId='4f344875-08d8- 49d8-b2ee-5ca3e1810051', taskId='f543383a-f369-488a- b625-73706b871a51'}), log id: 4ad7abb5 2017-12-28 16:22:59,535-06 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker. HSMClearTaskVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15528) [aa503a62-d439-4131-9b46- e161779847f4] FINISH, HSMClearTaskVDSCommand, log id: 4ad7abb5 2017-12-28 16:22:59,535-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. SPMClearTaskVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15528) [aa503a62-d439-4131-9b46- e161779847f4] FINISH, SPMClearTaskVDSCommand, log id: 2e9c1d1 2017-12-28 16:22:59,545-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15528) [aa503a62-d439-4131-9b46- e161779847f4] BaseAsyncTask:: removeTaskFromDB: Removed task 'f543383a-f369-488a-b625- 73706b871a51' from DataBase 2017-12-28 16:22:59,546-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15528) [aa503a62-d439-4131-9b46- e161779847f4] CommandAsyncTask:: HandleEndActionResult [within thread]: Removing CommandMultiAsyncTasks object for entity 'd8db5f12-cf59-40d2-b1b9- d5e4479766a3' 2017-12-28 16:23:07,064-06 INFO [org.ovirt.engine.core.bll.ConcurrentChildCommandsExecuti onCallback] (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.SerialChildCommandsExecutionCa llback] (EE-ManagedThreadFactory- engineScheduled-Thread-45) [aa503a62-d439-4131-9b46- e161779847f4] Command 'ExportOva' (id: '22e1df85-794b-4bb6-a6b6- a1679cbe2f78') waiting on child command id: '42331a77-2e38-4653-ba5f- 29e5dccaea69' type:'CreateAllOvaDisks' to complete 2017-12-28 16:23:08,089-06 INFO [org.ovirt.engine.core.bll.storage.disk. CreateAllOvaDisksCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-61) [aa503a62-d439-4131-9b46- e161779847f4] Ending command 'org.ovirt.engine.core.bll. storage.disk. CreateAllOvaDisksCommand' successfully. 2017-12-28 16:23:08,106-06 INFO [org.ovirt.engine.core.bll.storage.disk.image. CopyImageGroupCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-61) [aa503a62-d439-4131-9b46- e161779847f4] Ending command 'org.ovirt.engine.core.bll. storage.disk.image. CopyImageGroupCommand' successfully. 2017-12-28 16:23:08,118-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. GetImageInfoVDSCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-61) [aa503a62-d439-4131-9b46- e161779847f4] START, GetImageInfoVDSCommand( GetImageInfoVDSCommandParamete rs:{storagePoolId='3bb4edf8- be27-42e4-b860-a1f1f293b81c', ignoreFailoverLimit='false', storageDomainId='4108dd94- 7538-4fdb-a01e-2eb51b9083b9', imageGroupId='a2578b49-5edf- 47b8-a98a-12a20b47688c', imageId='34885dca-e1c6-4e92- 9f06-957a63c0ae56'}), log id: 2cec8f8 2017-12-28 16:23:08,122-06 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker. GetVolumeInfoVDSCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-61) [aa503a62-d439-4131-9b46- e161779847f4] START, GetVolumeInfoVDSCommand( HostName = reindeerHost, GetVolumeInfoVDSCommandParamet ers:{hostId='4f344875-08d8- 49d8-b2ee-5ca3e1810051', storagePoolId='3bb4edf8-be27- 42e4-b860-a1f1f293b81c', storageDomainId='4108dd94- 7538-4fdb-a01e-2eb51b9083b9', imageGroupId='a2578b49-5edf- 47b8-a98a-12a20b47688c', imageId='34885dca-e1c6-4e92- 9f06-957a63c0ae56'}), log id: c3fea19 2017-12-28 16:23:08,135-06 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker. GetVolumeInfoVDSCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-61) [aa503a62-d439-4131-9b46- e161779847f4] FINISH, GetVolumeInfoVDSCommand, return: org.ovirt.engine.core.common. businessentities.storage. DiskImage@95bb5b65, log id: c3fea19 2017-12-28 16:23:08,135-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. GetImageInfoVDSCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-61) [aa503a62-d439-4131-9b46- e161779847f4] FINISH, GetImageInfoVDSCommand, return: org.ovirt.engine.core.common. businessentities.storage. DiskImage@95bb5b65, log id: 2cec8f8 2017-12-28 16:23:08,232-06 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker. PrepareImageVDSCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-61) [aa503a62-d439-4131-9b46- e161779847f4] START, PrepareImageVDSCommand( HostName = reindeerHost, PrepareImageVDSCommandParamete rs:{hostId='4f344875-08d8- 49d8-b2ee-5ca3e1810051'}), log id: 6824c68f 2017-12-28 16:23:08,246-06 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker. PrepareImageVDSCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-61) [aa503a62-d439-4131-9b46- e161779847f4] FINISH, PrepareImageVDSCommand, return: PrepareImageReturn:{status=' Status [code=0, message=Done]'}, log id: 6824c68f 2017-12-28 16:23:08,251-06 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker. GetQemuImageInfoVDSCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-61) [aa503a62-d439-4131-9b46- e161779847f4] START, GetQemuImageInfoVDSCommand( HostName = reindeerHost, GetVolumeInfoVDSCommandParamet ers:{hostId='4f344875-08d8- 49d8-b2ee-5ca3e1810051', storagePoolId='3bb4edf8-be27- 42e4-b860-a1f1f293b81c', storageDomainId='4108dd94- 7538-4fdb-a01e-2eb51b9083b9', imageGroupId='a2578b49-5edf- 47b8-a98a-12a20b47688c', imageId='34885dca-e1c6-4e92- 9f06-957a63c0ae56'}), log id: 1fb3c78e 2017-12-28 16:23:08,495-06 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker. GetQemuImageInfoVDSCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-61) [aa503a62-d439-4131-9b46- e161779847f4] FINISH, GetQemuImageInfoVDSCommand, return: org.ovirt.engine.core.common. businessentities.storage. QemuImageInfo@3412697c, log id: 1fb3c78e 2017-12-28 16:23:08,499-06 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker. TeardownImageVDSCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-61) [aa503a62-d439-4131-9b46- e161779847f4] START, TeardownImageVDSCommand( HostName = reindeerHost, ImageActionsVDSCommandParamete rs:{hostId='4f344875-08d8- 49d8-b2ee-5ca3e1810051'}), log id: 6377d6a3 2017-12-28 16:23:08,508-06 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker. TeardownImageVDSCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-61) [aa503a62-d439-4131-9b46- e161779847f4] FINISH, TeardownImageVDSCommand, return: StatusReturn:{status='Status [code=0, message=Done]'}, log id: 6377d6a3 2017-12-28 16:23:08,561-06 INFO [org.ovirt.engine.core.bll.CreateOvaCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-61) [436aa42a] Running command: CreateOvaCommand internal: true. 2017-12-28 16:23:08,564-06 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker. PrepareImageVDSCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-61) [436aa42a] START, PrepareImageVDSCommand( HostName = reindeerHost, PrepareImageVDSCommandParamete rs:{hostId='4f344875-08d8- 49d8-b2ee-5ca3e1810051'}), log id: 4490da3c 2017-12-28 16:23:08,575-06 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker. PrepareImageVDSCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-61) [436aa42a] FINISH, PrepareImageVDSCommand, return: PrepareImageReturn:{status=' Status [code=0, message=Done]'}, log id: 4490da3c 2017-12-28 16:23:08,580-06 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker. GetVolumeInfoVDSCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-61) [436aa42a] START, GetVolumeInfoVDSCommand( HostName = reindeerHost, GetVolumeInfoVDSCommandParamet ers:{hostId='4f344875-08d8- 49d8-b2ee-5ca3e1810051', storagePoolId='3bb4edf8-be27- 42e4-b860-a1f1f293b81c', storageDomainId='4108dd94- 7538-4fdb-a01e-2eb51b9083b9', imageGroupId='a2578b49-5edf- 47b8-a98a-12a20b47688c', imageId='34885dca-e1c6-4e92- 9f06-957a63c0ae56'}), log id: 60f52262 2017-12-28 16:23:08,591-06 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker. GetVolumeInfoVDSCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-61) [436aa42a] FINISH, GetVolumeInfoVDSCommand, return: org.ovirt.engine.core.common. businessentities.storage. DiskImage@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.SerialChildCommandsExecutionCa llback] (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.SerialChildCommandsExecutionCa llback] (EE-ManagedThreadFactory- engineScheduled-Thread-61) [436aa42a] Command 'ExportOva' id: '22e1df85-794b-4bb6-a6b6- a1679cbe2f78' child commands '[42331a77-2e38-4653-ba5f- 29e5dccaea69]' executions were completed, status 'FAILED' 2017-12-28 16:23:09,628-06 ERROR [org.ovirt.engine.core.bll.exportimport.ExportOvaCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-15) [aa503a62-d439-4131-9b46- e161779847f4] Ending command 'org.ovirt.engine.core.bll. exportimport.ExportOvaCommand' with failure. 2017-12-28 16:23:09,637-06 INFO [org.ovirt.engine.core.bll.exportimport.ExportOvaCommand] (EE-ManagedThreadFactory- engineScheduled-Thread-15) [aa503a62-d439-4131-9b46- e161779847f4] Lock freed to object 'EngineLock:{exclusiveLocks='[ 43c82580-6c7a-4319-97f6- 6cfb17a4445a=VM]', sharedLocks=''}' 2017-12-28 16:23:09,667-06 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling. AuditLogDirector] (EE-ManagedThreadFactory- engineScheduled-Thread-15) [aa503a62-d439-4131-9b46- e161779847f4] EVENT_ID: IMPORTEXPORT_EXPORT_VM_TO_OVA_ FAILED(1,225), Failed to export Vm CentOS7 as a Virtual Appliance to path /media/primary/extra_space/ CentOS7.ova on Host reindeerHost 2017-12-28 16:23:09,716-06 INFO [org.ovirt.engine.core.bll.storage.disk. RemoveDiskCommand] (EE-ManagedThreadFactory- engine-Thread-15529) [31f8fbf6] Running command: RemoveDiskCommand internal: true. Entities affected : ID: a2578b49-5edf-47b8-a98a- 12a20b47688c Type: DiskAction group DELETE_DISK with role type USER 2017-12-28 16:23:09,734-06 INFO [org.ovirt.engine.core.bll.storage.disk.image. RemoveImageCommand] (EE-ManagedThreadFactory- engine-Thread-15529) [31f8fbf6] Running command: RemoveImageCommand internal: true. Entities affected : ID: 4108dd94-7538-4fdb-a01e- 2eb51b9083b9 Type: Storage 2017-12-28 16:23:09,796-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. DeleteImageGroupVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15529) [31f8fbf6] START, DeleteImageGroupVDSCommand( DeleteImageGroupVDSCommandPara meters:{storagePoolId=' 3bb4edf8-be27-42e4-b860- a1f1f293b81c', ignoreFailoverLimit='false', storageDomainId='4108dd94- 7538-4fdb-a01e-2eb51b9083b9', imageGroupId='a2578b49-5edf- 47b8-a98a-12a20b47688c', postZeros='false', discard='false', forceDelete='true'}), log id: 389abdf 2017-12-28 16:23:09,845-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. DeleteImageGroupVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15529) [31f8fbf6] FINISH, DeleteImageGroupVDSCommand, log id: 389abdf 2017-12-28 16:23:09,860-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15529) [31f8fbf6] CommandAsyncTask::Adding CommandMultiAsyncTasks object for command 'f9ca5d6f-effe-41a2-835f- 83f04da2de73' 2017-12-28 16:23:09,860-06 INFO [org.ovirt.engine.core.bll.CommandMultiAsyncTasks] (EE-ManagedThreadFactory- engine-Thread-15529) [31f8fbf6] CommandMultiAsyncTasks:: attachTask: Attaching task 'f2c7f5ec-b166-4cf2-97b6- b2cc02f715e1' to command 'f9ca5d6f-effe-41a2-835f- 83f04da2de73'. 2017-12-28 16:23:09,888-06 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory- engine-Thread-15529) [31f8fbf6] Adding task 'f2c7f5ec-b166-4cf2-97b6- b2cc02f715e1' (Parent Command 'RemoveDisk', Parameters Type 'org.ovirt.engine.core.common. asynctasks. AsyncTaskParameters'), polling hasn't started yet.. 2017-12-28 16:23:10,056-06 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling. AuditLogDirector] (EE-ManagedThreadFactory- engine-Thread-15529) [31f8fbf6] EVENT_ID: USER_FINISHED_REMOVE_DISK(2, 014), Disk Debian7_Disk1 was successfully removed from domain data (User admin@internal-authz). 2017-12-28 16:23:10,057-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15529) [31f8fbf6] BaseAsyncTask:: startPollingTask: Starting to poll task 'f2c7f5ec-b166-4cf2-97b6- b2cc02f715e1'. 2017-12-28 16:23:10,057-06 WARN [org.ovirt.engine.core.bll.lock.InMemoryLockManager] (EE-ManagedThreadFactory- engine-Thread-15529) [31f8fbf6] Trying to release exclusive lock which does not exist, lock key: '43c82580-6c7a-4319-97f6- 6cfb17a4445aVM' 2017-12-28 16:23:10,057-06 INFO [org.ovirt.engine.core.bll.storage.disk. RemoveDiskCommand] (EE-ManagedThreadFactory- engine-Thread-15529) [31f8fbf6] Lock freed to object 'EngineLock:{exclusiveLocks='[ 43c82580-6c7a-4319-97f6- 6cfb17a4445a=VM]', sharedLocks=''}' 2017-12-28 16:23:19,505-06 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory- engineScheduled-Thread-31) [] Polling and updating Async Tasks: 2 tasks, 1 tasks to poll now 2017-12-28 16:23:19,519-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory- engineScheduled-Thread-31) [] SPMAsyncTask::PollTask: Polling task 'f2c7f5ec-b166-4cf2-97b6- b2cc02f715e1' (Parent Command 'RemoveDisk', Parameters Type 'org.ovirt.engine.core.common. asynctasks. AsyncTaskParameters') returned status 'finished', result 'success'. 2017-12-28 16:23:19,530-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory- engineScheduled-Thread-31) [] BaseAsyncTask:: onTaskEndSuccess: Task 'f2c7f5ec-b166-4cf2-97b6- b2cc02f715e1' (Parent Command 'RemoveDisk', Parameters Type 'org.ovirt.engine.core.common. asynctasks. AsyncTaskParameters') ended successfully. 2017-12-28 16:23:19,563-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory- engineScheduled-Thread-31) [] CommandAsyncTask:: endActionIfNecessary: All tasks of command 'f9ca5d6f-effe-41a2-835f- 83f04da2de73' has ended -> executing 'endAction' 2017-12-28 16:23:19,563-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory- engineScheduled-Thread-31) [] CommandAsyncTask::endAction: Ending action for '1' tasks (command ID: 'f9ca5d6f-effe-41a2-835f- 83f04da2de73'): calling endAction '. 2017-12-28 16:23:19,564-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15532) [] CommandAsyncTask:: endCommandAction [within thread] context: Attempting to endAction 'RemoveDisk', 2017-12-28 16:23:19,579-06 INFO [org.ovirt.engine.core.bll.storage.disk. RemoveDiskCommand] (EE-ManagedThreadFactory- engine-Thread-15532) [31f8fbf6] Ending command 'org.ovirt.engine.core.bll. storage.disk. RemoveDiskCommand' successfully. 2017-12-28 16:23:19,585-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15532) [31f8fbf6] CommandAsyncTask:: HandleEndActionResult [within thread]: endAction for action type 'RemoveDisk' completed, handling the result. 2017-12-28 16:23:19,585-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15532) [31f8fbf6] CommandAsyncTask:: HandleEndActionResult [within thread]: endAction for action type 'RemoveDisk' succeeded, clearing tasks. 2017-12-28 16:23:19,585-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15532) [31f8fbf6] SPMAsyncTask::ClearAsyncTask: Attempting to clear task 'f2c7f5ec-b166-4cf2-97b6- b2cc02f715e1' 2017-12-28 16:23:19,588-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. SPMClearTaskVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15532) [31f8fbf6] START, SPMClearTaskVDSCommand( SPMTaskGuidBaseVDSCommandParam eters:{storagePoolId=' 3bb4edf8-be27-42e4-b860- a1f1f293b81c', ignoreFailoverLimit='false', taskId='f2c7f5ec-b166-4cf2- 97b6-b2cc02f715e1'}), log id: 6c25b62 2017-12-28 16:23:19,591-06 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker. HSMClearTaskVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15532) [31f8fbf6] START, HSMClearTaskVDSCommand( HostName = reindeerHost, HSMTaskGuidBaseVDSCommandParam eters:{hostId='4f344875-08d8- 49d8-b2ee-5ca3e1810051', taskId='f2c7f5ec-b166-4cf2- 97b6-b2cc02f715e1'}), log id: 4d4fcced 2017-12-28 16:23:19,602-06 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker. HSMClearTaskVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15532) [31f8fbf6] FINISH, HSMClearTaskVDSCommand, log id: 4d4fcced 2017-12-28 16:23:19,602-06 INFO [org.ovirt.engine.core.vdsbroker.irsbroker. SPMClearTaskVDSCommand] (EE-ManagedThreadFactory- engine-Thread-15532) [31f8fbf6] FINISH, SPMClearTaskVDSCommand, log id: 6c25b62 2017-12-28 16:23:19,614-06 INFO [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15532) [31f8fbf6] BaseAsyncTask:: removeTaskFromDB: Removed task 'f2c7f5ec-b166-4cf2-97b6- b2cc02f715e1' from DataBase 2017-12-28 16:23:19,614-06 INFO [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (EE-ManagedThreadFactory- engine-Thread-15532) [31f8fbf6] CommandAsyncTask:: HandleEndActionResult [within thread]: Removing CommandMultiAsyncTasks object for entity 'f9ca5d6f-effe-41a2-835f- 83f04da2de73' 2017-12-28 16:24:18,808-06 INFO [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (EE-ManagedThreadFactory- engineScheduled-Thread-55) [] Setting new tasks map. The map contains now 1 tasks Sent with ProtonMail Secure Email.-------- Original Message --------Subject: Re: [ovirt-users] Exporting/Copying VM to another oVirt serverLocal Time: December 28, 2017 4:20 PMUTC Time: December 28, 2017 10:20 PMFrom: ahadas@redhat.comTo: 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 Secure Email.-------- Original Message --------Subject: Re: [ovirt-users] Exporting/Copying VM to another oVirt serverLocal Time: December 28, 2017 4:11 PMUTC Time: December 28, 2017 10:11 PMFrom: ahadas@redhat.comTo: 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 Secure Email.-------- Original Message --------Subject: Re: [ovirt-users] Exporting/Copying VM to another oVirt serverLocal Time: December 28, 2017 3:56 PMUTC Time: December 28, 2017 9:56 PMFrom: ahadas@redhat.comTo: 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 Secure Email.-------- Original Message --------Subject: Re: [ovirt-users] Exporting/Copying VM to another oVirt serverLocal Time: December 28, 2017 3:18 PMUTC Time: December 28, 2017 9:18 PMFrom: ahadas@redhat.comTo: 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-engin eScheduled-Thread-22) [38896e98] Exception: java.lang.NullPointerException -------- Original Message --------Subject: Re: [ovirt-users] Exporting/Copying VM to another oVirt serverLocal Time: December 28, 2017 2:41 PMUTC Time: December 28, 2017 8:41 PMFrom: ahadas@redhat.comTo: 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