Bug 1422411

Summary: When a VM has single snapshot,deleting that snapshot fails and throws error in evm.log
Product: Red Hat CloudForms Management Engine Reporter: Aziza Karol <akarol>
Component: ProvidersAssignee: Adam Grare <agrare>
Status: CLOSED DUPLICATE QA Contact: Dave Johnson <dajohnso>
Severity: medium Docs Contact:
Priority: unspecified    
Version: 5.7.0CC: agrare, akarol, jfrey, jhardy, obarenbo
Target Milestone: GA   
Target Release: cfme-future   
Hardware: Unspecified   
OS: Unspecified   
Whiteboard:
Fixed In Version: Doc Type: If docs needed, set a value
Doc Text:
Story Points: ---
Clone Of: Environment:
Last Closed: 2017-02-15 13:54:51 UTC Type: Bug
Regression: --- Mount Type: ---
Documentation: --- CRM:
Verified Versions: Category: ---
oVirt Team: --- RHEL 7.3 requirements from Atomic Host:
Cloudforms Team: --- Target Upstream Version:
Embargoed:

Description Aziza Karol 2017-02-15 09:15:41 UTC
Description of problem:


Version-Release number of selected component (if applicable):
5.7.1.1.20170206165110_3c42361

How reproducible:
100%

Steps to Reproduce:
1.create a single snapshot on a VM and delete the selected snapshot
2.
3.

Actual results:
snapshot does not get deleted.

Note: if we have multiple snapshot, deleting the selected snapshot works fine.

Expected results:


Additional info:
evm.log
[----] I, [2017-02-15T04:08:34.809195 #2885:110713c]  INFO -- : Q-task_id([job_dispatcher]) MIQ(JobProxyDispatcher#dispatch) Complete - Timings: {:pending_container_jobs=>0.0028076171875, :container_jobs_to_dispatch_count=>0, :container_dispatching=>0.0029213428497314453, :pending_vm_jobs=>0.0008244514465332031, :vm_jobs_to_dispatch_count=>0, :total_time=>0.005115509033203125}
[----] I, [2017-02-15T04:08:34.809540 #2885:110713c]  INFO -- : Q-task_id([job_dispatcher]) MIQ(MiqQueue#delivered) Message id: [8994], State: [ok], Delivered in [0.00589291] seconds
[----] I, [2017-02-15T04:08:34.822544 #2885:110713c]  INFO -- : MIQ(MiqGenericWorker::Runner#get_message_via_drb) Message id: [8993], MiqWorker id: [46], Zone: [default], Role: [ems_operations], Server: [], Ident: [generic], Target id: [], Instance id: [88], Task id: [], Command: [VmOrTemplate.remove_snapshot], Timeout: [600], Priority: [100], State: [dequeue], Deliver On: [], Data: [], Args: [nil], Dequeued in: [6.082122491] seconds
[----] I, [2017-02-15T04:08:34.822676 #2885:110713c]  INFO -- : MIQ(MiqQueue#deliver) Message id: [8993], Delivering...
[----] E, [2017-02-15T04:08:34.834671 #2885:110713c] ERROR -- : MIQ(MiqQueue#deliver) Message id: [8993], Error: [Requested VM snapshot not found, unable to remove snapshot]
[----] E, [2017-02-15T04:08:34.834960 #2885:110713c] ERROR -- : [RuntimeError]: Requested VM snapshot not found, unable to remove snapshot  Method:[rescue in deliver]
[----] E, [2017-02-15T04:08:34.835086 #2885:110713c] ERROR -- : /var/www/miq/vmdb/app/models/vm_or_template/operations/snapshot.rb:44:in `raw_remove_snapshot'
/var/www/miq/vmdb/app/models/vm_or_template/operations/snapshot.rb:66:in `remove_snapshot'
/var/www/miq/vmdb/app/models/miq_queue.rb:347:in `block in deliver'
/opt/rh/rh-ruby23/root/usr/share/ruby/timeout.rb:91:in `block in timeout'
/opt/rh/rh-ruby23/root/usr/share/ruby/timeout.rb:33:in `block in catch'
/opt/rh/rh-ruby23/root/usr/share/ruby/timeout.rb:33:in `catch'
/opt/rh/rh-ruby23/root/usr/share/ruby/timeout.rb:33:in `catch'
/opt/rh/rh-ruby23/root/usr/share/ruby/timeout.rb:106:in `timeout'
/var/www/miq/vmdb/app/models/miq_queue.rb:343:in `deliver'
/var/www/miq/vmdb/app/models/miq_queue_worker_base/runner.rb:106:in `deliver_queue_message'
/var/www/miq/vmdb/app/models/miq_queue_worker_base/runner.rb:134:in `deliver_message'
/var/www/miq/vmdb/app/models/miq_queue_worker_base/runner.rb:152:in `block in do_work'
/var/www/miq/vmdb/app/models/miq_queue_worker_base/runner.rb:146:in `loop'
/var/www/miq/vmdb/app/models/miq_queue_worker_base/runner.rb:146:in `do_work'
/var/www/miq/vmdb/app/models/miq_worker/runner.rb:334:in `block in do_work_loop'
/var/www/miq/vmdb/app/models/miq_worker/runner.rb:331:in `loop'
/var/www/miq/vmdb/app/models/miq_worker/runner.rb:331:in `do_work_loop'
/var/www/miq/vmdb/app/models/miq_worker/runner.rb:153:in `run'
/var/www/miq/vmdb/app/models/miq_worker/runner.rb:128:in `start'
/var/www/miq/vmdb/app/models/miq_worker/runner.rb:21:in `start_worker'
/var/www/miq/vmdb/app/models/miq_worker.rb:343:in `block in start'
/opt/rh/cfme-gemset/gems/nakayoshi_fork-0.0.3/lib/nakayoshi_fork.rb:24:in `fork'
/opt/rh/cfme-gemset/gems/nakayoshi_fork-0.0.3/lib/nakayoshi_fork.rb:24:in `fork'
/var/www/miq/vmdb/app/models/miq_worker.rb:341:in `start'
/var/www/miq/vmdb/app/models/miq_worker.rb:270:in `start_worker'
/var/www/miq/vmdb/app/models/miq_worker.rb:150:in `block in sync_workers'
/var/www/miq/vmdb/app/models/miq_worker.rb:150:in `times'
/var/www/miq/vmdb/app/models/miq_worker.rb:150:in `sync_workers'
/var/www/miq/vmdb/app/models/miq_server/worker_management/monitor.rb:52:in `block in sync_workers'
/var/www/miq/vmdb/app/models/miq_server/worker_management/monitor.rb:50:in `each'
/var/www/miq/vmdb/app/models/miq_server/worker_management/monitor.rb:50:in `sync_workers'
/var/www/miq/vmdb/app/models/miq_server.rb:158:in `start'
/var/www/miq/vmdb/app/models/miq_server.rb:249:in `start'
/var/www/miq/vmdb/lib/workers/evm_server.rb:65:in `start'
/var/www/miq/vmdb/lib/workers/evm_server.rb:92:in `start'
/var/www/miq/vmdb/lib/workers/bin/evm_server.rb:4:in `<main>'
[----] I, [2017-02-15T04:08:34.835192 #2885:110713c]  INFO -- : MIQ(MiqQueue#delivered) Message id: [8993], State: [error], Delivered in [0.012513648] seconds
[----] I, [2017-02-15T04:08:34.837195 #2885:110713c]  INFO -- : MIQ(MiqQueue#m_callback) Message id: [8993], Invoking Callback with args: ["Finished", "error", "Requested VM snapshot not found, unable to remove snapshot", "nil"]

Comment 2 Adam Grare 2017-02-15 13:51:35 UTC
I'm guessing that this is the same issue as https://bugzilla.redhat.com/show_bug.cgi?id=1421951
It has the same error and only occurs when there is a single snapshot.  Once that is fixed can you re-test this?

Comment 3 Adam Grare 2017-02-15 13:54:51 UTC
This also looks like a duplicate of https://bugzilla.redhat.com/show_bug.cgi?id=1419885, closing

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

Comment 4 Red Hat Bugzilla 2023-09-14 03:53:40 UTC
The needinfo request[s] on this closed bug have been removed as they have been unresolved for 1000 days