[15103.537716] run fstests generic/479 at 2022-04-04 01:08:11
[15104.050888] BTRFS: device fsid 5a514003-4b06-4bd5-b60b-292f27721961 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (2312961)
[15104.138020] BTRFS info (device dm-9): flagging fs with big metadata feature
[15104.138238] BTRFS info (device dm-9): using free space tree
[15104.138412] BTRFS info (device dm-9): has skinny extents
[15104.141699] BTRFS info (device dm-9): checking UUID tree
[15104.332692] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-9 scanned by systemd-udevd (2311767)
[15104.333845] BTRFS info: devid 1 device path /dev/dm-9 changed to /dev/mapper/flakey-test scanned by systemd-udevd (2311767)
[15104.386370] BTRFS info (device dm-9): flagging fs with big metadata feature
[15104.386589] BTRFS info (device dm-9): using free space tree
[15104.386760] BTRFS info (device dm-9): has skinny extents
[15104.389388] BTRFS info (device dm-9): start tree-log replay
[15104.476894] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[15104.477183] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 464, name: systemd-udevd
[15104.477485] preempt_count: 100, expected: 0
[15104.477645] RCU nest depth: 0, expected: 0
[15104.477801] INFO: lockdep is turned off.
[15104.477968] Preemption disabled at:
[15104.477969] [] __do_softirq+0x5e/0x517
[15104.478952] CPU: 0 PID: 464 Comm: systemd-udevd Tainted: G        W         5.17.0+ #641
[15104.479297] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[15104.479711] Call Trace:
[15104.479894]  
[15104.480070]  dump_stack_lvl+0x56/0x6f
[15104.480233]  __might_resched.cold+0xff/0x13a
[15104.480394]  blk_release_queue+0x24/0x120
[15104.480546]  kobject_put+0x7c/0x1d0
[15104.480707]  ? rcu_do_batch+0x1ac/0x570
[15104.480849]  blkg_free.part.0+0x41/0x60
[15104.481016]  rcu_do_batch+0x1e1/0x570
[15104.481162]  ? rcu_do_batch+0x1ac/0x570
[15104.481310]  rcu_core+0x2cb/0x460
[15104.481454]  __do_softirq+0x178/0x517
[15104.481602]  __irq_exit_rcu+0xe3/0x160
[15104.481751]  irq_exit_rcu+0xa/0x20
[15104.481907]  sysvec_apic_timer_interrupt+0xa2/0xd0
[15104.482070]  
[15104.482185]  
[15104.482297]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[15104.482471] RIP: 0010:copy_user_generic_unrolled+0x7c/0xd0
[15104.482648] Code: 46 20 4c 8b 4e 28 4c 8b 56 30 4c 8b 5e 38 4c 89 47 20 4c 89 4f 28 4c 89 57 30 4c 89 5f 38 48 8d 76 40 48 8d 7f 40 ff c9 75 b6 <89> d1 83 e2 07 c1 e9 03 74 12 4c 8b 06 4c 89 07 48 8d 76 08 48 8d
[15104.483121] RSP: 0018:ffffb94a006e7d88 EFLAGS: 00040283
[15104.483311] RAX: 00007fffffffeff9 RBX: 0000000000000007 RCX: 0000000000000000
[15104.483531] RDX: 0000000000000007 RSI: 00007ffe36dad110 RDI: ffff9634496a5390
[15104.483749] RBP: ffffb94a006e7e68 R08: 0000000000000001 R09: 0000000000000000
[15104.483964] R10: 0000000000000001 R11: 0000000000000000 R12: ffffb94a006e7e68
[15104.484179] R13: 0000000000000000 R14: 0000000000000007 R15: 0000000000000000
[15104.484406]  copyin+0x3d/0x50
[15104.484550]  _copy_from_iter+0xd5/0x730
[15104.484747]  ? rcu_read_lock_sched_held+0x12/0x60
[15104.484959]  ? trace_kmalloc+0x29/0xd0
[15104.485164]  ? __kmalloc+0x1fc/0x380
[15104.485322]  kernfs_fop_write_iter+0x85/0x210
[15104.485531]  new_sync_write+0xf6/0x160
[15104.485724]  vfs_write+0x290/0x390
[15104.485897]  ksys_write+0x55/0xd0
[15104.486044]  do_syscall_64+0x38/0x90
[15104.486188]  entry_SYSCALL_64_after_hwframe+0x44/0xae
[15104.486416] RIP: 0033:0x7fa5351f9387
[15104.486589] Code: 0d 00 f7 d8 64 89 02 48 c7 c0 ff ff ff ff eb b7 0f 1f 00 f3 0f 1e fa 64 8b 04 25 18 00 00 00 85 c0 75 10 b8 01 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 51 c3 48 83 ec 28 48 89 54 24 18 48 89 74 24
[15104.487157] RSP: 002b:00007ffe36dad028 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[15104.493349] RAX: ffffffffffffffda RBX: 0000000000000007 RCX: 00007fa5351f9387
[15104.493568] RDX: 0000000000000007 RSI: 00007ffe36dad110 RDI: 000000000000000f
[15104.493771] RBP: 00007ffe36dad110 R08: 0000000000000000 R09: 0000000000000000
[15104.493990] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000007
[15104.494186] R13: 00005574843659c0 R14: 0000000000000007 R15: 00007fa5352cc700
[15104.494414]  
[15104.684358] BTRFS: device fsid 9f6a2e4b-3b99-4816-992b-8dbe3d63ea76 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (2313051)
[15104.797956] BTRFS info (device dm-9): flagging fs with big metadata feature
[15104.798205] BTRFS info (device dm-9): using free space tree
[15104.798410] BTRFS info (device dm-9): has skinny extents
[15104.800294] BTRFS info (device dm-9): checking UUID tree
[15104.985011] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-9 scanned by systemd-udevd (2311767)
[15104.985949] BTRFS info: devid 1 device path /dev/dm-9 changed to /dev/mapper/flakey-test scanned by systemd-udevd (2311767)
[15105.037183] BTRFS info (device dm-9): flagging fs with big metadata feature
[15105.037418] BTRFS info (device dm-9): using free space tree
[15105.037589] BTRFS info (device dm-9): has skinny extents
[15105.039472] BTRFS info (device dm-9): start tree-log replay
[15105.237763] BTRFS: device fsid 128d1c9d-d6a6-4669-a59c-e305b4183fa5 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (2313141)
[15105.318768] BTRFS info (device dm-9): flagging fs with big metadata feature
[15105.319004] BTRFS info (device dm-9): using free space tree
[15105.319180] BTRFS info (device dm-9): has skinny extents
[15105.321084] BTRFS info (device dm-9): checking UUID tree
[15105.455176] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-9 scanned by systemd-udevd (2311767)
[15105.456087] BTRFS info: devid 1 device path /dev/dm-9 changed to /dev/mapper/flakey-test scanned by systemd-udevd (2311767)
[15105.514891] BTRFS info (device dm-9): flagging fs with big metadata feature
[15105.515204] BTRFS info (device dm-9): using free space tree
[15105.515504] BTRFS info (device dm-9): has skinny extents
[15105.517699] BTRFS info (device dm-9): start tree-log replay
[15105.608823] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[15105.609106] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/1
[15105.609353] preempt_count: 101, expected: 0
[15105.609501] RCU nest depth: 0, expected: 0
[15105.609650] INFO: lockdep is turned off.
[15105.609792] Preemption disabled at:
[15105.609793] [] ___slab_alloc+0x961/0xf50
[15105.610114] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G        W         5.17.0+ #641
[15105.610359] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[15105.610616] Call Trace:
[15105.610738]  
[15105.610852]  dump_stack_lvl+0x56/0x6f
[15105.610996]  __might_resched.cold+0xff/0x13a
[15105.611146]  blk_release_queue+0x24/0x120
[15105.611292]  kobject_put+0x7c/0x1d0
[15105.611439]  ? rcu_do_batch+0x1ac/0x570
[15105.611585]  blkg_free.part.0+0x41/0x60
[15105.611725]  rcu_do_batch+0x1e1/0x570
[15105.611864]  ? rcu_do_batch+0x1ac/0x570
[15105.612010]  rcu_core+0x2cb/0x460
[15105.612144]  __do_softirq+0x178/0x517
[15105.612286]  __irq_exit_rcu+0xe3/0x160
[15105.612434]  irq_exit_rcu+0xa/0x20
[15105.612573]  sysvec_apic_timer_interrupt+0xa2/0xd0
[15105.612732]  
[15105.612843]  
[15105.612958]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[15105.613124] RIP: 0010:native_safe_halt+0xb/0x10
[15105.613279] 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
[15105.613753] RSP: 0018:ffffb94a00093ef8 EFLAGS: 00000246
[15105.613918] RAX: ffffffffa2e64a80 RBX: ffff96344037b200 RCX: 0000000000000000
[15105.614112] RDX: ffff96344037b200 RSI: ffffffffa387e4d9 RDI: ffffffffa2e64bf6
[15105.614304] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
[15105.614502] R10: 0000000000000000 R11: ffff9634bbd20c88 R12: 0000000000000000
[15105.614696] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[15105.614892]  ? mwait_idle+0x80/0x80
[15105.615031]  ? default_idle_call+0x26/0xa0
[15105.615183]  default_idle+0xa/0x10
[15105.615321]  default_idle_call+0x5e/0xa0
[15105.615467]  do_idle+0x1e9/0x240
[15105.615603]  cpu_startup_entry+0x19/0x20
[15105.615746]  secondary_startup_64_no_verify+0xd5/0xdb
[15105.615910]