Bug#719717: BUG: soft lockup - CPU#2 stuck for 23s! [kvm:2775] / RIP: 0010:[<ffffffffa03f6c95>] [<ffffffffa03f6c95>] kvm_mmu_prepare_zap_page+0x64/0x214 [kvm]
Package: linux-image-amd64
Version: 3.2+46~bpo60+1
Severity: important
Hi!
I today encountered the following problem when using
"virsh shutdown guest" to shutdown a windows 2003 32bit non r2 guest.
(i've migrated this machine from a vmware server 1 vmdk file)
Aug 14 16:07:44 k000227a kernel: [4296670.865615] breth0: port 2(vnet0) entering forwarding state
Aug 14 16:07:44 k000227a kernel: [4296670.871745] breth0: port 2(vnet0) entering disabled state
Aug 14 16:07:44 k000227a kernel: [4296670.872363] device vnet0 left promiscuous mode
Aug 14 16:07:44 k000227a kernel: [4296670.872370] breth0: port 2(vnet0) entering disabled state
Aug 14 16:08:10 k000227a kernel: [4296696.236047] BUG: soft lockup - CPU#2 stuck for 23s! [kvm:2775]
Aug 14 16:08:10 k000227a kernel: [4296696.239639] Modules linked in: 8021q garp tun ip6table_filter ebtable_nat ebtables act_police cls_flow cls_fw cls_u32 sch_htb sch_hfsc sch_ingress sch_sfq xt_time xt_connlimit xt_realm xt_addrtype iptable_raw xt_comment xt_recent xt_policy ipt_ULOG ipt_REJECT ipt_REDIRECT ipt_NETMAP ipt_MASQUERADE ipt_ECN ipt_ecn ipt_CLUSTERIP ipt_ah nf_nat_tftp nf_nat_snmp_basic nf_conntrack_snmp nf_nat_sip nf_nat_pptp nf_nat_proto_gre nf_nat_irc nf_nat_h323 nf_nat_ftp nf_nat_amanda ts_kmp nf_conntrack_amanda nf_conntrack_sane nf_conntrack_tftp nf_conntrack_sip nf_conntrack_proto_sctp nf_conntrack_pptp nf_conntrack_proto_gre nf_conntrack_netlink nf_conntrack_netbios_ns nf_conntrack_broadcast nf_conntrack_irc nf_conntrack_h323 nf_conntrack_ftp xt_TPROXY nf_tproxy_core ip6_tables nf_defrag_ipv6 xt_tcpmss xt_pkttype xt_physdev xt_owner xt_NFQUEUE xt_NFLOG nfnetlink_log xt_multiport xt_mark xt_mac xt_limit xt_length xt_iprange xt_helper xt_hashlimit xt_DSC
P xt_dsc
p
xt_dccp xt_conntrack xt_connmar
Aug 14 16:08:10 k000227a kernel: k xt_CLASSIFY ipt_LOG xt_tcpudp xt_state iptable_nat nf_nat nf_conntrack_ipv4 nf_defrag_ipv4 nf_conntrack iptable_mangle nfnetlink iptable_filter ip_tables x_tables bridge stp r8169 kvm_amd kvm radeon ttm drm_kms_helper drm snd_pcm snd_timer snd i2c_algo_bit soundcore sr_mod cdrom e100 ohci_hcd snd_page_alloc i2c_piix4 tpm_tis ehci_hcd tg3 tpm powernow_k8 usbcore libphy edac_core tpm_bios processor ata_generic pata_serverworks pcspkr i2c_core mii evdev k8temp sg power_supply usb_common thermal_sys edac_mce_amd sata_svw mperf psmouse serio_raw button dm_mod sata_via sata_sis pata_sis sata_sil sata_nv ext4 jbd2 mbcache crc16 raid1 md_mod ata_piix libata sd_mod crc_t10dif arcmsr scsi_mod shpchp
Aug 14 16:08:10 k000227a kernel: [4296696.239888] CPU 2
Aug 14 16:08:10 k000227a kernel: [4296696.239892] Modules linked in: 8021q garp tun ip6table_filter ebtable_nat ebtables act_police cls_flow cls_fw cls_u32 sch_htb sch_hfsc sch_ingress sch_sfq xt_time xt_connlimit xt_realm xt_addrtype iptable_raw xt_comment xt_recent xt_policy ipt_ULOG ipt_REJECT ipt_REDIRECT ipt_NETMAP ipt_MASQUERADE ipt_ECN ipt_ecn ipt_CLUSTERIP ipt_ah nf_nat_tftp nf_nat_snmp_basic nf_conntrack_snmp nf_nat_sip nf_nat_pptp nf_nat_proto_gre nf_nat_irc nf_nat_h323 nf_nat_ftp nf_nat_amanda ts_kmp nf_conntrack_amanda nf_conntrack_sane nf_conntrack_tftp nf_conntrack_sip nf_conntrack_proto_sctp nf_conntrack_pptp nf_conntrack_proto_gre nf_conntrack_netlink nf_conntrack_netbios_ns nf_conntrack_broadcast nf_conntrack_irc nf_conntrack_h323 nf_conntrack_ftp xt_TPROXY nf_tproxy_core ip6_tables nf_defrag_ipv6 xt_tcpmss xt_pkttype xt_physdev xt_owner xt_NFQUEUE xt_NFLOG nfnetlink_log xt_multiport xt_mark xt_mac xt_limit xt_length xt_iprange xt_helper xt_hashlimit xt_DSC
P xt_dsc
p
xt_dccp xt_conntrack xt_connmar
Aug 14 16:08:10 k000227a kernel: k xt_CLASSIFY ipt_LOG xt_tcpudp xt_state iptable_nat nf_nat nf_conntrack_ipv4 nf_defrag_ipv4 nf_conntrack iptable_mangle nfnetlink iptable_filter ip_tables x_tables bridge stp r8169 kvm_amd kvm radeon ttm drm_kms_helper drm snd_pcm snd_timer snd i2c_algo_bit soundcore sr_mod cdrom e100 ohci_hcd snd_page_alloc i2c_piix4 tpm_tis ehci_hcd tg3 tpm powernow_k8 usbcore libphy edac_core tpm_bios processor ata_generic pata_serverworks pcspkr i2c_core mii evdev k8temp sg power_supply usb_common thermal_sys edac_mce_amd sata_svw mperf psmouse serio_raw button dm_mod sata_via sata_sis pata_sis sata_sil sata_nv ext4 jbd2 mbcache crc16 raid1 md_mod ata_piix libata sd_mod crc_t10dif arcmsr scsi_mod shpchp
Aug 14 16:08:10 k000227a kernel: [4296696.240022]
Aug 14 16:08:10 k000227a kernel: [4296696.240022] Pid: 2775, comm: kvm Not tainted 3.2.0-0.bpo.4-amd64 #1 Debian 3.2.46-1~bpo60+1 empty empty/Tyan Transport GT24-B3992
Aug 14 16:08:10 k000227a kernel: [4296696.240022] RIP: 0010:[<ffffffffa03f6c95>] [<ffffffffa03f6c95>] kvm_mmu_prepare_zap_page+0x64/0x214 [kvm]
Aug 14 16:08:10 k000227a kernel: [4296696.240022] RSP: 0018:ffff880142e8fb08 EFLAGS: 00000282
Aug 14 16:08:10 k000227a kernel: [4296696.240022] RAX: 0000000000000000 RBX: ffff8801010db290 RCX: ffff8801010db290
Aug 14 16:08:10 k000227a kernel: [4296696.240022] RDX: ffff88014657f8c8 RSI: ffff8801010db290 RDI: 0000000000000286
Aug 14 16:08:10 k000227a kernel: [4296696.240022] RBP: ffff88023a4b4000 R08: ffff880108f0c7b8 R09: ffff88014657f8c0
Aug 14 16:08:10 k000227a kernel: [4296696.240022] R10: 0000000000000000 R11: ffff88023a4b4000 R12: ffffffff810f6e27
Aug 14 16:08:10 k000227a kernel: [4296696.240022] R13: 0000000000000000 R14: ffffffff810f647f R15: ffff880239f5a480
Aug 14 16:08:10 k000227a kernel: [4296696.240022] FS: 00007fc05ac2f700(0000) GS:ffff88023fc00000(0000) knlGS:0000000000000000
Aug 14 16:08:10 k000227a kernel: [4296696.240022] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
Aug 14 16:08:10 k000227a kernel: [4296696.240022] CR2: 00007fc0722501a0 CR3: 000000021624d000 CR4: 00000000000006e0
Aug 14 16:08:10 k000227a kernel: [4296696.240022] DR0: 00000000000000a0 DR1: 0000000000000000 DR2: 0000000000000003
Aug 14 16:08:10 k000227a kernel: [4296696.240022] DR3: 00000000000000b0 DR6: 00000000ffff0ff0 DR7: 0000000000000400
Aug 14 16:08:10 k000227a kernel: [4296696.240022] Process kvm (pid: 2775, threadinfo ffff880142e8e000, task ffff880239e0a970)
Aug 14 16:08:10 k000227a kernel: [4296696.240022] Stack:
Aug 14 16:08:10 k000227a kernel: [4296696.240022] 0000000239e0a970 ffff88023a4b4000 ffff880002249978 ffff880142e8fb48
Aug 14 16:08:10 k000227a kernel: [4296696.240022] ffff88023a4b6918 ffff88023a388980 0000000000000001 ffffffffa03f720f
Aug 14 16:08:10 k000227a kernel: [4296696.240022] ffff88010a07b138 ffff8801190d6348 0000000000000000 ffff88023a4b4000
Aug 14 16:08:10 k000227a kernel: [4296696.240022] Call Trace:
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffffa03f720f>] ? kvm_mmu_zap_all+0x3c/0x65 [kvm]
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffffa03ea72c>] ? kvm_arch_flush_shadow+0x9/0x12 [kvm]
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffffa03de5dd>] ? kvm_mmu_notifier_release+0x22/0x31 [kvm]
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff810f3f12>] ? __mmu_notifier_release+0x2a/0xa5
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff810df4da>] ? exit_mmap+0x28/0x101
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff810f647f>] ? virt_to_slab+0x9/0x3c
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff810f6de8>] ? __cache_free+0x3d/0x190
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff81047c53>] ? mmput+0x54/0xf4
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff8104bb0c>] ? exit_mm+0x10c/0x117
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff81369510>] ? down_read+0x9/0x19
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff8104d056>] ? do_exit+0x25b/0x799
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff8104d60e>] ? do_group_exit+0x7a/0xa4
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff8105a5c4>] ? get_signal_to_deliver+0x494/0x4b6
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff8100df47>] ? do_signal+0x38/0x635
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff81107183>] ? do_readv_writev+0x101/0x125
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff8100e569>] ? do_notify_resume+0x25/0x67
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff8136f5a0>] ? int_signal+0x12/0x17
Aug 14 16:08:10 k000227a kernel: [4296696.240022] Code: 83 c5 10 49 83 7d 00 00 eb e8 ff 85 d8 08 00 00 4c 89 e2 48 89 de 48 89 ef 45 31 f6 e8 ba 01 00 00 41 89 c5 4c 89 f2 48 03 53 30 <48> 89 de 48 89 ef 49 83 c6 08 e8 10 da ff ff 49 81 fe 00 10 00
Aug 14 16:08:10 k000227a kernel: [4296696.240022] Call Trace:
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffffa03f720f>] ? kvm_mmu_zap_all+0x3c/0x65 [kvm]
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffffa03ea72c>] ? kvm_arch_flush_shadow+0x9/0x12 [kvm]
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffffa03de5dd>] ? kvm_mmu_notifier_release+0x22/0x31 [kvm]
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff810f3f12>] ? __mmu_notifier_release+0x2a/0xa5
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff810df4da>] ? exit_mmap+0x28/0x101
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff810f647f>] ? virt_to_slab+0x9/0x3c
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff810f6de8>] ? __cache_free+0x3d/0x190
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff81047c53>] ? mmput+0x54/0xf4
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff8104bb0c>] ? exit_mm+0x10c/0x117
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff81369510>] ? down_read+0x9/0x19
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff8104d056>] ? do_exit+0x25b/0x799
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff8104d60e>] ? do_group_exit+0x7a/0xa4
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff8105a5c4>] ? get_signal_to_deliver+0x494/0x4b6
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff8100df47>] ? do_signal+0x38/0x635
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff81107183>] ? do_readv_writev+0x101/0x125
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff8100e569>] ? do_notify_resume+0x25/0x67
Aug 14 16:08:10 k000227a kernel: [4296696.240022] [<ffffffff8136f5a0>] ? int_signal+0x12/0x17
I'm running Debian GNU/Linux 6.0.7 64bit with backports enabled:
# dpkg -l | egrep -i "(qemu|kvm|linux-image|libvirt)"
ii etherboot-qemu 5.4.4-9 Bootstrapping for various network adapters (qemu)
ii ipxe-qemu 1.0.0+git-20120202.f6840ba-3~bpo60+1 PXE boot firmware - ROM images for qemu
ii libvirt-bin 0.9.12-11~bpo60+1 programs for the libvirt library
ii libvirt0 0.9.12-11~bpo60+1 library for interfacing with different virtualization systems
ii linux-image-3.2.0-0.bpo.4-amd64 3.2.46-1~bpo60+1 Linux 3.2 for 64-bit PCs
ii linux-image-amd64 3.2+46~bpo60+1 Linux for 64-bit PCs (meta-package)
ii python-libvirt 0.9.12-11~bpo60+1 libvirt Python bindings
ii qemu 1.1.2+dfsg-2~bpo60+1 fast processor emulator
ii qemu-keymaps 1.1.2+dfsg-2~bpo60+1 QEMU keyboard maps
ii qemu-kvm 1.1.2+dfsg-5~bpo60+1 Full virtualization on x86 hardware
ii qemu-system 1.1.2+dfsg-2~bpo60+1 QEMU full system emulation binaries
ii qemu-user 1.1.2+dfsg-2~bpo60+1 QEMU user mode emulation binaries
ii qemu-utils 1.1.2+dfsg-2~bpo60+1 QEMU utilities
ii vgabios 0.7a-2~bpo60+1 VGA BIOS software for the Bochs and Qemu emulated VGA card
The Hardware is "Tyan Transport GT24-B3992",
2x Dual-Core AMD Opteron(tm) Processor 2218,
8GiB RAM
Please let me know if you need any further information!
Cheers,
Raoul
Reply to: