[48021.822493] run fstests btrfs/232 at 2022-12-21 10:13:33
[48022.304118] BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm
[48022.304127] BTRFS info (device dm-0): using free space tree
[48022.308950] BTRFS info (device dm-0): auto enabling async discard
[48022.575978] BTRFS: device fsid cf1fccee-17b2-407a-affa-3e60b0d8b4ea devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (2819840)
[48022.610008] BTRFS info (device dm-9): using crc32c (crc32c-intel) checksum algorithm
[48022.610016] BTRFS info (device dm-9): using free space tree
[48022.624417] BTRFS info (device dm-9): auto enabling async discard
[48022.624638] BTRFS info (device dm-9): checking UUID tree
[48030.240143] BTRFS warning (device dm-9): qgroup rescan is already in progress
[48030.259682] BTRFS info (device dm-9): qgroup scan completed (inconsistency flag cleared)
[48037.673285] ------------[ cut here ]------------
[48037.673582] WARNING: CPU: 1 PID: 2819895 at fs/btrfs/space-info.h:199 btrfs_space_info_free_bytes_may_use+0xfd/0x190
[48037.673596] 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 rfkill ip_set nf_tables nfnetlink snd_hda_codec_generic snd_hda_intel intel_rapl_msr iTCO_wdt iTCO_vendor_support snd_intel_dspcfg snd_hda_codec snd_hwdep snd_hda_core intel_rapl_common snd_pcm joydev i2c_i801 i2c_smbus snd_timer snd soundcore lpc_ich virtio_balloon zram ip_tables crct10dif_pclmul crc32_pclmul xfs crc32c_intel ghash_clmulni_intel serio_raw qemu_fw_cfg
[48037.673700] CPU: 1 PID: 2819895 Comm: fsstress Not tainted 6.1.0-rc8+ #971
[48037.673704] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[48037.673711] RIP: 0010:btrfs_space_info_free_bytes_may_use+0xfd/0x190
[48037.673716] Code: 4d 89 e0 48 89 ea 4c 89 ee e8 bf 52 f3 ff 65 ff 0d b8 01 97 62 0f 85 51 ff ff ff 0f 1f 44 00 00 e9 47 ff ff ff 48 39 c3 76 86 <0f> 0b 31 c0 eb 83 48 8d 7d 18 be ff ff ff ff e8 bf 9c 82 00 85 c0
[48037.673720] RSP: 0018:ffff9e028235fd88 EFLAGS: 00010206
[48037.673724] RAX: 0000000000027000 RBX: 000000000005d000 RCX: 0000000000000001
[48037.673726] RDX: 0000000000000000 RSI: ffffffff9e7b2293 RDI: ffffffff9e853ebe
[48037.673729] RBP: ffff8ce5c3402c00 R08: 0000000000000000 R09: 0000000000000001
[48037.673731] R10: 00000000000428a3 R11: 0000000000000001 R12: fffffffffffa3000
[48037.673734] R13: ffff8ce58f260000 R14: 000000000005d000 R15: ffffffffffffff86
[48037.673736] FS: 00007ffacdd59740(0000) GS:ffff8ce5fbd00000(0000) knlGS:0000000000000000
[48037.673739] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[48037.673741] CR2: 00000000011d6000 CR3: 000000010aae2004 CR4: 0000000000370ee0
[48037.673745] Call Trace:
[48037.673747]
[48037.673754] btrfs_free_reserved_data_space+0x4f/0x70
[48037.673798] btrfs_fallocate+0xc94/0x1120
[48037.673815] ? lock_acquire+0xd2/0x2d0
[48037.673830] vfs_fallocate+0x148/0x440
[48037.673837] __x64_sys_fallocate+0x3e/0x70
[48037.673843] do_syscall_64+0x38/0x90
[48037.673849] entry_SYSCALL_64_after_hwframe+0x63/0xcd
[48037.673854] RIP: 0033:0x7ffacde5250a
[48037.673864] Code: d8 64 89 02 b8 ff ff ff ff eb bd 0f 1f 44 00 00 f3 0f 1e fa 49 89 ca 64 8b 04 25 18 00 00 00 85 c0 75 15 b8 1d 01 00 00 0f 05 <48> 3d 00 f0 ff ff 77 5e c3 0f 1f 44 00 00 48 83 ec 28 48 89 54 24
[48037.673868] RSP: 002b:00007ffe78a79cc8 EFLAGS: 00000246 ORIG_RAX: 000000000000011d
[48037.673872] RAX: ffffffffffffffda RBX: 0000000000000010 RCX: 00007ffacde5250a
[48037.673874] RDX: 00000000000f4e3a RSI: 0000000000000010 RDI: 0000000000000003
[48037.673876] RBP: 0000000000000003 R08: 0000000000000014 R09: 00007ffe78a79cec
[48037.673879] R10: 000000000005d70e R11: 0000000000000246 R12: 0000000000000149
[48037.673881] R13: 000000000005d70e R14: 00000000000f4e3a R15: 0000000000000010
[48037.673900]
[48037.673907] irq event stamp: 115007
[48037.673909] hardirqs last enabled at (115013): [] __up_console_sem+0x5e/0x70
[48037.673915] hardirqs last disabled at (115018): [] __up_console_sem+0x43/0x70
[48037.673919] softirqs last enabled at (114904): [] __irq_exit_rcu+0xfd/0x150
[48037.673924] softirqs last disabled at (114899): [] __irq_exit_rcu+0xfd/0x150
[48037.673927] ---[ end trace 0000000000000000 ]---
[48037.674135] ------------[ cut here ]------------
[48037.674268] WARNING: CPU: 1 PID: 1806391 at fs/btrfs/space-info.h:199 btrfs_add_reserved_bytes+0x1ae/0x280
[48037.674274] 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 rfkill ip_set nf_tables nfnetlink snd_hda_codec_generic snd_hda_intel intel_rapl_msr iTCO_wdt iTCO_vendor_support snd_intel_dspcfg snd_hda_codec snd_hwdep snd_hda_core intel_rapl_common snd_pcm joydev i2c_i801 i2c_smbus snd_timer snd soundcore lpc_ich virtio_balloon zram ip_tables crct10dif_pclmul crc32_pclmul xfs crc32c_intel ghash_clmulni_intel serio_raw qemu_fw_cfg
[48037.674377] CPU: 1 PID: 1806391 Comm: kworker/u4:3 Tainted: G W 6.1.0-rc8+ #971
[48037.674381] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[48037.674384] Workqueue: btrfs-flush_delalloc btrfs_work_helper
[48037.674390] RIP: 0010:btrfs_add_reserved_bytes+0x1ae/0x280
[48037.674394] Code: 4c 8b 54 24 10 4c 8b 5c 24 08 65 ff 0d 8b a0 96 62 0f 85 01 ff ff ff 0f 1f 44 00 00 e9 f7 fe ff ff 49 39 c5 0f 86 36 ff ff ff <0f> 0b 31 c0 e9 30 ff ff ff 48 8d 7d 18 be ff ff ff ff 4c 89 54 24
[48037.674397] RSP: 0018:ffff9e028502f7d8 EFLAGS: 00010206
[48037.674402] RAX: 0000000000008000 RBX: ffff8ce5960f8800 RCX: 0000000000000001
[48037.674405] RDX: 0000000000000000 RSI: ffffffff9e7b2293 RDI: ffffffff9e853ebe
[48037.674407] RBP: ffff8ce5c3402c00 R08: 0000000000000000 R09: 0000000000000001
[48037.674410] R10: 000000000000d000 R11: ffff8ce58f260000 R12: 000000000000d000
[48037.674412] R13: 000000000000d000 R14: ffffffffffff3000 R15: ffff8ce5960f8810
[48037.674415] FS: 0000000000000000(0000) GS:ffff8ce5fbd00000(0000) knlGS:0000000000000000
[48037.674418] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[48037.674421] CR2: 00000000011d6000 CR3: 0000000106eea005 CR4: 0000000000370ee0
[48037.674427] Call Trace:
[48037.674429]
[48037.674441] find_free_extent+0x6a2/0x1410
[48037.674453] ? _raw_spin_unlock+0x29/0x50
[48037.674458] ? btrfs_get_alloc_profile+0x11a/0x250
[48037.674469] btrfs_reserve_extent+0x13a/0x260
[48037.674502] cow_file_range+0x141/0x540
[48037.674528] btrfs_run_delalloc_range+0x119/0x5d0
[48037.674551] writepage_delalloc+0xa7/0x170
[48037.674567] __extent_writepage+0x162/0x4b0
[48037.674580] extent_write_cache_pages+0x12e/0x500
[48037.674614] extent_writepages+0x6a/0x120
[48037.674625] do_writepages+0xbf/0x1c0
[48037.674632] ? lock_release+0x137/0x2d0
[48037.674644] ? _raw_spin_unlock+0x29/0x50
[48037.674653] filemap_fdatawrite_wbc+0x66/0x90
[48037.674660] __filemap_fdatawrite_range+0x46/0x50
[48037.674677] btrfs_run_delalloc_work+0x17/0x40
[48037.674683] btrfs_work_helper+0xf2/0x3e0
[48037.674687] ? lock_is_held_type+0xe2/0x140
[48037.674700] process_one_work+0x271/0x590
[48037.674719] worker_thread+0x52/0x3b0
[48037.674728] ? process_one_work+0x590/0x590
[48037.674733] kthread+0xf0/0x120
[48037.674737] ? kthread_complete_and_exit+0x20/0x20
[48037.674746] ret_from_fork+0x1f/0x30
[48037.674794]
[48037.674797] irq event stamp: 52765357
[48037.674799] hardirqs last enabled at (52765363): [] __up_console_sem+0x5e/0x70
[48037.674804] hardirqs last disabled at (52765368): [] __up_console_sem+0x43/0x70
[48037.674808] softirqs last enabled at (52765350): [] __irq_exit_rcu+0xfd/0x150
[48037.674813] softirqs last disabled at (52765343): [] __irq_exit_rcu+0xfd/0x150
[48037.674816] ---[ end trace 0000000000000000 ]---
[48037.698481] ------------[ cut here ]------------
[48037.698723] WARNING: CPU: 1 PID: 2819888 at fs/btrfs/space-info.h:199 btrfs_space_info_free_bytes_may_use+0xfd/0x190
[48037.698730] 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 rfkill ip_set nf_tables nfnetlink snd_hda_codec_generic snd_hda_intel intel_rapl_msr iTCO_wdt iTCO_vendor_support snd_intel_dspcfg snd_hda_codec snd_hwdep snd_hda_core intel_rapl_common snd_pcm joydev i2c_i801 i2c_smbus snd_timer snd soundcore lpc_ich virtio_balloon zram ip_tables crct10dif_pclmul crc32_pclmul xfs crc32c_intel ghash_clmulni_intel serio_raw qemu_fw_cfg
[48037.698817] CPU: 1 PID: 2819888 Comm: fsstress Tainted: G W 6.1.0-rc8+ #971
[48037.698820] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[48037.698822] RIP: 0010:btrfs_space_info_free_bytes_may_use+0xfd/0x190
[48037.698825] Code: 4d 89 e0 48 89 ea 4c 89 ee e8 bf 52 f3 ff 65 ff 0d b8 01 97 62 0f 85 51 ff ff ff 0f 1f 44 00 00 e9 47 ff ff ff 48 39 c3 76 86 <0f> 0b 31 c0 eb 83 48 8d 7d 18 be ff ff ff ff e8 bf 9c 82 00 85 c0
[48037.698827] RSP: 0018:ffff9e0282327ce8 EFLAGS: 00010206
[48037.698830] RAX: 0000000000000000 RBX: 0000000000013000 RCX: 0000000000000001
[48037.698831] RDX: 0000000000000000 RSI: ffffffff9e7b2293 RDI: ffffffff9e853ebe
[48037.698833] RBP: ffff8ce5c3402c00 R08: 0000000000000000 R09: 0000000000000001
[48037.698834] R10: 000000000003c1e2 R11: 0000000000000001 R12: fffffffffffed000
[48037.698836] R13: ffff8ce58f260000 R14: 0000000000013000 R15: ffff8ce5938c6a80
[48037.698837] FS: 00007ffacdd59740(0000) GS:ffff8ce5fbd00000(0000) knlGS:0000000000000000
[48037.698839] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[48037.698841] CR2: 00000000011d6000 CR3: 00000001337a2004 CR4: 0000000000370ee0
[48037.698844] Call Trace:
[48037.698846]
[48037.698852] btrfs_check_data_free_space+0xa9/0xf0
[48037.698858] btrfs_buffered_write+0x1ff/0x830
[48037.698871] btrfs_do_write_iter+0x400/0x5d0
[48037.698875] ? lock_is_held_type+0xe2/0x140
[48037.698882] vfs_write+0x325/0x4a0
[48037.698892] ksys_write+0x55/0xd0
[48037.698896] do_syscall_64+0x38/0x90
[48037.698900] entry_SYSCALL_64_after_hwframe+0x63/0xcd
[48037.698903] RIP: 0033:0x7ffacdf3d7b7
[48037.698907] Code: 75 05 48 83 c4 58 c3 e8 f7 4e ff ff 0f 1f 80 00 00 00 00 f3 0f 1e fa 64 8b 04 25 18 00 00 00 85 c0 75 10 b8 01 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 51 c3 48 83 ec 28 48 89 54 24 18 48 89 74 24
[48037.698909] RSP: 002b:00007ffe78a79cd8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[48037.698911] RAX: ffffffffffffffda RBX: 00000000000122fe RCX: 00007ffacdf3d7b7
[48037.698913] RDX: 00000000000122fe RSI: 00000000011a5420 RDI: 0000000000000003
[48037.698914] RBP: 0000000000000003 R08: 00000000011a5420 R09: 00007ffacdf1fa60
[48037.698915] R10: 0000000000000079 R11: 0000000000000246 R12: 0000000000000198
[48037.698917] R13: 00000000002adb76 R14: 00000000011a5420 R15: 0000000000000000
[48037.698928]
[48037.698929] irq event stamp: 156721
[48037.698931] hardirqs last enabled at (156727): [] __up_console_sem+0x5e/0x70
[48037.698935] hardirqs last disabled at (156732): [] __up_console_sem+0x43/0x70
[48037.698937] softirqs last enabled at (156336): [] __irq_exit_rcu+0xfd/0x150
[48037.698941] softirqs last disabled at (156327): [] __irq_exit_rcu+0xfd/0x150
[48037.698943] ---[ end trace 0000000000000000 ]---
[48037.698959] ------------[ cut here ]------------
[48037.698961] WARNING: CPU: 0 PID: 2819886 at fs/btrfs/space-info.h:199 btrfs_space_info_free_bytes_may_use+0xfd/0x190
[48037.698967] 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 rfkill ip_set nf_tables nfnetlink snd_hda_codec_generic snd_hda_intel intel_rapl_msr iTCO_wdt iTCO_vendor_support snd_intel_dspcfg snd_hda_codec snd_hwdep snd_hda_core intel_rapl_common snd_pcm joydev i2c_i801 i2c_smbus snd_timer snd soundcore lpc_ich virtio_balloon zram ip_tables crct10dif_pclmul crc32_pclmul xfs crc32c_intel ghash_clmulni_intel serio_raw qemu_fw_cfg
[48037.699021] CPU: 0 PID: 2819886 Comm: fsstress Tainted: G W 6.1.0-rc8+ #971
[48037.699023] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[48037.699024] RIP: 0010:btrfs_space_info_free_bytes_may_use+0xfd/0x190
[48037.699027] Code: 4d 89 e0 48 89 ea 4c 89 ee e8 bf 52 f3 ff 65 ff 0d b8 01 97 62 0f 85 51 ff ff ff 0f 1f 44 00 00 e9 47 ff ff ff 48 39 c3 76 86 <0f> 0b 31 c0 eb 83 48 8d 7d 18 be ff ff ff ff e8 bf 9c 82 00 85 c0
[48037.699029] RSP: 0018:ffff9e0282317bf8 EFLAGS: 00010206
[48037.699032] RAX: 0000000000000000 RBX: 0000000000008000 RCX: 0000000000000001
[48037.699034] RDX: 0000000000000000 RSI: ffffffff9e7b2293 RDI: ffffffff9e853ebe
[48037.699035] RBP: ffff8ce5c3402c00 R08: 0000000000000000 R09: 0000000000000001
[48037.699036] R10: 000000000003c1e2 R11: 0000000000000001 R12: ffffffffffff8000
[48037.699038] R13: ffff8ce58f260000 R14: 0000000000008000 R15: ffff8ce5859e1bc0
[48037.699039] FS: 00007ffacdd59740(0000) GS:ffff8ce5fbc00000(0000) knlGS:0000000000000000
[48037.699041] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[48037.699043] CR2: 00007f7b17a7b100 CR3: 0000000116134005 CR4: 0000000000370ef0
[48037.699046] Call Trace:
[48037.699048]
[48037.699052] btrfs_check_data_free_space+0xa9/0xf0
[48037.699058] btrfs_buffered_write+0x1ff/0x830
[48037.699071] btrfs_do_write_iter+0x400/0x5d0
[48037.699079] do_iter_readv_writev+0xc2/0x110
[48037.699087] do_iter_write+0x80/0x1c0
[48037.699091] vfs_writev+0x7e/0x250
[48037.699099] ? __do_sys_newfstatat+0x22/0x40
[48037.699104] ? lock_is_held_type+0xe2/0x140
[48037.699109] do_writev+0x5d/0xf0
[48037.699114] do_syscall_64+0x38/0x90
[48037.699118] entry_SYSCALL_64_after_hwframe+0x63/0xcd
[48037.699121] RIP: 0033:0x7ffacde53587
[48037.699123] Code: 0c 00 f7 d8 64 89 02 48 c7 c0 ff ff ff ff eb b8 0f 1f 00 f3 0f 1e fa 64 8b 04 25 18 00 00 00 85 c0 75 10 b8 14 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 51 c3 48 83 ec 28 89 54 24 1c 48 89 74 24 10
[48037.699125] RSP: 002b:00007ffe78a79cc8 EFLAGS: 00000246 ORIG_RAX: 0000000000000014
[48037.699128] RAX: ffffffffffffffda RBX: 0000000000000035 RCX: 00007ffacde53587
[48037.699130] RDX: 000000000000034b RSI: 00000000011300d0 RDI: 0000000000000003
[48037.699131] RBP: 0000000000000003 R08: 000000000111e000 R09: 00007ffacdf1fa60
[48037.699132] R10: 0000000000080000 R11: 0000000000000246 R12: 0000000000000132
[48037.699134] R13: 000000000000034b R14: 00000000011300d0 R15: 000000000000b047
[48037.699144]
[48037.699145] irq event stamp: 135497
[48037.699147] hardirqs last enabled at (135503): [] __up_console_sem+0x5e/0x70
[48037.699150] hardirqs last disabled at (135508): [] __up_console_sem+0x43/0x70
[48037.699152] softirqs last enabled at (134926): [] __irq_exit_rcu+0xfd/0x150
[48037.699155] softirqs last disabled at (134915): [] __irq_exit_rcu+0xfd/0x150
[48037.699158] ---[ end trace 0000000000000000 ]---
[48037.699168] ------------[ cut here ]------------
[48037.699170] WARNING: CPU: 1 PID: 2819883 at fs/btrfs/space-info.h:199 btrfs_space_info_free_bytes_may_use+0xfd/0x190
[48037.699174] 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 rfkill ip_set nf_tables nfnetlink snd_hda_codec_generic snd_hda_intel intel_rapl_msr iTCO_wdt iTCO_vendor_support snd_intel_dspcfg snd_hda_codec snd_hwdep snd_hda_core intel_rapl_common snd_pcm joydev i2c_i801 i2c_smbus snd_timer snd soundcore lpc_ich virtio_balloon zram ip_tables crct10dif_pclmul crc32_pclmul xfs crc32c_intel ghash_clmulni_intel serio_raw qemu_fw_cfg
[48037.699233] CPU: 1 PID: 2819883 Comm: fsstress Tainted: G W 6.1.0-rc8+ #971
[48037.699235] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[48037.699236] RIP: 0010:btrfs_space_info_free_bytes_may_use+0xfd/0x190
[48037.699239] Code: 4d 89 e0 48 89 ea 4c 89 ee e8 bf 52 f3 ff 65 ff 0d b8 01 97 62 0f 85 51 ff ff ff 0f 1f 44 00 00 e9 47 ff ff ff 48 39 c3 76 86 <0f> 0b 31 c0 eb 83 48 8d 7d 18 be ff ff ff ff e8 bf 9c 82 00 85 c0
[48037.699241] RSP: 0018:ffff9e02822ffa98 EFLAGS: 00010206
[48037.699244] RAX: 0000000000000000 RBX: 0000000000005000 RCX: 0000000000000001
[48037.699245] RDX: 0000000000000000 RSI: ffffffff9e7b2293 RDI: ffffffff9e853ebe
[48037.699246] RBP: ffff8ce5c3402c00 R08: 0000000000000000 R09: 0000000000000001
[48037.699248] R10: 000000000003c1e2 R11: 0000000000000001 R12: ffffffffffffb000
[48037.699249] R13: ffff8ce58f260000 R14: 0000000000005000 R15: ffff8ce583c61080
[48037.699251] FS: 00007ffacdd59740(0000) GS:ffff8ce5fbd00000(0000) knlGS:0000000000000000
[48037.699252] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[48037.699254] CR2: 00000000011d6000 CR3: 0000000111e2c005 CR4: 0000000000370ee0
[48037.699257] Call Trace:
[48037.699259]
[48037.699263] btrfs_check_data_free_space+0xa9/0xf0
[48037.699268] btrfs_buffered_write+0x1ff/0x830
[48037.699281] btrfs_do_write_iter+0x400/0x5d0
[48037.699284] ? lock_is_held_type+0xe2/0x140
[48037.699290] do_iter_readv_writev+0xc2/0x110
[48037.699298] do_iter_write+0x80/0x1c0
[48037.699302] iter_file_splice_write+0x270/0x410
[48037.699316] direct_splice_actor+0x29/0x40
[48037.699318] splice_direct_to_actor+0xd1/0x1f0
[48037.699321] ? do_splice_direct+0xb0/0xb0
[48037.699327] do_splice_direct+0x7b/0xb0
[48037.699337] generic_copy_file_range+0x4b/0x80
[48037.699344] vfs_copy_file_range+0x171/0x5c0
[48037.699356] __do_sys_copy_file_range+0xc4/0x1f0
[48037.699366] do_syscall_64+0x38/0x90
[48037.699372] entry_SYSCALL_64_after_hwframe+0x63/0xcd
[48037.699375] RIP: 0033:0x7ffacde5711d
[48037.699379] Code: c5 0c 00 0f 05 eb a9 66 0f 1f 44 00 00 f3 0f 1e fa 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 23 7d 0c 00 f7 d8 64 89 01 48
[48037.699382] RSP: 002b:00007ffe78a79808 EFLAGS: 00000246 ORIG_RAX: 0000000000000146
[48037.699385] RAX: ffffffffffffffda RBX: 0000000000400000 RCX: 00007ffacde5711d
[48037.699386] RDX: 0000000000000004 RSI: 00007ffe78a79840 RDI: 0000000000000003
[48037.699388] RBP: 0000000000000003 R08: 0000000000003f83 R09: 0000000000000000
[48037.699389] R10: 00007ffe78a79848 R11: 0000000000000246 R12: 000000000000014c
[48037.699391] R13: 0000000000000004 R14: 0000000000003f83 R15: 0000000000167c40
[48037.699401]
[48037.699402] irq event stamp: 167787
[48037.699403] hardirqs last enabled at (167793): [] __up_console_sem+0x5e/0x70
[48037.699406] hardirqs last disabled at (167798): [] __up_console_sem+0x43/0x70
[48037.699409] softirqs last enabled at (166902): [] __irq_exit_rcu+0xfd/0x150
[48037.699411] softirqs last disabled at (166893): [] __irq_exit_rcu+0xfd/0x150
[48037.699414] ---[ end trace 0000000000000000 ]---
[48045.917788] ------------[ cut here ]------------
[48045.917801] WARNING: CPU: 0 PID: 2819886 at fs/btrfs/space-info.h:199 btrfs_space_info_free_bytes_may_use+0xfd/0x190
[48045.917826] 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 rfkill ip_set nf_tables nfnetlink snd_hda_codec_generic snd_hda_intel intel_rapl_msr iTCO_wdt iTCO_vendor_support snd_intel_dspcfg snd_hda_codec snd_hwdep snd_hda_core intel_rapl_common snd_pcm joydev i2c_i801 i2c_smbus snd_timer snd soundcore lpc_ich virtio_balloon zram ip_tables crct10dif_pclmul crc32_pclmul xfs crc32c_intel ghash_clmulni_intel serio_raw qemu_fw_cfg
[48045.918070] CPU: 0 PID: 2819886 Comm: fsstress Tainted: G W 6.1.0-rc8+ #971
[48045.918080] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[48045.918087] RIP: 0010:btrfs_space_info_free_bytes_may_use+0xfd/0x190
[48045.918101] Code: 4d 89 e0 48 89 ea 4c 89 ee e8 bf 52 f3 ff 65 ff 0d b8 01 97 62 0f 85 51 ff ff ff 0f 1f 44 00 00 e9 47 ff ff ff 48 39 c3 76 86 <0f> 0b 31 c0 eb 83 48 8d 7d 18 be ff ff ff ff e8 bf 9c 82 00 85 c0
[48045.918110] RSP: 0018:ffff9e0282317920 EFLAGS: 00010206
[48045.918121] RAX: 0000000000000000 RBX: 0000000000001000 RCX: 0000000000000001
[48045.918165] RDX: 0000000000000000 RSI: ffffffff9e7b2293 RDI: ffffffff9e853ebe
[48045.918171] RBP: ffff8ce5c3402c00 R08: 0000000000000000 R09: 0000000000000001
[48045.918177] R10: 000000000003c1e2 R11: 0000000000000001 R12: fffffffffffff000
[48045.918184] R13: ffff8ce58f260000 R14: 0000000000001000 R15: 0000000000000000
[48045.918191] FS: 00007ffacdd59740(0000) GS:ffff8ce5fbc00000(0000) knlGS:0000000000000000
[48045.918199] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[48045.918206] CR2: 000000000137be88 CR3: 0000000116134001 CR4: 0000000000370ef0
[48045.918220] Call Trace:
[48045.918228]
[48045.918250] btrfs_free_reserved_data_space+0x4f/0x70
[48045.918272] btrfs_truncate_block+0x756/0x7d0
[48045.918313] btrfs_cont_expand+0x49/0x3e0
[48045.918334] ? seqcount_lockdep_reader_access.constprop.0+0x82/0x90
[48045.918350] ? lockdep_hardirqs_on+0x7d/0x100
[48045.918364] ? seqcount_lockdep_reader_access.constprop.0+0x82/0x90
[48045.918375] ? ktime_get_coarse_real_ts64+0xe/0x60
[48045.918385] ? ktime_get_coarse_real_ts64+0xe/0x60
[48045.918408] btrfs_write_check.constprop.0+0xf4/0x150
[48045.918430] btrfs_buffered_write+0xab/0x830
[48045.918454] ? __lock_acquire+0x360/0x1df0
[48045.918497] btrfs_do_write_iter+0x400/0x5d0
[48045.918511] ? lock_is_held_type+0xe2/0x140
[48045.918536] do_iter_readv_writev+0xc2/0x110
[48045.918572] do_iter_write+0x80/0x1c0
[48045.918592] iter_file_splice_write+0x270/0x410
[48045.918648] direct_splice_actor+0x29/0x40
[48045.918658] splice_direct_to_actor+0xd1/0x1f0
[48045.918764] ? do_splice_direct+0xb0/0xb0
[48045.918797] do_splice_direct+0x7b/0xb0
[48045.918824] generic_copy_file_range+0x4b/0x80
[48045.918844] vfs_copy_file_range+0x171/0x5c0
[48045.918874] __do_sys_copy_file_range+0xc4/0x1f0
[48045.918900] do_syscall_64+0x38/0x90
[48045.918917] entry_SYSCALL_64_after_hwframe+0x63/0xcd
[48045.918930] RIP: 0033:0x7ffacde5711d
[48045.918944] Code: c5 0c 00 0f 05 eb a9 66 0f 1f 44 00 00 f3 0f 1e fa 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 23 7d 0c 00 f7 d8 64 89 01 48
[48045.918953] RSP: 002b:00007ffe78a79808 EFLAGS: 00000246 ORIG_RAX: 0000000000000146
[48045.918965] RAX: ffffffffffffffda RBX: 0000000000c0a497 RCX: 00007ffacde5711d
[48045.918972] RDX: 0000000000000004 RSI: 00007ffe78a79840 RDI: 0000000000000003
[48045.918978] RBP: 0000000000000003 R08: 000000000000a22a R09: 0000000000000000
[48045.918984] R10: 00007ffe78a79848 R11: 0000000000000246 R12: 000000000000018f
[48045.918990] R13: 0000000000000004 R14: 000000000000a22a R15: 0000000000b76ace
[48045.919035]
[48045.919041] irq event stamp: 177041
[48045.919046] hardirqs last enabled at (177047): [] __up_console_sem+0x5e/0x70
[48045.919060] hardirqs last disabled at (177052): [] __up_console_sem+0x43/0x70
[48045.919071] softirqs last enabled at (176382): [] __irq_exit_rcu+0xfd/0x150
[48045.919084] softirqs last disabled at (176377): [] __irq_exit_rcu+0xfd/0x150
[48045.919095] ---[ end trace 0000000000000000 ]---
[48050.373338] ------------[ cut here ]------------
[48050.373344] WARNING: CPU: 0 PID: 2819906 at fs/btrfs/space-info.h:199 btrfs_add_reserved_bytes+0x1ae/0x280
[48050.373351] 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 rfkill ip_set nf_tables nfnetlink snd_hda_codec_generic snd_hda_intel intel_rapl_msr iTCO_wdt iTCO_vendor_support snd_intel_dspcfg snd_hda_codec snd_hwdep snd_hda_core intel_rapl_common snd_pcm joydev i2c_i801 i2c_smbus snd_timer snd soundcore lpc_ich virtio_balloon zram ip_tables crct10dif_pclmul crc32_pclmul xfs crc32c_intel ghash_clmulni_intel serio_raw qemu_fw_cfg
[48050.373447] CPU: 0 PID: 2819906 Comm: kworker/u4:2 Tainted: G W 6.1.0-rc8+ #971
[48050.373450] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[48050.373453] Workqueue: btrfs-flush_delalloc btrfs_work_helper
[48050.373460] RIP: 0010:btrfs_add_reserved_bytes+0x1ae/0x280
[48050.373463] Code: 4c 8b 54 24 10 4c 8b 5c 24 08 65 ff 0d 8b a0 96 62 0f 85 01 ff ff ff 0f 1f 44 00 00 e9 f7 fe ff ff 49 39 c5 0f 86 36 ff ff ff <0f> 0b 31 c0 e9 30 ff ff ff 48 8d 7d 18 be ff ff ff ff 4c 89 54 24
[48050.373466] RSP: 0018:ffff9e02823a77d8 EFLAGS: 00010206
[48050.373470] RAX: 0000000000011000 RBX: ffff8ce5960f8800 RCX: 0000000000000001
[48050.373473] RDX: 0000000000000000 RSI: ffffffff9e7b2293 RDI: ffffffff9e853ebe
[48050.373485] RBP: ffff8ce5c3402c00 R08: 0000000000000000 R09: 0000000000000001
[48050.373487] R10: 0000000000012000 R11: ffff8ce58f260000 R12: 0000000000012000
[48050.373489] R13: 0000000000012000 R14: fffffffffffee000 R15: ffff8ce5960f8810
[48050.373491] FS: 0000000000000000(0000) GS:ffff8ce5fbc00000(0000) knlGS:0000000000000000
[48050.373494] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[48050.373496] CR2: 00007ffacdd58000 CR3: 000000013766e002 CR4: 0000000000370ef0
[48050.373501] Call Trace:
[48050.373504]
[48050.373515] find_free_extent+0x6a2/0x1410
[48050.373525] ? _raw_spin_unlock+0x29/0x50
[48050.373531] ? btrfs_get_alloc_profile+0x11a/0x250
[48050.373539] btrfs_reserve_extent+0x13a/0x260
[48050.373563] cow_file_range+0x141/0x540
[48050.373581] btrfs_run_delalloc_range+0x119/0x5d0
[48050.373597] writepage_delalloc+0xa7/0x170
[48050.373609] __extent_writepage+0x162/0x4b0
[48050.373618] extent_write_cache_pages+0x12e/0x500
[48050.373676] extent_writepages+0x6a/0x120
[48050.373685] do_writepages+0xbf/0x1c0
[48050.373691] ? lock_release+0x137/0x2d0
[48050.373700] ? _raw_spin_unlock+0x29/0x50
[48050.373706] filemap_fdatawrite_wbc+0x66/0x90
[48050.373713] __filemap_fdatawrite_range+0x46/0x50
[48050.373725] btrfs_run_delalloc_work+0x17/0x40
[48050.373730] btrfs_work_helper+0xf2/0x3e0
[48050.373734] ? lock_is_held_type+0xe2/0x140
[48050.373743] process_one_work+0x271/0x590
[48050.373755] ? process_one_work+0x590/0x590
[48050.373759] worker_thread+0x52/0x3b0
[48050.373767] ? process_one_work+0x590/0x590
[48050.373771] kthread+0xf0/0x120
[48050.373775] ? kthread_complete_and_exit+0x20/0x20
[48050.373781] ret_from_fork+0x1f/0x30
[48050.373800]
[48050.373802] irq event stamp: 19299
[48050.373804] hardirqs last enabled at (19305): [] __up_console_sem+0x5e/0x70
[48050.373809] hardirqs last disabled at (19310): [] __up_console_sem+0x43/0x70
[48050.373812] softirqs last enabled at (19196): [] __irq_exit_rcu+0xfd/0x150
[48050.373817] softirqs last disabled at (19187): [] __irq_exit_rcu+0xfd/0x150
[48050.373820] ---[ end trace 0000000000000000 ]---
[48102.434470] BTRFS info (device dm-9): using crc32c (crc32c-intel) checksum algorithm
[48102.434479] BTRFS info (device dm-9): using free space tree
[48102.438446] BTRFS info (device dm-9): auto enabling async discard