10:56 a.m.
Hi,
I want to create a live snapshot, but it fails at the finalizing task. There are 3 events:
- Snapshot 'test' creation for VM 'snaptest' was initiated by EwertA
- Failed to create live snapshot 'test' for VM 'snaptest'. VM restart is
recommended.
- Failed to complete snapshot 'test' creation for VM 'snaptest‘.
Thread-338209::DEBUG::2014-02-13 08:40:19,672::BindingXMLRPC::965::vds::(wrapper) client
[10.98.229.5]::call vmSnapshot with ('31c185ce-cc2e-4246-bf46-fcd96cd30050',
[{'baseVolumeID': 'b9448428-b787-4286-b54e-aa54a8f8bb17',
'domainID': '54f86ad7-2c12-4322-b2d1-f129f3d20e57', 'volumeID':
'c677d01e-dc50-486b-a532-f88a71666d2c', 'imageID':
'db6faf9e-2cc8-4106-954b-fef7e4b1bd1b'}], '') {}
Thread-338209::DEBUG::2014-02-13 08:40:19,672::task::579::TaskManager.Task::(_updateState)
Task=`8675b6b0-3216-46a8-8d9a-d0feb02d5b49`::moving from state init -> state preparing
Thread-338209::INFO::2014-02-13 08:40:19,672::logUtils::44::dispatcher::(wrapper) Run and
protect: prepareImage(sdUUID='54f86ad7-2c12-4322-b2d1-f129f3d20e57',
spUUID='5849b030-626e-47cb-ad90-3ce782d831b3',
imgUUID='db6faf9e-2cc8-4106-954b-fef7e4b1bd1b',
leafUUID='c677d01e-dc50-486b-a532-f88a71666d2c')
Thread-338209::DEBUG::2014-02-13
08:40:19,673::resourceManager::197::ResourceManager.Request::(__init__)
ResName=`Storage.54f86ad7-2c12-4322-b2d1-f129f3d20e57`ReqID=`630a701e-bd44-49ef-8a14-f657b8653a33`::Request
was made in '/usr/share/vdsm/storage/hsm.py' line '3236' at
'prepareImage'
Thread-338209::DEBUG::2014-02-13
08:40:19,673::resourceManager::541::ResourceManager::(registerResource) Trying to register
resource 'Storage.54f86ad7-2c12-4322-b2d1-f129f3d20e57' for lock type
'shared'
Thread-338209::DEBUG::2014-02-13
08:40:19,673::resourceManager::600::ResourceManager::(registerResource) Resource
'Storage.54f86ad7-2c12-4322-b2d1-f129f3d20e57' is free. Now locking as
'shared' (1 active user)
Thread-338209::DEBUG::2014-02-13
08:40:19,673::resourceManager::237::ResourceManager.Request::(grant)
ResName=`Storage.54f86ad7-2c12-4322-b2d1-f129f3d20e57`ReqID=`630a701e-bd44-49ef-8a14-f657b8653a33`::Granted
request
Thread-338209::DEBUG::2014-02-13
08:40:19,674::task::811::TaskManager.Task::(resourceAcquired)
Task=`8675b6b0-3216-46a8-8d9a-d0feb02d5b49`::_resourcesAcquired:
Storage.54f86ad7-2c12-4322-b2d1-f129f3d20e57 (shared)
Thread-338209::DEBUG::2014-02-13 08:40:19,675::task::974::TaskManager.Task::(_decref)
Task=`8675b6b0-3216-46a8-8d9a-d0feb02d5b49`::ref 1 aborting False
Thread-338209::DEBUG::2014-02-13 08:40:19,675::lvm::440::OperationMutex::(_reloadlvs)
Operation 'lvm reload operation' got the operation mutex
Thread-338209::DEBUG::2014-02-13 08:40:19,675::lvm::309::Storage.Misc.excCmd::(cmd)
'/usr/bin/sudo -n /sbin/lvm lvs --config " devices { preferred_names =
[\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0
disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [
\'a|/dev/mapper/36000d7710000ec7c7d5beda78691839c|\', \'r|.*|\' ] }
global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup {
retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator |
-o uuid,name,vg_name,attr,size,seg_start_pe,devices,tags
54f86ad7-2c12-4322-b2d1-f129f3d20e57' (cwd None)
Thread-338209::DEBUG::2014-02-13 08:40:19,715::lvm::309::Storage.Misc.excCmd::(cmd)
SUCCESS: <err> = ''; <rc> = 0
Thread-338209::DEBUG::2014-02-13 08:40:19,739::lvm::475::Storage.LVM::(_reloadlvs) lvs
reloaded
Thread-338209::DEBUG::2014-02-13 08:40:19,740::lvm::475::OperationMutex::(_reloadlvs)
Operation 'lvm reload operation' released the operation mutex
Thread-338209::DEBUG::2014-02-13 08:40:19,741::lvm::309::Storage.Misc.excCmd::(cmd)
'/usr/bin/sudo -n /sbin/lvm lvchange --config " devices { preferred_names =
[\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0
disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [
\'a|/dev/mapper/36000d7710000ec7c7d5beda78691839c|\', \'r|.*|\' ] }
global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup {
retain_min = 50 retain_days = 0 } " --autobackup n --available y
54f86ad7-2c12-4322-b2d1-f129f3d20e57/c677d01e-dc50-486b-a532-f88a71666d2c' (cwd None)
Thread-338209::DEBUG::2014-02-13 08:40:19,800::lvm::309::Storage.Misc.excCmd::(cmd)
SUCCESS: <err> = ''; <rc> = 0
Thread-338209::DEBUG::2014-02-13 08:40:19,801::lvm::526::OperationMutex::(_invalidatelvs)
Operation 'lvm invalidate operation' got the operation mutex
Thread-338209::DEBUG::2014-02-13 08:40:19,801::lvm::538::OperationMutex::(_invalidatelvs)
Operation 'lvm invalidate operation' released the operation mutex
Thread-338209::WARNING::2014-02-13
08:40:19,801::fileUtils::167::Storage.fileUtils::(createdir) Dir
/var/run/vdsm/storage/54f86ad7-2c12-4322-b2d1-f129f3d20e57/db6faf9e-2cc8-4106-954b-fef7e4b1bd1b
already exists
Thread-338209::DEBUG::2014-02-13
08:40:19,801::blockSD::1068::Storage.StorageDomain::(createImageLinks) img run vol already
exists:
/var/run/vdsm/storage/54f86ad7-2c12-4322-b2d1-f129f3d20e57/db6faf9e-2cc8-4106-954b-fef7e4b1bd1b/b9448428-b787-4286-b54e-aa54a8f8bb17
Thread-338209::DEBUG::2014-02-13
08:40:19,802::blockSD::1068::Storage.StorageDomain::(createImageLinks) img run vol already
exists:
/var/run/vdsm/storage/54f86ad7-2c12-4322-b2d1-f129f3d20e57/db6faf9e-2cc8-4106-954b-fef7e4b1bd1b/bac74b7e-94f0-48d2-a5e5-8b2e846411e8
Thread-338209::DEBUG::2014-02-13
08:40:19,802::blockSD::1040::Storage.StorageDomain::(linkBCImage) path to image directory
already exists:
/rhev/data-center/mnt/blockSD/54f86ad7-2c12-4322-b2d1-f129f3d20e57/images/db6faf9e-2cc8-4106-954b-fef7e4b1bd1b
Thread-338209::DEBUG::2014-02-13 08:40:19,802::lvm::440::OperationMutex::(_reloadlvs)
Operation 'lvm reload operation' got the operation mutex
Thread-338209::DEBUG::2014-02-13 08:40:19,803::lvm::309::Storage.Misc.excCmd::(cmd)
'/usr/bin/sudo -n /sbin/lvm lvs --config " devices { preferred_names =
[\\"^/dev/mapper/\\"] ignore_suspended_devices=1 write_cache_state=0
disable_after_error_count=3 obtain_device_list_from_udev=0 filter = [
\'a|/dev/mapper/36000d7710000ec7c7d5beda78691839c|\', \'r|.*|\' ] }
global { locking_type=1 prioritise_write_locks=1 wait_for_locks=1 } backup {
retain_min = 50 retain_days = 0 } " --noheadings --units b --nosuffix --separator |
-o uuid,name,vg_name,attr,size,seg_start_pe,devices,tags
54f86ad7-2c12-4322-b2d1-f129f3d20e57' (cwd None)
Thread-338209::DEBUG::2014-02-13 08:40:19,831::lvm::309::Storage.Misc.excCmd::(cmd)
SUCCESS: <err> = ''; <rc> = 0
Thread-338209::DEBUG::2014-02-13 08:40:19,849::lvm::475::Storage.LVM::(_reloadlvs) lvs
reloaded
Thread-338209::DEBUG::2014-02-13 08:40:19,849::lvm::475::OperationMutex::(_reloadlvs)
Operation 'lvm reload operation' released the operation mutex
Thread-338209::INFO::2014-02-13 08:40:19,850::logUtils::47::dispatcher::(wrapper) Run and
protect: prepareImage, Return response: {'info': {'domainID':
'54f86ad7-2c12-4322-b2d1-f129f3d20e57', 'volType': 'path',
'leaseOffset': 128974848, 'path':
'/rhev/data-center/mnt/blockSD/54f86ad7-2c12-4322-b2d1-f129f3d20e57/images/db6faf9e-2cc8-4106-954b-fef7e4b1bd1b/c677d01e-dc50-486b-a532-f88a71666d2c',
'volumeID': 'c677d01e-dc50-486b-a532-f88a71666d2c', 'leasePath':
'/dev/54f86ad7-2c12-4322-b2d1-f129f3d20e57/leases', 'imageID':
'db6faf9e-2cc8-4106-954b-fef7e4b1bd1b'}, 'path':
'/rhev/data-center/mnt/blockSD/54f86ad7-2c12-4322-b2d1-f129f3d20e57/images/db6faf9e-2cc8-4106-954b-fef7e4b1bd1b/c677d01e-dc50-486b-a532-f88a71666d2c',
'imgVolumesInfo': [{'domainID':
'54f86ad7-2c12-4322-b2d1-f129f3d20e57', 'volType': 'path',
'leaseOffset': 128974848, 'path':
'/rhev/data-center/mnt/blockSD/54f86ad7-2c12-4322-b2d1-f129f3d20e57/images/db6faf9e-2cc8-4106-954b-fef7e4b1bd1b/c677d01e-dc50-486b-a532-f88a71666d2c',
'volumeID': 'c677d01e-dc50-486b-a532-f88a71666d2c', 'leasePath':
'/dev/54f86ad7-2c12-4322-b2d1-f129f3d20e57/leases', 'imageID':
'db6faf9e-2cc8-4106-954b-fef7e4b1bd1b'}, {'domainID':
'54f86ad7-2c12-4322-b2d1-f129f3d20e57', 'volType': 'path',
'leaseOffset': 127926272, 'path':
'/rhev/data-center/mnt/blockSD/54f86ad7-2c12-4322-b2d1-f129f3d20e57/images/db6faf9e-2cc8-4106-954b-fef7e4b1bd1b/b9448428-b787-4286-b54e-aa54a8f8bb17',
'volumeID': 'b9448428-b787-4286-b54e-aa54a8f8bb17', 'leasePath':
'/dev/54f86ad7-2c12-4322-b2d1-f129f3d20e57/leases', 'imageID':
'db6faf9e-2cc8-4106-954b-fef7e4b1bd1b'}, {'domainID':
'54f86ad7-2c12-4322-b2d1-f129f3d20e57', 'volType': 'path',
'leaseOffset': 111149056, 'path':
'/rhev/data-center/mnt/blockSD/54f86ad7-2c12-4322-b2d1-f129f3d20e57/images/db6faf9e-2cc8-4106-954b-fef7e4b1bd1b/bac74b7e-94f0-48d2-a5e5-8b2e846411e8',
'volumeID': 'bac74b7e-94f0-48d2-a5e5-8b2e846411e8', 'leasePath':
'/dev/54f86ad7-2c12-4322-b2d1-f129f3d20e57/leases', 'imageID':
'db6faf9e-2cc8-4106-954b-fef7e4b1bd1b'}]}
Thread-338209::DEBUG::2014-02-13 08:40:19,850::task::1168::TaskManager.Task::(prepare)
Task=`8675b6b0-3216-46a8-8d9a-d0feb02d5b49`::finished: {'info':
{'domainID': '54f86ad7-2c12-4322-b2d1-f129f3d20e57', 'volType':
'path', 'leaseOffset': 128974848, 'path':
'/rhev/data-center/mnt/blockSD/54f86ad7-2c12-4322-b2d1-f129f3d20e57/images/db6faf9e-2cc8-4106-954b-fef7e4b1bd1b/c677d01e-dc50-486b-a532-f88a71666d2c',
'volumeID': 'c677d01e-dc50-486b-a532-f88a71666d2c', 'leasePath':
'/dev/54f86ad7-2c12-4322-b2d1-f129f3d20e57/leases', 'imageID':
'db6faf9e-2cc8-4106-954b-fef7e4b1bd1b'}, 'path':
'/rhev/data-center/mnt/blockSD/54f86ad7-2c12-4322-b2d1-f129f3d20e57/images/db6faf9e-2cc8-4106-954b-fef7e4b1bd1b/c677d01e-dc50-486b-a532-f88a71666d2c',
'imgVolumesInfo': [{'domainID':
'54f86ad7-2c12-4322-b2d1-f129f3d20e57', 'volType': 'path',
'leaseOffset': 128974848, 'path':
'/rhev/data-center/mnt/blockSD/54f86ad7-2c12-4322-b2d1-f129f3d20e57/images/db6faf9e-2cc8-4106-954b-fef7e4b1bd1b/c677d01e-dc50-486b-a532-f88a71666d2c',
'volumeID': 'c677d01e-dc50-486b-a532-f88a71666d2c', 'leasePath':
'/dev/54f86ad7-2c12-4322-b2d1-f129f3d20e57/leases', 'imageID':
'db6faf9e-2cc8-4106-954b-fef7e4b1bd1b'}, {'domainID':
'54f86ad7-2c12-4322-b2d1-f129f3d20e57', 'volType': 'path',
'leaseOffset': 127926272, 'path':
'/rhev/data-center/mnt/blockSD/54f86ad7-2c12-4322-b2d1-f129f3d20e57/images/db6faf9e-2cc8-4106-954b-fef7e4b1bd1b/b9448428-b787-4286-b54e-aa54a8f8bb17',
'volumeID': 'b9448428-b787-4286-b54e-aa54a8f8bb17', 'leasePath':
'/dev/54f86ad7-2c12-4322-b2d1-f129f3d20e57/leases', 'imageID':
'db6faf9e-2cc8-4106-954b-fef7e4b1bd1b'}, {'domainID':
'54f86ad7-2c12-4322-b2d1-f129f3d20e57', 'volType': 'path',
'leaseOffset': 111149056, 'path':
'/rhev/data-center/mnt/blockSD/54f86ad7-2c12-4322-b2d1-f129f3d20e57/images/db6faf9e-2cc8-4106-954b-fef7e4b1bd1b/bac74b7e-94f0-48d2-a5e5-8b2e846411e8',
'volumeID': 'bac74b7e-94f0-48d2-a5e5-8b2e846411e8', 'leasePath':
'/dev/54f86ad7-2c12-4322-b2d1-f129f3d20e57/leases', 'imageID':
'db6faf9e-2cc8-4106-954b-fef7e4b1bd1b'}]}
Thread-338209::DEBUG::2014-02-13 08:40:19,850::task::579::TaskManager.Task::(_updateState)
Task=`8675b6b0-3216-46a8-8d9a-d0feb02d5b49`::moving from state preparing -> state
finished
Thread-338209::DEBUG::2014-02-13
08:40:19,850::resourceManager::939::ResourceManager.Owner::(releaseAll) Owner.releaseAll
requests {} resources {'Storage.54f86ad7-2c12-4322-b2d1-f129f3d20e57': <
ResourceRef 'Storage.54f86ad7-2c12-4322-b2d1-f129f3d20e57', isValid:
'True' obj: 'None'>}
Thread-338209::DEBUG::2014-02-13
08:40:19,851::resourceManager::976::ResourceManager.Owner::(cancelAll) Owner.cancelAll
requests {}
Thread-338209::DEBUG::2014-02-13
08:40:19,851::resourceManager::615::ResourceManager::(releaseResource) Trying to release
resource 'Storage.54f86ad7-2c12-4322-b2d1-f129f3d20e57'
Thread-338209::DEBUG::2014-02-13
08:40:19,851::resourceManager::634::ResourceManager::(releaseResource) Released resource
'Storage.54f86ad7-2c12-4322-b2d1-f129f3d20e57' (0 active users)
Thread-338209::DEBUG::2014-02-13
08:40:19,851::resourceManager::640::ResourceManager::(releaseResource) Resource
'Storage.54f86ad7-2c12-4322-b2d1-f129f3d20e57' is free, finding out if anyone is
waiting for it.
Thread-338209::DEBUG::2014-02-13
08:40:19,851::resourceManager::648::ResourceManager::(releaseResource) No one is waiting
for resource 'Storage.54f86ad7-2c12-4322-b2d1-f129f3d20e57', Clearing records.
Thread-338209::DEBUG::2014-02-13 08:40:19,852::task::974::TaskManager.Task::(_decref)
Task=`8675b6b0-3216-46a8-8d9a-d0feb02d5b49`::ref 0 aborting False
Thread-338209::INFO::2014-02-13 08:40:19,852::clientIF::353::vds::(prepareVolumePath)
prepared volume path:
/rhev/data-center/mnt/blockSD/54f86ad7-2c12-4322-b2d1-f129f3d20e57/images/db6faf9e-2cc8-4106-954b-fef7e4b1bd1b/c677d01e-dc50-486b-a532-f88a71666d2c
Thread-338209::DEBUG::2014-02-13 08:40:19,852::vm::3743::vm.Vm::(snapshot)
vmId=`31c185ce-cc2e-4246-bf46-fcd96cd30050`::<domainsnapshot>
Thread-338209::DEBUG::2014-02-13
08:40:19,865::libvirtconnection::108::libvirtconnection::(wrapper) Unknown libvirterror:
ecode: 67 edom: 10 level: 2 message: unsupported configuration: reuse is not supported
with this QEMU binary
Thread-338209::DEBUG::2014-02-13 08:40:19,865::vm::3764::vm.Vm::(snapshot)
vmId=`31c185ce-cc2e-4246-bf46-fcd96cd30050`::Snapshot failed using the quiesce flag,
trying again without it (unsupported configuration: reuse is not supported with this QEMU
binary)
Thread-338209::DEBUG::2014-02-13
08:40:19,869::libvirtconnection::108::libvirtconnection::(wrapper) Unknown libvirterror:
ecode: 67 edom: 10 level: 2 message: unsupported configuration: reuse is not supported
with this QEMU binary
Thread-338209::ERROR::2014-02-13 08:40:19,869::vm::3768::vm.Vm::(snapshot)
vmId=`31c185ce-cc2e-4246-bf46-fcd96cd30050`::Unable to take snapshot
Thread-338209::DEBUG::2014-02-13 08:40:19,870::BindingXMLRPC::972::vds::(wrapper) return
vmSnapshot with {'status': {'message': 'Snapshot failed',
'code': 48}}
What can I do to fix this?
best regards
Andreas