Bug 1388403

Summary: migration: Virt-manager source stuck in paused
Product: [Community] Virtualization Tools Reporter: Dr. David Alan Gilbert <dgilbert>
Component: virt-managerAssignee: Cole Robinson <crobinso>
Status: CLOSED DUPLICATE QA Contact: Fedora Extras Quality Assurance <extras-qa>
Severity: unspecified Docs Contact:
Priority: unspecified    
Version: unspecifiedCC: berrange, crobinso, gscrivan, rbalakri, virt-maint
Target Milestone: ---   
Target Release: ---   
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: 2018-02-27 21:40:21 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 Dr. David Alan Gilbert 2016-10-25 09:17:03 UTC
Description of problem:
I'm bouncing a VM back and forward between two remote hosts, using virt-manager's migrate.  I'm clicking the 'temporary' when going from host vl413-vl414 and then bringing it back.
Sometimes (1/4-1/8 ish) the source is shown as 'paused' after migration has completed (virsh list on the source shows it empty).

Version-Release number of selected component (if applicable):
Client (f25 laptop)
  virt-manager-1.4.0-3.fc25.noarch
  libvirt-client-2.2.0-1.fc25.x86_64

Hosts (RHEL7.2/3 ish)
  qemu-kvm-rhev-2.3.0-31.el7_2.23.x86_64
  libvirt-daemon-driver-qemu-2.0.0-5.el7.x86_64

How reproducible:
10-25%ish

Steps to Reproduce:
1. Start a VM on a remote host (~150ms ping latency) connected via ssh
2. Connect to another similar host
3. Select migrate and tick the temporary move
4. Wait for migration to complete
5. Select migrate (hmm ?? Not sure did I tick the temporary??)
6. Wait for migration to complete
7. goto 3

Actual results:
virt-manager shows VM as running on destination, but shows the VM still on the source as paused.  virsh list  on the source doesn't show the VM.
(I think this was probably after step 6 ?)

Expected results:
VM is no longer shown on source

Additional info:

from virt-manager's log:
[Tue, 25 Oct 2016 09:55:31 virt-manager 2450] DEBUG (console:844) Viewer connected
[Tue, 25 Oct 2016 09:55:40 virt-manager 2450] DEBUG (connection:755) domain lifecycle event: domain=cbitwin2k12r2 event=3 reason=1
[Tue, 25 Oct 2016 09:55:40 virt-manager 2450] DEBUG (connection:755) domain lifecycle event: domain=cbitwin2k12r2 event=0 reason=1
[Tue, 25 Oct 2016 09:55:40 virt-manager 2450] DEBUG (connection:755) domain lifecycle event: domain=cbitwin2k12r2 event=4 reason=0
[Tue, 25 Oct 2016 09:55:40 virt-manager 2450] DEBUG (connection:755) domain lifecycle event: domain=cbitwin2k12r2 event=4 reason=1
[Tue, 25 Oct 2016 09:55:40 virt-manager 2450] ERROR (connection:1206) Tick for <domain.vmmDomain object at 0x7efc77f287d0 (virtManager+domain+vmmDomain at 0x555bc8a514e0)> failed
Traceback (most recent call last):
  File "/usr/share/virt-manager/virtManager/connection.py", line 1204, in _tick
    obj.tick(stats_update=stats_update)
  File "/usr/share/virt-manager/virtManager/domain.py", line 1886, in tick
    self._tick_stats(info)
  File "/usr/share/virt-manager/virtManager/domain.py", line 1900, in _tick_stats
    pcentHostCpu, pcentGuestCpu) = self._sample_cpu_stats(info, now)
  File "/usr/share/virt-manager/virtManager/domain.py", line 1503, in _sample_cpu_stats
    info = self._backend.info()
  File "/usr/lib64/python2.7/site-packages/libvirt.py", line 1310, in info
    if ret is None: raise libvirtError ('virDomainGetInfo() failed', dom=self)
libvirtError: Domain not found: no domain with matching uuid '8358e334-c8b8-4f9c-97eb-fa5d22a20b0b' (cbitwin2k12r2)
[Tue, 25 Oct 2016 09:55:40 virt-manager 2450] ERROR (domain:137) Error calling jobinfo
Traceback (most recent call last):
  File "/usr/share/virt-manager/virtManager/domain.py", line 121, in jobinfo_cb
    jobinfo = vm.job_info()
  File "/usr/share/virt-manager/virtManager/domain.py", line 1111, in job_info
    return self._backend.jobInfo()
  File "/usr/lib64/python2.7/site-packages/libvirt.py", line 1381, in jobInfo
    if ret is None: raise libvirtError ('virDomainGetJobInfo() failed', dom=self)
libvirtError: Domain not found: no domain with matching uuid '8358e334-c8b8-4f9c-97eb-fa5d22a20b0b' (cbitwin2k12r2)
[Tue, 25 Oct 2016 09:55:41 virt-manager 2450] DEBUG (cli:251) Uncaught exception:
Traceback (most recent call last):
  File "/usr/share/virt-manager/virtManager/details.py", line 1307, in refresh_vm_state
    reason = self.vm.run_status_reason()
  File "/usr/share/virt-manager/virtManager/domain.py", line 1659, in run_status_reason
    return self.pretty_status_reason(self.status(), self.status_reason())
  File "/usr/share/virt-manager/virtManager/domain.py", line 453, in status_reason
    self._status_reason = self._backend.state()[1]
  File "/usr/lib64/python2.7/site-packages/libvirt.py", line 2817, in state
    if ret is None: raise libvirtError ('virDomainGetState() failed', dom=self)
libvirtError: Domain not found: no domain with matching uuid '8358e334-c8b8-4f9c-97eb-fa5d22a20b0b' (cbitwin2k12r2)

[Tue, 25 Oct 2016 09:55:42 virt-manager 2450] DEBUG (migrate:83) Closing migrate wizard
[Tue, 25 Oct 2016 09:55:42 virt-manager 2450] DEBUG (connection:755) domain lifecycle event: domain=cbitwin2k12r2 event=5 reason=3
[Tue, 25 Oct 2016 09:55:42 virt-manager 2450] DEBUG (libvirtobject:277) Error refreshing <domain.vmmDomain object at 0x7efc77f287d0 (virtManager+domain+vmmDomain at 0x555bc8a514e0)> from events: Domain not found: no domain with matching uuid '8358e334-c8b8-4f9c-97eb-fa5d22a20b0b' (cbitwin2k12r2)
[Tue, 25 Oct 2016 09:55:42 virt-manager 2450] DEBUG (libvirtobject:281) Scheduling priority tick with: {'pollvm': True, 'force': True}
[Tue, 25 Oct 2016 09:55:44 virt-manager 2450] ERROR (connection:1206) Tick for <domain.vmmDomain object at 0x7efc77f287d0 (virtManager+domain+vmmDomain at 0x555bc8a514e0)> failed
Traceback (most recent call last):
  File "/usr/share/virt-manager/virtManager/connection.py", line 1204, in _tick
    obj.tick(stats_update=stats_update)
  File "/usr/share/virt-manager/virtManager/domain.py", line 1886, in tick
    self._tick_stats(info)
  File "/usr/share/virt-manager/virtManager/domain.py", line 1900, in _tick_stats
    pcentHostCpu, pcentGuestCpu) = self._sample_cpu_stats(info, now)
  File "/usr/share/virt-manager/virtManager/domain.py", line 1503, in _sample_cpu_stats
    info = self._backend.info()
  File "/usr/lib64/python2.7/site-packages/libvirt.py", line 1310, in info
    if ret is None: raise libvirtError ('virDomainGetInfo() failed', dom=self)
libvirtError: Domain not found: no domain with matching uuid '8358e334-c8b8-4f9c-97eb-fa5d22a20b0b' (cbitwin2k12r2)
[Tue, 25 Oct 2016 09:55:47 virt-manager 2450] ERROR (connection:1206) Tick for <domain.vmmDomain object at 0x7efc77f287d0 (virtManager+domain+vmmDomain at 0x555bc8a514e0)> failed
Traceback (most recent call last):
  File "/usr/share/virt-manager/virtManager/connection.py", line 1204, in _tick
    obj.tick(stats_update=stats_update)
  File "/usr/share/virt-manager/virtManager/domain.py", line 1886, in tick
    self._tick_stats(info)
  File "/usr/share/virt-manager/virtManager/domain.py", line 1900, in _tick_stats
    pcentHostCpu, pcentGuestCpu) = self._sample_cpu_stats(info, now)
  File "/usr/share/virt-manager/virtManager/domain.py", line 1503, in _sample_cpu_stats
    info = self._backend.info()
  File "/usr/lib64/python2.7/site-packages/libvirt.py", line 1310, in info
    if ret is None: raise libvirtError ('virDomainGetInfo() failed', dom=self)
libvirtError: Domain not found: no domain with matching uuid '8358e334-c8b8-4f9c-97eb-fa5d22a20b0b' (cbitwin2k12r2)

Comment 1 Cole Robinson 2018-02-27 21:40:21 UTC

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