[18343.979338] run fstests btrfs/159 at 2022-04-04 02:02:12
[18344.235152] BTRFS info (device dm-0): flagging fs with big metadata feature
[18344.235399] BTRFS info (device dm-0): using free space tree
[18344.235589] BTRFS info (device dm-0): has skinny extents
[18344.477382] BTRFS: device fsid b7ebbe94-78ab-4b4d-b359-75a75d4c15c7 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (3007398)
[18344.538493] BTRFS info (device dm-9): flagging fs with big metadata feature
[18344.538763] BTRFS info (device dm-9): use zlib compression, level 3
[18344.538973] BTRFS info (device dm-9): using free space tree
[18344.539158] BTRFS info (device dm-9): has skinny extents
[18344.541271] BTRFS info (device dm-9): checking UUID tree
[18348.908247] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-9 scanned by systemd-udevd (3009110)
[18348.909455] BTRFS info: devid 1 device path /dev/dm-9 changed to /dev/mapper/flakey-test scanned by systemd-udevd (3009110)
[18349.011256] BTRFS info (device dm-9): flagging fs with big metadata feature
[18349.011572] BTRFS info (device dm-9): use zlib compression, level 3
[18349.011884] BTRFS info (device dm-9): using free space tree
[18349.012177] BTRFS info (device dm-9): has skinny extents
[18349.015050] BTRFS info (device dm-9): start tree-log replay
[18350.313586] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[18350.313864] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 3009110, name: systemd-udevd
[18350.314128] preempt_count: 100, expected: 0
[18350.314284] RCU nest depth: 0, expected: 0
[18350.314428] INFO: lockdep is turned off.
[18350.314568] Preemption disabled at:
[18350.314584] [] __do_softirq+0x5e/0x517
[18350.314893] CPU: 1 PID: 3009110 Comm: systemd-udevd Tainted: G        W         5.17.0+ #641
[18350.315151] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[18350.315414] Call Trace:
[18350.315536]  
[18350.315656]  dump_stack_lvl+0x56/0x6f
[18350.315812]  __might_resched.cold+0xff/0x13a
[18350.316053]  blk_release_queue+0x24/0x120
[18350.316215]  kobject_put+0x7c/0x1d0
[18350.316390]  ? rcu_do_batch+0x1ac/0x570
[18350.316559]  blkg_free.part.0+0x41/0x60
[18350.316701]  rcu_do_batch+0x1e1/0x570
[18350.316845]  ? rcu_do_batch+0x1ac/0x570
[18350.317051]  rcu_core+0x2cb/0x460
[18350.317195]  __do_softirq+0x178/0x517
[18350.317340]  __irq_exit_rcu+0xe3/0x160
[18350.317484]  irq_exit_rcu+0xa/0x20
[18350.317618]  sysvec_apic_timer_interrupt+0xa2/0xd0
[18350.317788]  
[18350.317908]  
[18350.318094]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[18350.318270] RIP: 0010:find_vma+0x96/0xb0
[18350.318422] Code: 7a a3 00 0f 0b 49 8b 44 24 08 48 85 c0 75 15 eb bd 4c 8d 68 e0 48 39 68 e0 76 15 48 8b 40 10 48 85 c0 74 0c 48 39 68 e8 77 e7 <48> 8b 40 08 eb ef 4d 85 ed 74 99 4c 89 ee 48 89 ef e8 b4 7b fe ff
[18350.318880] RSP: 0000:ffffb94a01787ec0 EFLAGS: 00000293
[18350.319044] RAX: ffff96344536aef8 RBX: 0000000000000255 RCX: ffff963451e00000
[18350.319324] RDX: 0000000000000000 RSI: 00007ffe36da6468 RDI: 0000000000000001
[18350.319523] RBP: 00007ffe36da6468 R08: 0000000000000000 R09: 0000000000000000
[18350.319718] R10: 0000000000000000 R11: 0000000000000000 R12: ffff963464b25b00
[18350.319916] R13: 0000000000000000 R14: ffff963464b25b00 R15: ffff963464b25bb8
[18350.320119]  do_user_addr_fault+0x176/0x6b0
[18350.320284]  exc_page_fault+0x78/0x280
[18350.320427]  ? asm_exc_page_fault+0x8/0x30
[18350.320575]  asm_exc_page_fault+0x1e/0x30
[18350.320722] RIP: 0033:0x7fa535315fad
[18350.320864] Code: 62 ff ff ff e8 24 43 fe ff 0f 1f 40 00 41 57 41 56 41 55 41 54 55 53 48 81 ec 00 10 00 00 48 83 0c 24 00 48 81 ec 00 10 00 00 <48> 83 0c 24 00 48 83 ec 38 48 8d 15 e6 56 00 00 48 89 34 24 64 48
[18350.321326] RSP: 002b:00007ffe36da6468 EFLAGS: 00010202
[18350.321493] RAX: 0000557484351640 RBX: 00007ffe36da84d0 RCX: 0000000000000000
[18350.321692] RDX: 0000000000000028 RSI: 00007ffe36da84a0 RDI: 0000557484351640
[18350.321887] RBP: 0000557484351640 R08: 00005574843526a0 R09: 00007fa5352cba60
[18350.322085] R10: 0000557484352720 R11: 0000000000000000 R12: 0000000000000000
[18350.327893] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[18350.328095]  
[18351.411376] BTRFS: device fsid fb64fc23-0cc6-49a8-aceb-00cb658879d4 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (3009152)
[18351.473622] BTRFS info (device dm-9): flagging fs with big metadata feature
[18351.473841] BTRFS info (device dm-9): use zlib compression, level 3
[18351.474027] BTRFS info (device dm-9): using free space tree
[18351.474201] BTRFS info (device dm-9): has skinny extents
[18351.476169] BTRFS info (device dm-9): checking UUID tree
[18355.652592] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-9 scanned by systemd-udevd (3010865)
[18355.653523] BTRFS info: devid 1 device path /dev/dm-9 changed to /dev/mapper/flakey-test scanned by systemd-udevd (3010865)
[18355.771145] BTRFS info (device dm-9): flagging fs with big metadata feature
[18355.771460] BTRFS info (device dm-9): use zlib compression, level 3
[18355.771780] BTRFS info (device dm-9): using free space tree
[18355.772045] BTRFS info (device dm-9): has skinny extents
[18355.775709] BTRFS info (device dm-9): start tree-log replay
[18356.851532] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[18356.851823] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/0
[18356.852129] preempt_count: 101, expected: 0
[18356.852281] RCU nest depth: 0, expected: 0
[18356.852446] INFO: lockdep is turned off.
[18356.852617] Preemption disabled at:
[18356.852618] [] schedule_preempt_disabled+0x1e/0x20
[18356.852956] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G        W         5.17.0+ #641
[18356.854188] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[18356.854574] Call Trace:
[18356.854768]  
[18356.854947]  dump_stack_lvl+0x56/0x6f
[18356.855119]  __might_resched.cold+0xff/0x13a
[18356.855282]  blk_release_queue+0x24/0x120
[18356.855436]  kobject_put+0x7c/0x1d0
[18356.855580]  ? rcu_do_batch+0x1ac/0x570
[18356.855733]  blkg_free.part.0+0x41/0x60
[18356.855885]  rcu_do_batch+0x1e1/0x570
[18356.856029]  ? rcu_do_batch+0x1ac/0x570
[18356.856184]  rcu_core+0x2cb/0x460
[18356.856326]  __do_softirq+0x178/0x517
[18356.856475]  __irq_exit_rcu+0xe3/0x160
[18356.856623]  irq_exit_rcu+0xa/0x20
[18356.856767]  sysvec_apic_timer_interrupt+0xa2/0xd0
[18356.856934]  
[18356.857052]  
[18356.857184]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[18356.857361] RIP: 0010:native_safe_halt+0xb/0x10
[18356.857521] 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
[18356.858012] RSP: 0018:ffffffffa3a03ea8 EFLAGS: 00000246
[18356.858196] RAX: ffffffffa2e64a80 RBX: ffffffffa3a30a00 RCX: 0000000000000000
[18356.858401] RDX: ffffffffa3a30a00 RSI: ffffffffa387e4d9 RDI: ffffffffa2e64bf6
[18356.858606] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000
[18356.858806] R10: 0000000000000000 R11: ffff9634bbc20c88 R12: 0000000000000000
[18356.859010] R13: 0000000000000000 R14: ffffffffa3a30118 R15: 000000000000007b
[18356.859224]  ? mwait_idle+0x80/0x80
[18356.859367]  ? default_idle_call+0x26/0xa0
[18356.859523]  default_idle+0xa/0x10
[18356.859666]  default_idle_call+0x5e/0xa0
[18356.859815]  do_idle+0x1e9/0x240
[18356.859955]  cpu_startup_entry+0x19/0x20
[18356.860116]  start_kernel+0x98c/0x99e
[18356.860263]  ? copy_bootdata+0x18/0x55
[18356.860412]  secondary_startup_64_no_verify+0xd5/0xdb
[18356.860586]