From mboxrd@z Thu Jan 1 00:00:00 1970 From: Nikola Ciprich Subject: high host load from vmx_set_supported_cpuid call? Date: Sun, 2 Dec 2012 12:41:37 +0100 Message-ID: <20121202114137.GA7448@nik-comp.linuxbox.cz> Mime-Version: 1.0 Content-Type: multipart/signed; micalg=pgp-sha1; protocol="application/pgp-signature"; boundary="WIyZ46R2i8wDzkSu" Cc: nikola.ciprich@linuxbox.cz To: kvm Return-path: Received: from gwu.lbox.cz ([62.245.111.132]:43253 "EHLO gwu.lbox.cz" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1752295Ab2LBLl3 (ORCPT ); Sun, 2 Dec 2012 06:41:29 -0500 Received: from linuxbox.linuxbox.cz (linuxbox.linuxbox.cz [IPv6:fd97:818a:331c:66::10] (may be forged)) by gwu.lbox.cz (Sendmail) with ESMTP id qB2BfRZn027880 (version=TLSv1/SSLv3 cipher=DHE-RSA-AES256-SHA bits=256 verify=NO) for ; Sun, 2 Dec 2012 12:41:27 +0100 Content-Disposition: inline Sender: kvm-owner@vger.kernel.org List-ID: --WIyZ46R2i8wDzkSu Content-Type: text/plain; charset=us-ascii Content-Disposition: inline Content-Transfer-Encoding: quoted-printable Hi, while trying to find source of KVM guest slowness, I noticed following in p= erf top: 326.00 19.6% vmx_set_supported_cpuid /= lib/modules/3.0.53lb6.02/kernel/arch/x86/kvm/kvm-intel.ko =20 108.00 6.5% kvm_arch_dev_ioctl /= lib/modules/3.0.53lb6.02/kernel/arch/x86/kvm/kvm.ko =20 100.00 6.0% tick_dev_program_event [= kernel.kallsyms] =20 78.00 4.7% __remove_hrtimer [= kernel.kallsyms] =20 52.00 3.1% acpi_processor_reevaluate_tstate /= lib/modules/3.0.53lb6.02/kernel/drivers/acpi/processor.ko =20 45.00 2.7% find_busiest_group [= kernel.kallsyms] =20 43.00 2.6% do_raw_spin_lock [= kernel.kallsyms] =20 my question is, is this normal? I tried googling for vmx_set_supported_cpui= d but am not really clever about it... here's snippet from trace-cmd: version =3D 6 CPU 11 is empty cpus=3D12 qemu-kvm-7766 [000] 235066.551604: kvm_msi_set_irq: dst 1 vec= 51 (LowPrio|logical|edge|rh) qemu-kvm-7766 [000] 235066.551606: kvm_apic_accept_irq: apicid 0 = vec 81 (LowPrio|edge) qemu-kvm-7767 [001] 235066.551618: kvm_inj_virq: irq 81 qemu-kvm-7767 [001] 235066.551620: kvm_entry: vcpu 0 qemu-kvm-7767 [001] 235066.551625: kvm_exit: reason EP= T_MISCONFIG rip 0xffffffff81023d96 info 0 0 qemu-kvm-7767 [001] 235066.551630: kvm_emulate_insn: [FAILED T= O PARSE] rip=3D18446744071578992022 csbase=3D0 len=3D2 insn=3DARRAY[8b, 00,= c9, 89, c0, c3, 0f, 1f, 40, 00, 55, 48, 89, e5, 0f] flags=3D9 failed=3D0 qemu-kvm-7767 [001] 235066.551631: vcpu_match_mmio: gva 0xfff= fc900000040f0 gpa 0xfed000f0 Read GPA qemu-kvm-7767 [001] 235066.551632: kvm_mmio: mmio unsa= tisfied-read len 4 gpa 0xfed000f0 val 0x0 qemu-kvm-7767 [001] 235066.551634: kvm_userspace_exit: reason KV= M_EXIT_MMIO (6) qemu-kvm-7767 [001] 235066.551648: kvm_mmio: mmio read= len 4 gpa 0xfed000f0 val 0xfed25f11 qemu-kvm-7767 [001] 235066.551649: kvm_entry: vcpu 0 qemu-kvm-7767 [001] 235066.551650: kvm_exit: reason EP= T_MISCONFIG rip 0xffffffff81023d96 info 0 0 qemu-kvm-7767 [001] 235066.551652: kvm_emulate_insn: [FAILED T= O PARSE] rip=3D18446744071578992022 csbase=3D0 len=3D2 insn=3DARRAY[8b, 00,= c9, 89, c0, c3, 0f, 1f, 40, 00, 55, 48, 89, e5, 0f] flags=3D9 failed=3D0 qemu-kvm-7767 [001] 235066.551652: vcpu_match_mmio: gva 0xfff= fc900000040f0 gpa 0xfed000f0 Read GPA qemu-kvm-7767 [001] 235066.551653: kvm_mmio: mmio unsa= tisfied-read len 4 gpa 0xfed000f0 val 0x0 qemu-kvm-7767 [001] 235066.551653: kvm_userspace_exit: reason KV= M_EXIT_MMIO (6) qemu-kvm-7767 [001] 235066.551656: kvm_mmio: mmio read= len 4 gpa 0xfed000f0 val 0xfed26450 qemu-kvm-7767 [001] 235066.551657: kvm_entry: vcpu 0 qemu-kvm-7767 [001] 235066.551659: kvm_exit: reason EP= T_MISCONFIG rip 0xffffffff81023d96 info 0 0 qemu-kvm-7767 [001] 235066.551660: kvm_emulate_insn: [FAILED T= O PARSE] rip=3D18446744071578992022 csbase=3D0 len=3D2 insn=3DARRAY[8b, 00,= c9, 89, c0, c3, 0f, 1f, 40, 00, 55, 48, 89, e5, 0f] flags=3D9 failed=3D0 qemu-kvm-7767 [001] 235066.551660: vcpu_match_mmio: gva 0xfff= fc900000040f0 gpa 0xfed000f0 Read GPA qemu-kvm-7767 [001] 235066.551660: kvm_mmio: mmio unsa= tisfied-read len 4 gpa 0xfed000f0 val 0x0 qemu-kvm-7767 [001] 235066.551661: kvm_userspace_exit: reason KV= M_EXIT_MMIO (6) qemu-kvm-7767 [001] 235066.551663: kvm_mmio: mmio read= len 4 gpa 0xfed000f0 val 0xfed2672b qemu-kvm-7767 [001] 235066.551664: kvm_entry: vcpu 0 qemu-kvm-7767 [001] 235066.551667: kvm_exit: reason AP= IC_ACCESS rip 0xffffffff810219eb info 10b0 0 qemu-kvm-7767 [001] 235066.551667: kvm_apic: apic_writ= e APIC_EOI =3D 0x0 qemu-kvm-7767 [001] 235066.551668: kvm_eoi: apicid 0 = vector 81 qemu-kvm-7767 [001] 235066.551668: kvm_entry: vcpu 0 qemu-kvm-7767 [001] 235066.551681: kvm_exit: reason EP= T_MISCONFIG rip 0xffffffff81023d96 info 0 0 qemu-kvm-7767 [001] 235066.551682: kvm_emulate_insn: [FAILED T= O PARSE] rip=3D18446744071578992022 csbase=3D0 len=3D2 insn=3DARRAY[8b, 00,= c9, 89, c0, c3, 0f, 1f, 40, 00, 55, 48, 89, e5, 0f] flags=3D9 failed=3D0 qemu-kvm-7767 [001] 235066.551683: vcpu_match_mmio: gva 0xfff= fc900000040f0 gpa 0xfed000f0 Read GPA qemu-kvm-7767 [001] 235066.551683: kvm_mmio: mmio unsa= tisfied-read len 4 gpa 0xfed000f0 val 0x0 qemu-kvm-7767 [001] 235066.551684: kvm_userspace_exit: reason KV= M_EXIT_MMIO (6) (I can store trace-cmd file somewhere if it can help). This host is x86_64 centos6, running kernel 3.0.53 with kvm-kmod-3.6 and qe= mu-kvm-1.2.0 If I could provide more information, I'll be happy to do so.. BR nik --=20 ------------------------------------- Ing. Nikola CIPRICH LinuxBox.cz, s.r.o. 28. rijna 168, 709 00 Ostrava tel.: +420 591 166 214 fax: +420 596 621 273 mobil: +420 777 093 799 www.linuxbox.cz mobil servis: +420 737 238 656 email servis: servis@linuxbox.cz ------------------------------------- --WIyZ46R2i8wDzkSu Content-Type: application/pgp-signature -----BEGIN PGP SIGNATURE----- Version: GnuPG v2.0.14 (GNU/Linux) iEYEARECAAYFAlC7PnEACgkQ3xdJJrLygV5INgCgyqOP6fiTowILkQBFW8Jgi8wb xZwAoJ5nPE8nhL3y7mTzXerPp0P3rhdU =/CsZ -----END PGP SIGNATURE----- --WIyZ46R2i8wDzkSu--