[11292.044282] run fstests generic/251 at 2023-09-08 00:01:22
[11292.638376] BTRFS: device fsid ec3e1159-917e-46d6-82d2-6d36aac552b0 devid 1 transid 2673815 /dev/mapper/vg0-lv0 scanned by mount (1588793)
[11292.639191] BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm
[11292.639198] BTRFS info (device dm-0): using free space tree
[11292.643809] BTRFS info (device dm-0): auto enabling async discard
[11292.866238] BTRFS: device fsid d49f0bbb-8b0f-46b6-90d6-ea7aefb259c6 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (1588841)
[11292.892347] BTRFS info (device dm-9): using crc32c (crc32c-intel) checksum algorithm
[11292.892357] BTRFS info (device dm-9): turning on async discard
[11292.892359] BTRFS info (device dm-9): disk space caching is enabled
[11292.908539] BTRFS info (device dm-9): checking UUID tree
[11938.366721] ------------[ cut here ]------------
[11938.366991] WARNING: CPU: 0 PID: 1302169 at fs/btrfs/free-space-cache.c:1636 tree_insert_offset+0xae/0x120
[11938.368912] 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 nft_compat ip_set rfkill nf_tables nfnetlink iTCO_wdt intel_rapl_msr iTCO_vendor_support intel_rapl_common snd_hda_codec_generic joydev snd_hda_intel snd_intel_dspcfg snd_hda_codec snd_hwdep virtio_balloon snd_hda_core snd_pcm snd_timer snd i2c_i801 soundcore lpc_ich i2c_smbus zram ip_tables xfs crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel serio_raw qemu_fw_cfg
[11938.369004] CPU: 0 PID: 1302169 Comm: kworker/u6:6 Not tainted 6.5.0+ #1295
[11938.369008] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[11938.369011] Workqueue: events_unbound btrfs_preempt_reclaim_metadata_space
[11938.369096] RIP: 0010:tree_insert_offset+0xae/0x120
[11938.369100] Code: 89 ef 48 c7 45 08 00 00 00 00 48 c7 45 10 00 00 00 00 48 89 29 e8 22 51 90 00 31 c0 5b 5d 41 5c c3 cc cc cc cc 48 85 d2 75 c1 <0f> 0b b8 ef ff ff ff eb e9 49 83 c4 40 e9 70 ff ff ff 48 8d 7f 18
[11938.369103] RSP: 0018:ffffbc5b02dcfb78 EFLAGS: 00010246
[11938.369106] RAX: ffff9bf4777e9820 RBX: 0000000000000000 RCX: ffff9bf55754bbd8
[11938.369109] RDX: 0000000000000000 RSI: 00000001d203c000 RDI: ffffffffa29f1bbe
[11938.369111] RBP: ffff9bf55754b000 R08: 00000001d203c000 R09: ffff9bf502b92800
[11938.369113] R10: 0000000000000004 R11: 0000000000000000 R12: ffff9bf503b0c240
[11938.369115] R13: ffff9bf516d58000 R14: ffff9bf503b0c200 R15: 0000000000004000
[11938.369117] FS: 0000000000000000(0000) GS:ffff9bf57bc00000(0000) knlGS:0000000000000000
[11938.369119] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[11938.369121] CR2: 00007fd6f9250000 CR3: 0000000066f7c003 CR4: 0000000000370ef0
[11938.369126] Call Trace:
[11938.369128]
[11938.369132] ? __warn+0x80/0x170
[11938.369149] ? tree_insert_offset+0xae/0x120
[11938.369153] ? report_bug+0x1c3/0x1d0
[11938.369372] ? handle_bug+0x42/0x70
[11938.369495] ? exc_invalid_op+0x14/0x70
[11938.369499] ? asm_exc_invalid_op+0x16/0x20
[11938.369728] ? tree_insert_offset+0xae/0x120
[11938.369734] ? tree_insert_offset+0xce/0x120
[11938.369737] link_free_space+0x2a/0x150
[11938.369742] __btrfs_add_free_space+0xb9/0x4c0
[11938.369750] unpin_extent_range+0x21b/0x500
[11938.369885] btrfs_finish_extent_commit+0x67/0x280
[11938.369900] btrfs_commit_transaction+0xe50/0x1390
[11938.369919] flush_space+0xc8/0x5a0
[11938.369929] ? lock_release+0x134/0x270
[11938.369941] btrfs_preempt_reclaim_metadata_space+0xab/0x210
[11938.369949] process_one_work+0x1ff/0x4e0
[11938.369962] worker_thread+0x1d8/0x3d0
[11938.369969] ? __pfx_worker_thread+0x10/0x10
[11938.369974] kthread+0xfc/0x130
[11938.369983] ? __pfx_kthread+0x10/0x10
[11938.369989] ret_from_fork+0x2d/0x50
[11938.370005] ? __pfx_kthread+0x10/0x10
[11938.370010] ret_from_fork_asm+0x1b/0x30
[11938.370029]
[11938.370031] irq event stamp: 28180455
[11938.370034] hardirqs last enabled at (28180461): [] __up_console_sem+0x5e/0x70
[11938.370041] hardirqs last disabled at (28180466): [] __up_console_sem+0x43/0x70
[11938.370046] softirqs last enabled at (28179860): [] __irq_exit_rcu+0xa5/0x110
[11938.370051] softirqs last disabled at (28179851): [] __irq_exit_rcu+0xa5/0x110
[11938.370056] ---[ end trace 0000000000000000 ]---
[11938.370152] BTRFS critical (device dm-9): unable to add free space :-17
[12743.522741] BTRFS warning (device dm-9): failed to trim 8 block group(s), last error -512
[12751.033459] BTRFS: device fsid d49f0bbb-8b0f-46b6-90d6-ea7aefb259c6 devid 1 transid 135 /dev/mapper/vg0-lv9 scanned by mount (1631740)
[12751.034251] BTRFS info (device dm-9): using crc32c (crc32c-intel) checksum algorithm
[12751.034262] BTRFS info (device dm-9): turning on async discard
[12751.034264] BTRFS info (device dm-9): disk space caching is enabled
[12751.076482] BTRFS warning (device dm-9): block group 7815036928 has wrong amount of free space
[12751.076505] BTRFS warning (device dm-9): failed to load free space cache for block group 7815036928, rebuilding it now