[15456.701596] run fstests btrfs/142 at 2022-04-02 01:09:02
[15456.922209] BTRFS info (device dm-0): flagging fs with big metadata feature
[15456.922440] BTRFS info (device dm-0): using free space tree
[15456.922648] BTRFS info (device dm-0): has skinny extents
[15457.396657] BTRFS: device fsid 5a3e5a1a-373d-4230-853a-449c6d1cbe80 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (3023741)
[15457.397138] BTRFS: device fsid 5a3e5a1a-373d-4230-853a-449c6d1cbe80 devid 2 transid 6 /dev/mapper/vg0-lv8 scanned by mkfs.btrfs (3023741)
[15457.454222] BTRFS info (device dm-9): flagging fs with big metadata feature
[15457.454437] BTRFS info (device dm-9): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[15457.454696] BTRFS info (device dm-9): use zstd compression, level 3
[15457.454885] BTRFS info (device dm-9): turning on async discard
[15457.455087] BTRFS info (device dm-9): setting nodatasum
[15457.455265] BTRFS info (device dm-9): disabling disk space caching
[15457.455450] BTRFS info (device dm-9): has skinny extents
[15457.457089] BTRFS info (device dm-9): cleaning free space cache v1
[15457.465656] BTRFS info (device dm-9): checking UUID tree
[15457.599915] BTRFS info (device dm-11): flagging fs with big metadata feature
[15457.600175] BTRFS info (device dm-11): use zstd compression, level 3
[15457.600376] BTRFS info (device dm-11): turning on async discard
[15457.600559] BTRFS info (device dm-11): has skinny extents
[15457.605879] device-mapper: dust: dust_add_block: badblock added at block 269056 with write fail count 0
[15457.607997] device-mapper: dust: enabling read failures on bad sectors
[15457.612137] BTRFS warning (device dm-11): direct IO failed ino 257 rw 0,0 sector 0x41b07 len 512 err no 10
[15457.612550] device-mapper: dust: block 269056 removed from badblocklist by write
[15457.655065] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[15457.655541] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 20, name: ksoftirqd/1
[15457.655846] preempt_count: 100, expected: 0
[15457.656010] RCU nest depth: 0, expected: 0
[15457.656226] INFO: lockdep is turned off.
[15457.656386] Preemption disabled at:
[15457.656387] [] __do_softirq+0x5e/0x517
[15457.656739] CPU: 1 PID: 20 Comm: ksoftirqd/1 Tainted: G        W         5.17.0+ #639
[15457.657038] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[15457.657351] Call Trace:
[15457.657472]  
[15457.657631]  dump_stack_lvl+0x56/0x6f
[15457.657860]  __might_resched.cold+0xff/0x13a
[15457.658024]  blk_release_queue+0x24/0x120
[15457.658201]  kobject_put+0x7c/0x1d0
[15457.658344]  ? rcu_do_batch+0x1ac/0x570
[15457.658488]  blkg_free.part.0+0x41/0x60
[15457.658664]  rcu_do_batch+0x1e1/0x570
[15457.658807]  ? rcu_do_batch+0x1ac/0x570
[15457.658950]  rcu_core+0x2cb/0x460
[15457.659108]  __do_softirq+0x178/0x517
[15457.659258]  ? smpboot_thread_fn+0x2c/0x270
[15457.659408]  run_ksoftirqd+0x43/0x70
[15457.659548]  smpboot_thread_fn+0x1c1/0x270
[15457.659699]  ? sort_range+0x20/0x20
[15457.659840]  kthread+0xf0/0x120
[15457.659972]  ? kthread_complete_and_exit+0x20/0x20
[15457.660133]  ret_from_fork+0x1f/0x30
[15457.660280]