Bug 1218165 - Create template from Xtreme IO block device fails with CopyImageError: low level Image copy failed
Summary: Create template from Xtreme IO block device fails with CopyImageError: low l...
Keywords:
Status: CLOSED DUPLICATE of bug 1209034
Alias: None
Product: oVirt
Classification: Retired
Component: ovirt-engine-core
Version: 3.6
Hardware: x86_64
OS: Unspecified
unspecified
high
Target Milestone: ---
: 3.5.4
Assignee: Tal Nisan
QA Contact: Pavel Stehlik
URL:
Whiteboard: storage
Depends On:
Blocks:
TreeView+ depends on / blocked
 
Reported: 2015-05-04 10:46 UTC by Kevin Alon Goldblatt
Modified: 2016-02-10 19:44 UTC (History)
6 users (show)

Fixed In Version:
Doc Type: Bug Fix
Doc Text:
Clone Of:
Environment:
Last Closed: 2015-05-04 11:02:49 UTC
oVirt Team: Storage
Embargoed:


Attachments (Terms of Use)

Description Kevin Alon Goldblatt 2015-05-04 10:46:58 UTC
Description of problem:
Fail to create a template from a Vm with Extreme IO disk - works for NFS 

Version-Release number of selected component (if applicable):
v3.6
ovirt-engine-3.6.0-0.0.master.20150412172306.git55ba764.el6.noarch
vdsm-4.17.0-632.git19a83a2.el7.x86_64

How reproducible:
100%

Steps to Reproduce:
1. Create a VM with a disk from Extreme-IO domain
2. Attempt to create a template
3. The operation fails with "CopyImageError: low level Image copy failed:"
4. The same opearation on a VM with NFS disks works fine

Actual results:
The create template operation failed 

Expected results:
The create template operation should succeed

Additional info:

Engine.log
--------------
2015-05-04 13:28:58,685 INFO  [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-12) [29d82e5b] Correlation ID: 2137db57, Job ID: 8465499b-e2e9-40f0-90ea-aff5bf447033, Call Stack: null, Custom Event ID: -1, Message: Creation of Template template_vm11 from VM vm11 was initiated by admin@internal.
2015-05-04 13:28:58,686 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (ajp--127.0.0.1-8702-12) [29d82e5b] BaseAsyncTask::startPollingTask: Starting to poll task '034c9dc1-d31f-44b4-8a66-ced5e5095147'.
2015-05-04 13:29:07,504 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (DefaultQuartzScheduler_Worker-93) [373f550a] Polling and updating Async Tasks: 1 tasks, 1 tasks to poll now
2015-05-04 13:29:07,516 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.HSMGetAllTasksStatusesVDSCommand] (DefaultQuartzScheduler_Worker-93) [373f550a] Failed in 'HSMGetAllTasksStatusesVDS' method
2015-05-04 13:29:07,517 INFO  [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (DefaultQuartzScheduler_Worker-93) [373f550a] SPMAsyncTask::PollTask: Polling task '034c9dc1-d31f-44b4-8a66-ced5e5095147' (Parent Command 'AddVmTemplate', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') returned status 'finished', result 'cleanSuccess'.
2015-05-04 13:29:07,524 ERROR [org.ovirt.engine.core.bll.tasks.SPMAsyncTask] (DefaultQuartzScheduler_Worker-93) [373f550a] BaseAsyncTask::logEndTaskFailure: Task '034c9dc1-d31f-44b4-8a66-ced5e5095147' (Parent Command 'AddVmTemplate', Parameters Type 'org.ovirt.engine.core.common.asynctasks.AsyncTaskParameters') ended with failure:
-- Result: 'cleanSuccess'
-- Message: 'VDSGenericException: VDSErrorException: Failed to HSMGetAllTasksStatusesVDS, error = low level Image copy failed, code = 261',
-- Exception: 'VDSGenericException: VDSErrorException: Failed to HSMGetAllTasksStatusesVDS, error = low level Image copy failed, code = 261'
2015-05-04 13:29:07,531 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (DefaultQuartzScheduler_Worker-93) [373f550a] CommandAsyncTask::endActionIfNecessary: All tasks of command '94fbd762-3dd2-486e-8cfd-651f43234a03' has ended -> executing 'endAction'
2015-05-04 13:29:07,533 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (DefaultQuartzScheduler_Worker-93) [373f550a] CommandAsyncTask::endAction: Ending action for '1' tasks (command ID: '94fbd762-3dd2-486e-8cfd-651f43234a03'): calling endAction '.
2015-05-04 13:29:07,534 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (org.ovirt.thread.pool-8-thread-42) [373f550a] CommandAsyncTask::endCommandAction [within thread] context: Attempting to endAction 'AddVmTemplate', executionIndex: '0'
2015-05-04 13:29:07,565 ERROR [org.ovirt.engine.core.bll.AddVmTemplateCommand] (org.ovirt.thread.pool-8-thread-42) [2137db57] Ending command 'org.ovirt.engine.core.bll.AddVmTemplateCommand' with failure.
2015-05-04 13:29:07,570 ERROR [org.ovirt.engine.core.bll.CreateImageTemplateCommand] (org.ovirt.thread.pool-8-thread-42) [29d82e5b] Ending command 'org.ovirt.engine.core.bll.CreateImageTemplateCommand' with failure.
2015-05-04 13:29:07,583 INFO  [org.ovirt.engine.core.bll.RemoveImageCommand] (org.ovirt.thread.pool-8-thread-42) [759c0f4] Running command: RemoveImageCommand internal: true. Entities affected :  ID: 00000000-0000-0000-0000-000000000000 Type: Storage
2015-05-04 13:29:07,616 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand] (org.ovirt.thread.pool-8-thread-42) [759c0f4] START, DeleteImageGroupVDSCommand( storagePoolId = 7145e0b2-2282-4bb0-93f6-fe012a3b5797, ignoreFailoverLimit = false, storageDomainId = d9e4583a-95d9-48ea-a660-25ec0da45541, imageGroupId = 21de1c42-208b-4487-8c31-4987a0d7a492, postZeros = false, forceDelete = false), log id: 3bc773aa
2015-05-04 13:29:07,766 ERROR [org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand] (org.ovirt.thread.pool-8-thread-42) [759c0f4] Command 'DeleteImageGroupVDSCommand( storagePoolId = 7145e0b2-2282-4bb0-93f6-fe012a3b5797, ignoreFailoverLimit = false, storageDomainId = d9e4583a-95d9-48ea-a660-25ec0da45541, imageGroupId = 21de1c42-208b-4487-8c31-4987a0d7a492, postZeros = false, forceDelete = false)' execution failed: IRSGenericException: IRSErrorException: Image does not exist in domain: u'image=21de1c42-208b-4487-8c31-4987a0d7a492, domain=d9e4583a-95d9-48ea-a660-25ec0da45541'
2015-05-04 13:29:07,769 INFO  [org.ovirt.engine.core.vdsbroker.irsbroker.DeleteImageGroupVDSCommand] (org.ovirt.thread.pool-8-thread-42) [759c0f4] FINISH, DeleteImageGroupVDSCommand, log id: 3bc773aa
2015-05-04 13:29:07,770 INFO  [org.ovirt.engine.core.bll.RemoveImageCommand] (org.ovirt.thread.pool-8-thread-42) [759c0f4] Disk '21de1c42-208b-4487-8c31-4987a0d7a492' doesn't exist on storage domain 'd9e4583a-95d9-48ea-a660-25ec0da45541', rolling forward
2015-05-04 13:29:07,932 INFO  [org.ovirt.engine.core.bll.tasks.AsyncTaskManager] (org.ovirt.thread.pool-8-thread-42) [759c0f4] Removed task 'ee69d0c5-4d50-41bd-9638-2059791341c6' from DataBase
2015-05-04 13:29:07,948 INFO  [org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand] (org.ovirt.thread.pool-8-thread-42) [] START, SetVmStatusVDSCommand( vmId = 2b4cdda9-2326-4a8d-b93e-228f0471205b, status = Down, exit status = Normal), log id: 592a9fa7
2015-05-04 13:29:07,959 INFO  [org.ovirt.engine.core.vdsbroker.SetVmStatusVDSCommand] (org.ovirt.thread.pool-8-thread-42) [] FINISH, SetVmStatusVDSCommand, log id: 592a9fa7
2015-05-04 13:29:07,968 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (org.ovirt.thread.pool-8-thread-42) [] Correlation ID: 2137db57, Job ID: 8465499b-e2e9-40f0-90ea-aff5bf447033, Call Stack: null, Custom Event ID: -1, Message: Failed to complete creation of Template template_vm11 from VM vm11.
2015-05-04 13:29:07,969 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (org.ovirt.thread.pool-8-thread-42) [] CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type 'AddVmTemplate' completed, handling the result.
2015-05-04 13:29:07,970 INFO  [org.ovirt.engine.core.bll.tasks.CommandAsyncTask] (org.ovirt.thread.pool-8-thread-42) [] CommandAsyncTask::HandleEndActionResult [within thread]: endAction for action type 'AddVmTemplate' succeeded, clearing tasks.

Vdsm.log
-------------
034c9dc1-d31f-44b4-8a66-ced5e5095147::ERROR::2015-05-04 13:29:09,768::image::841::Storage.Image::(copyCollapsed) conversion failure for volume 0eb1da11-dd59-4f0b-a74e-7b0e859e00fc
Traceback (most recent call last):
  File "/usr/share/vdsm/storage/image.py", line 836, in copyCollapsed
    volume.fmt2str(dstVolFormat))
  File "/usr/lib/python2.7/site-packages/vdsm/qemuimg.py", line 208, in convert
    raise QImgError(rc, out, err)
QImgError: ecode=1, stdout=[], stderr=['qemu-img: error writing zeroes at sector 0: Invalid argument'], message=None
034c9dc1-d31f-44b4-8a66-ced5e5095147::ERROR::2015-05-04 13:29:09,769::image::854::Storage.Image::(copyCollapsed) Unexpected error
Traceback (most recent call last):
  File "/usr/share/vdsm/storage/image.py", line 842, in copyCollapsed
    raise se.CopyImageError(str(e))
CopyImageError: low level Image copy failed: ("ecode=1, stdout=[], stderr=['qemu-img: error writing zeroes at sector 0: Invalid argument'], message=None",)
034c9dc1-d31f-44b4-8a66-ced5e5095147::INFO::2015-05-04 13:29:09,770::blockVolume::401::Storage.Volume::(teardown) Tearing down volume d9e4583a-95d9-48ea-a660-25ec0da45541/0eb1da11-dd59-4f0b-a74e-7b0e859e00fc justme False
034c9dc1-d31f-44b4-8a66-ced5e5095147::DEBUG::2015-05-04 13:29:09,770::resourceManager::616::Storage.ResourceManager::(releaseResource) Trying to release resource 'd9e4583a-95d9-48ea-a660-25ec0da45541_lvmActivationNS.0eb1da11-dd59-4f0b-a74e-7b0e859e00fc'
034c9dc1-d31f-44b4-8a66-ced5e5095147::DEBUG::2015-05-04 13:29:09,771::resourceManager::635::Storage.ResourceManager::(releaseResource) Released resource 'd9e4583a-95d9-48ea-a660-25ec0da45541_lvmActivationNS.0eb1da11-dd59-4f0b-a74e-7b0e859e00fc' (0 active users)
034c9dc1-d31f-44b4-8a66-ced5e5095147::DEBUG::2015-05-04 13:29:09,771::resourceManager::641::Storage.ResourceManager::(releaseResource) Resource 'd9e4583a-95d9-48ea-a660-25ec0da45541_lvmActivationNS.0eb1da11-dd59-4f0b-a74e-7b0e859e00fc' is free, finding out if anyone is waiting for it.

Comment 1 Allon Mureinik 2015-05-04 11:02:49 UTC

*** This bug has been marked as a duplicate of bug 1209034 ***


Note You need to log in before you can comment on or make changes to this bug.