[31490.331356] run fstests generic/282 at 2022-04-02 05:36:16
[31490.547348] BTRFS info (device dm-0): flagging fs with big metadata feature
[31490.547582] BTRFS info (device dm-0): using free space tree
[31490.547756] BTRFS info (device dm-0): has skinny extents
[31490.707873] BTRFS: device fsid 1b23ecd6-b2e6-46ea-8082-058fd91515c2 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (3853567)
[31490.727668] BTRFS info (device dm-9): flagging fs with big metadata feature
[31490.727890] BTRFS info (device dm-9): turning on sync discard
[31490.728066] BTRFS info (device dm-9): enabling free space tree
[31490.728250] BTRFS info (device dm-9): using free space tree
[31490.728424] BTRFS info (device dm-9): has skinny extents
[31490.747991] BTRFS info (device dm-9): creating free space tree
[31490.748251] BTRFS info (device dm-9): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[31490.748521] BTRFS info (device dm-9): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[31490.758713] BTRFS info (device dm-9): cleaning free space cache v1
[31490.767313] BTRFS info (device dm-9): checking UUID tree
[31490.917168] BTRFS: device fsid 9ee13e2e-ab77-4a8b-88a2-45311f3793b8 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (3853640)
[31490.998120] BTRFS info (device dm-11): flagging fs with big metadata feature
[31490.998339] BTRFS info (device dm-11): turning on sync discard
[31490.998533] BTRFS info (device dm-11): enabling free space tree
[31490.998707] BTRFS info (device dm-11): using free space tree
[31490.998873] BTRFS info (device dm-11): has skinny extents
[31491.000720] BTRFS info (device dm-11): creating free space tree
[31491.000960] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[31491.001231] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[31491.011053] BTRFS info (device dm-11): cleaning free space cache v1
[31491.020814] BTRFS info (device dm-11): checking UUID tree
[31491.322705] BTRFS info (device dm-11): flagging fs with big metadata feature
[31491.323247] BTRFS info (device dm-11): turning on sync discard
[31491.323729] BTRFS info (device dm-11): using free space tree
[31491.324167] BTRFS info (device dm-11): has skinny extents
[31491.547492] Buffer I/O error on dev dm-11, logical block 2621424, async page read
[31491.644862] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (3850844)
[31491.645629] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (3850844)
[31491.696388] BTRFS info (device dm-11): flagging fs with big metadata feature
[31491.696655] BTRFS info (device dm-11): turning on sync discard
[31491.696854] BTRFS info (device dm-11): using free space tree
[31491.697049] BTRFS info (device dm-11): has skinny extents
[31491.822441] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[31491.822715] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 3853374, name: 282
[31491.822964] preempt_count: 101, expected: 0
[31491.823113] RCU nest depth: 1, expected: 0
[31491.823262] INFO: lockdep is turned off.
[31491.823408] Preemption disabled at:
[31491.823409] [] percpu_counter_add_batch+0x1b/0xb0
[31491.823744] CPU: 0 PID: 3853374 Comm: 282 Tainted: G        W         5.17.0+ #639
[31491.823987] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[31491.824244] Call Trace:
[31491.824368]  
[31491.824486]  dump_stack_lvl+0x56/0x6f
[31491.824628]  __might_resched.cold+0xff/0x13a
[31491.824781]  blk_release_queue+0x24/0x120
[31491.824932]  kobject_put+0x7c/0x1d0
[31491.825069]  ? rcu_do_batch+0x1ac/0x570
[31491.825220]  blkg_free.part.0+0x41/0x60
[31491.825367]  rcu_do_batch+0x1e1/0x570
[31491.825506]  ? rcu_do_batch+0x1ac/0x570
[31491.825648]  rcu_core+0x2cb/0x460
[31491.825784]  __do_softirq+0x178/0x517
[31491.825929]  __irq_exit_rcu+0xe3/0x160
[31491.826071]  irq_exit_rcu+0xa/0x20
[31491.826212]  sysvec_apic_timer_interrupt+0xa2/0xd0
[31491.826373]  
[31491.826485]  
[31491.826602]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[31491.826768] RIP: 0010:rcu_is_watching+0x14/0x40
[31491.826921] Code: 90 b9 e8 1f ae c4 00 65 8a 05 5c b0 e2 47 0f be c0 c3 0f 1f 40 00 53 65 ff 05 78 69 e1 47 e8 e3 ad c4 00 48 c7 c3 90 41 03 00 <89> c0 48 03 1c c5 20 5b 93 b9 8b 03 83 e0 01 65 ff 0d 56 69 e1 47
[31491.827381] RSP: 0018:ffffb835c5527a40 EFLAGS: 00000292
[31491.827548] RAX: 0000000000000000 RBX: 0000000000034190 RCX: 0000000000000000
[31491.827743] RDX: ffffffffb842dcf4 RSI: ffffffffb987e4d9 RDI: ffffffffb983354b
[31491.827941] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
[31491.828136] R10: 0000000000000000 R11: 0000000000000000 R12: ffff941843d83800
[31491.828331] R13: 0000000000000cc0 R14: ffffffffb8167fa1 R15: 0000000000000cc0
[31491.828524]  ? vm_area_dup+0x21/0xa0
[31491.828664]  ? get_obj_cgroup_from_current+0xd4/0x310
[31491.828829]  rcu_read_unlock+0x5/0x60
[31491.828971]  get_obj_cgroup_from_current+0x1b0/0x310
[31491.829139]  kmem_cache_alloc+0x75/0x3f0
[31491.829284]  vm_area_dup+0x21/0xa0
[31491.829422]  ? rcu_read_lock_sched_held+0x12/0x60
[31491.829586]  ? lock_acquire+0x176/0x2d0
[31491.829731]  ? copy_page_range+0xe8c/0x1460
[31491.829881]  ? lock_acquire+0x176/0x2d0
[31491.830025]  ? percpu_counter_add_batch+0x58/0xb0
[31491.830188]  ? __vm_enough_memory+0x26/0x110
[31491.830336]  dup_mm+0x1d8/0x610
[31491.830469]  copy_process+0x134f/0x1e90
[31491.830614]  ? wp_page_reuse+0x60/0x70
[31491.830759]  kernel_clone+0x8b/0x3c0
[31491.830897]  ? rcu_read_lock_sched_held+0x12/0x60
[31491.831055]  ? rcu_read_lock_sched_held+0x12/0x60
[31491.831219]  ? lock_acquire+0x176/0x2d0
[31491.831361]  __do_sys_clone+0x52/0x60
[31491.831501]  do_syscall_64+0x38/0x90
[31491.831642]  entry_SYSCALL_64_after_hwframe+0x44/0xae
[31491.831806] RIP: 0033:0x7f45523100df
[31491.831943] Code: ed 0f 85 f4 00 00 00 64 4c 8b 0c 25 10 00 00 00 45 31 c0 4d 8d 91 d0 02 00 00 31 d2 31 f6 bf 11 00 20 01 b8 38 00 00 00 0f 05 <48> 3d 00 f0 ff ff 0f 87 8d 00 00 00 41 89 c5 85 c0 0f 85 9a 00 00
[31491.832406] RSP: 002b:00007ffc87dda910 EFLAGS: 00000246 ORIG_RAX: 0000000000000038
[31491.832649] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f45523100df
[31491.832844] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000001200011
[31491.838617] RBP: 0000000000000000 R08: 0000000000000000 R09: 00007f455223f740
[31491.838816] R10: 00007f455223fa10 R11: 0000000000000246 R12: 0000000000000000
[31491.839032] R13: 00007ffc87dda950 R14: 000055bbb4144980 R15: 000055bbb218cd31
[31491.839236]