[27052.078263] run fstests btrfs/095 at 2022-04-03 04:22:20
[27053.462065] BTRFS: device fsid d11a95cf-e3a8-418a-9953-4a708d569d8b devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (2576129)
[27053.535743] _btrfs_printk: 8 callbacks suppressed
[27053.535746] BTRFS info (device dm-11): flagging fs with big metadata feature
[27053.536156] BTRFS info (device dm-11): turning on sync discard
[27053.536378] BTRFS info (device dm-11): enabling free space tree
[27053.536572] BTRFS info (device dm-11): using free space tree
[27053.536759] BTRFS info (device dm-11): has skinny extents
[27053.538551] BTRFS info (device dm-11): creating free space tree
[27053.538831] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[27053.539117] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[27053.694366] BTRFS info (device dm-11): cleaning free space cache v1
[27053.827917] BTRFS info (device dm-11): checking UUID tree
[27053.981385] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (2574232)
[27053.982122] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (2574232)
[27054.035202] BTRFS info (device dm-11): flagging fs with big metadata feature
[27054.035506] BTRFS info (device dm-11): turning on sync discard
[27054.035686] BTRFS info (device dm-11): using free space tree
[27054.035859] BTRFS info (device dm-11): has skinny extents
[27054.038284] BTRFS info (device dm-11): start tree-log replay
[27054.678196] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[27054.678516] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 2576239, name: systemctl
[27054.678806] preempt_count: 100, expected: 0
[27054.678975] RCU nest depth: 0, expected: 0
[27054.679149] INFO: lockdep is turned off.
[27054.679337] Preemption disabled at:
[27054.679338] [] __do_softirq+0x5e/0x517
[27054.679794] CPU: 1 PID: 2576239 Comm: systemctl Tainted: G        W         5.17.0+ #640
[27054.680082] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[27054.680389] Call Trace:
[27054.680526]  
[27054.680654]  dump_stack_lvl+0x56/0x6f
[27054.680819]  __might_resched.cold+0xff/0x13a
[27054.680990]  blk_release_queue+0x24/0x120
[27054.681165]  kobject_put+0x7c/0x1d0
[27054.681336]  ? rcu_do_batch+0x1ac/0x570
[27054.681500]  blkg_free.part.0+0x41/0x60
[27054.681663]  rcu_do_batch+0x1e1/0x570
[27054.688230]  ? rcu_do_batch+0x1ac/0x570
[27054.688389]  rcu_core+0x2cb/0x460
[27054.688542]  __do_softirq+0x178/0x517
[27054.688703]  __irq_exit_rcu+0xe3/0x160
[27054.688859]  irq_exit_rcu+0xa/0x20
[27054.689012]  sysvec_apic_timer_interrupt+0xa2/0xd0
[27054.689196]  
[27054.689327]  
[27054.689452]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[27054.689636] RIP: 0010:__rcu_read_unlock+0x38/0x1b0
[27054.689812] Code: 8b 2c 25 c0 fe 01 00 53 83 ad f4 07 00 00 01 75 0a 8b 85 f8 07 00 00 85 c0 75 23 65 48 8b 04 25 c0 fe 01 00 8b 80 f4 07 00 00 <3d> ff ff ff 3f 0f 87 ba 00 00 00 5b 5d 41 5c 41 5d 41 5e c3 65 8b
[27054.690336] RSP: 0018:ffffb18fc41dba18 EFLAGS: 00000246
[27054.690522] RAX: 0000000000000000 RBX: 0000000000000002 RCX: ffffffffb7402386
[27054.690740] RDX: 0000000000000000 RSI: ffffffffb887e4d9 RDI: ffffffffb883354b
[27054.690975] RBP: ffff9e59db0d8000 R08: 0000000000000000 R09: 0000000000000000
[27054.691198] R10: ffff9e5a0503db00 R11: 0000000000000000 R12: ffff9e59c4f9cfc0
[27054.691415] R13: 0000000000000001 R14: ffffb18fc41dba90 R15: ffffe16704a25e00
[27054.691626]  ? memcg_slab_post_alloc_hook+0x1b6/0x440
[27054.691804]  memcg_slab_post_alloc_hook+0x20b/0x440
[27054.691977]  kmem_cache_alloc+0x1d1/0x3f0
[27054.692138]  vm_area_dup+0x21/0xa0
[27054.692294]  ? lock_acquire+0x176/0x2d0
[27054.692448]  ? unmap_page_range+0x970/0x10e0
[27054.692611]  ? rcu_read_lock_sched_held+0x12/0x60
[27054.692783]  ? lock_acquire+0x176/0x2d0
[27054.692941]  ? rcu_read_lock_sched_held+0x12/0x60
[27054.693118]  ? lock_acquire+0x176/0x2d0
[27054.693279]  ? lock_acquire+0x176/0x2d0
[27054.693436]  ? rcu_read_lock_sched_held+0x12/0x60
[27054.693608]  ? lock_release+0x1ed/0x2c0
[27054.693759]  ? rcu_read_lock_sched_held+0x12/0x60
[27054.693928]  ? rcu_read_lock_sched_held+0x12/0x60
[27054.694118]  ? lock_acquire+0x176/0x2d0
[27054.694277]  ? rcu_read_lock_sched_held+0x12/0x60
[27054.694440]  ? rcu_read_lock_sched_held+0x12/0x60
[27054.694604]  ? lock_release+0x1ed/0x2c0
[27054.694753]  ? rcu_read_lock_sched_held+0x12/0x60
[27054.694921]  ? trace_hardirqs_on+0x1b/0xe0
[27054.695079]  ? seqcount_lockdep_reader_access.constprop.0+0x82/0x90
[27054.695279]  ? ktime_get_coarse_real_ts64+0xe/0x50
[27054.695448]  ? ktime_get_coarse_real_ts64+0xe/0x50
[27054.695614]  ? rcu_read_lock_sched_held+0x12/0x60
[27054.695781]  ? lock_acquire+0x176/0x2d0
[27054.695929]  ? rcu_read_lock_sched_held+0x12/0x60
[27054.696098]  __split_vma+0x48/0x190
[27054.696254]  __do_munmap+0x3e0/0x4c0
[27054.696400]  ? vma_set_page_prot+0x8e/0xe0
[27054.696553]  mmap_region+0x174/0x620
[27054.696701]  do_mmap+0x33d/0x530
[27054.696844]  vm_mmap_pgoff+0xb8/0x150
[27054.697009]  ksys_mmap_pgoff+0x18c/0x1f0
[27054.697157]  do_syscall_64+0x38/0x90
[27054.697309]  entry_SYSCALL_64_after_hwframe+0x44/0xae
[27054.697474] RIP: 0033:0x7f6ea5271176
[27054.697614] Code: 5d 41 5c c3 f3 0f 1e fa 41 f7 c1 ff 0f 00 00 75 2b 55 48 89 fd 53 89 cb 48 85 ff 74 37 41 89 da 48 89 ef b8 09 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 5a 5b 5d c3 0f 1f 80 00 00 00 00 c7 05 d6 0f
[27054.698106] RSP: 002b:00007ffd12d305f8 EFLAGS: 00000206 ORIG_RAX: 0000000000000009
[27054.698352] RAX: ffffffffffffffda RBX: 0000000000000812 RCX: 00007f6ea5271176
[27054.698545] RDX: 0000000000000001 RSI: 0000000000001000 RDI: 00007f6ea4224000
[27054.698741] RBP: 00007f6ea4224000 R08: 0000000000000003 R09: 0000000000007000
[27054.698937] R10: 0000000000000812 R11: 0000000000000206 R12: 00007f6ea50ab610
[27054.699138] R13: 00007ffd12d30670 R14: 0000000000000000 R15: 0000000000000000
[27054.699344]