[31727.445525] run fstests generic/272 at 2022-04-03 05:40:15
[31727.666444] BTRFS info (device dm-0): flagging fs with big metadata feature
[31727.666680] BTRFS info (device dm-0): using free space tree
[31727.666852] BTRFS info (device dm-0): has skinny extents
[31727.820697] BTRFS: device fsid 30b1783f-9232-4316-891d-5cb44e9b0fb5 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (3919933)
[31727.833716] BTRFS info (device dm-9): flagging fs with big metadata feature
[31727.833936] BTRFS info (device dm-9): turning on sync discard
[31727.834117] BTRFS info (device dm-9): enabling free space tree
[31727.834296] BTRFS info (device dm-9): using free space tree
[31727.834472] BTRFS info (device dm-9): has skinny extents
[31727.845501] BTRFS info (device dm-9): creating free space tree
[31727.845777] BTRFS info (device dm-9): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[31727.846044] BTRFS info (device dm-9): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[31727.854293] BTRFS info (device dm-9): cleaning free space cache v1
[31727.862518] BTRFS info (device dm-9): checking UUID tree
[31728.048055] BTRFS: device fsid b8f0d2da-3047-43f8-8adf-d7a7bea71420 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (3920010)
[31728.129465] BTRFS info (device dm-11): flagging fs with big metadata feature
[31728.129710] BTRFS info (device dm-11): turning on sync discard
[31728.129889] BTRFS info (device dm-11): enabling free space tree
[31728.130065] BTRFS info (device dm-11): using free space tree
[31728.130239] BTRFS info (device dm-11): has skinny extents
[31728.132249] BTRFS info (device dm-11): creating free space tree
[31728.132520] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[31728.132841] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[31728.142172] BTRFS info (device dm-11): cleaning free space cache v1
[31728.149999] BTRFS info (device dm-11): checking UUID tree
[31728.402646] BTRFS info (device dm-11): flagging fs with big metadata feature
[31728.402869] BTRFS info (device dm-11): turning on sync discard
[31728.403047] BTRFS info (device dm-11): using free space tree
[31728.403216] BTRFS info (device dm-11): has skinny extents
[31728.631080] Buffer I/O error on dev dm-11, logical block 2621424, async page read
[31728.643586] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 1, rd 0, flush 0, corrupt 0, gen 0
[31728.643891] BTRFS warning (device dm-11): direct IO failed ino 259 rw 1,34817 sector 0x126800 len 5787648 err no 10
[31728.658978] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 2, rd 0, flush 0, corrupt 0, gen 0
[31728.659288] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 3, rd 0, flush 0, corrupt 0, gen 0
[31728.659670] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 4, rd 0, flush 0, corrupt 0, gen 0
[31728.659966] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 5, rd 0, flush 0, corrupt 0, gen 0
[31728.660254] BTRFS: error (device dm-11) in btrfs_commit_transaction:2418: errno=-5 IO failure (Error while writing out transaction)
[31728.660606] BTRFS info (device dm-11: state E): forced readonly
[31728.660815] BTRFS warning (device dm-11: state E): Skipping commit of aborted transaction.
[31728.661065] BTRFS: error (device dm-11: state EA) in cleanup_transaction:1982: errno=-5 IO failure
[31728.661417] BTRFS error (device dm-11: state EA): commit super ret -5
[31728.690584] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[31728.690859] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 3920106, name: fsck
[31728.691111] preempt_count: 100, expected: 0
[31728.691257] RCU nest depth: 0, expected: 0
[31728.691403] INFO: lockdep is turned off.
[31728.691557] Preemption disabled at:
[31728.691558] [] __do_softirq+0x5e/0x517
[31728.691876] CPU: 1 PID: 3920106 Comm: fsck Tainted: G W 5.17.0+ #640
[31728.692121] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[31728.692371] Call Trace:
[31728.692497]
[31728.692610] dump_stack_lvl+0x56/0x6f
[31728.692751] __might_resched.cold+0xff/0x13a
[31728.692904] blk_release_queue+0x24/0x120
[31728.693050] kobject_put+0x7c/0x1d0
[31728.693186] ? rcu_do_batch+0x1ac/0x570
[31728.693331] blkg_free.part.0+0x41/0x60
[31728.693479] rcu_do_batch+0x1e1/0x570
[31728.693618] ? rcu_do_batch+0x1ac/0x570
[31728.693760] rcu_core+0x2cb/0x460
[31728.693895] __do_softirq+0x178/0x517
[31728.694034] __irq_exit_rcu+0xe3/0x160
[31728.694177] irq_exit_rcu+0xa/0x20
[31728.694316] sysvec_apic_timer_interrupt+0xa2/0xd0
[31728.694479]
[31728.694593]
[31728.694707] asm_sysvec_apic_timer_interrupt+0x12/0x20
[31728.694873] RIP: 0010:do_user_addr_fault+0x2ed/0x6b0
[31728.695033] 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
[31728.695494] RSP: 0018:ffffb18fc7103ba0 EFLAGS: 00000246
[31728.695661] RAX: 0000000080000000 RBX: 0000000000000214 RCX: 0000000000000000
[31728.695860] RDX: 00007f6626832000 RSI: ffffffffb890b2d5 RDI: ffffffffb71048e7
[31728.696057] RBP: 0000000000000002 R08: 0000000000000000 R09: 0000000000000000
[31728.696252] R10: 0000000000000000 R11: 0000000000000000 R12: ffffb18fc7103c18
[31728.696445] R13: 00007f6626832000 R14: ffff9e59dbca1380 R15: 0000000000000000
[31728.696644] ? do_user_addr_fault+0x2e7/0x6b0
[31728.696796] exc_page_fault+0x78/0x280
[31728.696935] asm_exc_page_fault+0x1e/0x30
[31728.697081] RIP: 0010:copy_user_enhanced_fast_string+0xe/0x40
[31728.697255] 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
[31728.697716] RSP: 0018:ffffb18fc7103cc8 EFLAGS: 00050206
[31728.697882] RAX: 00007fffffffe000 RBX: 0000000000001000 RCX: 0000000000000038
[31728.698076] RDX: 0000000000001000 RSI: ffff9e59d59e0fc8 RDI: 00007f6626832000
[31728.704547] RBP: ffffb18fc7103e68 R08: 0000000000000001 R09: ffffb18fc7103e58
[31728.704745] R10: 00007f6626831038 R11: 000000000000000a R12: 0000000000001000
[31728.704941] R13: 0000000000001000 R14: 0000000000000000 R15: 0000000000016000
[31728.705139] copyout+0x3d/0x50
[31728.705272] copy_page_to_iter+0x104/0x4a0
[31728.705420] filemap_read+0x18c/0x340
[31728.705566] ? register_handler_proc+0xef/0x130
[31728.705727] blkdev_read_iter+0xac/0x1c0
[31728.705874] new_sync_read+0xf3/0x160
[31728.706017] vfs_read+0x15f/0x1b0
[31728.706150] ksys_read+0x55/0xd0
[31728.706280] do_syscall_64+0x38/0x90
[31728.706421] entry_SYSCALL_64_after_hwframe+0x44/0xae
[31728.706585] RIP: 0033:0x7f6626aca4f2
[31728.706724] 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
[31728.707187] RSP: 002b:00007ffe75bb13b8 EFLAGS: 00000246 ORIG_RAX: 0000000000000000
[31728.707429] RAX: ffffffffffffffda RBX: 00007f662681b028 RCX: 00007f6626aca4f2
[31728.707630] RDX: 0000000000040000 RSI: 00007f662681b038 RDI: 0000000000000003
[31728.707825] RBP: 000055d4ca4f07d0 R08: 00007f662681b010 R09: 0000000000000000
[31728.708026] R10: 0000000000000022 R11: 0000000000000246 R12: 000000027ff80000
[31728.708222] R13: 0000000000040000 R14: 00007f662681b010 R15: 000055d4ca4f0820
[31728.708422]
[31728.718948] BTRFS info (device dm-9): flagging fs with big metadata feature
[31728.719164] BTRFS info (device dm-9): turning on sync discard
[31728.719340] BTRFS info (device dm-9): using free space tree
[31728.719520] BTRFS info (device dm-9): has skinny extents