[20438.525559] run fstests generic/283 at 2022-04-03 02:32:06
[20438.742342] BTRFS info (device dm-0): flagging fs with big metadata feature
[20438.742568] BTRFS info (device dm-0): using free space tree
[20438.742749] BTRFS info (device dm-0): has skinny extents
[20438.955139] BTRFS: device fsid f2708100-6e9d-4d3f-b13c-8275e7709e53 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (774275)
[20438.967782] BTRFS info (device dm-9): flagging fs with big metadata feature
[20438.968027] BTRFS info (device dm-9): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[20438.968289] BTRFS info (device dm-9): use zstd compression, level 3
[20438.968470] BTRFS info (device dm-9): turning on async discard
[20438.968649] BTRFS info (device dm-9): disk space caching is enabled
[20438.968829] BTRFS info (device dm-9): has skinny extents
[20438.979623] BTRFS info (device dm-9): checking UUID tree
[20439.280875] BTRFS: device fsid 5784c193-3ac0-4b38-a702-e131b9f995f1 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (774348)
[20439.370776] BTRFS info (device dm-11): flagging fs with big metadata feature
[20439.371012] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[20439.371267] BTRFS info (device dm-11): use zstd compression, level 3
[20439.371454] BTRFS info (device dm-11): turning on async discard
[20439.371646] BTRFS info (device dm-11): disk space caching is enabled
[20439.371834] BTRFS info (device dm-11): has skinny extents
[20439.373409] BTRFS info (device dm-11): checking UUID tree
[20439.489656] BTRFS info (device dm-11): flagging fs with big metadata feature
[20439.489914] BTRFS info (device dm-11): use zstd compression, level 3
[20439.490117] BTRFS info (device dm-11): turning on async discard
[20439.490309] BTRFS info (device dm-11): disk space caching is enabled
[20439.490507] BTRFS info (device dm-11): has skinny extents
[20439.726579] Buffer I/O error on dev dm-11, logical block 2621424, async page read
[20439.799181] btrfs_dev_stat_print_on_error: 641 callbacks suppressed
[20439.799185] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 1, rd 0, flush 0, corrupt 0, gen 0
[20439.799720] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 2, rd 0, flush 0, corrupt 0, gen 0
[20439.800048] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 3, rd 0, flush 0, corrupt 0, gen 0
[20439.800362] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 4, rd 0, flush 0, corrupt 0, gen 0
[20439.800678] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 5, rd 0, flush 0, corrupt 0, gen 0
[20439.800995] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 6, rd 0, flush 0, corrupt 0, gen 0
[20439.801313] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 7, rd 0, flush 0, corrupt 0, gen 0
[20439.801619] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 8, rd 0, flush 0, corrupt 0, gen 0
[20439.801945] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 9, rd 0, flush 0, corrupt 0, gen 0
[20439.802259] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 10, rd 0, flush 0, corrupt 0, gen 0
[20439.840601] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (770691)
[20439.841363] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (770691)
[20440.088981] BTRFS info (device dm-11): flagging fs with big metadata feature
[20440.089317] BTRFS info (device dm-11): use zstd compression, level 3
[20440.089605] BTRFS info (device dm-11): turning on async discard
[20440.089908] BTRFS info (device dm-11): disk space caching is enabled
[20440.090200] BTRFS info (device dm-11): has skinny extents
[20440.092874] BTRFS info (device dm-11): bdev /dev/mapper/error-test errs: wr 320, rd 0, flush 0, corrupt 0, gen 0
[20440.234857] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[20440.235163] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 20, name: ksoftirqd/1
[20440.235419] preempt_count: 100, expected: 0
[20440.235564] RCU nest depth: 0, expected: 0
[20440.235718] INFO: lockdep is turned off.
[20440.235878] Preemption disabled at:
[20440.235879] [] __do_softirq+0x5e/0x517
[20440.236189] CPU: 1 PID: 20 Comm: ksoftirqd/1 Tainted: G        W         5.17.0+ #640
[20440.236437] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[20440.236694] Call Trace:
[20440.236816]  
[20440.236932]  dump_stack_lvl+0x56/0x6f
[20440.237075]  __might_resched.cold+0xff/0x13a
[20440.237228]  blk_release_queue+0x24/0x120
[20440.237373]  kobject_put+0x7c/0x1d0
[20440.237511]  ? rcu_do_batch+0x1ac/0x570
[20440.237658]  blkg_free.part.0+0x41/0x60
[20440.237805]  rcu_do_batch+0x1e1/0x570
[20440.237942]  ? rcu_do_batch+0x1ac/0x570
[20440.238088]  rcu_core+0x2cb/0x460
[20440.238224]  __do_softirq+0x178/0x517
[20440.238364]  ? smpboot_thread_fn+0x2c/0x270
[20440.238512]  run_ksoftirqd+0x43/0x70
[20440.238657]  smpboot_thread_fn+0x1c1/0x270
[20440.238808]  ? sort_range+0x20/0x20
[20440.238944]  kthread+0xf0/0x120
[20440.239084]  ? kthread_complete_and_exit+0x20/0x20
[20440.239245]  ret_from_fork+0x1f/0x30
[20440.239384]