[ 7710.168731] run fstests generic/252 at 2022-04-01 22:59:00
[ 7710.371509] BTRFS info (device dm-0): flagging fs with big metadata feature
[ 7710.371726] BTRFS info (device dm-0): using free space tree
[ 7710.371899] BTRFS info (device dm-0): has skinny extents
[ 7711.588719] BTRFS: device fsid 8e24e0e4-01f1-4c2f-8b2f-6d961b62d6d8 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (1622213)
[ 7711.685111] BTRFS info (device dm-9): using free space tree
[ 7711.685408] BTRFS info (device dm-9): has skinny extents
[ 7711.687355] BTRFS info (device dm-9): checking UUID tree
[ 7711.720605] BTRFS info (device dm-9): using free space tree
[ 7711.720795] BTRFS info (device dm-9): has skinny extents
[ 7711.760599] BTRFS info (device dm-9): using free space tree
[ 7711.760810] BTRFS info (device dm-9): has skinny extents
[ 7712.232170] Buffer I/O error on dev dm-9, logical block 2621424, async page read
[ 7712.268111] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 1, rd 0, flush 0, corrupt 0, gen 0
[ 7712.268625] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 2, rd 0, flush 0, corrupt 0, gen 0
[ 7712.269057] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 3, rd 0, flush 0, corrupt 0, gen 0
[ 7712.269481] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 4, rd 0, flush 0, corrupt 0, gen 0
[ 7712.269902] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 5, rd 0, flush 0, corrupt 0, gen 0
[ 7712.270317] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 6, rd 0, flush 0, corrupt 0, gen 0
[ 7712.270787] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 7, rd 0, flush 0, corrupt 0, gen 0
[ 7712.271250] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 8, rd 0, flush 0, corrupt 0, gen 0
[ 7712.274437] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 9, rd 0, flush 0, corrupt 0, gen 0
[ 7712.326870] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-9 scanned by systemd-udevd (1620928)
[ 7712.327792] BTRFS info: devid 1 device path /dev/dm-9 changed to /dev/mapper/error-test scanned by systemd-udevd (1620928)
[ 7712.362367] BTRFS info (device dm-9): using free space tree
[ 7712.362608] BTRFS info (device dm-9): has skinny extents
[ 7712.364376] BTRFS info (device dm-9): bdev /dev/mapper/error-test errs: wr 33, rd 0, flush 0, corrupt 0, gen 0
[ 7712.507219] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[ 7712.507486] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 1622352, name: rm
[ 7712.507728] preempt_count: 101, expected: 0
[ 7712.507871] RCU nest depth: 0, expected: 0
[ 7712.508018] INFO: lockdep is turned off.
[ 7712.508162] Preemption disabled at:
[ 7712.508163] [<0000000000000000>] 0x0
[ 7712.508453] CPU: 0 PID: 1622352 Comm: rm Tainted: G W 5.17.0+ #639
[ 7712.508689] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[ 7712.508942] Call Trace:
[ 7712.509062]
[ 7712.514724] dump_stack_lvl+0x56/0x6f
[ 7712.514866] __might_resched.cold+0xff/0x13a
[ 7712.515016] blk_release_queue+0x24/0x120
[ 7712.515165] kobject_put+0x7c/0x1d0
[ 7712.515302] ? rcu_do_batch+0x1ac/0x570
[ 7712.515440] blkg_free.part.0+0x41/0x60
[ 7712.515582] rcu_do_batch+0x1e1/0x570
[ 7712.515721] ? rcu_do_batch+0x1ac/0x570
[ 7712.515861] rcu_core+0x2cb/0x460
[ 7712.515994] __do_softirq+0x178/0x517
[ 7712.516139] __irq_exit_rcu+0xe3/0x160
[ 7712.516278] irq_exit_rcu+0xa/0x20
[ 7712.516410] sysvec_apic_timer_interrupt+0xa2/0xd0
[ 7712.516568]
[ 7712.516680]
[ 7712.516790] asm_sysvec_apic_timer_interrupt+0x12/0x20
[ 7712.516954] RIP: 0010:_raw_spin_unlock_irq+0x2a/0x50
[ 7712.517114] Code: 0f 1f 44 00 00 55 48 8b 74 24 08 48 89 fd 48 83 c7 18 e8 99 1b 38 ff 48 89 ef e8 31 45 38 ff e8 ac 70 44 ff fb 0f 1f 44 00 00 01 00 00 00 e8 ec d8 33 ff 65 8b 05 c5 ac 1b 6d 85 c0 74 02 5d
[ 7712.517564] RSP: 0018:ffffa5928594bbf0 EFLAGS: 00000246
[ 7712.517725] RAX: 0000000080000001 RBX: ffff935fd4ebe670 RCX: 0000000000000000
[ 7712.517920] RDX: 0000000000000001 RSI: ffffffff92612f79 RDI: ffffffff92e651a4
[ 7712.518113] RBP: ffff935fd4ebe8f8 R08: 0000000000000000 R09: 0000000000000000
[ 7712.518311] R10: 0000000000000004 R11: ffffffff923cd75c R12: 0000000000280000
[ 7712.518505] R13: 0000000000000000 R14: ffff935fd4ebe8f8 R15: 0000000000280fff
[ 7712.518701] ? free_unref_page_list+0x12c/0x560
[ 7712.518856] ? btrfs_lookup_first_ordered_range+0x119/0x150
[ 7712.519028] ? _raw_spin_unlock_irq+0x24/0x50
[ 7712.519179] btrfs_lookup_first_ordered_range+0x119/0x150
[ 7712.519348] btrfs_invalidate_folio+0x11c/0x420
[ 7712.519505] truncate_cleanup_folio+0x72/0xb0
[ 7712.519652] truncate_inode_pages_range+0xeb/0x5f0
[ 7712.519810] btrfs_evict_inode+0x88/0x510
[ 7712.519955] ? rcu_read_lock_sched_held+0x12/0x60
[ 7712.520114] ? lock_release+0x1ed/0x2c0
[ 7712.520255] ? collect_percpu_times+0x280/0x280
[ 7712.520408] evict+0xcc/0x1d0
[ 7712.520535] do_unlinkat+0x1a5/0x2a0
[ 7712.520676] __x64_sys_unlinkat+0x34/0x60
[ 7712.520818] do_syscall_64+0x38/0x90
[ 7712.520954] entry_SYSCALL_64_after_hwframe+0x44/0xae
[ 7712.521116] RIP: 0033:0x7f4045746e8b
[ 7712.521258] Code: 73 01 c3 48 8b 0d e5 ff 0c 00 f7 d8 64 89 01 48 83 c8 ff c3 66 2e 0f 1f 84 00 00 00 00 00 90 f3 0f 1e fa b8 07 01 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d b5 ff 0c 00 f7 d8 64 89 01 48
[ 7712.521706] RSP: 002b:00007ffdf94898b8 EFLAGS: 00000246 ORIG_RAX: 0000000000000107
[ 7712.521944] RAX: ffffffffffffffda RBX: 0000561a8a9637e0 RCX: 00007f4045746e8b
[ 7712.522142] RDX: 0000000000000000 RSI: 0000561a8a962380 RDI: 00000000ffffff9c
[ 7712.522332] RBP: 0000561a8a9622f0 R08: 0000000000000000 R09: 0000000000000000
[ 7712.522523] R10: 00007ffdf94899e0 R11: 0000000000000246 R12: 0000000000000000
[ 7712.522712] R13: 00007ffdf94899e0 R14: 0000000000000002 R15: 0000000000000002
[ 7712.522907]