Castillo, Claris
2006-Jul-14 17:51 UTC
[Xen-users] XM save hanging when saving VM in pause state
Hi,
I apologize for sending a second email on the same issue but I have been
looking and looking at
different lists for a hint that point me in some direction.
I am stuck on this and have no idea of how to fix it. Unfortunately the
error messages in the log file are not self-explained so I can''t really
figure it out myself.
I am trying to save (xm save) a virtual machine which is in pause state
(xm pause) and xen seems to hang.
Below step by step what is happening
[root@overlay2 ~]# xm list
Name ID Mem(MiB) VCPUs State Time(s)
Domain-0 0 3418 4 r----- 22.6
[root@overlay2 ~]# clear
[root@overlay2 ~]# xm create /etc/xen/suse1
Using config file "/etc/xen/suse1".
Started domain ecdvm1
[root@overlay2 ~]# xm list
Name ID Mem(MiB) VCPUs State Time(s)
Domain-0 0 3418 4 r----- 25.2
ecdvm1 2 128 1 -b---- 37.4
[root@overlay2 ~]# xm pause ecdvm1
[root@overlay2 ~]# xm list
Name ID Mem(MiB) VCPUs State Time(s)
Domain-0 0 3418 4 r----- 25.5
ecdvm1 2 128 1 --p--- 37.5
[root@overlay2 ~]# xm save ecdvm1 ecdvm1.back
[root@overlay2 ~]# xm save ecdvm1 ecdvm1.back
[CTRL+ C]
Interrupted.
[root@overlay2 ~]#
Xend.log file below
[2006-07-14 17:11:15 xend] INFO (SrvDaemon:285) Xend Daemon started
[2006-07-14 17:11:15 xend] INFO (SrvDaemon:289) Xend changeset:
unavailable .
[2006-07-14 17:11:15 xend.XendDomainInfo] DEBUG (XendDomainInfo:201)
XendDomainInfo.recreate({''paused'': 0,
''cpu_time'': 13439716051L,
''ssidref'': 0, ''handle'': [0, 0, 0, 0, 0, 0,
0, 0, 0, 0, 0, 0, 0, 0, 0,
0], ''shutdown_reason'': 0, ''dying'': 0,
''dom'': 0, ''mem_kb'': 3500796,
''maxmem_kb'': -4, ''max_vcpu_id'': 3,
''crashed'': 0, ''running'': 1,
''shutdown'': 0, ''online_vcpus'': 4,
''blocked'': 0})
[2006-07-14 17:11:15 xend.XendDomainInfo] INFO (XendDomainInfo:213)
Recreating domain 0, UUID 00000000-0000-0000-0000-000000000000.
[2006-07-14 17:11:15 xend.XendDomainInfo] WARNING (XendDomainInfo:235)
No vm path in store for existing domain 0
[2006-07-14 17:11:15 xend.XendDomainInfo] DEBUG (XendDomainInfo:673)
Storing VM details: {''ssidref'': ''0'',
''uuid'':
''00000000-0000-0000-0000-000000000000'',
''on_reboot'': ''restart'',
''on_poweroff'': ''destroy'',
''name'': ''Domain-0'',
''vcpus'': ''4'',
''vcpu_avail'': ''15'',
''memory'': ''3419'',
''on_crash'': ''restart'',
''maxmem'':
''3419''}
[2006-07-14 17:11:15 xend.XendDomainInfo] DEBUG (XendDomainInfo:698)
Storing domain details: {''cpu/1/availability'':
''online'',
''cpu/3/availability'': ''online'',
''name'': ''Domain-0'',
''console/limit'':
''1048576'', ''cpu/2/availability'':
''online'', ''vm'':
''/vm/00000000-0000-0000-0000-000000000000'',
''domid'': ''0'',
''cpu/0/availability'': ''online'',
''memory/target'': ''3501056''}
[2006-07-14 17:11:15 xend] DEBUG (XendDomain:152) number of vcpus to use
is 0
[2006-07-14 17:11:15 xend.XendDomainInfo] DEBUG (XendDomainInfo:882)
XendDomainInfo.handleShutdownWatch
[2006-07-14 17:13:09 xend.XendDomainInfo] DEBUG (XendDomainInfo:179)
XendDomainInfo.create([''vm'', [''name'',
''ecdvm1''], [''memory'', 128],
[''image'', [''linux'',
[''kernel'', ''/boot/vmlinuz-2.6.16.13-4-xen''],
[''ramdisk'', ''/boot/initrd-xen''],
[''ip'', '':1.2.3.4::::eth0:dhcp''],
[''root'', ''/dev/sda1'']]],
[''device'', [''vbd'',
[''uname'',
''phy:planetlab/ecdvm1''], [''dev'',
''sda1''], [''mode'', ''w'']]],
[''device'',
[''vif'']], [''device'',
[''vif'', [''bridge'',
''xenbr0'']]]])
[2006-07-14 17:13:09 xend.XendDomainInfo] DEBUG (XendDomainInfo:285)
parseConfig: config is [''vm'', [''name'',
''ecdvm1''], [''memory'', 128],
[''image'', [''linux'',
[''kernel'', ''/boot/vmlinuz-2.6.16.13-4-xen''],
[''ramdisk'', ''/boot/initrd-xen''],
[''ip'', '':1.2.3.4::::eth0:dhcp''],
[''root'', ''/dev/sda1'']]],
[''device'', [''vbd'',
[''uname'',
''phy:planetlab/ecdvm1''], [''dev'',
''sda1''], [''mode'', ''w'']]],
[''device'',
[''vif'']], [''device'',
[''vif'', [''bridge'',
''xenbr0'']]]]
[2006-07-14 17:13:09 xend.XendDomainInfo] DEBUG (XendDomainInfo:381)
parseConfig: result is {''ssidref'': None,
''uuid'': None, ''on_crash'': None,
''on_reboot'': None, ''image'':
[''linux'', [''kernel'',
''/boot/vmlinuz-2.6.16.13-4-xen''],
[''ramdisk'', ''/boot/initrd-xen''],
[''ip'', '':1.2.3.4::::eth0:dhcp''],
[''root'', ''/dev/sda1'']],
''on_poweroff'':
None, ''cpus'': None, ''name'':
''ecdvm1'', ''backend'': [],
''vcpus'': None,
''cpu_weight'': None, ''features'': None,
''vcpu_avail'': None, ''memory'': 128,
''device'': [(''vbd'', [''vbd'',
[''uname'', ''phy:planetlab/ecdvm1''],
[''dev'',
''sda1''], [''mode'', ''w'']]),
(''vif'', [''vif'']), (''vif'',
[''vif'', [''bridge'',
''xenbr0'']])], ''bootloader'': None,
''cpu'': None, ''maxmem'': None}
[2006-07-14 17:13:09 xend.XendDomainInfo] DEBUG (XendDomainInfo:1169)
XendDomainInfo.construct: None 0
[2006-07-14 17:13:09 xend.XendDomainInfo] DEBUG (XendDomainInfo:1201)
XendDomainInfo.initDomain: 1 1.0
[2006-07-14 17:13:09 xend] DEBUG (balloon:130) Balloon: free 128; need
129.
[2006-07-14 17:13:09 xend] DEBUG (balloon:139) Balloon: setting dom0
target to 3418.
[2006-07-14 17:13:09 xend.XendDomainInfo] DEBUG (XendDomainInfo:950)
Setting memory target of domain Domain-0 (0) to 3418 MiB.
[2006-07-14 17:13:09 xend] DEBUG (balloon:126) Balloon: free 129; need
129; done.
[2006-07-14 17:13:09 xend] INFO (image:133) buildDomain os=linux dom=1
vcpus=1
[2006-07-14 17:13:09 xend] DEBUG (image:171) dom = 1
[2006-07-14 17:13:09 xend] DEBUG (image:172) image
/boot/vmlinuz-2.6.16.13-4-xen
[2006-07-14 17:13:09 xend] DEBUG (image:173) store_evtchn = 1
[2006-07-14 17:13:09 xend] DEBUG (image:174) console_evtchn = 2
[2006-07-14 17:13:09 xend] DEBUG (image:175) cmdline
ip=:1.2.3.4::::eth0:dhcp root=/dev/sda1
[2006-07-14 17:13:09 xend] DEBUG (image:176) ramdisk /boot/initrd-xen
[2006-07-14 17:13:09 xend] DEBUG (image:177) vcpus = 1
[2006-07-14 17:13:09 xend] DEBUG (image:178) features
[2006-07-14 17:13:10 xend] DEBUG (DevController:103) DevController:
writing {''virtual-device'': ''2049'',
''backend-id'': ''0'',
''state'': ''1'',
''backend'':
''/local/domain/0/backend/vbd/1/2049''} to
/local/domain/1/device/vbd/2049.
[2006-07-14 17:13:10 xend] DEBUG (DevController:105) DevController:
writing {''domain'': ''ecdvm1'',
''frontend'':
''/local/domain/1/device/vbd/2049'', ''dev'':
''sda1'', ''state'': ''1'',
''params'': ''planetlab/ecdvm1'',
''mode'': ''w'',
''frontend-id'': ''1'',
''type'':
''phy''} to /local/domain/0/backend/vbd/1/2049.
[2006-07-14 17:13:10 xend] DEBUG (DevController:103) DevController:
writing {''backend-id'': ''0'',
''mac'': ''00:16:3e:52:d6:e4'',
''handle'': ''0'',
''state'': ''1'', ''backend'':
''/local/domain/0/backend/vif/1/0''} to
/local/domain/1/device/vif/0.
[2006-07-14 17:13:10 xend] DEBUG (DevController:105) DevController:
writing {''mac'': ''00:16:3e:52:d6:e4'',
''state'': ''1'', ''handle'':
''0'',
''script'': ''/etc/xen/scripts/vif-bridge'',
''frontend-id'': ''1'',
''domain'':
''ecdvm1'', ''frontend'':
''/local/domain/1/device/vif/0''} to
/local/domain/0/backend/vif/1/0.
[2006-07-14 17:13:10 xend] DEBUG (DevController:103) DevController:
writing {''backend-id'': ''0'',
''mac'': ''00:16:3e:74:08:82'',
''handle'': ''1'',
''state'': ''1'', ''backend'':
''/local/domain/0/backend/vif/1/1''} to
/local/domain/1/device/vif/1.
[2006-07-14 17:13:10 xend] DEBUG (DevController:105) DevController:
writing {''bridge'': ''xenbr0'',
''domain'': ''ecdvm1'',
''handle'': ''1'',
''script'': ''/etc/xen/scripts/vif-bridge'',
''state'': ''1'', ''frontend'':
''/local/domain/1/device/vif/1'', ''mac'':
''00:16:3e:74:08:82'',
''frontend-id'': ''1''} to
/local/domain/0/backend/vif/1/1.
[2006-07-14 17:13:10 xend.XendDomainInfo] DEBUG (XendDomainInfo:673)
Storing VM details: {''ssidref'': ''0'',
''uuid'':
''2eeadc9a-5b32-7452-b636-9799a337f616'',
''on_reboot'': ''restart'',
''start_time'': ''1152915190.22'',
''on_poweroff'': ''destroy'',
''name'':
''ecdvm1'', ''vcpus'': ''1'',
''vcpu_avail'': ''1'',
''memory'': ''128'',
''on_crash'':
''restart'', ''image'': ''(linux (kernel
/boot/vmlinuz-2.6.16.13-4-xen)
(ramdisk /boot/initrd-xen) (ip :1.2.3.4::::eth0:dhcp) (root
/dev/sda1))'', ''maxmem'': ''128''}
[2006-07-14 17:13:10 xend.XendDomainInfo] DEBUG (XendDomainInfo:698)
Storing domain details: {''console/ring-ref'':
''293514'', ''console/port'':
''2'', ''name'': ''ecdvm1'',
''console/limit'': ''1048576'',
''vm'':
''/vm/2eeadc9a-5b32-7452-b636-9799a337f616'',
''domid'': ''1'',
''cpu/0/availability'': ''online'',
''memory/target'': ''131072'',
''store/ring-ref'': ''293515'',
''store/port'': ''1''}
[2006-07-14 17:13:10 xend.XendDomainInfo] DEBUG (XendDomainInfo:882)
XendDomainInfo.handleShutdownWatch
[2006-07-14 17:13:10 xend] DEBUG (DevController:132) Waiting for devices
vif.
[2006-07-14 17:13:10 xend] DEBUG (DevController:138) Waiting for 0.
[2006-07-14 17:13:10 xend] DEBUG (DevController:403)
hotplugStatusCallback /local/domain/0/backend/vif/1/0/hotplug-status.
[2006-07-14 17:13:10 xend] DEBUG (DevController:403)
hotplugStatusCallback /local/domain/0/backend/vif/1/0/hotplug-status.
[2006-07-14 17:13:10 xend] DEBUG (DevController:417)
hotplugStatusCallback 1.
[2006-07-14 17:13:10 xend] DEBUG (DevController:138) Waiting for 1.
[2006-07-14 17:13:10 xend] DEBUG (DevController:403)
hotplugStatusCallback /local/domain/0/backend/vif/1/1/hotplug-status.
[2006-07-14 17:13:10 xend] DEBUG (DevController:417)
hotplugStatusCallback 1.
[2006-07-14 17:13:10 xend] DEBUG (DevController:132) Waiting for devices
usb.
[2006-07-14 17:13:10 xend] DEBUG (DevController:132) Waiting for devices
vbd.
[2006-07-14 17:13:10 xend] DEBUG (DevController:138) Waiting for 2049.
[2006-07-14 17:13:10 xend] DEBUG (DevController:403)
hotplugStatusCallback /local/domain/0/backend/vbd/1/2049/hotplug-status.
[2006-07-14 17:13:10 xend] DEBUG (DevController:403)
hotplugStatusCallback /local/domain/0/backend/vbd/1/2049/hotplug-status.
[2006-07-14 17:13:10 xend] DEBUG (DevController:417)
hotplugStatusCallback 1.
[2006-07-14 17:13:10 xend] DEBUG (DevController:132) Waiting for devices
irq.
[2006-07-14 17:13:10 xend] DEBUG (DevController:132) Waiting for devices
pci.
[2006-07-14 17:13:10 xend] DEBUG (DevController:132) Waiting for devices
ioports.
[2006-07-14 17:13:10 xend] DEBUG (DevController:132) Waiting for devices
vtpm.
[2006-07-14 17:13:10 xend] INFO (XendDomain:363) Domain ecdvm1 (1)
unpaused.
[2006-07-14 17:13:28 xend] INFO (XendDomain:376) Domain ecdvm1 (1)
paused.
[2006-07-14 17:13:37 xend] DEBUG (XendCheckpoint:81) [xc_save]:
/usr/lib/xen/bin/xc_save 10 18 1 0 0 0
[2006-07-14 17:13:37 xend] DEBUG (XendCheckpoint:204) suspend
[2006-07-14 17:13:37 xend] DEBUG (XendCheckpoint:84) In saveInputHandler
suspend
[2006-07-14 17:13:37 xend] DEBUG (XendCheckpoint:86) Suspending 1 ...
[2006-07-14 17:13:37 xend.XendDomainInfo] DEBUG (XendDomainInfo:882)
XendDomainInfo.handleShutdownWatch -------> It HANGS HERE
_______________________________________________
Xen-users mailing list
Xen-users@lists.xensource.com
http://lists.xensource.com/xen-users