[39268.815476] run fstests generic/338 at 2022-04-04 07:45:53
[39269.070397] BTRFS info (device dm-0): flagging fs with big metadata feature
[39269.070634] BTRFS info (device dm-0): using free space tree
[39269.070813] BTRFS info (device dm-0): has skinny extents
[39269.248360] BTRFS: device fsid 96167939-e142-492c-a9db-9768861cbef5 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (4005802)
[39269.357634] BTRFS info (device dm-11): flagging fs with big metadata feature
[39269.357848] BTRFS info (device dm-11): turning on sync discard
[39269.358028] BTRFS info (device dm-11): enabling free space tree
[39269.358204] BTRFS info (device dm-11): using free space tree
[39269.358392] BTRFS info (device dm-11): has skinny extents
[39269.359924] BTRFS info (device dm-11): creating free space tree
[39269.360178] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[39269.360443] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[39269.367938] BTRFS info (device dm-11): cleaning free space cache v1
[39269.374985] BTRFS info (device dm-11): checking UUID tree
[39269.388891] Buffer I/O error on dev dm-11, logical block 2621424, async page read
[39269.406101] 338 (4005590): drop_caches: 3
[39269.424899] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 1, rd 0, flush 0, corrupt 0, gen 0
[39269.425033] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 2, rd 0, flush 0, corrupt 0, gen 0
[39269.425216] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 3, rd 0, flush 0, corrupt 0, gen 0
[39269.425899] BTRFS: error (device dm-11: state A) in __btrfs_run_delayed_items:1092: errno=-5 IO failure
[39269.431777] BTRFS info (device dm-11: state EA): forced readonly
[39269.431957] BTRFS warning (device dm-11: state EA): Skipping commit of aborted transaction.
[39269.432218] BTRFS: error (device dm-11: state EA) in cleanup_transaction:1982: errno=-5 IO failure
[39269.469619] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[39269.469961] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 20, name: ksoftirqd/1
[39269.470849] preempt_count: 100, expected: 0
[39269.471002] RCU nest depth: 0, expected: 0
[39269.471156] INFO: lockdep is turned off.
[39269.471303] Preemption disabled at:
[39269.471304] [] __do_softirq+0x5e/0x517
[39269.471616] CPU: 1 PID: 20 Comm: ksoftirqd/1 Tainted: G        W         5.17.0+ #641
[39269.471868] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[39269.472123] Call Trace:
[39269.472251]  
[39269.472386]  dump_stack_lvl+0x56/0x6f
[39269.472538]  __might_resched.cold+0xff/0x13a
[39269.472697]  blk_release_queue+0x24/0x120
[39269.472850]  kobject_put+0x7c/0x1d0
[39269.473012]  ? rcu_do_batch+0x1ac/0x570
[39269.473161]  blkg_free.part.0+0x41/0x60
[39269.473306]  rcu_do_batch+0x1e1/0x570
[39269.473447]  ? rcu_do_batch+0x1ac/0x570
[39269.473591]  rcu_core+0x2cb/0x460
[39269.473725]  __do_softirq+0x178/0x517
[39269.473866]  ? smpboot_thread_fn+0x2c/0x270
[39269.474017]  run_ksoftirqd+0x43/0x70
[39269.474158]  smpboot_thread_fn+0x1c1/0x270
[39269.474307]  ? sort_range+0x20/0x20
[39269.474443]  kthread+0xf0/0x120
[39269.474576]  ? kthread_complete_and_exit+0x20/0x20
[39269.474732]  ret_from_fork+0x1f/0x30
[39269.474908]