[19504.267671] run fstests btrfs/159 at 2022-04-04 02:16:28
[19504.477574] BTRFS info (device dm-0): flagging fs with big metadata feature
[19504.477811] BTRFS info (device dm-0): using free space tree
[19504.478019] BTRFS info (device dm-0): has skinny extents
[19504.673398] BTRFS: device fsid 41e56de6-90eb-48ef-a1b9-9b3fba854b1c devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (3160071)
[19504.745196] BTRFS info (device dm-11): flagging fs with big metadata feature
[19504.745458] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[19504.745770] BTRFS info (device dm-11): use zstd compression, level 3
[19504.746040] BTRFS info (device dm-11): turning on async discard
[19504.746261] BTRFS info (device dm-11): disk space caching is enabled
[19504.746481] BTRFS info (device dm-11): has skinny extents
[19504.748494] BTRFS info (device dm-11): checking UUID tree
[19509.409844] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (3161783)
[19509.410744] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (3161783)
[19509.509446] BTRFS info (device dm-11): flagging fs with big metadata feature
[19509.509671] BTRFS info (device dm-11): use zstd compression, level 3
[19509.509856] BTRFS info (device dm-11): turning on async discard
[19509.510051] BTRFS info (device dm-11): disk space caching is enabled
[19509.510259] BTRFS info (device dm-11): has skinny extents
[19509.512116] BTRFS info (device dm-11): start tree-log replay
[19510.492873] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[19510.493158] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 3161824, name: mkfs.btrfs
[19510.493413] preempt_count: 101, expected: 0
[19510.493561] RCU nest depth: 0, expected: 0
[19510.493706] INFO: lockdep is turned off.
[19510.493850] Preemption disabled at:
[19510.493851] [] copy_page_from_iter_atomic+0x24/0x8d0
[19510.494196] CPU: 1 PID: 3161824 Comm: mkfs.btrfs Tainted: G W 5.17.0+ #641
[19510.494440] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[19510.494698] Call Trace:
[19510.494817]
[19510.494951] dump_stack_lvl+0x56/0x6f
[19510.495095] __might_resched.cold+0xff/0x13a
[19510.495423] blk_release_queue+0x24/0x120
[19510.495791] kobject_put+0x7c/0x1d0
[19510.496006] ? rcu_do_batch+0x1ac/0x570
[19510.496265] blkg_free.part.0+0x41/0x60
[19510.496446] rcu_do_batch+0x1e1/0x570
[19510.496606] ? rcu_do_batch+0x1ac/0x570
[19510.496751] rcu_core+0x2cb/0x460
[19510.496969] __do_softirq+0x178/0x517
[19510.497146] __irq_exit_rcu+0xe3/0x160
[19510.497378] irq_exit_rcu+0xa/0x20
[19510.497513] sysvec_apic_timer_interrupt+0xa2/0xd0
[19510.497673]
[19510.497787]
[19510.497898] asm_sysvec_apic_timer_interrupt+0x12/0x20
[19510.498065] RIP: 0010:copy_user_enhanced_fast_string+0xe/0x40
[19510.498247] 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
[19510.498707] RSP: 0018:ffffb12646497cb0 EFLAGS: 00050206
[19510.498871] RAX: 00007fffffffe000 RBX: 0000000000001000 RCX: 0000000000000260
[19510.499066] RDX: 0000000000001000 RSI: 00007f360e586db0 RDI: ffff9be2ffeecda0
[19510.499262] RBP: 0000000000000000 R08: 0000000000000001 R09: 0000000000001000
[19510.499460] R10: ffff9be2950005e8 R11: 0000000000000000 R12: 0000000000000000
[19510.499656] R13: ffffb12646497e60 R14: 00000000000bc000 R15: ffffb12646497e60
[19510.499869] copyin+0x3d/0x50
[19510.500010] copy_page_from_iter_atomic+0xf9/0x8d0
[19510.500193] ? blkdev_llseek+0x60/0x60
[19510.500334] ? block_write_begin+0x50/0x130
[19510.500485] generic_perform_write+0xd4/0x1d0
[19510.500641] __generic_file_write_iter+0xdb/0x1a0
[19510.500798] blkdev_write_iter+0xc1/0x150
[19510.500949] new_sync_write+0xf6/0x160
[19510.501128] vfs_write+0x290/0x390
[19510.501272] __x64_sys_pwrite64+0x6f/0xb0
[19510.501417] do_syscall_64+0x38/0x90
[19510.501554] entry_SYSCALL_64_after_hwframe+0x44/0xae
[19510.501718] RIP: 0033:0x7f360e8c953a
[19510.501855] 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
[19510.502328] RSP: 002b:00007fff5ef86af8 EFLAGS: 00000246 ORIG_RAX: 0000000000000012
[19510.502569] RAX: ffffffffffffffda RBX: 00007f360e4ca010 RCX: 00007f360e8c953a
[19510.502759] RDX: 0000000000200000 RSI: 00007f360e4ca010 RDI: 0000000000000003
[19510.502954] RBP: 0000000000200000 R08: 00007f360e4ca010 R09: 0000000000000000
[19510.503154] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
[19510.503354] R13: 0000000000000003 R14: 0000000000000000 R15: 0000000000000000
[19510.503561]
[19510.694875] BTRFS: device fsid 58650ea5-fab7-45f6-b63f-44bbf4d0e02f devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (3161824)
[19510.758193] BTRFS info (device dm-11): flagging fs with big metadata feature
[19510.758411] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[19510.758665] BTRFS info (device dm-11): use zstd compression, level 3
[19510.758851] BTRFS info (device dm-11): turning on async discard
[19510.759052] BTRFS info (device dm-11): disk space caching is enabled
[19510.759246] BTRFS info (device dm-11): has skinny extents
[19510.761280] BTRFS info (device dm-11): checking UUID tree
[19514.797746] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (3163537)
[19514.798618] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (3163537)
[19514.899852] BTRFS info (device dm-11): flagging fs with big metadata feature
[19514.900071] BTRFS info (device dm-11): use zstd compression, level 3
[19514.900284] BTRFS info (device dm-11): turning on async discard
[19514.900460] BTRFS info (device dm-11): disk space caching is enabled
[19514.900641] BTRFS info (device dm-11): has skinny extents
[19514.902403] BTRFS info (device dm-11): start tree-log replay
[19515.960826] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[19515.961142] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/0
[19515.961411] preempt_count: 101, expected: 0
[19515.961567] RCU nest depth: 0, expected: 0
[19515.961715] INFO: lockdep is turned off.
[19515.961903] Preemption disabled at:
[19515.961904] [] schedule_preempt_disabled+0x1e/0x20
[19515.962308] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G W 5.17.0+ #641
[19515.962546] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[19515.962806] Call Trace:
[19515.962925]
[19515.963041] dump_stack_lvl+0x56/0x6f
[19515.963191] __might_resched.cold+0xff/0x13a
[19515.963340] blk_release_queue+0x24/0x120
[19515.963489] kobject_put+0x7c/0x1d0
[19515.963630] ? rcu_do_batch+0x1ac/0x570
[19515.963774] blkg_free.part.0+0x41/0x60
[19515.963917] rcu_do_batch+0x1e1/0x570
[19515.964060] ? rcu_do_batch+0x1ac/0x570
[19515.964208] rcu_core+0x2cb/0x460
[19515.964343] __do_softirq+0x178/0x517
[19515.964486] __irq_exit_rcu+0xe3/0x160
[19515.964630] irq_exit_rcu+0xa/0x20
[19515.964766] sysvec_apic_timer_interrupt+0xa2/0xd0
[19515.964929]
[19515.965045]
[19515.965199] asm_sysvec_apic_timer_interrupt+0x12/0x20
[19515.965368] RIP: 0010:native_safe_halt+0xb/0x10
[19515.971239] 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
[19515.971712] RSP: 0018:ffffffffa3a03ea8 EFLAGS: 00000246
[19515.971900] RAX: ffffffffa2e64a80 RBX: ffffffffa3a30a00 RCX: 0000000000000000
[19515.972160] RDX: ffffffffa3a30a00 RSI: ffffffffa387e4d9 RDI: ffffffffa2e64bf6
[19515.972439] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000
[19515.972693] R10: 0000000000000000 R11: ffff9be2fbc20c88 R12: 0000000000000000
[19515.972899] R13: 0000000000000000 R14: ffffffffa3a30118 R15: 0000000000000065
[19515.973108] ? mwait_idle+0x80/0x80
[19515.973285] ? default_idle_call+0x26/0xa0
[19515.973493] default_idle+0xa/0x10
[19515.973630] default_idle_call+0x5e/0xa0
[19515.973799] do_idle+0x1e9/0x240
[19515.973941] cpu_startup_entry+0x19/0x20
[19515.974099] start_kernel+0x98c/0x99e
[19515.974281] ? copy_bootdata+0x18/0x55
[19515.974483] secondary_startup_64_no_verify+0xd5/0xdb
[19515.974652]