[ 8528.511492] run fstests generic/331 at 2022-04-01 23:13:34
[ 8528.760043] BTRFS info (device dm-0): flagging fs with big metadata feature
[ 8528.760284] BTRFS info (device dm-0): using free space tree
[ 8528.760459] BTRFS info (device dm-0): has skinny extents
[ 8528.882266] BTRFS: device fsid b67fab9f-fa5d-4c5c-aef1-fa7a9102af2f devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (1674098)
[ 8528.913638] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 8528.913868] BTRFS info (device dm-9): turning on async discard
[ 8528.914041] BTRFS info (device dm-9): disk space caching is enabled
[ 8528.914869] BTRFS info (device dm-9): has skinny extents
[ 8528.947177] BTRFS info (device dm-9): checking UUID tree
[ 8529.150951] BTRFS: device fsid a4963491-d40d-411b-bbf5-10822dd781e7 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (1674175)
[ 8529.233063] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 8529.233306] BTRFS info (device dm-11): turning on async discard
[ 8529.233483] BTRFS info (device dm-11): disk space caching is enabled
[ 8529.233665] BTRFS info (device dm-11): has skinny extents
[ 8529.235399] BTRFS info (device dm-11): checking UUID tree
[ 8529.498321] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 8529.498573] BTRFS info (device dm-11): turning on async discard
[ 8529.498780] BTRFS info (device dm-11): disk space caching is enabled
[ 8529.498992] BTRFS info (device dm-11): has skinny extents
[ 8530.064612] Buffer I/O error on dev dm-11, logical block 2621424, async page read
[ 8530.175945] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (1671781)
[ 8530.176787] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (1671781)
[ 8530.236911] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 8530.237219] BTRFS info (device dm-11): turning on async discard
[ 8530.237435] BTRFS info (device dm-11): disk space caching is enabled
[ 8530.237647] BTRFS info (device dm-11): has skinny extents
[ 8530.239547] BTRFS info (device dm-11): bdev /dev/mapper/error-test errs: wr 8, rd 0, flush 0, corrupt 0, gen 0
[ 8530.445121] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[ 8530.445399] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 1674304, name: rm
[ 8530.445647] preempt_count: 100, expected: 0
[ 8530.445795] RCU nest depth: 1, expected: 0
[ 8530.445942] INFO: lockdep is turned off.
[ 8530.446088] Preemption disabled at:
[ 8530.446088] [] __do_softirq+0x5e/0x517
[ 8530.447155] CPU: 1 PID: 1674304 Comm: rm Tainted: G W 5.17.0+ #639
[ 8530.447525] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[ 8530.447901] Call Trace:
[ 8530.448085]
[ 8530.448259] dump_stack_lvl+0x56/0x6f
[ 8530.448473] __might_resched.cold+0xff/0x13a
[ 8530.448703] blk_release_queue+0x24/0x120
[ 8530.448918] kobject_put+0x7c/0x1d0
[ 8530.449126] ? rcu_do_batch+0x1ac/0x570
[ 8530.449344] blkg_free.part.0+0x41/0x60
[ 8530.449561] rcu_do_batch+0x1e1/0x570
[ 8530.449766] ? rcu_do_batch+0x1ac/0x570
[ 8530.449985] rcu_core+0x2cb/0x460
[ 8530.450195] __do_softirq+0x178/0x517
[ 8530.450406] __irq_exit_rcu+0xe3/0x160
[ 8530.450614] irq_exit_rcu+0xa/0x20
[ 8530.450819] sysvec_apic_timer_interrupt+0xa2/0xd0
[ 8530.451052]
[ 8530.451224]
[ 8530.451399] asm_sysvec_apic_timer_interrupt+0x12/0x20
[ 8530.451642] RIP: 0010:lock_acquire+0xf3/0x2d0
[ 8530.451865] Code: 48 83 c4 20 e8 4e d2 c6 00 b8 ff ff ff ff 65 0f c1 05 f9 9c e3 47 83 f8 01 0f 85 bf 01 00 00 4d 85 ff 74 06 fb 0f 1f 44 00 00 <48> 83 c4 30 5b 5d 41 5c 41 5d 41 5e 41 5f c3 65 8b 05 d7 28 e3 47
[ 8530.452562] RSP: 0018:ffffb835c7557b80 EFLAGS: 00000246
[ 8530.452808] RAX: 0000000000000001 RBX: 0000000000000000 RCX: 0000000000000000
[ 8530.453096] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffffb9b9ce40
[ 8530.453387] RBP: ffffffffb9b9ce40 R08: 0000000000000000 R09: 0000000000000000
[ 8530.453671] R10: 0000000000000004 R11: 0000000000000003 R12: 0000000000000002
[ 8530.453959] R13: 0000000000000000 R14: 0000000000000000 R15: ffff94184cff1800
[ 8530.454253] ? lock_release+0x1ed/0x2c0
[ 8530.454466] ? rcu_read_lock_sched_held+0x12/0x60
[ 8530.454703] percpu_ref_put_many.constprop.0+0x29/0xf0
[ 8530.454949] ? mem_cgroup_css_online+0x140/0x140
[ 8530.455182] __mem_cgroup_uncharge_list+0x51/0x80
[ 8530.455415] release_pages+0x37a/0x6b0
[ 8530.455636] __pagevec_release+0x1b/0x30
[ 8530.455854] truncate_inode_pages_range+0x137/0x5f0
[ 8530.456098] btrfs_evict_inode+0x88/0x510
[ 8530.456319] ? rcu_read_lock_sched_held+0x12/0x60
[ 8530.456556] ? lock_release+0x1ed/0x2c0
[ 8530.456769] ? collect_percpu_times+0x280/0x280
[ 8530.456999] evict+0xcc/0x1d0
[ 8530.457195] do_unlinkat+0x1a5/0x2a0
[ 8530.457407] __x64_sys_unlinkat+0x34/0x60
[ 8530.457629] do_syscall_64+0x38/0x90
[ 8530.457834] entry_SYSCALL_64_after_hwframe+0x44/0xae
[ 8530.458079] RIP: 0033:0x7fd4b81de0cb
[ 8530.458292] Code: 73 01 c3 48 8b 0d ad fd 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 7d fd 0c 00 f7 d8 64 89 01 48
[ 8530.458974] RSP: 002b:00007ffe80d76228 EFLAGS: 00000246 ORIG_RAX: 0000000000000107
[ 8530.459332] RAX: ffffffffffffffda RBX: 000055ba218866c0 RCX: 00007fd4b81de0cb
[ 8530.459621] RDX: 0000000000000000 RSI: 000055ba21885380 RDI: 00000000ffffff9c
[ 8530.459908] RBP: 000055ba218852f0 R08: 0000000000000000 R09: 0000000000000000
[ 8530.460196] R10: 00007ffe80d76350 R11: 0000000000000246 R12: 0000000000000000
[ 8530.460482] R13: 00007ffe80d76350 R14: 0000000000000002 R15: 0000000000000002
[ 8530.460767]