[31212.816446] run fstests btrfs/159 at 2022-04-04 05:31:06
[31213.020112] BTRFS info (device dm-0): flagging fs with big metadata feature
[31213.020556] BTRFS info (device dm-0): using free space tree
[31213.020884] BTRFS info (device dm-0): has skinny extents
[31213.858365] BTRFS: device fsid a166fd57-0a1f-40b9-9b4d-fe40aef57fae devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (2808035)
[31213.924132] BTRFS info (device dm-11): flagging fs with big metadata feature
[31213.924603] BTRFS info (device dm-11): using free space tree
[31213.925097] BTRFS info (device dm-11): has skinny extents
[31213.927270] BTRFS info (device dm-11): checking UUID tree
[31218.524006] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (2809747)
[31218.525305] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (2809747)
[31218.624812] BTRFS info (device dm-11): flagging fs with big metadata feature
[31218.625271] BTRFS info (device dm-11): using free space tree
[31218.625611] BTRFS info (device dm-11): has skinny extents
[31218.627976] BTRFS info (device dm-11): start tree-log replay
[31220.053141] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[31220.053691] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 20, name: ksoftirqd/1
[31220.054190] preempt_count: 100, expected: 0
[31220.054442] RCU nest depth: 0, expected: 0
[31220.054691] INFO: lockdep is turned off.
[31220.054926] Preemption disabled at:
[31220.054927] [] __do_softirq+0x5e/0x517
[31220.055477] CPU: 1 PID: 20 Comm: ksoftirqd/1 Tainted: G W 5.17.0+ #641
[31220.056005] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[31220.056507] Call Trace:
[31220.056659]
[31220.056792] dump_stack_lvl+0x56/0x6f
[31220.057020] __might_resched.cold+0xff/0x13a
[31220.057281] blk_release_queue+0x24/0x120
[31220.057525] kobject_put+0x7c/0x1d0
[31220.057857] ? rcu_do_batch+0x1ac/0x570
[31220.058248] blkg_free.part.0+0x41/0x60
[31220.058668] rcu_do_batch+0x1e1/0x570
[31220.058892] ? rcu_do_batch+0x1ac/0x570
[31220.059130] rcu_core+0x2cb/0x460
[31220.059332] __do_softirq+0x178/0x517
[31220.059555] ? smpboot_thread_fn+0x2c/0x270
[31220.059810] run_ksoftirqd+0x43/0x70
[31220.060032] smpboot_thread_fn+0x1c1/0x270
[31220.060280] ? sort_range+0x20/0x20
[31220.060495] kthread+0xf0/0x120
[31220.060687] ? kthread_complete_and_exit+0x20/0x20
[31220.061051] ret_from_fork+0x1f/0x30
[31220.061285]
[31221.001469] BTRFS: device fsid 8ebe06d7-1fbb-4b42-b287-ec542e698e55 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (2809788)
[31221.064361] BTRFS info (device dm-11): flagging fs with big metadata feature
[31221.064797] BTRFS info (device dm-11): using free space tree
[31221.065188] BTRFS info (device dm-11): has skinny extents
[31221.067316] BTRFS info (device dm-11): checking UUID tree
[31226.301899] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (2811501)
[31226.303230] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (2811501)
[31226.402942] BTRFS info (device dm-11): flagging fs with big metadata feature
[31226.403391] BTRFS info (device dm-11): using free space tree
[31226.403727] BTRFS info (device dm-11): has skinny extents
[31226.405846] BTRFS info (device dm-11): start tree-log replay
[31227.849057] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[31227.849550] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/0
[31227.850015] preempt_count: 101, expected: 0
[31227.850283] RCU nest depth: 0, expected: 0
[31227.850531] INFO: lockdep is turned off.
[31227.850767] Preemption disabled at:
[31227.850768] [] schedule_preempt_disabled+0x1e/0x20
[31227.851374] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G W 5.17.0+ #641
[31227.851821] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[31227.852324] Call Trace:
[31227.852478]
[31227.852606] dump_stack_lvl+0x56/0x6f
[31227.852831] __might_resched.cold+0xff/0x13a
[31227.853093] blk_release_queue+0x24/0x120
[31227.853338] kobject_put+0x7c/0x1d0
[31227.853552] ? rcu_do_batch+0x1ac/0x570
[31227.853786] blkg_free.part.0+0x41/0x60
[31227.854022] rcu_do_batch+0x1e1/0x570
[31227.854245] ? rcu_do_batch+0x1ac/0x570
[31227.854479] rcu_core+0x2cb/0x460
[31227.854683] __do_softirq+0x178/0x517
[31227.854911] __irq_exit_rcu+0xe3/0x160
[31227.855141] irq_exit_rcu+0xa/0x20
[31227.855347] sysvec_apic_timer_interrupt+0xa2/0xd0
[31227.855635]
[31227.855767]
[31227.855902] asm_sysvec_apic_timer_interrupt+0x12/0x20
[31227.856211] RIP: 0010:native_safe_halt+0xb/0x10
[31227.856484] Code: 56 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
[31227.857576] RSP: 0018:ffffffffaaa03ea8 EFLAGS: 00000246
[31227.857892] RAX: ffffffffa9e64a80 RBX: ffffffffaaa30a00 RCX: 0000000000000000
[31227.858316] RDX: ffffffffaaa30a00 RSI: ffffffffaa87e4d9 RDI: ffffffffa9e64bf6
[31227.858736] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000
[31227.859159] R10: 0000000000000000 R11: ffff94fcbbc20c88 R12: 0000000000000000
[31227.859578] R13: 0000000000000000 R14: ffffffffaaa30118 R15: 0000000000000073
[31227.860003] ? mwait_idle+0x80/0x80
[31227.860216] ? default_idle_call+0x26/0xa0
[31227.860464] default_idle+0xa/0x10
[31227.860673] default_idle_call+0x5e/0xa0
[31227.860913] do_idle+0x1e9/0x240
[31227.861112] cpu_startup_entry+0x19/0x20
[31227.861348] start_kernel+0x98c/0x99e
[31227.861570] ? copy_bootdata+0x18/0x55
[31227.861799] secondary_startup_64_no_verify+0xd5/0xdb
[31227.862108]