[11564.811299] run fstests generic/479 at 2022-04-03 00:15:11
[11565.369417] BTRFS: device fsid c6eaa380-0068-4071-8a7f-8b8464c53cb7 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (2365777)
[11565.484702] BTRFS info (device dm-11): flagging fs with big metadata feature
[11565.485146] BTRFS info (device dm-11): disk space caching is enabled
[11565.485544] BTRFS info (device dm-11): has skinny extents
[11565.488464] BTRFS info (device dm-11): checking UUID tree
[11565.745483] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (2364572)
[11565.746760] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (2364572)
[11565.797311] BTRFS info (device dm-11): flagging fs with big metadata feature
[11565.797768] BTRFS info (device dm-11): disk space caching is enabled
[11565.798149] BTRFS info (device dm-11): has skinny extents
[11565.800098] BTRFS info (device dm-11): start tree-log replay
[11565.860367] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[11565.860858] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 2365867, name: mkfs.btrfs
[11565.861368] preempt_count: 100, expected: 0
[11565.861624] RCU nest depth: 0, expected: 0
[11565.862030] INFO: lockdep is turned off.
[11565.862444] Preemption disabled at:
[11565.862445] [] __do_softirq+0x5e/0x517
[11565.863018] CPU: 1 PID: 2365867 Comm: mkfs.btrfs Tainted: G W 5.17.0+ #640
[11565.863538] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[11565.864169] Call Trace:
[11565.864368]
[11565.864523] dump_stack_lvl+0x56/0x6f
[11565.865053] __might_resched.cold+0xff/0x13a
[11565.865408] blk_release_queue+0x24/0x120
[11565.865762] kobject_put+0x7c/0x1d0
[11565.866035] ? rcu_do_batch+0x1ac/0x570
[11565.866284] blkg_free.part.0+0x41/0x60
[11565.866601] rcu_do_batch+0x1e1/0x570
[11565.866888] ? rcu_do_batch+0x1ac/0x570
[11565.867121] rcu_core+0x2cb/0x460
[11565.867327] __do_softirq+0x178/0x517
[11565.867550] __irq_exit_rcu+0xe3/0x160
[11565.867774] irq_exit_rcu+0xa/0x20
[11565.867979] sysvec_apic_timer_interrupt+0xa2/0xd0
[11565.868264]
[11565.868400]
[11565.868529] asm_sysvec_apic_timer_interrupt+0x12/0x20
[11565.868834] RIP: 0010:__handle_mm_fault+0xb8e/0x1460
[11565.869129] Code: d8 6d 08 00 85 c0 0f 84 38 06 00 00 4c 89 e7 e8 18 87 ff ff 44 8b 4c 24 08 e9 5e f8 ff ff 48 25 00 f0 ff ff 48 f7 d0 48 21 c3 c3 81 01 00 00 0f 85 c1 fc ff ff e9 8a fa ff ff 48 8d 7c 24 18
[11565.870209] RSP: 0000:ffffa8c184b87de8 EFLAGS: 00000202
[11565.870521] RAX: fff0000000000fff RBX: 0000000000000067 RCX: 00000001080fa000
[11565.870942] RDX: 0400000000000080 RSI: 0400000000000000 RDI: 000000010461d067
[11565.871361] RBP: ffff9da1080fa9f8 R08: 0000000000000000 R09: 0000000000000000
[11565.871778] R10: 0000000000000000 R11: 0000000000000000 R12: 0400000000000080
[11565.872196] R13: 00000001080fa067 R14: 00000000000009f8 R15: ffff9da1075ff948
[11565.872622] ? __handle_mm_fault+0x81a/0x1460
[11565.872886] ? mmap_region+0x2da/0x620
[11565.873115] handle_mm_fault+0x11e/0x3a0
[11565.873377] do_user_addr_fault+0x1e9/0x6b0
[11565.873630] exc_page_fault+0x78/0x280
[11565.873854] ? asm_exc_page_fault+0x8/0x30
[11565.874102] asm_exc_page_fault+0x1e/0x30
[11565.874344] RIP: 0033:0x7f4a67ffee71
[11565.874592] Code: 01 00 00 48 83 fa 40 77 77 c5 fe 7f 44 17 e0 c5 fe 7f 07 c5 f8 77 c3 66 90 f3 0f 1e fa c5 f8 77 48 89 d1 40 0f b6 c6 48 89 fa aa 48 89 d0 c3 66 0f 1f 84 00 00 00 00 00 f3 0f 1e fa 48 39 d1
[11565.875708] RSP: 002b:00007ffc0fedf298 EFLAGS: 00010206
[11565.876041] RAX: 0000000000000000 RBX: 00007f4a67c7a010 RCX: 000000000002a010
[11565.876512] RDX: 00007f4a67c7a010 RSI: 0000000000000000 RDI: 00007f4a67e50000
[11565.876952] RBP: 0000000000200000 R08: 00007f4a67c7a010 R09: 0000000000000000
[11565.877378] R10: 00007f4a67ea7c70 R11: 00007f4a67ffee90 R12: 0000000000000000
[11565.877823] R13: 0000000000000003 R14: 0000000000000000 R15: 0000000000000000
[11565.878242]
[11566.045853] BTRFS: device fsid 98ba3519-efb2-43b0-be06-edebd28c73c5 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (2365867)
[11566.152528] BTRFS info (device dm-11): flagging fs with big metadata feature
[11566.153659] BTRFS info (device dm-11): disk space caching is enabled
[11566.154608] BTRFS info (device dm-11): has skinny extents
[11566.159135] BTRFS info (device dm-11): checking UUID tree
[11566.279544] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (2364572)
[11566.280697] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (2364572)
[11566.329977] BTRFS info (device dm-11): flagging fs with big metadata feature
[11566.330455] BTRFS info (device dm-11): disk space caching is enabled
[11566.330857] BTRFS info (device dm-11): has skinny extents
[11566.332764] BTRFS info (device dm-11): start tree-log replay
[11566.555035] BTRFS: device fsid a4f69dc4-4780-4dd1-8030-29658e0b20a4 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (2365958)
[11566.640319] BTRFS info (device dm-11): flagging fs with big metadata feature
[11566.640764] BTRFS info (device dm-11): disk space caching is enabled
[11566.641139] BTRFS info (device dm-11): has skinny extents
[11566.643004] BTRFS info (device dm-11): checking UUID tree
[11566.722618] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (2364572)
[11566.723807] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (2364572)
[11566.774794] BTRFS info (device dm-11): flagging fs with big metadata feature
[11566.775249] BTRFS info (device dm-11): disk space caching is enabled
[11566.775656] BTRFS info (device dm-11): has skinny extents
[11566.777260] BTRFS info (device dm-11): start tree-log replay
[11566.914363] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[11566.914879] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 2366049, name: udevadm
[11566.915418] preempt_count: 100, expected: 0
[11566.915781] RCU nest depth: 0, expected: 0
[11566.916111] INFO: lockdep is turned off.
[11566.916482] Preemption disabled at:
[11566.916483] [] __do_softirq+0x5e/0x517
[11566.917194] CPU: 1 PID: 2366049 Comm: udevadm Tainted: G W 5.17.0+ #640
[11566.917698] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[11566.918220] Call Trace:
[11566.918388]
[11566.918522] dump_stack_lvl+0x56/0x6f
[11566.918754] __might_resched.cold+0xff/0x13a
[11566.919018] blk_release_queue+0x24/0x120
[11566.919269] kobject_put+0x7c/0x1d0
[11566.919490] ? rcu_do_batch+0x1ac/0x570
[11566.919728] blkg_free.part.0+0x41/0x60
[11566.919971] rcu_do_batch+0x1e1/0x570
[11566.920195] ? rcu_do_batch+0x1ac/0x570
[11566.920448] rcu_core+0x2cb/0x460
[11566.920658] __do_softirq+0x178/0x517
[11566.920883] __irq_exit_rcu+0xe3/0x160
[11566.921118] irq_exit_rcu+0xa/0x20
[11566.921336] sysvec_apic_timer_interrupt+0xa2/0xd0
[11566.921634]
[11566.921773]
[11566.921908] asm_sysvec_apic_timer_interrupt+0x12/0x20
[11566.922225] RIP: 0010:strncpy_from_user+0x165/0x190
[11566.922544] Code: ff ff ff 0f 0b e9 20 ff ff ff 48 85 db 75 9c 4c 39 ea 72 b9 48 89 d0 eb bb 48 8d 4e ff 48 f7 d6 48 21 f1 48 c1 e9 07 48 21 c8 <49> 89 00 48 b8 08 06 05 04 03 02 01 00 48 0f af c8 48 c1 e9 38 48
[11566.923682] RSP: 0018:ffffa8c184ec7e18 EFLAGS: 00040246
[11566.924011] RAX: 0000000000000000 RBX: 0000000000000fe0 RCX: 0000000000000000
[11566.924447] RDX: 0000000000000000 RSI: ffffffffffffff7f RDI: 8080808080808080
[11566.924890] RBP: 00007fedac445592 R08: ffff9da11365c020 R09: 0000000000000000
[11566.925318] R10: fefefefefefefeff R11: 0000000000000000 R12: ffff9da11365c020
[11566.925773] R13: 0000000000000fe0 R14: 0000000000004001 R15: 0000000000000000
[11566.926225] ? strncpy_from_user+0x53/0x190
[11566.926538] getname_flags.part.0+0x45/0x1a0
[11566.926828] vfs_fstatat+0x3a/0x70
[11566.927034] __do_sys_newfstatat+0x13/0x30
[11566.927288] ? vfs_read+0x13d/0x1b0
[11566.927523] ? trace_hardirqs_on+0x1b/0xe0
[11566.927778] ? syscall_enter_from_user_mode+0x21/0x70
[11566.928081] do_syscall_64+0x38/0x90
[11566.928312] entry_SYSCALL_64_after_hwframe+0x44/0xae
[11566.928621] RIP: 0033:0x7fedac43efee
[11566.928848] Code: 48 89 f2 b9 00 01 00 00 48 89 fe bf 9c ff ff ff e9 07 00 00 00 0f 1f 80 00 00 00 00 f3 0f 1e fa 41 89 ca b8 06 01 00 00 0f 05 <3d> 00 f0 ff ff 77 0b 31 c0 c3 0f 1f 84 00 00 00 00 00 f7 d8 89 05
[11566.929965] RSP: 002b:00007ffea9783f08 EFLAGS: 00000246 ORIG_RAX: 0000000000000106
[11566.930426] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fedac43efee
[11566.930853] RDX: 00007ffea9783fa0 RSI: 00007fedac445592 RDI: 0000000000000003
[11566.931277] RBP: 00007ffea9784060 R08: 00007fedac2bfee0 R09: 00007fedac41d000
[11566.931720] R10: 0000000000001000 R11: 0000000000000246 R12: 00007fedac41d000
[11566.932162] R13: 00007ffea97840f0 R14: 00007fedac44f000 R15: 00007ffea97840f0
[11566.932618]