[ 4332.756697] run fstests btrfs/232 at 2022-02-03 22:03:03
[ 4333.112183] BTRFS info (device dm-0): flagging fs with big metadata feature
[ 4333.112624] BTRFS info (device dm-0): using free space tree
[ 4333.112978] BTRFS info (device dm-0): has skinny extents
[ 4333.319963] BTRFS: device fsid a246cca1-7871-4840-ae75-1555669d3829 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (891794)
[ 4333.342841] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4333.343364] BTRFS info (device dm-9): disk space caching is enabled
[ 4333.343849] BTRFS info (device dm-9): has skinny extents
[ 4333.345715] BTRFS info (device dm-9): checking UUID tree
[ 4338.526887] BTRFS warning (device dm-9): qgroup rescan is already in progress
[ 4338.532957] BTRFS info (device dm-9): qgroup scan completed (inconsistency flag cleared)
[ 4448.500152] ------------[ cut here ]------------
[ 4448.500449] qgroup 5 data reserved space underflow, have 0 to free 4096
[ 4448.500474] WARNING: CPU: 0 PID: 837465 at fs/btrfs/qgroup.c:88 qgroup_rsv_release+0xaa/0xb0
[ 4448.501389] Modules linked in: dm_thin_pool dm_persistent_data dm_bio_prison dm_log_writes dm_dust dm_flakey nft_fib_inet nft_fib_ipv4 nft_fib_ipv6 nft_fib nft_reject_inet nf_reject_ipv4 nf_reject_ipv6 nft_reject nft_ct nft_chain_nat nf_nat nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 ip6_tables nft_compat ip_set rfkill nf_tables nfnetlink intel_rapl_msr iTCO_wdt iTCO_vendor_support snd_hda_codec_generic joydev intel_rapl_common snd_hda_intel snd_intel_dspcfg snd_hda_codec snd_hwdep snd_hda_core virtio_balloon snd_pcm snd_timer snd lpc_ich i2c_i801 soundcore i2c_smbus zram ip_tables xfs crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel serio_raw qemu_fw_cfg virtio_blk
[ 4448.504952] CPU: 0 PID: 837465 Comm: kworker/u4:5 Not tainted 5.17.0-rc2+ #558
[ 4448.505448] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[ 4448.505971] Workqueue: btrfs-flush_delalloc btrfs_work_helper
[ 4448.506366] RIP: 0010:qgroup_rsv_release+0xaa/0xb0
[ 4448.506653] Code: fe 01 74 14 41 83 fe 02 48 c7 c2 ef 8d 85 b7 b8 00 00 00 00 48 0f 45 d0 48 8b 33 49 89 e8 48 c7 c7 80 e9 85 b7 e8 39 b6 75 00 <0f> 0b eb a7 66 90 0f 1f 44 00 00 41 57 41 56 41 55 41 54 55 53 48
[ 4448.507750] RSP: 0018:ffffaeaf026ab828 EFLAGS: 00010292
[ 4448.508067] RAX: 000000000000003b RBX: ffff9a2584fa7c00 RCX: 0000000000000000
[ 4448.508480] RDX: 0000000000000002 RSI: ffffffffb7871c2a RDI: 00000000ffffffff
[ 4448.508913] RBP: 0000000000001000 R08: 0000000000000000 R09: ffffaeaf026ab668
[ 4448.509332] R10: ffffaeaf026ab660 R11: ffffffffb7b58348 R12: ffff9a2596388000
[ 4448.509760] R13: 000000000000000a R14: 0000000000000000 R15: ffff9a2596389790
[ 4448.510224] FS: 0000000000000000(0000) GS:ffff9a25fbc00000(0000) knlGS:0000000000000000
[ 4448.510713] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 4448.511062] CR2: 00007f48749f3000 CR3: 0000000103e52006 CR4: 0000000000370ef0
[ 4448.511482] Call Trace:
[ 4448.511639]
[ 4448.511796] btrfs_qgroup_free_refroot+0x14d/0x190
[ 4448.512088] __btrfs_qgroup_release_data.part.0+0x258/0x2e0
[ 4448.512421] __btrfs_add_ordered_extent+0x381/0x4d0
[ 4448.512727] btrfs_add_ordered_extent+0x18/0x20
[ 4448.513013] run_delalloc_nocow+0x872/0x950
[ 4448.513269] btrfs_run_delalloc_range+0x8c/0x790
[ 4448.513547] ? find_lock_delalloc_range+0x229/0x250
[ 4448.513854] writepage_delalloc+0xa7/0x160
[ 4448.514106] ? rcu_read_lock_sched_held+0x12/0x60
[ 4448.514387] __extent_writepage+0x148/0x390
[ 4448.514635] extent_write_cache_pages+0x24e/0x420
[ 4448.514929] extent_writepages+0x66/0x110
[ 4448.515172] do_writepages+0xbf/0x1b0
[ 4448.515398] ? rcu_read_lock_sched_held+0x12/0x60
[ 4448.515689] ? lock_release+0x1f0/0x2d0
[ 4448.515929] ? lock_release+0x1f0/0x2d0
[ 4448.516162] ? _raw_spin_unlock+0x29/0x40
[ 4448.516403] filemap_fdatawrite_wbc+0x62/0x90
[ 4448.516663] filemap_flush+0x39/0x40
[ 4448.516893] btrfs_run_delalloc_work+0x17/0x40
[ 4448.517163] btrfs_work_helper+0xf2/0x3e0
[ 4448.517401] ? lock_release+0x1f0/0x2d0
[ 4448.517630] ? finish_task_switch.isra.0+0xf9/0x3a0
[ 4448.517934] process_one_work+0x26d/0x580
[ 4448.518182] ? process_one_work+0x580/0x580
[ 4448.518435] worker_thread+0x55/0x3b0
[ 4448.518657] ? process_one_work+0x580/0x580
[ 4448.518924] kthread+0xf0/0x120
[ 4448.519116] ? kthread_complete_and_exit+0x20/0x20
[ 4448.519400] ret_from_fork+0x1f/0x30
[ 4448.519622]
[ 4448.519770] irq event stamp: 0
[ 4448.519958] hardirqs last enabled at (0): [<0000000000000000>] 0x0
[ 4448.520332] hardirqs last disabled at (0): [] copy_process+0x865/0x2160
[ 4448.520817] softirqs last enabled at (0): [] copy_process+0x865/0x2160
[ 4448.521299] softirqs last disabled at (0): [<0000000000000000>] 0x0
[ 4448.521669] ---[ end trace 0000000000000000 ]---
[ 4458.133352] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 4458.133810] BTRFS info (device dm-9): disk space caching is enabled
[ 4458.134186] BTRFS info (device dm-9): has skinny extents