[14163.234599] run fstests btrfs/118 at 2022-04-03 00:58:30
[14163.465489] BTRFS info (device dm-0): flagging fs with big metadata feature
[14163.465947] BTRFS info (device dm-0): using free space tree
[14163.466291] BTRFS info (device dm-0): has skinny extents
[14163.669892] BTRFS: device fsid b0b6c6f8-51c9-4912-9353-5137c3a1d36f devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (3034559)
[14163.738424] BTRFS info (device dm-11): flagging fs with big metadata feature
[14163.738876] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_LZO (0x8)
[14163.739371] BTRFS info (device dm-11): use lzo compression, level 0
[14163.739740] BTRFS info (device dm-11): disk space caching is enabled
[14163.740137] BTRFS info (device dm-11): has skinny extents
[14163.742023] BTRFS info (device dm-11): checking UUID tree
[14163.783458] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (3033564)
[14163.784575] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (3033564)
[14163.831596] BTRFS info (device dm-11): flagging fs with big metadata feature
[14163.832047] BTRFS info (device dm-11): use lzo compression, level 0
[14163.832424] BTRFS info (device dm-11): disk space caching is enabled
[14163.832796] BTRFS info (device dm-11): has skinny extents
[14163.877184] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (3033564)
[14163.878302] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (3033564)
[14163.925170] BTRFS info (device dm-11): flagging fs with big metadata feature
[14163.925614] BTRFS info (device dm-11): use lzo compression, level 0
[14163.926009] BTRFS info (device dm-11): disk space caching is enabled
[14163.926398] BTRFS info (device dm-11): has skinny extents
[14163.973882] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[14163.974383] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 20, name: ksoftirqd/1
[14163.974867] preempt_count: 100, expected: 0
[14163.975118] RCU nest depth: 0, expected: 0
[14163.975366] INFO: lockdep is turned off.
[14163.975604] Preemption disabled at:
[14163.975604] [] __do_softirq+0x5e/0x517
[14163.976151] CPU: 1 PID: 20 Comm: ksoftirqd/1 Tainted: G        W         5.17.0+ #640
[14163.976610] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[14163.977108] Call Trace:
[14163.977262]  
[14163.977394]  dump_stack_lvl+0x56/0x6f
[14163.977615]  __might_resched.cold+0xff/0x13a
[14163.977872]  blk_release_queue+0x24/0x120
[14163.978116]  kobject_put+0x7c/0x1d0
[14163.978330]  ? rcu_do_batch+0x1ac/0x570
[14163.978562]  blkg_free.part.0+0x41/0x60
[14163.978796]  rcu_do_batch+0x1e1/0x570
[14163.979017]  ? rcu_do_batch+0x1ac/0x570
[14163.979251]  rcu_core+0x2cb/0x460
[14163.979452]  __do_softirq+0x178/0x517
[14163.979673]  ? smpboot_thread_fn+0x2c/0x270
[14163.979926]  run_ksoftirqd+0x43/0x70
[14163.980142]  smpboot_thread_fn+0x1c1/0x270
[14163.980389]  ? sort_range+0x20/0x20
[14163.980599]  kthread+0xf0/0x120
[14163.980790]  ? kthread_complete_and_exit+0x20/0x20
[14163.981075]  ret_from_fork+0x1f/0x30
[14163.981299]