Description of problem: I was running a couple of libvirt VMs when this happened all of a sudden. Not sure how I can reproduce this. Additional info: WARNING: at fs/btrfs/tree-log.c:3716 btrfs_log_inode_parent+0x3f8/0x450 [btrfs]() Hardware name: 2429BN6 Modules linked in: ip6table_filter ip6_tables ebtable_nat ebtables ipt_MASQUERADE xt_CHECKSUM iptable_mangle xt_conntrack iptable_nat nf_conntrack_ipv4 nf_defrag_ipv4 nf_nat_ipv4 nf_nat nf_conntrack bridge stp llc rfcomm bnep be2iscsi iscsi_boot_sysfs bnx2i cnic uio cxgb4i cxgb4 cxgb3i cxgb3 mdio libcxgbi ib_iser rdma_cm ib_addr iw_cm ib_cm ib_sa ib_mad ib_core iscsi_tcp libiscsi_tcp libiscsi scsi_transport_iscsi arc4 iwldvm snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_intel coretemp mac80211 thinkpad_acpi btusb iTCO_wdt iTCO_vendor_support snd_hda_codec snd_hwdep iwlwifi snd_seq snd_seq_device snd_pcm snd_page_alloc snd_timer uvcvideo videobuf2_vmalloc cfg80211 videobuf2_memops videobuf2_core snd i2c_i801 bluetooth rfkill videodev soundcore media mei lpc_ich mfd_core e1000e microcode vhost_net tun macvtap macvlan kvm_intel kvm uinput btrfs libcrc32c zlib_deflate crc32c_intel i915 sdhci_pci sdhci ghash_clmulni_intel mmc_core i2c_algo_bit drm_kms_helper drm i2c_core wmi video [last unloaded: iptable_mangle] Pid: 22321, comm: qemu-kvm Not tainted 3.7.1-2.fc18.x86_64 #1 Call Trace: [<ffffffff8105e70f>] warn_slowpath_common+0x7f/0xc0 [<ffffffff8105e76a>] warn_slowpath_null+0x1a/0x20 [<ffffffffa01d8e48>] btrfs_log_inode_parent+0x3f8/0x450 [btrfs] [<ffffffffa01d8ee7>] btrfs_log_dentry_safe+0x47/0x70 [btrfs] [<ffffffffa01b13fa>] btrfs_sync_file+0x15a/0x220 [btrfs] [<ffffffff811c2f9d>] do_fsync+0x5d/0x90 [<ffffffff810dc8cc>] ? __audit_syscall_exit+0x3ec/0x450 [<ffffffff811c3233>] sys_fdatasync+0x13/0x20 [<ffffffff8163d9d9>] system_call_fastpath+0x16/0x1b Potential duplicate: bug 893690
Interestingly, this doesn't seem to happen if I'm using a guest with a qcow2 disk image; guests with raw disk images trigger this quite a bit.
I experience the same in Archlinux, using btrfs-progs 0.20rc1.1 and linux 3.7.6; playing with libvirt and kvm too [611038.094632] ------------[ cut here ]------------ [611038.094653] WARNING: at fs/btrfs/tree-log.c:3716 btrfs_log_inode_parent+0x3f8/0x450 [btrfs]() [611038.094654] Hardware name: PowerEdge R210 [611038.094655] Modules linked in: loop vhost_net macvtap macvlan tun ip6table_filter ip6_tables ebtable_nat ebtables ipt_MASQUERADE iptable_nat nf_nat_ipv4 nf_nat nf_conntrack_ipv4 nf_defrag_ipv4 xt_conntrack nf_conntrack ipt_REJECT xt_CHECKSUM iptable_mangle xt_tcpudp iptable_filter ip_tables x_tables bridge stp llc ext4 crc16 jbd2 mbcache mgag200 ttm drm_kms_helper coretemp kvm_intel processor iTCO_wdt i7core_edac dcdbas drm kvm edac_core gpio_ich microcode bnx2 syscopyarea sysfillrect sysimgblt i2c_algo_bit i2c_core iTCO_vendor_support lpc_ich acpi_power_meter button evdev pcspkr btrfs libcrc32c zlib_deflate sd_mod sr_mod cdrom ahci libahci libata crc32c_intel mpt2sas ehci_hcd raid_class scsi_transport_sas usbcore scsi_mod usb_common [611038.094688] Pid: 630, comm: qemu-kvm Not tainted 3.7.4-1-ARCH #1 [611038.094689] Call Trace: [611038.094694] [<ffffffff8105750f>] warn_slowpath_common+0x7f/0xc0 [611038.094696] [<ffffffff8105756a>] warn_slowpath_null+0x1a/0x20 [611038.094704] [<ffffffffa01b0708>] btrfs_log_inode_parent+0x3f8/0x450 [btrfs] [611038.094713] [<ffffffffa01b07a7>] btrfs_log_dentry_safe+0x47/0x70 [btrfs] [611038.094722] [<ffffffffa018844f>] btrfs_sync_file+0x18f/0x250 [btrfs] [611038.094725] [<ffffffff811b344d>] do_fsync+0x5d/0x90 [611038.094727] [<ffffffff811b3823>] sys_fdatasync+0x13/0x20 [611038.094731] [<ffffffff814b435d>] system_call_fastpath+0x1a/0x1f [611038.094733] ---[ end trace e17640f98ca870e4 ]--- Which is quickly followed by: [612738.293836] INFO: task flush-btrfs-1:327 blocked for more than 120 seconds. [612738.294287] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [612738.294741] flush-btrfs-1 D ffff8804275f3750 0 327 2 0x00000000 [612738.294744] ffff8804275f36a8 0000000000000046 ffff880428d769a0 ffff8804275f3fd8 [612738.294746] ffff8804275f3fd8 ffff8804275f3fd8 ffff8804290c71c0 ffff880428d769a0 [612738.294748] 00000000000021c0 0000000000000000 ffffea0002590940 ffff88042f233e30 [612738.294751] Call Trace: [612738.294757] [<ffffffff81090dd8>] ? __enqueue_entity+0x78/0x80 [612738.294760] [<ffffffff810935d0>] ? enqueue_entity+0xc0/0x4a0 [612738.294762] [<ffffffff81093a58>] ? enqueue_task_fair+0xa8/0xf0 [612738.294765] [<ffffffff8101ca99>] ? read_tsc+0x9/0x20 [612738.294768] [<ffffffff81120dd0>] ? __lock_page+0x70/0x70 [612738.294772] [<ffffffff814ab899>] schedule+0x29/0x70 [612738.294774] [<ffffffff814ab96f>] io_schedule+0x8f/0xd0 [612738.294776] [<ffffffff81120dde>] sleep_on_page+0xe/0x20 [612738.294778] [<ffffffff814a94cb>] __wait_on_bit_lock+0x5b/0xc0 [612738.294780] [<ffffffff81120dc7>] __lock_page+0x67/0x70 [612738.294782] [<ffffffff8107bd80>] ? autoremove_wake_function+0x40/0x40 [612738.294801] [<ffffffffa01905a9>] lock_delalloc_pages+0x1d9/0x1f0 [btrfs] [612738.294811] [<ffffffffa0192cb2>] find_lock_delalloc_range.constprop.42+0x142/0x1e0 [btrfs] [612738.294820] [<ffffffffa01946f1>] __extent_writepage+0x141/0x7c0 [btrfs] [612738.294828] [<ffffffffa0193ab0>] ? end_extent_writepage+0x70/0x70 [btrfs] [612738.294837] [<ffffffffa019507a>] extent_write_cache_pages.isra.29.constprop.45+0x30a/0x410 [btrfs] [612738.294846] [<ffffffffa01953ee>] extent_writepages+0x4e/0x70 [btrfs] [612738.294855] [<ffffffffa017cce0>] ? btrfs_writepage+0x70/0x70 [btrfs] [612738.294863] [<ffffffffa017bee8>] btrfs_writepages+0x28/0x30 [btrfs] [612738.294866] [<ffffffff8112cb4e>] do_writepages+0x1e/0x40 [612738.294869] [<ffffffff811ac9bb>] __writeback_single_inode+0x3b/0x190 [612738.294872] [<ffffffff8107b9be>] ? wake_up_bit+0x2e/0x40 [612738.294875] [<ffffffff811ae7da>] writeback_sb_inodes+0x2ba/0x4a0 [612738.294877] [<ffffffff811aea5f>] __writeback_inodes_wb+0x9f/0xd0 [612738.294879] [<ffffffff811aeda3>] wb_writeback+0x313/0x340 [612738.294881] [<ffffffff811af72d>] wb_do_writeback+0xcd/0x260 [612738.294884] [<ffffffff810675f0>] ? call_timer_fn+0x180/0x180 [612738.294886] [<ffffffff811af953>] bdi_writeback_thread+0x93/0x2d0 [612738.294887] [<ffffffff811af8c0>] ? wb_do_writeback+0x260/0x260 [612738.294890] [<ffffffff8107b050>] kthread+0xc0/0xd0 [612738.294893] [<ffffffff81010000>] ? perf_trace_xen_mmu_set_pte_at+0xb0/0x100 [612738.294895] [<ffffffff8107af90>] ? kthread_freezable_should_stop+0x70/0x70 [612738.294898] [<ffffffff814b42ac>] ret_from_fork+0x7c/0xb0 [612738.294901] [<ffffffff8107af90>] ? kthread_freezable_should_stop+0x70/0x70 [612738.294905] INFO: task qemu-kvm:909 blocked for more than 120 seconds. [612738.295282] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [612738.295734] qemu-kvm D ffff88001e46f3f0 0 909 1 0x00000000 [612738.295736] ffff88001e46f348 0000000000000086 ffff8801914f0000 ffff88001e46ffd8 [612738.295738] ffff88001e46ffd8 ffff88001e46ffd8 ffff8804290c69a0 ffff8801914f0000 [612738.295740] ffff88001e46f2b8 ffffffffa0190f75 0000000003845000 ffff8802b5af11c0 [612738.295743] Call Trace: [612738.295753] [<ffffffffa0190f75>] ? clear_state_bit+0xb5/0x180 [btrfs] [612738.295762] [<ffffffffa019179c>] ? clear_extent_bit+0x23c/0x3b0 [btrfs] [612738.295764] [<ffffffff81120dd0>] ? __lock_page+0x70/0x70 [612738.295766] [<ffffffff814ab899>] schedule+0x29/0x70 [612738.295768] [<ffffffff814ab96f>] io_schedule+0x8f/0xd0 [612738.295770] [<ffffffff81120dde>] sleep_on_page+0xe/0x20 [612738.295772] [<ffffffff814a93b0>] __wait_on_bit+0x60/0x90 [612738.295774] [<ffffffff81121070>] wait_on_page_bit+0x80/0x90 [612738.295776] [<ffffffff8107bd80>] ? autoremove_wake_function+0x40/0x40 [612738.295778] [<ffffffff81133cc4>] shrink_page_list+0x5e4/0x9d0 [612738.295781] [<ffffffff811345ff>] shrink_inactive_list+0x14f/0x420 [612738.295784] [<ffffffff81261862>] ? cfq_set_request+0x212/0x460 [612738.295786] [<ffffffff81135001>] shrink_lruvec+0x391/0x5b0 [612738.295788] [<ffffffff81135295>] shrink_zone+0x75/0xa0 [612738.295790] [<ffffffff81135603>] do_try_to_free_pages+0xe3/0x500 [612738.295793] [<ffffffff810943d3>] ? find_busiest_group+0x143/0xaa0 [612738.295795] [<ffffffff81135baf>] try_to_free_mem_cgroup_pages+0xbf/0x1b0 [612738.295799] [<ffffffff8117c62e>] mem_cgroup_reclaim+0x4e/0xe0 [612738.295801] [<ffffffff8117d4c5>] __mem_cgroup_try_charge+0x405/0x900 [612738.295803] [<ffffffff8112e250>] ? release_pages+0x1f0/0x230 [612738.295805] [<ffffffff8108faf5>] ? sched_clock_cpu+0xc5/0x120 [612738.295807] [<ffffffff8117e051>] mem_cgroup_charge_common+0x51/0xa0 [612738.295810] [<ffffffff8117ea0a>] mem_cgroup_cache_charge+0x7a/0xa0 [612738.295812] [<ffffffff81121476>] add_to_page_cache_locked+0x46/0x160 [612738.295813] [<ffffffff811215aa>] add_to_page_cache_lru+0x1a/0x40 [612738.295815] [<ffffffff811219b5>] find_or_create_page+0x65/0xb0 [612738.295824] [<ffffffffa0188bec>] prepare_pages.isra.17+0x19c/0x350 [btrfs] [612738.295831] [<ffffffffa0164b6f>] ? btrfs_delalloc_reserve_metadata+0x26f/0x430 [btrfs] [612738.295840] [<ffffffffa01895b4>] __btrfs_buffered_write+0x164/0x350 [btrfs] [612738.295843] [<ffffffff8119da45>] ? update_time+0x25/0xc0 [612738.295851] [<ffffffffa0189991>] btrfs_file_aio_write+0x1f1/0x4a0 [btrfs] [612738.295854] [<ffffffff8107f942>] ? hrtimer_cancel+0x22/0x30 [612738.295862] [<ffffffffa01897a0>] ? __btrfs_buffered_write+0x350/0x350 [btrfs] [612738.295864] [<ffffffff811849d3>] do_sync_readv_writev+0xa3/0xe0 [612738.295867] [<ffffffff81184cb4>] do_readv_writev+0xd4/0x1e0 [612738.295869] [<ffffffff81184df5>] vfs_writev+0x35/0x60 [612738.295870] [<ffffffff811851b2>] sys_pwritev+0xb2/0xe0 [612738.295873] [<ffffffff814b435d>] system_call_fastpath+0x1a/0x1f
Description of problem: I was running a few updates and then got the notification that the kernel had crashed. Unfortunately I can't give any more information than that. Version-Release number of selected component: kernel Additional info: cmdline: BOOT_IMAGE=/vmlinuz-3.8.4-202.fc18.x86_64 root=UUID=26559178-7740-4426-8c1a-03e5f89d8936 ro rootflags=subvol=root rd.md=0 rd.lvm=0 rd.dm=0 rd.luks=0 vconsole.keymap=us rhgb quiet LANG=en_US.UTF-8 kernel: 3.8.4-202.fc18.x86_64 type: Kerneloops ureports_counter: 1 Truncated backtrace: WARNING: at fs/btrfs/tree-log.c:3843 btrfs_log_inode_parent+0x3f8/0x450 [btrfs]() Hardware name: OptiPlex GX620 Modules linked in: nfsv4 auth_rpcgss nfs lockd dns_resolver fscache nf_conntrack_netbios_ns nf_conntrack_broadcast ipt_MASQUERADE ip6table_mangle ip6t_REJECT nf_conntrack_ipv6 nf_defrag_ipv6 iptable_nat nf_nat_ipv4 nf_nat bnep iptable_mangle nf_conntrack_ipv4 nf_defrag_ipv4 xt_conntrack nf_conntrack ebtable_filter ebtables bluetooth rfkill ip6table_filter ip6_tables be2iscsi iscsi_boot_sysfs bnx2i cnic uio cxgb4i cxgb4 cxgb3i cxgb3 mdio libcxgbi ib_iser rdma_cm ib_addr iw_cm ib_cm ib_sa ib_mad ib_core iscsi_tcp libiscsi_tcp libiscsi scsi_transport_iscsi iTCO_wdt snd_hda_codec_hdmi snd_hda_intel snd_intel8x0 snd_hda_codec snd_ac97_codec snd_hwdep ac97_bus snd_seq snd_seq_device snd_pcm iTCO_vendor_support joydev snd_page_alloc snd_timer ppdev lpc_ich snd microcode dcdbas mfd_core i2c_i801 serio_raw parport_pc soundcore parport uinput btrfs zlib_deflate libcrc32c radeon i2c_algo_bit drm_kms_helper ttm tg3 drm ptp pps_core i2c_core sunrpc Pid: 2070, comm: kate Not tainted 3.8.4-202.fc18.x86_64 #1 Call Trace: [<ffffffff8105e62f>] warn_slowpath_common+0x7f/0xc0 [<ffffffff8105e68a>] warn_slowpath_null+0x1a/0x20 [<ffffffffa027b938>] btrfs_log_inode_parent+0x3f8/0x450 [btrfs] [<ffffffffa027b9d7>] btrfs_log_dentry_safe+0x47/0x70 [btrfs] [<ffffffffa02523c7>] btrfs_sync_file+0x167/0x230 [btrfs] [<ffffffff811cbc4d>] do_fsync+0x5d/0x90 [<ffffffff811cbee3>] sys_fdatasync+0x13/0x20 [<ffffffff816588d9>] system_call_fastpath+0x16/0x1b
*** Bug 904143 has been marked as a duplicate of this bug. ***
Fixed in 3.10.