[25361.822503] run fstests generic/278 at 2022-04-04 03:54:06
[25362.081613] BTRFS info (device dm-0): flagging fs with big metadata feature
[25362.081840] BTRFS info (device dm-0): using free space tree
[25362.082031] BTRFS info (device dm-0): has skinny extents
[25362.313161] BTRFS: device fsid aefef365-e820-41e5-84d5-92096b85f08d devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (970015)
[25362.327060] BTRFS info (device dm-9): flagging fs with big metadata feature
[25362.327295] BTRFS info (device dm-9): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[25362.333850] BTRFS info (device dm-9): use zstd compression, level 3
[25362.334063] BTRFS info (device dm-9): turning on async discard
[25362.334269] BTRFS info (device dm-9): disk space caching is enabled
[25362.334472] BTRFS info (device dm-9): has skinny extents
[25362.353865] BTRFS info (device dm-9): checking UUID tree
[25362.703363] BTRFS: device fsid ca13b1fe-0ed0-4513-aa1a-779f315e8de3 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (970091)
[25362.795720] BTRFS info (device dm-11): flagging fs with big metadata feature
[25362.795962] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[25362.796229] BTRFS info (device dm-11): use zstd compression, level 3
[25362.796416] BTRFS info (device dm-11): turning on async discard
[25362.796590] BTRFS info (device dm-11): disk space caching is enabled
[25362.796774] BTRFS info (device dm-11): has skinny extents
[25362.798997] BTRFS info (device dm-11): checking UUID tree
[25362.924641] BTRFS info (device dm-11): flagging fs with big metadata feature
[25362.924881] BTRFS info (device dm-11): use zstd compression, level 3
[25362.925135] BTRFS info (device dm-11): turning on async discard
[25362.925319] BTRFS info (device dm-11): disk space caching is enabled
[25362.925508] BTRFS info (device dm-11): has skinny extents
[25363.184751] Buffer I/O error on dev dm-11, logical block 2621424, async page read
[25363.226380] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (968458)
[25363.227535] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (968458)
[25363.400765] BTRFS info (device dm-11): flagging fs with big metadata feature
[25363.401120] BTRFS info (device dm-11): use zstd compression, level 3
[25363.401385] BTRFS info (device dm-11): turning on async discard
[25363.401627] BTRFS info (device dm-11): disk space caching is enabled
[25363.401881] BTRFS info (device dm-11): has skinny extents
[25363.403794] BTRFS info (device dm-11): bdev /dev/mapper/error-test errs: wr 64, rd 0, flush 0, corrupt 0, gen 0
[25363.572943] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[25363.573264] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 970217, name: rm
[25363.573527] preempt_count: 101, expected: 0
[25363.573687] RCU nest depth: 0, expected: 0
[25363.573887] INFO: lockdep is turned off.
[25363.574058] Preemption disabled at:
[25363.574059] [] percpu_counter_add_batch+0x1b/0xb0
[25363.574417] CPU: 0 PID: 970217 Comm: rm Tainted: G        W         5.17.0+ #641
[25363.574667] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[25363.574945] Call Trace:
[25363.575067]  
[25363.575183]  dump_stack_lvl+0x56/0x6f
[25363.575330]  __might_resched.cold+0xff/0x13a
[25363.575482]  blk_release_queue+0x24/0x120
[25363.575631]  kobject_put+0x7c/0x1d0
[25363.575784]  ? rcu_do_batch+0x1ac/0x570
[25363.575950]  blkg_free.part.0+0x41/0x60
[25363.576100]  rcu_do_batch+0x1e1/0x570
[25363.576243]  ? rcu_do_batch+0x1ac/0x570
[25363.576388]  rcu_core+0x2cb/0x460
[25363.576519]  __do_softirq+0x178/0x517
[25363.576664]  __irq_exit_rcu+0xe3/0x160
[25363.576807]  irq_exit_rcu+0xa/0x20
[25363.576947]  sysvec_apic_timer_interrupt+0xa2/0xd0
[25363.577104]  
[25363.577218]  
[25363.577332]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[25363.577495] RIP: 0010:rcu_read_lock_sched_held+0x0/0x60
[25363.578312] Code: 0f 1f 84 00 00 00 00 00 66 90 0f 1f 44 00 00 9c 58 0f 1f 40 00 48 c1 e8 09 48 83 f0 01 83 e0 01 c3 66 0f 1f 84 00 00 00 00 00 <0f> 1f 44 00 00 41 54 41 bc 01 00 00 00 e8 4e db c4 00 85 c0 75 06
[25363.578787] RSP: 0000:ffffb126474b7d20 EFLAGS: 00000283
[25363.578963] RAX: 0000000000000000 RBX: ffff9be296885000 RCX: ffffffffa2402386
[25363.579161] RDX: 0000000000000000 RSI: ffffffffa24023d6 RDI: ffffffffa3b9ce40
[25363.579354] RBP: ffffffffa3b9ce40 R08: 0000000000000000 R09: 0000000000000000
[25363.579549] R10: 0000000000000000 R11: 0000000000000000 R12: ffff9be296bbf6c0
[25363.579749] R13: 0000000000000cc0 R14: ffffffffa24023d6 R15: 0000000000000cc0
[25363.579947]  ? memcg_slab_post_alloc_hook+0x206/0x440
[25363.580126]  ? memcg_slab_post_alloc_hook+0x1b6/0x440
[25363.580292]  ? memcg_slab_post_alloc_hook+0x206/0x440
[25363.580460]  lock_release+0x1ed/0x2c0
[25363.580602]  kmem_cache_alloc+0x1d1/0x3f0
[25363.580752]  __anon_vma_prepare+0x41/0x1b0
[25363.580908]  __handle_mm_fault+0x1342/0x1460
[25363.581056]  ? mmap_region+0x2da/0x620
[25363.581198]  handle_mm_fault+0x11e/0x3a0
[25363.581344]  do_user_addr_fault+0x1e9/0x6b0
[25363.581498]  exc_page_fault+0x78/0x280
[25363.581637]  ? asm_exc_page_fault+0x8/0x30
[25363.581790]  asm_exc_page_fault+0x1e/0x30
[25363.581941] RIP: 0033:0x7f7156cbc19b
[25363.582090] Code: 00 00 c1 e9 03 f3 48 ab 49 89 ac 24 c0 09 00 00 48 8b 3d 28 be 01 00 48 8d 5f 0e 48 83 c7 10 ff 15 8a ac 01 00 48 85 c0 74 15 <48> 89 18 48 83 c0 10 49 89 44 24 08 4c 89 e0 5b 5d 41 5c c3 90 45
[25363.582545] RSP: 002b:00007ffdabfe6660 EFLAGS: 00010206
[25363.582719] RAX: 00007f7156ad4000 RBX: 000000000000000f RCX: 00007f7156ad4110
[25363.582920] RDX: 00007f7156ad6000 RSI: 0000000000002000 RDI: 0000000000000000
[25363.583117] RBP: 00007f7156ca1e90 R08: 00000000ffffffff R09: 0000000000000000
[25363.583312] R10: 0000000000000022 R11: 0000000000000246 R12: 00007f7156ca2600
[25363.583510] R13: 0000000000000001 R14: 00007f7156cd81a0 R15: 0000000000000000
[25363.583708]