[24085.490450] run fstests generic/321 at 2022-04-04 03:32:19
[24085.870708] BTRFS info (device dm-0): flagging fs with big metadata feature
[24085.871139] BTRFS info (device dm-0): using free space tree
[24085.871458] BTRFS info (device dm-0): has skinny extents
[24086.514608] BTRFS: device fsid 7b93b2ac-68c8-4dcc-88ff-f9c52c7e65f3 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (987578)
[24086.585297] BTRFS info (device dm-11): flagging fs with big metadata feature
[24086.585735] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_LZO (0x8)
[24086.586301] BTRFS info (device dm-11): use lzo compression, level 0
[24086.586678] BTRFS info (device dm-11): disk space caching is enabled
[24086.587068] BTRFS info (device dm-11): has skinny extents
[24086.588682] BTRFS info (device dm-11): checking UUID tree
[24086.704384] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (987355)
[24086.705517] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (987355)
[24086.757109] BTRFS info (device dm-11): flagging fs with big metadata feature
[24086.757544] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_LZO (0x8)
[24086.758038] BTRFS info (device dm-11): use lzo compression, level 0
[24086.758473] BTRFS info (device dm-11): disk space caching is enabled
[24086.758853] BTRFS info (device dm-11): has skinny extents
[24086.760742] BTRFS info (device dm-11): start tree-log replay
[24086.902259] BTRFS info (device dm-11): checking UUID tree
[24087.193556] BTRFS info (device dm-11): flagging fs with big metadata feature
[24087.193994] BTRFS info (device dm-11): use lzo compression, level 0
[24087.194398] BTRFS info (device dm-11): disk space caching is enabled
[24087.194776] BTRFS info (device dm-11): has skinny extents
[24087.288910] BTRFS info (device dm-11): flagging fs with big metadata feature
[24087.289366] BTRFS info (device dm-11): use lzo compression, level 0
[24087.289741] BTRFS info (device dm-11): disk space caching is enabled
[24087.290145] BTRFS info (device dm-11): has skinny extents
[24087.585288] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (987355)
[24087.586614] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (987355)
[24087.639755] BTRFS info (device dm-11): flagging fs with big metadata feature
[24087.640218] BTRFS info (device dm-11): use lzo compression, level 0
[24087.640600] BTRFS info (device dm-11): disk space caching is enabled
[24087.640977] BTRFS info (device dm-11): has skinny extents
[24087.643271] BTRFS info (device dm-11): start tree-log replay
[24088.134640] BTRFS info (device dm-11): flagging fs with big metadata feature
[24088.135103] BTRFS info (device dm-11): use lzo compression, level 0
[24088.135475] BTRFS info (device dm-11): disk space caching is enabled
[24088.135850] BTRFS info (device dm-11): has skinny extents
[24088.224605] BTRFS info (device dm-11): flagging fs with big metadata feature
[24088.225062] BTRFS info (device dm-11): use lzo compression, level 0
[24088.225438] BTRFS info (device dm-11): disk space caching is enabled
[24088.225814] BTRFS info (device dm-11): has skinny extents
[24088.722704] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (987355)
[24088.723858] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (987355)
[24088.775739] BTRFS info (device dm-11): flagging fs with big metadata feature
[24088.776197] BTRFS info (device dm-11): use lzo compression, level 0
[24088.776571] BTRFS info (device dm-11): disk space caching is enabled
[24088.776981] BTRFS info (device dm-11): has skinny extents
[24088.778584] BTRFS info (device dm-11): start tree-log replay
[24089.202111] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[24089.202791] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 20, name: ksoftirqd/1
[24089.203471] preempt_count: 100, expected: 0
[24089.203807] RCU nest depth: 0, expected: 0
[24089.204157] INFO: lockdep is turned off.
[24089.204473] Preemption disabled at:
[24089.204475] [] __do_softirq+0x5e/0x517
[24089.205205] CPU: 1 PID: 20 Comm: ksoftirqd/1 Tainted: G        W         5.17.0+ #641
[24089.205840] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[24089.206522] Call Trace:
[24089.206717]  
[24089.206900]  dump_stack_lvl+0x56/0x6f
[24089.207209]  __might_resched.cold+0xff/0x13a
[24089.207557]  blk_release_queue+0x24/0x120
[24089.207882]  kobject_put+0x7c/0x1d0
[24089.208178]  ? rcu_do_batch+0x1ac/0x570
[24089.208483]  blkg_free.part.0+0x41/0x60
[24089.208801]  rcu_do_batch+0x1e1/0x570
[24089.209105]  ? rcu_do_batch+0x1ac/0x570
[24089.209423]  rcu_core+0x2cb/0x460
[24089.209703]  __do_softirq+0x178/0x517
[24089.210007]  ? smpboot_thread_fn+0x2c/0x270
[24089.210353]  run_ksoftirqd+0x43/0x70
[24089.210654]  smpboot_thread_fn+0x1c1/0x270
[24089.210997]  ? sort_range+0x20/0x20
[24089.211292]  kthread+0xf0/0x120
[24089.211548]  ? kthread_complete_and_exit+0x20/0x20
[24089.211933]  ret_from_fork+0x1f/0x30
[24089.212241]