[24475.286230] run fstests btrfs/056 at 2022-04-03 03:50:22
[24475.469135] BTRFS info (device dm-0): flagging fs with big metadata feature
[24475.469567] BTRFS info (device dm-0): using free space tree
[24475.469916] BTRFS info (device dm-0): has skinny extents
[24475.599382] BTRFS: device fsid d68ea11e-7276-4bb0-9425-0ee64d0e5e9b devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (2536056)
[24475.663369] BTRFS info (device dm-11): flagging fs with big metadata feature
[24475.663822] BTRFS info (device dm-11): using free space tree
[24475.664157] BTRFS info (device dm-11): has skinny extents
[24475.665961] BTRFS info (device dm-11): checking UUID tree
[24475.733897] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (2532525)
[24475.735036] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (2532525)
[24475.796079] BTRFS info (device dm-11): flagging fs with big metadata feature
[24475.796520] BTRFS info (device dm-11): using free space tree
[24475.796874] BTRFS info (device dm-11): has skinny extents
[24475.798592] BTRFS info (device dm-11): start tree-log replay
[24475.806257] BTRFS info (device dm-11): checking UUID tree
[24475.862800] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[24475.863293] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 2536194, name: dmsetup
[24475.863877] preempt_count: 100, expected: 0
[24475.864127] RCU nest depth: 0, expected: 0
[24475.864371] INFO: lockdep is turned off.
[24475.864609] Preemption disabled at:
[24475.864610] [] __do_softirq+0x5e/0x517
[24475.865148] CPU: 1 PID: 2536194 Comm: dmsetup Tainted: G W 5.17.0+ #640
[24475.865616] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[24475.866117] Call Trace:
[24475.866269]
[24475.866404] dump_stack_lvl+0x56/0x6f
[24475.866634] __might_resched.cold+0xff/0x13a
[24475.867160] blk_release_queue+0x24/0x120
[24475.867502] kobject_put+0x7c/0x1d0
[24475.867836] ? rcu_do_batch+0x1ac/0x570
[24475.868085] blkg_free.part.0+0x41/0x60
[24475.868404] rcu_do_batch+0x1e1/0x570
[24475.868673] ? rcu_do_batch+0x1ac/0x570
[24475.868947] rcu_core+0x2cb/0x460
[24475.869147] __do_softirq+0x178/0x517
[24475.869370] __irq_exit_rcu+0xe3/0x160
[24475.869616] irq_exit_rcu+0xa/0x20
[24475.869821] sysvec_apic_timer_interrupt+0xa2/0xd0
[24475.870104]
[24475.870234]
[24475.870364] asm_sysvec_apic_timer_interrupt+0x12/0x20
[24475.870670] RIP: 0010:kmem_cache_free+0x159/0x3e0
[24475.870950] Code: 0f ca 48 33 95 b8 00 00 00 48 89 10 ba 01 00 00 00 4c 89 24 24 e8 47 73 ff ff 48 8b 45 00 65 48 03 05 43 f1 c0 54 48 8b 50 08 <4c> 39 68 10 0f 85 46 02 00 00 8b 4d 28 48 8b 00 4c 01 e1 49 39 c4
[24475.872034] RSP: 0018:ffffa8c1874b7d18 EFLAGS: 00000286
[24475.872343] RAX: ffff9da17bd3a9a0 RBX: 0000000000000000 RCX: 0000000000000000
[24475.872762] RDX: 0000026c4eeec001 RSI: ffffffffab401da7 RDI: ffffffffacb9ce40
[24475.873179] RBP: ffff9da1001e8500 R08: 0000000000000000 R09: 0000000000000000
[24475.873595] R10: 0000000000000000 R11: 0000000000000000 R12: ffff9da126136af0
[24475.874014] R13: ffffeeb204984d80 R14: ffffffffab3af99c R15: ffff9da10029d480
[24475.874428] ? remove_vma+0x6c/0x80
[24475.874645] ? memcg_slab_free_hook+0x1d7/0x2b0
[24475.874918] ? kmem_cache_free+0x149/0x3e0
[24475.875163] remove_vma+0x6c/0x80
[24475.875363] __do_munmap+0x22f/0x4c0
[24475.875581] mmap_region+0x174/0x620
[24475.875799] do_mmap+0x33d/0x530
[24475.875995] vm_mmap_pgoff+0xb8/0x150
[24475.876218] ksys_mmap_pgoff+0x18c/0x1f0
[24475.876453] do_syscall_64+0x38/0x90
[24475.876671] entry_SYSCALL_64_after_hwframe+0x44/0xae
[24475.876971] RIP: 0033:0x7fbb194de3d6
[24475.877187] 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 b6 0d
[24475.878268] RSP: 002b:00007ffd3a64c178 EFLAGS: 00000206 ORIG_RAX: 0000000000000009
[24475.878710] RAX: ffffffffffffffda RBX: 0000000000000812 RCX: 00007fbb194de3d6
[24475.879128] RDX: 0000000000000001 RSI: 0000000000004000 RDI: 00007fbb1902c000
[24475.879549] RBP: 00007fbb1902c000 R08: 0000000000000003 R09: 0000000000015000
[24475.880003] R10: 0000000000000812 R11: 0000000000000206 R12: 0000000000000004
[24475.880419] R13: 00007ffd3a64c580 R14: 0000000000000001 R15: 00007fbb190cfa60
[24475.880844]
[24475.912992] BTRFS: device fsid af370c47-6811-4f22-8d82-1b0f801fd7f3 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (2536193)
[24475.973819] BTRFS info (device dm-11): flagging fs with big metadata feature
[24475.974254] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_LZO (0x8)
[24475.974748] BTRFS info (device dm-11): force lzo compression, level 0
[24475.975143] BTRFS info (device dm-11): using free space tree
[24475.975480] BTRFS info (device dm-11): has skinny extents
[24475.977384] BTRFS info (device dm-11): checking UUID tree
[24476.042973] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (2532525)
[24476.044195] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (2532525)
[24476.107165] BTRFS info (device dm-11): flagging fs with big metadata feature
[24476.107604] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_LZO (0x8)
[24476.108112] BTRFS info (device dm-11): force lzo compression, level 0
[24476.108497] BTRFS info (device dm-11): using free space tree
[24476.108838] BTRFS info (device dm-11): has skinny extents
[24476.110631] BTRFS info (device dm-11): start tree-log replay
[24476.159725] BTRFS info (device dm-11): checking UUID tree
[24476.288040] BTRFS: device fsid c07ff5be-82f3-419c-b86f-257006d9bafa devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (2536330)
[24476.349011] BTRFS info (device dm-11): flagging fs with big metadata feature
[24476.349451] BTRFS info (device dm-11): using free space tree
[24476.349811] BTRFS info (device dm-11): has skinny extents
[24476.351818] BTRFS info (device dm-11): checking UUID tree
[24476.422251] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (2532525)
[24476.423400] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (2532525)
[24476.488328] BTRFS info (device dm-11): flagging fs with big metadata feature
[24476.488773] BTRFS info (device dm-11): using free space tree
[24476.489135] BTRFS info (device dm-11): has skinny extents
[24476.490977] BTRFS info (device dm-11): start tree-log replay
[24476.499019] BTRFS info (device dm-11): checking UUID tree
[24476.622160] BTRFS: device fsid 0fb50847-b5db-4373-8ae7-4123bb8b14c0 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (2536467)
[24476.682814] BTRFS info (device dm-11): flagging fs with big metadata feature
[24476.683257] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_LZO (0x8)
[24476.683758] BTRFS info (device dm-11): force lzo compression, level 0
[24476.684158] BTRFS info (device dm-11): using free space tree
[24476.684504] BTRFS info (device dm-11): has skinny extents
[24476.686226] BTRFS info (device dm-11): checking UUID tree
[24476.754927] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (2532525)
[24476.756208] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (2532525)
[24476.818319] BTRFS info (device dm-11): flagging fs with big metadata feature
[24476.818767] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_LZO (0x8)
[24476.819275] BTRFS info (device dm-11): force lzo compression, level 0
[24476.819663] BTRFS info (device dm-11): using free space tree
[24476.820007] BTRFS info (device dm-11): has skinny extents
[24476.821843] BTRFS info (device dm-11): start tree-log replay
[24476.829640] BTRFS info (device dm-11): checking UUID tree
[24476.889791] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[24476.890282] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/1
[24476.890751] preempt_count: 101, expected: 0
[24476.891015] RCU nest depth: 0, expected: 0
[24476.891259] INFO: lockdep is turned off.
[24476.891502] Preemption disabled at:
[24476.891503] [] ___slab_alloc+0x961/0xf50
[24476.892050] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G W 5.17.0+ #640
[24476.892498] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[24476.892998] Call Trace:
[24476.893149]
[24476.893277] dump_stack_lvl+0x56/0x6f
[24476.893510] __might_resched.cold+0xff/0x13a
[24476.893768] blk_release_queue+0x24/0x120
[24476.894010] kobject_put+0x7c/0x1d0
[24476.894224] ? rcu_do_batch+0x1ac/0x570
[24476.894463] blkg_free.part.0+0x41/0x60
[24476.894699] rcu_do_batch+0x1e1/0x570
[24476.894920] ? rcu_do_batch+0x1ac/0x570
[24476.895151] rcu_core+0x2cb/0x460
[24476.895353] __do_softirq+0x178/0x517
[24476.895585] __irq_exit_rcu+0xe3/0x160
[24476.895811] irq_exit_rcu+0xa/0x20
[24476.896018] sysvec_apic_timer_interrupt+0xa2/0xd0
[24476.896305]
[24476.896435]
[24476.896569] asm_sysvec_apic_timer_interrupt+0x12/0x20
[24476.896877] RIP: 0010:native_safe_halt+0xb/0x10
[24476.897147] Code: 54 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
[24476.898233] RSP: 0018:ffffa8c180093ef8 EFLAGS: 00000246
[24476.898550] RAX: ffffffffabe64a80 RBX: ffff9da100340000 RCX: 0000000000000000
[24476.898969] RDX: ffff9da100340000 RSI: ffffffffac87e4d9 RDI: ffffffffabe64bf6
[24476.899386] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
[24476.899812] R10: 0000000000000000 R11: ffff9da17bd20c88 R12: 0000000000000000
[24476.900230] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[24476.900652] ? mwait_idle+0x80/0x80
[24476.900863] ? default_idle_call+0x26/0xa0
[24476.901109] default_idle+0xa/0x10
[24476.901315] default_idle_call+0x5e/0xa0
[24476.901552] do_idle+0x1e9/0x240
[24476.901749] cpu_startup_entry+0x19/0x20
[24476.901985] secondary_startup_64_no_verify+0xd5/0xdb
[24476.902290]