[34342.921144] run fstests generic/299 at 2022-09-25 06:23:35
[34343.396887] BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm
[34343.396895] BTRFS info (device dm-0): using free space tree
[34347.575762] BTRFS: device fsid 06409c3f-fa86-42ce-aca1-60aeee5638a0 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (706667)
[34347.614157] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[34347.614167] BTRFS info (device dm-7): use zlib compression, level 3
[34347.614171] BTRFS info (device dm-7): using free space tree
[34347.621082] BTRFS info (device dm-7): checking UUID tree
[34424.442831] ------------[ cut here ]------------
[34424.443012] BTRFS: Transaction aborted (error -28)
[34424.443034] WARNING: CPU: 1 PID: 520387 at fs/btrfs/free-space-tree.c:859 remove_from_free_space_tree+0xfc/0x140
[34424.443042] 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 xfs intel_rapl_msr iTCO_wdt iTCO_vendor_support snd_hda_codec_generic intel_rapl_common snd_hda_intel snd_intel_dspcfg i2c_i801 joydev virtio_balloon i2c_smbus snd_hda_codec snd_hwdep snd_hda_core snd_pcm snd_timer snd soundcore lpc_ich zram ip_tables crct10dif_pclmul crc32_pclmul crc32c_intel ghash_clmulni_intel serio_raw qemu_fw_cfg
[34424.443117] CPU: 1 PID: 520387 Comm: kworker/u4:5 Not tainted 6.0.0-rc6+ #847
[34424.443120] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[34424.443124] Workqueue: events_unbound btrfs_async_reclaim_metadata_space
[34424.443131] RIP: 0010:remove_from_free_space_tree+0xfc/0x140
[34424.443134] Code: 41 83 fc fb 0f 95 c3 41 83 fc e2 0f 95 c0 20 c3 75 09 66 90 bb 01 00 00 00 eb 11 44 89 e6 48 c7 c7 f8 d3 87 8f e8 2b ab 79 00 <0f> 0b 41 89 d8 44 89 e1 ba 5b 03 00 00 48 89 ef 41 83 e0 01 48 c7
[34424.443137] RSP: 0018:ffffa62d416c7bd0 EFLAGS: 00010286
[34424.443140] RAX: 0000000000000026 RBX: 0000000000004001 RCX: 0000000000000000
[34424.443142] RDX: 0000000000000001 RSI: ffffffff8f89ce9e RDI: 00000000ffffffff
[34424.443144] RBP: ffff9af6dab63750 R08: 0000000000000000 R09: 0000000100008cf7
[34424.443145] R10: ffffa62d416c7a88 R11: ffffffff8fd58208 R12: 00000000ffffffe4
[34424.443147] R13: ffff9af6d5562850 R14: ffff9af6f5401000 R15: ffff9af6f5401280
[34424.443149] FS:  0000000000000000(0000) GS:ffff9af73fd00000(0000) knlGS:0000000000000000
[34424.443151] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[34424.443153] CR2: 000055d379a34008 CR3: 0000000103bae005 CR4: 0000000000370ee0
[34424.443159] Call Trace:
[34424.443163]  
[34424.443200]  alloc_reserved_extent+0x20/0x120
[34424.443208]  __btrfs_run_delayed_refs+0xa64/0x1250
[34424.443228]  btrfs_run_delayed_refs+0x8f/0x240
[34424.443236]  flush_space+0x3d5/0x640
[34424.443239]  ? find_held_lock+0x2b/0x80
[34424.443245]  ? lock_release+0x137/0x2d0
[34424.443248]  ? _raw_spin_unlock+0x29/0x50
[34424.443256]  btrfs_async_reclaim_metadata_space+0x159/0x360
[34424.443264]  process_one_work+0x271/0x590
[34424.443275]  ? process_one_work+0x590/0x590
[34424.443278]  worker_thread+0x52/0x3b0
[34424.443284]  ? process_one_work+0x590/0x590
[34424.443287]  kthread+0xf0/0x120
[34424.443290]  ? kthread_complete_and_exit+0x20/0x20
[34424.443296]  ret_from_fork+0x1f/0x30
[34424.443312]  
[34424.443314] irq event stamp: 24103673
[34424.443315] hardirqs last  enabled at (24103679): [] __up_console_sem+0x5e/0x70
[34424.443319] hardirqs last disabled at (24103684): [] __up_console_sem+0x43/0x70
[34424.443321] softirqs last  enabled at (24102856): [] __irq_exit_rcu+0xfd/0x150
[34424.443325] softirqs last disabled at (24102791): [] __irq_exit_rcu+0xfd/0x150
[34424.443327] ---[ end trace 0000000000000000 ]---
[34424.443333] BTRFS info (device dm-7: state A): dumping space info:
[34424.443336] BTRFS info (device dm-7: state A): space_info DATA has 694902784 free, is full
[34424.443526] BTRFS info (device dm-7: state A): space_info total=10182721536, used=7237480448, pinned=2240675840, reserved=7548928, may_use=2113536, readonly=0 zone_unusable=0
[34424.443530] BTRFS info (device dm-7: state A): space_info METADATA has 933888 free, is not full
[34424.443533] BTRFS info (device dm-7: state A): space_info total=268435456, used=39698432, pinned=117473280, reserved=32768, may_use=110231552, readonly=65536 zone_unusable=0
[34424.443536] BTRFS info (device dm-7: state A): space_info SYSTEM has 8372224 free, is not full
[34424.443538] BTRFS info (device dm-7: state A): space_info total=8388608, used=16384, pinned=0, reserved=0, may_use=0, readonly=0 zone_unusable=0
[34424.443541] BTRFS info (device dm-7: state A): global_block_rsv: size 3670016 reserved 0
[34424.443643] BTRFS info (device dm-7: state A): trans_block_rsv: size 0 reserved 0
[34424.443646] BTRFS info (device dm-7: state A): chunk_block_rsv: size 0 reserved 0
[34424.443648] BTRFS info (device dm-7: state A): delayed_block_rsv: size 131072 reserved 131072
[34424.443650] BTRFS info (device dm-7: state A): delayed_refs_rsv: size 139460608 reserved 0
[34424.443764] BTRFS: error (device dm-7: state A) in remove_from_free_space_tree:859: errno=-28 No space left
[34424.444352] BTRFS info (device dm-7: state EA): forced readonly
[34424.450055] BTRFS: error (device dm-7: state EA) in btrfs_run_delayed_refs:2141: errno=-28 No space left
[34441.183906] BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm
[34441.183917] BTRFS info (device dm-0): use zlib compression, level 3
[34441.183923] BTRFS info (device dm-0): using free space tree
[34442.791917] BTRFS info (device dm-7): using crc32c (crc32c-intel) checksum algorithm
[34442.791926] BTRFS info (device dm-7): use zlib compression, level 3
[34442.791930] BTRFS info (device dm-7): using free space tree