[31392.936444] run fstests generic/268 at 2022-04-02 05:34:39
[31393.162824] _btrfs_printk: 10 callbacks suppressed
[31393.162828] BTRFS info (device dm-0): flagging fs with big metadata feature
[31393.163203] BTRFS info (device dm-0): using free space tree
[31393.163394] BTRFS info (device dm-0): has skinny extents
[31393.283236] BTRFS: device fsid 861ca8bf-ee0f-408a-82ce-7b15954f31cc devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (3840477)
[31393.297685] BTRFS info (device dm-9): flagging fs with big metadata feature
[31393.297909] BTRFS info (device dm-9): turning on sync discard
[31393.298088] BTRFS info (device dm-9): enabling free space tree
[31393.298260] BTRFS info (device dm-9): using free space tree
[31393.298448] BTRFS info (device dm-9): has skinny extents
[31393.309981] BTRFS info (device dm-9): creating free space tree
[31393.310236] BTRFS info (device dm-9): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[31393.310521] BTRFS info (device dm-9): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[31393.317485] BTRFS info (device dm-9): cleaning free space cache v1
[31393.321069] BTRFS info (device dm-9): checking UUID tree
[31393.434644] BTRFS: device fsid 2387bf70-c761-46ac-91e2-de70ad60b9ce devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (3840550)
[31393.524783] BTRFS info (device dm-11): flagging fs with big metadata feature
[31393.525007] BTRFS info (device dm-11): turning on sync discard
[31393.525184] BTRFS info (device dm-11): enabling free space tree
[31393.525381] BTRFS info (device dm-11): using free space tree
[31393.525559] BTRFS info (device dm-11): has skinny extents
[31393.527823] BTRFS info (device dm-11): creating free space tree
[31393.528079] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[31393.528360] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[31393.533727] BTRFS info (device dm-11): cleaning free space cache v1
[31393.537065] BTRFS info (device dm-11): checking UUID tree
[31393.795980] BTRFS info (device dm-11): flagging fs with big metadata feature
[31393.796475] BTRFS info (device dm-11): turning on sync discard
[31393.796863] BTRFS info (device dm-11): using free space tree
[31393.797251] BTRFS info (device dm-11): has skinny extents
[31394.017851] Buffer I/O error on dev dm-11, logical block 2621424, async page read
[31394.073737] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (3838896)
[31394.074541] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (3838896)
[31394.347554] BTRFS info (device dm-11): flagging fs with big metadata feature
[31394.347844] BTRFS info (device dm-11): turning on sync discard
[31394.348088] BTRFS info (device dm-11): using free space tree
[31394.348349] BTRFS info (device dm-11): has skinny extents
[31394.350307] BTRFS info (device dm-11): bdev /dev/mapper/error-test errs: wr 11, rd 0, flush 0, corrupt 0, gen 0
[31394.472281] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[31394.472555] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 3840674, name: fsck
[31394.472805] preempt_count: 100, expected: 0
[31394.472952] RCU nest depth: 0, expected: 0
[31394.473105] INFO: lockdep is turned off.
[31394.473249] Preemption disabled at:
[31394.473249] [] __do_softirq+0x5e/0x517
[31394.473575] CPU: 0 PID: 3840674 Comm: fsck Tainted: G W 5.17.0+ #639
[31394.473821] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[31394.474079] Call Trace:
[31394.474201]
[31394.474315] dump_stack_lvl+0x56/0x6f
[31394.474456] __might_resched.cold+0xff/0x13a
[31394.474607] blk_release_queue+0x24/0x120
[31394.474755] kobject_put+0x7c/0x1d0
[31394.474893] ? rcu_do_batch+0x1ac/0x570
[31394.475043] blkg_free.part.0+0x41/0x60
[31394.475190] rcu_do_batch+0x1e1/0x570
[31394.475328] ? rcu_do_batch+0x1ac/0x570
[31394.475472] rcu_core+0x2cb/0x460
[31394.475609] __do_softirq+0x178/0x517
[31394.475748] __irq_exit_rcu+0xe3/0x160
[31394.475888] irq_exit_rcu+0xa/0x20
[31394.476028] sysvec_apic_timer_interrupt+0xa2/0xd0
[31394.476190]
[31394.476301]
[31394.476416] asm_sysvec_apic_timer_interrupt+0x12/0x20
[31394.476582] RIP: 0010:do_user_addr_fault+0x2ed/0x6b0
[31394.476743] Code: ff 0f 0b e9 4c ff ff ff 31 f6 4c 89 f7 44 89 04 24 e8 67 b5 29 00 44 8b 04 24 e9 18 ff ff ff e8 69 79 1a 00 fb 0f 1f 44 00 00 03 fe ff ff 66 81 3d e5 3c d7 01 0f 02 0f 84 29 01 00 00 48 83
[31394.477210] RSP: 0018:ffffb835c613fba0 EFLAGS: 00000246
[31394.477378] RAX: 0000000080000000 RBX: 0000000000000214 RCX: 0000000000000000
[31394.477574] RDX: 00007efebc6c1000 RSI: ffffffffb990b2d5 RDI: ffffffffb81048e7
[31394.477771] RBP: 0000000000000002 R08: 0000000000000000 R09: 0000000000000000
[31394.477967] R10: 0000000000000000 R11: 0000000000000000 R12: ffffb835c613fc18
[31394.478162] R13: 00007efebc6c1000 R14: ffff94184ad44e00 R15: 0000000000000000
[31394.478355] ? do_user_addr_fault+0x2e7/0x6b0
[31394.478509] exc_page_fault+0x78/0x280
[31394.478650] asm_exc_page_fault+0x1e/0x30
[31394.478797] RIP: 0010:copy_user_enhanced_fast_string+0xe/0x40
[31394.478972] 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
[31394.479430] RSP: 0018:ffffb835c613fcc8 EFLAGS: 00050206
[31394.479597] RAX: 00007fffffffe000 RBX: 0000000000001000 RCX: 0000000000000038
[31394.479793] RDX: 0000000000001000 RSI: ffff941882f96fc8 RDI: 00007efebc6c1000
[31394.479994] RBP: ffffb835c613fe68 R08: 0000000000000001 R09: ffffb835c613fe58
[31394.480191] R10: 00007efebc6c0038 R11: ffffffffb83cd75c R12: 0000000000001000
[31394.480388] R13: 0000000000001000 R14: 0000000000000000 R15: 000000000001b000
[31394.480585] ? free_unref_page_list+0x12c/0x560
[31394.480742] copyout+0x3d/0x50
[31394.480869] copy_page_to_iter+0x104/0x4a0
[31394.481023] filemap_read+0x18c/0x340
[31394.481166] ? register_handler_proc+0xef/0x130
[31394.487700] blkdev_read_iter+0xac/0x1c0
[31394.487852] new_sync_read+0xf3/0x160
[31394.487998] vfs_read+0x15f/0x1b0
[31394.488132] ksys_read+0x55/0xd0
[31394.488268] do_syscall_64+0x38/0x90
[31394.488405] entry_SYSCALL_64_after_hwframe+0x44/0xae
[31394.488567] RIP: 0033:0x7efebc9544f2
[31394.488708] Code: c0 e9 b2 fe ff ff 50 48 8d 3d b2 39 0a 00 e8 95 f0 01 00 0f 1f 44 00 00 f3 0f 1e fa 64 8b 04 25 18 00 00 00 85 c0 75 10 0f 05 <48> 3d 00 f0 ff ff 77 56 c3 0f 1f 44 00 00 48 83 ec 28 48 89 54 24
[31394.489175] RSP: 002b:00007ffce358eed8 EFLAGS: 00000246 ORIG_RAX: 0000000000000000
[31394.489412] RAX: ffffffffffffffda RBX: 00007efebc6a5028 RCX: 00007efebc9544f2
[31394.489607] RDX: 0000000000040000 RSI: 00007efebc6a5038 RDI: 0000000000000003
[31394.489804] RBP: 0000556f1c5477d0 R08: 00007efebc6a5010 R09: 0000000000000000
[31394.490002] R10: 0000000000000022 R11: 0000000000000246 R12: 000000027ff80000
[31394.490208] R13: 0000000000040000 R14: 00007efebc6a5010 R15: 0000556f1c547820
[31394.490403]