[31388.632394] run fstests generic/265 at 2022-04-02 05:34:34
[31388.970093] BTRFS: device fsid 308fcfe9-9645-4234-be40-e38fb16df0f0 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (3839079)
[31388.987154] BTRFS info (device dm-9): flagging fs with big metadata feature
[31388.987385] BTRFS info (device dm-9): turning on sync discard
[31388.987565] BTRFS info (device dm-9): enabling free space tree
[31388.987739] BTRFS info (device dm-9): using free space tree
[31388.987909] BTRFS info (device dm-9): has skinny extents
[31388.989768] BTRFS info (device dm-9): creating free space tree
[31388.990020] BTRFS info (device dm-9): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[31388.990290] BTRFS info (device dm-9): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[31388.996918] BTRFS info (device dm-9): cleaning free space cache v1
[31388.999809] BTRFS info (device dm-9): checking UUID tree
[31389.140648] BTRFS: device fsid cf97451b-dec3-4bef-bd00-380a09586924 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (3839152)
[31389.225093] BTRFS info (device dm-11): flagging fs with big metadata feature
[31389.225325] BTRFS info (device dm-11): turning on sync discard
[31389.225499] BTRFS info (device dm-11): enabling free space tree
[31389.225675] BTRFS info (device dm-11): using free space tree
[31389.225843] BTRFS info (device dm-11): has skinny extents
[31389.227863] BTRFS info (device dm-11): creating free space tree
[31389.228125] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[31389.228411] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[31389.233835] BTRFS info (device dm-11): cleaning free space cache v1
[31389.237069] BTRFS info (device dm-11): checking UUID tree
[31389.514459] BTRFS info (device dm-11): flagging fs with big metadata feature
[31389.515101] BTRFS info (device dm-11): turning on sync discard
[31389.515676] BTRFS info (device dm-11): using free space tree
[31389.516203] BTRFS info (device dm-11): has skinny extents
[31389.773792] Buffer I/O error on dev dm-11, logical block 2621424, async page read
[31389.798051] btrfs_dev_stat_print_on_error: 15 callbacks suppressed
[31389.798055] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 1, rd 0, flush 0, corrupt 0, gen 0
[31389.799943] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 2, rd 0, flush 0, corrupt 0, gen 0
[31389.801588] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 3, rd 0, flush 0, corrupt 0, gen 0
[31389.803391] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 4, rd 0, flush 0, corrupt 0, gen 0
[31389.805183] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 5, rd 0, flush 0, corrupt 0, gen 0
[31389.807997] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 6, rd 0, flush 0, corrupt 0, gen 0
[31389.811290] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 7, rd 0, flush 0, corrupt 0, gen 0
[31389.814193] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 8, rd 0, flush 0, corrupt 0, gen 0
[31389.833527] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (3838896)
[31389.834271] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (3838896)
[31389.869287] BTRFS info (device dm-11): flagging fs with big metadata feature
[31389.869522] BTRFS info (device dm-11): turning on sync discard
[31389.869697] BTRFS info (device dm-11): using free space tree
[31389.869868] BTRFS info (device dm-11): has skinny extents
[31389.871516] BTRFS info (device dm-11): bdev /dev/mapper/error-test errs: wr 8, rd 0, flush 0, corrupt 0, gen 0
[31389.993320] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[31389.993595] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 3838907, name: 265
[31389.993844] preempt_count: 101, expected: 0
[31389.993990] RCU nest depth: 0, expected: 0
[31389.994138] INFO: lockdep is turned off.
[31389.994281] Preemption disabled at:
[31389.994281] [<0000000000000000>] 0x0
[31389.994568] CPU: 1 PID: 3838907 Comm: 265 Tainted: G        W         5.17.0+ #639
[31389.994809] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[31389.995068] Call Trace:
[31389.995189]  
[31389.995301]  dump_stack_lvl+0x56/0x6f
[31389.995442]  __might_resched.cold+0xff/0x13a
[31389.995593]  blk_release_queue+0x24/0x120
[31389.995738]  kobject_put+0x7c/0x1d0
[31389.995874]  ? rcu_do_batch+0x1ac/0x570
[31389.996023]  blkg_free.part.0+0x41/0x60
[31389.996168]  rcu_do_batch+0x1e1/0x570
[31389.996307]  ? rcu_do_batch+0x1ac/0x570
[31389.996449]  rcu_core+0x2cb/0x460
[31389.996586]  __do_softirq+0x178/0x517
[31389.996725]  __irq_exit_rcu+0xe3/0x160
[31390.002404]  irq_exit_rcu+0xa/0x20
[31390.002539]  sysvec_apic_timer_interrupt+0xa2/0xd0
[31390.002697]  
[31390.002811]  
[31390.002923]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[31390.003090] RIP: 0010:debug_lockdep_rcu_enabled+0xa/0x30
[31390.003259] Code: df b2 90 b9 e8 67 0c 00 00 65 c7 05 14 d7 1c 47 00 00 00 00 eb be cc cc cc cc cc cc cc cc cc cc 8b 05 aa 8a 02 01 85 c0 74 21 <8b> 05 7c ee 02 01 85 c0 74 17 65 48 8b 04 25 c0 fe 01 00 8b 80 0c
[31390.003719] RSP: 0000:ffffb835c41dfe48 EFLAGS: 00000202
[31390.003882] RAX: 0000000000000002 RBX: 0000000000000001 RCX: 0000000000000001
[31390.004080] RDX: 0000000000000001 RSI: 0000000000000000 RDI: ffff94184cecc8a8
[31390.004273] RBP: ffff94184cecc8a8 R08: 0000000000000001 R09: 0000000000000000
[31390.004467] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000001
[31390.004662] R13: 0000000000000001 R14: 0000000000000000 R15: ffff94184cecc838
[31390.004862]  rcu_read_lock_sched_held+0x12/0x60
[31390.005021]  lock_acquire+0x176/0x2d0
[31390.005164]  ? rcu_read_lock_sched_held+0x12/0x60
[31390.005320]  ? lock_release+0x1ed/0x2c0
[31390.005460]  down_read_trylock+0x79/0xf0
[31390.005606]  ? do_user_addr_fault+0x148/0x6b0
[31390.005760]  do_user_addr_fault+0x148/0x6b0
[31390.005906]  ? sigprocmask+0x8c/0xb0
[31390.006047]  exc_page_fault+0x78/0x280
[31390.006187]  ? asm_exc_page_fault+0x8/0x30
[31390.006331]  asm_exc_page_fault+0x1e/0x30
[31390.006474] RIP: 0033:0x55c4e63522ae
[31390.006617] Code: 85 db 75 d8 5b 5d 41 5c c3 0f 1f 00 c3 66 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 f3 0f 1e fa 48 b8 df df df df df df df df <48> 89 07 48 89 47 08 48 63 05 b0 16 10 00 8d 50 01 89 15 a7 16 10
[31390.007083] RSP: 002b:00007ffec587cb68 EFLAGS: 00010283
[31390.007246] RAX: dfdfdfdfdfdfdfdf RBX: 0000000000000000 RCX: 000055c4e7b5b010
[31390.007439] RDX: 0000000000000005 RSI: 000055c4e7e70470 RDI: 000055c4e7e71570
[31390.007633] RBP: 000055c4e7e72670 R08: 000055c4e7e73020 R09: 00747365742d726f
[31390.007829] R10: 0000000000000008 R11: 0000000000000246 R12: 000055c4e7e71570
[31390.008029] R13: dfdfdfdfdfdfdfdf R14: 000055c4e6453c50 R15: 0000000000000000
[31390.008228]