[24968.557948] run fstests generic/331 at 2022-04-04 03:52:37
[24968.819001] BTRFS info (device dm-0): flagging fs with big metadata feature
[24968.819241] BTRFS info (device dm-0): using free space tree
[24968.819420] BTRFS info (device dm-0): has skinny extents
[24968.966295] BTRFS: device fsid b9d6c09b-a480-429a-b463-44aba91efe1e devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (819376)
[24968.991771] BTRFS info (device dm-7): flagging fs with big metadata feature
[24968.992047] BTRFS info (device dm-7): use zlib compression, level 3
[24968.992245] BTRFS info (device dm-7): using free space tree
[24968.992431] BTRFS info (device dm-7): has skinny extents
[24968.999139] BTRFS info (device dm-7): checking UUID tree
[24969.194506] BTRFS: device fsid e5c682fe-5c99-4075-919a-d031529875c1 devid 1 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (819453)
[24969.294406] BTRFS info (device dm-9): flagging fs with big metadata feature
[24969.294651] BTRFS info (device dm-9): use zlib compression, level 3
[24969.294850] BTRFS info (device dm-9): using free space tree
[24969.295064] BTRFS info (device dm-9): has skinny extents
[24969.296765] BTRFS info (device dm-9): checking UUID tree
[24969.447118] BTRFS info (device dm-9): flagging fs with big metadata feature
[24969.447351] BTRFS info (device dm-9): use zlib compression, level 3
[24969.447548] BTRFS info (device dm-9): using free space tree
[24969.447726] BTRFS info (device dm-9): has skinny extents
[24969.941380] Buffer I/O error on dev dm-9, logical block 2621424, async page read
[24970.100152] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-9 scanned by systemd-udevd (817078)
[24970.101213] BTRFS info: devid 1 device path /dev/dm-9 changed to /dev/mapper/error-test scanned by systemd-udevd (817078)
[24970.137289] BTRFS info (device dm-9): flagging fs with big metadata feature
[24970.137509] BTRFS info (device dm-9): use zlib compression, level 3
[24970.137692] BTRFS info (device dm-9): using free space tree
[24970.137863] BTRFS info (device dm-9): has skinny extents
[24970.139532] BTRFS info (device dm-9): bdev /dev/mapper/error-test errs: wr 320, rd 0, flush 0, corrupt 0, gen 0
[24970.393898] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[24970.394180] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 819580, name: fsck
[24970.394424] preempt_count: 100, expected: 0
[24970.394574] RCU nest depth: 0, expected: 0
[24970.394722] INFO: lockdep is turned off.
[24970.394865] Preemption disabled at:
[24970.394866] [] __do_softirq+0x5e/0x517
[24970.395198] CPU: 0 PID: 819580 Comm: fsck Tainted: G        W         5.17.0+ #641
[24970.395438] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[24970.395692] Call Trace:
[24970.395814]  
[24970.395929]  dump_stack_lvl+0x56/0x6f
[24970.396077]  __might_resched.cold+0xff/0x13a
[24970.396230]  blk_release_queue+0x24/0x120
[24970.396376]  kobject_put+0x7c/0x1d0
[24970.396537]  ? rcu_do_batch+0x1ac/0x570
[24970.396693]  blkg_free.part.0+0x41/0x60
[24970.396845]  rcu_do_batch+0x1e1/0x570
[24970.396992]  ? rcu_do_batch+0x1ac/0x570
[24970.397155]  rcu_core+0x2cb/0x460
[24970.397300]  __do_softirq+0x178/0x517
[24970.397449]  __irq_exit_rcu+0xe3/0x160
[24970.397596]  irq_exit_rcu+0xa/0x20
[24970.397755]  sysvec_apic_timer_interrupt+0xa2/0xd0
[24970.397913]  
[24970.398032]  
[24970.398151]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[24970.398316] RIP: 0010:__srcu_read_unlock+0x12/0x20
[24970.398473] Code: 41 83 e0 01 65 48 ff 04 c2 f0 83 44 24 fc 00 44 89 c0 c3 0f 1f 44 00 00 0f 1f 44 00 00 f0 83 44 24 fc 00 48 8b 87 00 37 01 00 <48> 63 f6 65 48 ff 44 f0 10 c3 0f 1f 40 00 0f 1f 44 00 00 41 54 49
[24970.398933] RSP: 0018:ffffb94a0701f9a8 EFLAGS: 00000282
[24970.399110] RAX: 0000431544026700 RBX: ffff96348d307900 RCX: 0000000000000000
[24970.399305] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffff963445060d78
[24970.399498] RBP: ffff963445060000 R08: ffff963455b6b888 R09: 0000000000000000
[24970.399704] R10: ffff963455b7d800 R11: ffff963455b7d858 R12: 0000000000000000
[24970.399926] R13: ffff963445060d78 R14: 0000000000000003 R15: ffffdfe6042dbd40
[24970.400129]  dm_submit_bio+0x2ee/0x630
[24970.400272]  __submit_bio+0x50/0x180
[24970.400412]  submit_bio_noacct_nocheck+0xba/0x280
[24970.400580]  mpage_readahead+0x171/0x200
[24970.400728]  ? blkdev_llseek+0x60/0x60
[24970.400897]  read_pages+0x60/0x3d0
[24970.401069]  page_cache_ra_unbounded+0x176/0x1f0
[24970.401226]  force_page_cache_ra+0xc5/0x100
[24970.401394]  filemap_get_pages+0xca/0x740
[24970.401564]  ? copy_user_enhanced_fast_string+0xe/0x40
[24970.401735]  ? copyout+0x3d/0x50
[24970.401873]  filemap_read+0xbe/0x340
[24970.402022]  ? register_handler_proc+0xe0/0x130
[24970.402184]  ? lock_release+0x1ed/0x2c0
[24970.402342]  blkdev_read_iter+0xac/0x1c0
[24970.402492]  new_sync_read+0xf3/0x160
[24970.402638]  vfs_read+0x15f/0x1b0
[24970.402792]  ksys_read+0x55/0xd0
[24970.402921]  do_syscall_64+0x38/0x90
[24970.403068]  entry_SYSCALL_64_after_hwframe+0x44/0xae
[24970.403234] RIP: 0033:0x7efdd266e2e2
[24970.403382] Code: c0 e9 b2 fe ff ff 50 48 8d 3d ea 2e 0a 00 e8 95 e9 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
[24970.403833] RSP: 002b:00007ffc89902da8 EFLAGS: 00000246 ORIG_RAX: 0000000000000000
[24970.404077] RAX: ffffffffffffffda RBX: 00007efdd2442028 RCX: 00007efdd266e2e2
[24970.404270] RDX: 0000000000040000 RSI: 00007efdd2442038 RDI: 0000000000000003
[24970.404460] RBP: 000055cd24ef6ad0 R08: 00007efdd2442010 R09: 0000000000000000
[24970.404652] R10: 0000000000000022 R11: 0000000000000246 R12: 0000000000000000
[24970.404842] R13: 0000000000040000 R14: 00007efdd2442010 R15: 000055cd24ef6b20
[24970.405047]