Created attachment 1132476 [details] engine.log, vdsm.log Description of problem: When deleting a snapshot a few errors appear in engine.log saying volume doesn't exist. Version-Release number of selected component (if applicable): rhevm-3.6.3.3-0.1.el6.noarch vdsm-4.17.23-0.el7ev.noarch How reproducible: 100% Steps to Reproduce: 1. Create VM (install OS and guest-agent). 2. Create snapshots (save memory). 3. Delete snapshots (one by one). Actual results: The following errors appear in engine.log: 2016-03-02 20:12:31,246 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand] (pool-5-thread-3) [32cfe2a2] Failed in 'GetVolumeInfoVDS' method 2016-03-02 20:12:31,251 ERROR [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (pool-5-thread-3) [32cfe2a2] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: VDSM aqua-vds5 command failed: Volume does not exist: (u'9eb820fb-da4d-44a2-bba8-96a931636dbb',) 2016-03-02 20:12:31,252 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.GetVolumeInfoVDSCommand] (pool-5-thread-3) [32cfe2a2] Command 'GetVolumeInfoVDSCommand(HostName = aqua-vds5, GetVolumeInfoVDSCommandParameters:{runAsync='true', hostId='da84a672-c913-4b1c-881a-b367a5646c47', storagePoolId='00000001-0001-0001-0001-000000000216', storageDomainId='855997f5-64fa-4f10-a08f-61e5ebcdf6f3', imageGroupId='8ad374fd-3d98-45e4-b7ff-b4c394adfd69', imageId='9eb820fb-da4d-44a2-bba8-96a931636dbb'})' execution failed: VDSGenericException: VDSErrorException: Failed to GetVolumeInfoVDS, error = Volume does not exist: (u'9eb820fb-da4d-44a2-bba8-96a931636dbb',), code = 201 Expected results: For all operations to succeed. Additional info: * Found while verifying bug #1313276. * Storage domain type is NFS.
Natalie, just to make sure - the snapshot deletion is also performed while the VM is running right? Does it succeed and just produce a redudant ugly log message, or does it fail?
(In reply to Allon Mureinik from comment #1) > Natalie, just to make sure - the snapshot deletion is also performed while > the VM is running right? > Does it succeed and just produce a redundant ugly log message, or does it > fail? The VM was running (there is no memory to save if it's not), the snapshot succeeds. It might seem like a redundant log message (but I usually assume that if there is an error - it indicates something went wrong).
Root cause of this bug is same as of bug 1310615: During DESTROY_IMAG_CHECK, we invoke getVolumeInfo in order to verify that the volume was deleted. We expect the getVolumeInfo command to fail but the framework running the command displays an error log message an audit log message when command execution fails.
This bug resolved as a result of fixing bug 1310615. To fix both bugs we introduced a new request parameter called engineExpectedErrors. This parameter is needed because there are use cases, like this one, where we send a request to vdsm and we expect to get an error, i.e. that's not a bug but actually this is the expected behavior. So, here we shall see in the expectedEngineParameters 'VolumeDoesNotExist' value.
(In reply to Ala Hino from comment #4) Setting requires-doctext to "-" - let's use bug 1310615 for documentation purposes.
Bugs moved pre-mature to ON_QA since they didn't have target release. Notice that only bugs with a set target release will move to ON_QA.
Snapshot (that was taken with memory) live merge successful operation doesn't raise a "Volume does not exist" alert. Used: rhevm-3.6.5-0.1.el6.noarch vdsm-4.17.25-0.el7ev.noarch