[39288.041638] run fstests generic/347 at 2022-04-04 07:46:12
[39288.274726] BTRFS info (device dm-0): flagging fs with big metadata feature
[39288.274954] BTRFS info (device dm-0): using free space tree
[39288.275145] BTRFS info (device dm-0): has skinny extents
[39288.828434] BTRFS: device fsid 9d385509-2877-4f2d-90aa-33b3dadf5a25 devid 1 transid 6 /dev/mapper/thin-vol scanned by mkfs.btrfs (4009021)
[39288.851816] BTRFS info (device dm-14): flagging fs with big metadata feature
[39288.852779] BTRFS info (device dm-14): turning on sync discard
[39288.852981] BTRFS info (device dm-14): enabling free space tree
[39288.853181] BTRFS info (device dm-14): using free space tree
[39288.853388] BTRFS info (device dm-14): has skinny extents
[39288.856021] BTRFS info (device dm-14): creating free space tree
[39288.856309] BTRFS info (device dm-14): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[39288.856620] BTRFS info (device dm-14): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[39288.871987] BTRFS info (device dm-14): cleaning free space cache v1
[39288.885423] BTRFS info (device dm-14): checking UUID tree
[39308.810117] device-mapper: thin: 251:13: reached low water mark for data device: sending event.
[39314.882005] device-mapper: thin: 251:13: switching pool to out-of-data-space (queue IO) mode
[39320.702178] device-mapper: thin: 251:13: switching pool to write mode
[39322.964513] device-mapper: thin: 251:13: switching pool to out-of-data-space (queue IO) mode
[39383.728520] device-mapper: thin: 251:13: switching pool to out-of-data-space (error IO) mode
[39383.959158] BTRFS: error (device dm-14) in btrfs_commit_transaction:2418: errno=-5 IO failure (Error while writing out transaction)
[39383.959660] BTRFS info (device dm-14: state E): forced readonly
[39383.959922] BTRFS warning (device dm-14: state E): Skipping commit of aborted transaction.
[39383.960298] BTRFS: error (device dm-14: state EA) in cleanup_transaction:1982: errno=-5 IO failure
[39384.000780] dm-12: detected capacity change from 1024000 to 1228800
[39384.068794] device-mapper: thin: 251:13: switching pool to write mode
[39384.072505] dm-13: detected capacity change from 1024000 to 1228800
[39384.073525] device-mapper: thin: 251:13: growing the data device from 1000 to 1200 blocks
[39384.238491] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[39384.238761] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/1
[39384.239011] preempt_count: 101, expected: 0
[39384.239166] RCU nest depth: 0, expected: 0
[39384.239310] INFO: lockdep is turned off.
[39384.239454] Preemption disabled at:
[39384.239455] [] ___slab_alloc+0x961/0xf50
[39384.239778] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G W 5.17.0+ #641
[39384.240017] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[39384.240278] Call Trace:
[39384.240401]
[39384.240519] dump_stack_lvl+0x56/0x6f
[39384.240661] __might_resched.cold+0xff/0x13a
[39384.240815] blk_release_queue+0x24/0x120
[39384.240962] kobject_put+0x7c/0x1d0
[39384.241100] ? rcu_do_batch+0x1ac/0x570
[39384.241244] blkg_free.part.0+0x41/0x60
[39384.241387] rcu_do_batch+0x1e1/0x570
[39384.241527] ? rcu_do_batch+0x1ac/0x570
[39384.241668] rcu_core+0x2cb/0x460
[39384.241805] __do_softirq+0x178/0x517
[39384.241948] __irq_exit_rcu+0xe3/0x160
[39384.242089] irq_exit_rcu+0xa/0x20
[39384.242231] sysvec_apic_timer_interrupt+0xa2/0xd0
[39384.242390]
[39384.242502]
[39384.242614] asm_sysvec_apic_timer_interrupt+0x12/0x20
[39384.242780] RIP: 0010:native_safe_halt+0xb/0x10
[39384.242934] Code: 5d ff ff ff 7f 5b c3 65 48 8b 04 25 c0 fe 01 00 f0 80 48 02 20 48 8b 00 a8 08 75 c3 eb 80 cc eb 07 0f 00 2d 79 b7 5b 00 fb f4 0f 1f 40 00 eb 07 0f 00 2d 69 b7 5b 00 f4 c3 cc cc cc cc cc 0f
[39384.243391] RSP: 0018:ffffb12640093ef8 EFLAGS: 00000246
[39384.243556] RAX: ffffffffa2e64a80 RBX: ffff9be280378000 RCX: 0000000000000000
[39384.243752] RDX: ffff9be280378000 RSI: ffffffffa387e4d9 RDI: ffffffffa2e64bf6
[39384.243952] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
[39384.244150] R10: 0000000000000000 R11: ffff9be2fbd20c88 R12: 0000000000000000
[39384.244345] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[39384.244538] ? mwait_idle+0x80/0x80
[39384.244674] ? default_idle_call+0x26/0xa0
[39384.244821] default_idle+0xa/0x10
[39384.244958] default_idle_call+0x5e/0xa0
[39384.245099] do_idle+0x1e9/0x240
[39384.245235] cpu_startup_entry+0x19/0x20
[39384.245379] secondary_startup_64_no_verify+0xd5/0xdb
[39384.245547]