[ 4645.041925] run fstests btrfs/211 at 2022-04-02 22:19:51
[ 4645.237521] BTRFS info (device dm-0): flagging fs with big metadata feature
[ 4645.238121] BTRFS info (device dm-0): using free space tree
[ 4645.238619] BTRFS info (device dm-0): has skinny extents
[ 4645.465688] BTRFS: device fsid 7fc4bda7-3f77-4a4c-83a1-ac94d8513120 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (918283)
[ 4645.532004] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 4645.532455] BTRFS info (device dm-11): disk space caching is enabled
[ 4645.532831] BTRFS info (device dm-11): has skinny extents
[ 4645.534650] BTRFS info (device dm-11): checking UUID tree
[ 4645.595105] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (916050)
[ 4645.596238] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (916050)
[ 4645.647518] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 4645.647969] BTRFS info (device dm-11): disk space caching is enabled
[ 4645.648362] BTRFS info (device dm-11): has skinny extents
[ 4645.650027] BTRFS info (device dm-11): start tree-log replay
[ 4645.663676] BTRFS info (device dm-11): checking UUID tree
[ 4645.686087] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 4645.686547] BTRFS info (device dm-11): disk space caching is enabled
[ 4645.686928] BTRFS info (device dm-11): has skinny extents
[ 4645.688696] BTRFS info (device dm-11): checking UUID tree
[ 4645.746350] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[ 4645.746846] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 918413, name: mkfs.btrfs
[ 4645.747441] preempt_count: 101, expected: 0
[ 4645.747719] RCU nest depth: 0, expected: 0
[ 4645.747989] INFO: lockdep is turned off.
[ 4645.748272] Preemption disabled at:
[ 4645.748273] [] copy_page_from_iter_atomic+0x24/0x8d0
[ 4645.748981] CPU: 0 PID: 918413 Comm: mkfs.btrfs Tainted: G W 5.17.0+ #640
[ 4645.749490] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[ 4645.749988] Call Trace:
[ 4645.750145]
[ 4645.750271] dump_stack_lvl+0x56/0x6f
[ 4645.750493] __might_resched.cold+0xff/0x13a
[ 4645.750749] blk_release_queue+0x24/0x120
[ 4645.750995] kobject_put+0x7c/0x1d0
[ 4645.751208] ? rcu_do_batch+0x1ac/0x570
[ 4645.751438] blkg_free.part.0+0x41/0x60
[ 4645.751670] rcu_do_batch+0x1e1/0x570
[ 4645.751893] ? rcu_do_batch+0x1ac/0x570
[ 4645.752125] rcu_core+0x2cb/0x460
[ 4645.752332] __do_softirq+0x178/0x517
[ 4645.752555] __irq_exit_rcu+0xe3/0x160
[ 4645.752780] irq_exit_rcu+0xa/0x20
[ 4645.752994] sysvec_apic_timer_interrupt+0xa2/0xd0
[ 4645.753283]
[ 4645.753413]
[ 4645.753543] asm_sysvec_apic_timer_interrupt+0x12/0x20
[ 4645.753849] RIP: 0010:copy_user_enhanced_fast_string+0xe/0x40
[ 4645.754191] Code: 89 d1 c1 e9 03 83 e2 07 f3 48 a5 89 d1 f3 a4 31 c0 0f 01 ca c3 8d 0c ca 89 ca eb 20 0f 01 cb 83 fa 40 0f 82 60 ff ff ff 89 d1 a4 31 c0 0f 01 ca c3 89 ca eb 06 66 0f 1f 44 00 00 83 f8 12 74
[ 4645.755270] RSP: 0018:ffffa8c187a0fcb0 EFLAGS: 00050206
[ 4645.755577] RAX: 00007fffffffe000 RBX: 0000000000001000 RCX: 0000000000000fb0
[ 4645.755997] RDX: 0000000000001000 RSI: 00007f028315e060 RDI: ffff9da113750050
[ 4645.756411] RBP: 0000000000000000 R08: 0000000000000001 R09: 0000000000001000
[ 4645.756827] R10: ffff9da114bc2540 R11: 0000000000000000 R12: 0000000000000000
[ 4645.757245] R13: ffffa8c187a0fe60 R14: 0000000000042000 R15: ffffa8c187a0fe60
[ 4645.757670] copyin+0x3d/0x50
[ 4645.757851] copy_page_from_iter_atomic+0xf9/0x8d0
[ 4645.758140] ? blkdev_llseek+0x60/0x60
[ 4645.758368] ? block_write_begin+0x50/0x130
[ 4645.758619] generic_perform_write+0xd4/0x1d0
[ 4645.758887] __generic_file_write_iter+0xdb/0x1a0
[ 4645.759168] blkdev_write_iter+0xc1/0x150
[ 4645.759408] new_sync_write+0xf6/0x160
[ 4645.759634] vfs_write+0x290/0x390
[ 4645.759842] __x64_sys_pwrite64+0x6f/0xb0
[ 4645.760085] do_syscall_64+0x38/0x90
[ 4645.760303] entry_SYSCALL_64_after_hwframe+0x44/0xae
[ 4645.760601] RIP: 0033:0x7f028351f19a
[ 4645.760819] Code: d8 64 89 02 48 c7 c0 ff ff ff ff eb ba 0f 1f 00 f3 0f 1e fa 49 89 ca 64 8b 04 25 18 00 00 00 85 c0 75 15 b8 12 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 5e c3 0f 1f 44 00 00 48 83 ec 28 48 89 54 24
[ 4645.761902] RSP: 002b:00007ffdcb7a5998 EFLAGS: 00000246 ORIG_RAX: 0000000000000012
[ 4645.762345] RAX: ffffffffffffffda RBX: 00007f028311c010 RCX: 00007f028351f19a
[ 4645.762761] RDX: 0000000000200000 RSI: 00007f028311c010 RDI: 0000000000000003
[ 4645.763180] RBP: 0000000000200000 R08: 00007f028311c010 R09: 0000000000000000
[ 4645.763598] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
[ 4645.764017] R13: 0000000000000003 R14: 0000000000000000 R15: 0000000000000000
[ 4645.764442]
[ 4645.894689] BTRFS: device fsid d89d6bb7-82a2-42fb-bf9f-ecc599735c7a devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (918413)
[ 4645.966488] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 4645.967091] BTRFS info (device dm-11): disk space caching is enabled
[ 4645.967628] BTRFS info (device dm-11): has skinny extents
[ 4645.969935] BTRFS info (device dm-11): checking UUID tree
[ 4646.023128] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (916050)
[ 4646.024242] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (916050)
[ 4646.076350] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 4646.076838] BTRFS info (device dm-11): disk space caching is enabled
[ 4646.077204] BTRFS info (device dm-11): has skinny extents
[ 4646.079267] BTRFS info (device dm-11): start tree-log replay
[ 4646.089664] BTRFS info (device dm-11): checking UUID tree
[ 4646.126258] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 4646.126794] BTRFS info (device dm-11): disk space caching is enabled
[ 4646.127163] BTRFS info (device dm-11): has skinny extents