From mboxrd@z Thu Jan 1 00:00:00 1970 From: =?ISO-8859-1?Q?Oriol_Mart=ED?= Subject: Virtual machine freezed after a save Date: Mon, 09 Jan 2012 11:49:31 +0100 Message-ID: <4F0AC63B.5000202@cesca.cat> Mime-Version: 1.0 Content-Type: text/plain; charset=ISO-8859-1; format=flowed Content-Transfer-Encoding: QUOTED-PRINTABLE To: kvm@vger.kernel.org Return-path: Received: from gabarro.xs.cesca.cat ([84.88.0.6]:16933 "EHLO gabarro.xs.cesca.cat" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1753536Ab2AIK73 (ORCPT ); Mon, 9 Jan 2012 05:59:29 -0500 Sender: kvm-owner@vger.kernel.org List-ID: Hello, I have an Ubuntu Server with KVM, the extensions in the BIOS are= =20 enabled: root@cluster03:~# kvm-ok INFO: Your CPU supports KVM extensions INFO: /dev/kvm exists KVM acceleration can be used The problem is that when i do a save of a virtual machine, the screen=20 freezes and the ping does not respond when I restore. Does sombody know= =20 why the vm does not restore normally? Thx. PD: the commands I use--> virsh --connect qemu+ssh:///system save one-309 one-309 virsh --connect qemu+ssh:///system restore one-309 I've saved the debug logs with export=20 LIBVIRT_LOG_OUTPUTS=3D"1:file:virsh.log" and this is: 10:49:31.794: debug : virInitialize:337 : register drivers 10:49:31.794: debug : virRegisterDriver:838 : registering Test as drive= r 0 10:49:31.794: debug : virRegisterNetworkDriver:676 : registering Test a= s network driver 0 10:49:31.794: debug : virRegisterInterfaceDriver:707 : registering Test= as interface driver 0 10:49:31.794: debug : virRegisterStorageDriver:738 : registering Test a= s storage driver 0 10:49:31.794: debug : virRegisterDeviceMonitor:769 : registering Test a= s device driver 0 10:49:31.794: debug : virRegisterSecretDriver:800 : registering Test as= secret driver 0 10:49:31.794: debug : virRegisterDriver:838 : registering Xen as driver= 1 10:49:31.794: debug : virRegisterDriver:838 : registering OPENVZ as dri= ver 2 10:49:31.794: debug : vboxRegister:109 : VBoxCGlueInit failed, using du= mmy driver 10:49:31.794: debug : virRegisterDriver:838 : registering VBOX as drive= r 3 10:49:31.794: debug : virRegisterNetworkDriver:676 : registering VBOX a= s network driver 1 10:49:31.794: debug : virRegisterStorageDriver:738 : registering VBOX a= s storage driver 1 10:49:31.794: debug : virRegisterDriver:838 : registering remote as dri= ver 4 10:49:31.794: debug : virRegisterNetworkDriver:676 : registering remote= as network driver 2 10:49:31.794: debug : virRegisterInterfaceDriver:707 : registering remo= te as interface driver 1 10:49:31.794: debug : virRegisterStorageDriver:738 : registering remote= as storage driver 2 10:49:31.794: debug : virRegisterDeviceMonitor:769 : registering remote= as device driver 1 10:49:31.794: debug : virRegisterSecretDriver:800 : registering remote = as secret driver 1 10:49:31.794: debug : virConnectOpenAuth:1338 : name=3Dqemu+ssh:///syst= em, auth=3D0x7f282a1b3b80, flags=3D0 10:49:31.794: debug : do_open:1107 : name "qemu+ssh:///system" to URI c= omponents: scheme qemu+ssh opaque (null) authority (null) server (null) user (null) port 0 path /system 10:49:31.794: debug : do_open:1117 : trying driver 0 (Test) ... 10:49:31.794: debug : do_open:1123 : driver 0 Test returned DECLINED 10:49:31.794: debug : do_open:1117 : trying driver 1 (Xen) ... 10:49:31.794: debug : do_open:1123 : driver 1 Xen returned DECLINED 10:49:31.794: debug : do_open:1117 : trying driver 2 (OPENVZ) ... 10:49:31.794: debug : do_open:1123 : driver 2 OPENVZ returned DECLINED 10:49:31.794: debug : do_open:1117 : trying driver 3 (VBOX) ... 10:49:31.794: debug : do_open:1123 : driver 3 VBOX returned DECLINED 10:49:31.794: debug : do_open:1117 : trying driver 4 (remote) ... 10:49:31.794: debug : doRemoteOpen:565 : proceeding with name =3D qemu:= ///system 10:49:31.794: debug : virExecWithHook:620 : ssh localhost nc -q 2>&1 | = grep -q 'requires an argument';if [ $? -eq 0 ] ; then CMD=3D'-q 0';el= se CMD=3D'';fi;nc $CMD -U /var/run/libvirt/libvirt-sock 10:49:31.794: debug : remoteIO:8457 : Do proc=3D66 serial=3D0 length=3D= 28 wait=3D(nil) 10:49:31.794: debug : remoteIO:8519 : We have the buck 66 0x7f282a1ea01= 0 0x7f282a1ea010 10:49:35.755: debug : remoteIODecodeMessageLength:7941 : Got length, no= w need 64 total (60 more) 10:49:35.755: debug : remoteIOEventLoop:8383 : Giving up the buck 66 0x= 7f282a1ea010 (nil) 10:49:35.755: debug : remoteIO:8550 : All done with our call 66 (nil) 0= x7f282a1ea010 10:49:35.755: debug : remoteIO:8457 : Do proc=3D1 serial=3D1 length=3D5= 6 wait=3D(nil) 10:49:35.755: debug : remoteIO:8519 : We have the buck 1 0x67a930 0x67a= 930 10:49:35.755: debug : remoteIODecodeMessageLength:7941 : Got length, no= w need 56 total (52 more) 10:49:35.755: debug : remoteIOEventLoop:8383 : Giving up the buck 1 0x6= 7a930 (nil) 10:49:35.755: debug : remoteIO:8550 : All done with our call 1 (nil) 0x= 67a930 10:49:35.755: debug : doRemoteOpen:918 : Adding Handler for remote even= ts 10:49:35.755: debug : doRemoteOpen:925 : virEventAddHandle failed: No a= ddHandleImpl defined. continuing without events. 10:49:35.755: debug : do_open:1123 : driver 4 remote returned SUCCESS 10:49:35.755: debug : do_open:1143 : network driver 0 Test returned DEC= LINED 10:49:35.755: debug : do_open:1143 : network driver 1 VBOX returned DEC= LINED 10:49:35.755: debug : do_open:1143 : network driver 2 remote returned S= UCCESS 10:49:35.755: debug : do_open:1162 : interface driver 0 Test returned D= ECLINED 10:49:35.755: debug : do_open:1162 : interface driver 1 remote returned= SUCCESS 10:49:35.755: debug : do_open:1182 : storage driver 0 Test returned DEC= LINED 10:49:35.755: debug : do_open:1182 : storage driver 1 VBOX returned DEC= LINED 10:49:35.755: debug : do_open:1182 : storage driver 2 remote returned S= UCCESS 10:49:35.755: debug : do_open:1202 : node driver 0 Test returned DECLIN= ED 10:49:35.755: debug : do_open:1202 : node driver 1 remote returned SUCC= ESS 10:49:35.755: debug : do_open:1229 : secret driver 0 Test returned DECL= INED 10:49:35.755: debug : do_open:1229 : secret driver 1 remote returned SU= CCESS 10:49:35.755: debug : virDomainLookupByName:1975 : conn=3D0x674c50, nam= e=3Done-309 10:49:35.756: debug : remoteIO:8457 : Do proc=3D23 serial=3D2 length=3D= 40 wait=3D(nil) 10:49:35.756: debug : remoteIO:8519 : We have the buck 23 0x67a4d0 0x67= a4d0 10:49:35.756: debug : remoteIODecodeMessageLength:7941 : Got length, no= w need 88 total (84 more) 10:49:35.756: debug : remoteIOEventLoop:8383 : Giving up the buck 23 0x= 67a4d0 (nil) 10:49:35.756: debug : remoteIO:8550 : All done with our call 23 (nil) 0= x67a4d0 10:49:35.756: debug : virGetDomain:345 : New hash entry 0x6749b0 10:49:35.756: debug : virDomainSave:2217 : domain=3D0x6749b0, to=3Done-= 309 10:49:35.756: debug : remoteIO:8457 : Do proc=3D55 serial=3D3 length=3D= 80 wait=3D(nil) 10:49:35.756: debug : remoteIO:8519 : We have the buck 55 0x67a4d0 0x67= a4d0 10:52:23.598: debug : remoteIODecodeMessageLength:7941 : Got length, no= w need 56 total (52 more) 10:52:23.598: debug : remoteIOEventLoop:8383 : Giving up the buck 55 0x= 67a4d0 (nil) 10:52:23.598: debug : remoteIO:8550 : All done with our call 55 (nil) 0= x67a4d0 10:52:23.598: debug : virDomainFree:2063 : domain=3D0x6749b0 10:52:23.598: debug : virUnrefDomain:422 : unref domain 0x6749b0 one-30= 9 1 10:52:23.598: debug : virReleaseDomain:376 : release domain 0x6749b0 on= e-309 10:52:23.598: debug : virReleaseDomain:392 : unref connection 0x674c50 = 2 10:52:23.598: debug : virConnectClose:1356 : conn=3D0x674c50 10:52:23.598: debug : virUnrefConnect:259 : unref connection 0x674c50 1 10:52:23.598: debug : remoteIO:8457 : Do proc=3D2 serial=3D4 length=3D2= 8 wait=3D(nil) 10:52:23.598: debug : remoteIO:8519 : We have the buck 2 0x67a4d0 0x67a= 4d0 10:52:23.598: debug : remoteIODecodeMessageLength:7941 : Got length, no= w need 56 total (52 more) 10:52:23.598: debug : remoteIOEventLoop:8383 : Giving up the buck 2 0x6= 7a4d0 (nil) 10:52:23.598: debug : remoteIO:8550 : All done with our call 2 (nil) 0x= 67a4d0 10:52:23.599: debug : virReleaseConnect:216 : release connection 0x674c= 50 11:01:19.623: debug : virInitialize:337 : register drivers 11:01:19.624: debug : virRegisterDriver:838 : registering Test as drive= r 0 11:01:19.624: debug : virRegisterNetworkDriver:676 : registering Test a= s network driver 0 11:01:19.624: debug : virRegisterInterfaceDriver:707 : registering Test= as interface driver 0 11:01:19.624: debug : virRegisterStorageDriver:738 : registering Test a= s storage driver 0 11:01:19.624: debug : virRegisterDeviceMonitor:769 : registering Test a= s device driver 0 11:01:19.624: debug : virRegisterSecretDriver:800 : registering Test as= secret driver 0 11:01:19.624: debug : virRegisterDriver:838 : registering Xen as driver= 1 11:01:19.624: debug : virRegisterDriver:838 : registering OPENVZ as dri= ver 2 11:01:19.624: debug : vboxRegister:109 : VBoxCGlueInit failed, using du= mmy driver 11:01:19.624: debug : virRegisterDriver:838 : registering VBOX as drive= r 3 11:01:19.624: debug : virRegisterNetworkDriver:676 : registering VBOX a= s network driver 1 11:01:19.624: debug : virRegisterStorageDriver:738 : registering VBOX a= s storage driver 1 11:01:19.624: debug : virRegisterDriver:838 : registering remote as dri= ver 4 11:01:19.624: debug : virRegisterNetworkDriver:676 : registering remote= as network driver 2 11:01:19.624: debug : virRegisterInterfaceDriver:707 : registering remo= te as interface driver 1 11:01:19.624: debug : virRegisterStorageDriver:738 : registering remote= as storage driver 2 11:01:19.624: debug : virRegisterDeviceMonitor:769 : registering remote= as device driver 1 11:01:19.624: debug : virRegisterSecretDriver:800 : registering remote = as secret driver 1 11:01:19.624: debug : virConnectOpenAuth:1338 : name=3Dqemu+ssh:///syst= em, auth=3D0x7fcfdd6b4b80, flags=3D0 11:01:19.624: debug : do_open:1107 : name "qemu+ssh:///system" to URI c= omponents: scheme qemu+ssh opaque (null) authority (null) server (null) user (null) port 0 path /system 11:01:19.624: debug : do_open:1117 : trying driver 0 (Test) ... 11:01:19.624: debug : do_open:1123 : driver 0 Test returned DECLINED 11:01:19.624: debug : do_open:1117 : trying driver 1 (Xen) ... 11:01:19.624: debug : do_open:1123 : driver 1 Xen returned DECLINED 11:01:19.624: debug : do_open:1117 : trying driver 2 (OPENVZ) ... 11:01:19.624: debug : do_open:1123 : driver 2 OPENVZ returned DECLINED 11:01:19.624: debug : do_open:1117 : trying driver 3 (VBOX) ... 11:01:19.624: debug : do_open:1123 : driver 3 VBOX returned DECLINED 11:01:19.624: debug : do_open:1117 : trying driver 4 (remote) ... 11:01:19.624: debug : doRemoteOpen:565 : proceeding with name =3D qemu:= ///system 11:01:19.624: debug : virExecWithHook:620 : ssh localhost nc -q 2>&1 | = grep -q 'requires an argument';if [ $? -eq 0 ] ; then CMD=3D'-q 0';el= se CMD=3D'';fi;nc $CMD -U /var/run/libvirt/libvirt-sock 11:01:19.624: debug : remoteIO:8457 : Do proc=3D66 serial=3D0 length=3D= 28 wait=3D(nil) 11:01:19.624: debug : remoteIO:8519 : We have the buck 66 0x7fcfdd6eb01= 0 0x7fcfdd6eb010 11:01:22.993: debug : remoteIODecodeMessageLength:7941 : Got length, no= w need 64 total (60 more) 11:01:22.993: debug : remoteIOEventLoop:8383 : Giving up the buck 66 0x= 7fcfdd6eb010 (nil) 11:01:22.993: debug : remoteIO:8550 : All done with our call 66 (nil) 0= x7fcfdd6eb010 11:01:22.993: debug : remoteIO:8457 : Do proc=3D1 serial=3D1 length=3D5= 6 wait=3D(nil) 11:01:22.993: debug : remoteIO:8519 : We have the buck 1 0x6c68f0 0x6c6= 8f0 11:01:22.994: debug : remoteIODecodeMessageLength:7941 : Got length, no= w need 56 total (52 more) 11:01:22.994: debug : remoteIOEventLoop:8383 : Giving up the buck 1 0x6= c68f0 (nil) 11:01:22.994: debug : remoteIO:8550 : All done with our call 1 (nil) 0x= 6c68f0 11:01:22.994: debug : doRemoteOpen:918 : Adding Handler for remote even= ts 11:01:22.994: debug : doRemoteOpen:925 : virEventAddHandle failed: No a= ddHandleImpl defined. continuing without events. 11:01:22.994: debug : do_open:1123 : driver 4 remote returned SUCCESS 11:01:22.994: debug : do_open:1143 : network driver 0 Test returned DEC= LINED 11:01:22.994: debug : do_open:1143 : network driver 1 VBOX returned DEC= LINED 11:01:22.994: debug : do_open:1143 : network driver 2 remote returned S= UCCESS 11:01:22.994: debug : do_open:1162 : interface driver 0 Test returned D= ECLINED 11:01:22.994: debug : do_open:1162 : interface driver 1 remote returned= SUCCESS 11:01:22.994: debug : do_open:1182 : storage driver 0 Test returned DEC= LINED 11:01:22.994: debug : do_open:1182 : storage driver 1 VBOX returned DEC= LINED 11:01:22.994: debug : do_open:1182 : storage driver 2 remote returned S= UCCESS 11:01:22.994: debug : do_open:1202 : node driver 0 Test returned DECLIN= ED 11:01:22.994: debug : do_open:1202 : node driver 1 remote returned SUCC= ESS 11:01:22.994: debug : do_open:1229 : secret driver 0 Test returned DECL= INED 11:01:22.994: debug : do_open:1229 : secret driver 1 remote returned SU= CCESS 11:01:22.994: debug : virDomainRestore:2284 : conn=3D0x6c0c10, from=3Do= ne-309 11:01:22.994: debug : remoteIO:8457 : Do proc=3D54 serial=3D2 length=3D= 48 wait=3D(nil) 11:01:22.994: debug : remoteIO:8519 : We have the buck 54 0x6c6490 0x6c= 6490 11:01:23.620: debug : remoteIODecodeMessageLength:7941 : Got length, no= w need 56 total (52 more) 11:01:23.620: debug : remoteIOEventLoop:8383 : Giving up the buck 54 0x= 6c6490 (nil) 11:01:23.621: debug : remoteIO:8550 : All done with our call 54 (nil) 0= x6c6490 11:01:23.621: debug : virConnectClose:1356 : conn=3D0x6c0c10 11:01:23.621: debug : virUnrefConnect:259 : unref connection 0x6c0c10 1 11:01:23.621: debug : remoteIO:8457 : Do proc=3D2 serial=3D3 length=3D2= 8 wait=3D(nil) 11:01:23.621: debug : remoteIO:8519 : We have the buck 2 0x6c6490 0x6c6= 490 11:01:23.621: debug : remoteIODecodeMessageLength:7941 : Got length, no= w need 56 total (52 more) 11:01:23.621: debug : remoteIOEventLoop:8383 : Giving up the buck 2 0x6= c6490 (nil) 11:01:23.621: debug : remoteIO:8550 : All done with our call 2 (nil) 0x= 6c6490 11:01:23.622: debug : virReleaseConnect:216 : release connection 0x6c0c= 10 --=20 =2E....................................................................= =2E __ / / Oriol Mart=ED i Bonveh=ED C E / S / C A Departament de Sistemes i Xarxes /_/ Centre de Serveis Cient=EDfics i Acad=E8mics de Cat= alunya Gran Capit=E0, 2-4 (Edifici Nexus) =B7 08034 Barcelona T. 93 551 62 12 =B7 F. 93 205 6979 =B7 omarti@cesca.cat =2E....................................................................= =2E