[20427.730388] run fstests generic/276 at 2022-04-03 02:31:55
[20428.161941] BTRFS: device fsid 19ee7199-21b2-429a-b977-301a12810de6 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (771351)
[20428.196146] BTRFS info (device dm-9): flagging fs with big metadata feature
[20428.196373] BTRFS info (device dm-9): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[20428.196640] BTRFS info (device dm-9): use zstd compression, level 3
[20428.197540] BTRFS info (device dm-9): turning on async discard
[20428.197724] BTRFS info (device dm-9): disk space caching is enabled
[20428.197931] BTRFS info (device dm-9): has skinny extents
[20428.214423] BTRFS info (device dm-9): checking UUID tree
[20428.405350] BTRFS: device fsid 1e0a0bd2-aeb2-463e-a571-4c9658ecd0d6 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (771427)
[20428.522135] BTRFS info (device dm-11): flagging fs with big metadata feature
[20428.522356] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[20428.522618] BTRFS info (device dm-11): use zstd compression, level 3
[20428.522807] BTRFS info (device dm-11): turning on async discard
[20428.523005] BTRFS info (device dm-11): disk space caching is enabled
[20428.523191] BTRFS info (device dm-11): has skinny extents
[20428.524852] BTRFS info (device dm-11): checking UUID tree
[20428.692360] BTRFS info (device dm-11): flagging fs with big metadata feature
[20428.693236] BTRFS info (device dm-11): use zstd compression, level 3
[20428.693922] BTRFS info (device dm-11): turning on async discard
[20428.694641] BTRFS info (device dm-11): disk space caching is enabled
[20428.695383] BTRFS info (device dm-11): has skinny extents
[20428.947843] Buffer I/O error on dev dm-11, logical block 2621424, async page read
[20428.963792] btrfs_dev_stat_print_on_error: 128 callbacks suppressed
[20428.963797] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 1, rd 0, flush 0, corrupt 0, gen 0
[20428.964452] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 2, rd 0, flush 0, corrupt 0, gen 0
[20428.964794] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 3, rd 0, flush 0, corrupt 0, gen 0
[20428.965140] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 4, rd 0, flush 0, corrupt 0, gen 0
[20428.965471] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 5, rd 0, flush 0, corrupt 0, gen 0
[20428.965811] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 6, rd 0, flush 0, corrupt 0, gen 0
[20428.966151] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 7, rd 0, flush 0, corrupt 0, gen 0
[20428.966485] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 8, rd 0, flush 0, corrupt 0, gen 0
[20428.966822] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 9, rd 0, flush 0, corrupt 0, gen 0
[20428.967163] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 10, rd 0, flush 0, corrupt 0, gen 0
[20428.985522] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (770691)
[20428.986324] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (770691)
[20429.054216] BTRFS info (device dm-11): flagging fs with big metadata feature
[20429.054438] BTRFS info (device dm-11): use zstd compression, level 3
[20429.054626] BTRFS info (device dm-11): turning on async discard
[20429.054809] BTRFS info (device dm-11): disk space caching is enabled
[20429.055012] BTRFS info (device dm-11): has skinny extents
[20429.056637] BTRFS info (device dm-11): bdev /dev/mapper/error-test errs: wr 64, rd 0, flush 0, corrupt 0, gen 0
[20429.197953] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[20429.198229] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 771548, name: fsck.btrfs
[20429.198479] preempt_count: 100, expected: 0
[20429.198629] RCU nest depth: 0, expected: 0
[20429.198779] INFO: lockdep is turned off.
[20429.198920] Preemption disabled at:
[20429.198921] [] __do_softirq+0x5e/0x517
[20429.199244] CPU: 1 PID: 771548 Comm: fsck.btrfs Tainted: G        W         5.17.0+ #640
[20429.199497] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[20429.199760] Call Trace:
[20429.199879]  
[20429.199997]  dump_stack_lvl+0x56/0x6f
[20429.200138]  __might_resched.cold+0xff/0x13a
[20429.200290]  blk_release_queue+0x24/0x120
[20429.200443]  kobject_put+0x7c/0x1d0
[20429.200584]  ? rcu_do_batch+0x1ac/0x570
[20429.200727]  blkg_free.part.0+0x41/0x60
[20429.200877]  rcu_do_batch+0x1e1/0x570
[20429.201019]  ? rcu_do_batch+0x1ac/0x570
[20429.201161]  rcu_core+0x2cb/0x460
[20429.201295]  __do_softirq+0x178/0x517
[20429.201439]  __irq_exit_rcu+0xe3/0x160
[20429.201584]  irq_exit_rcu+0xa/0x20
[20429.201718]  sysvec_apic_timer_interrupt+0xa2/0xd0
[20429.201885]  
[20429.202000]  
[20429.202113]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[20429.202281] RIP: 0010:get_page_from_freelist+0x9cd/0x16d0
[20429.202478] Code: 48 c7 45 28 00 00 00 00 48 c7 c6 93 e9 3c b7 48 89 ef e8 86 83 e1 ff 48 83 7c 24 20 00 74 0b e8 99 d8 ed ff fb 0f 1f 44 00 00 <4d> 85 ed 0f 84 a3 02 00 00 49 8b 45 00 48 c1 e8 33 83 e0 07 65 48
[20429.202959] RSP: 0000:ffffb18fc37e3b90 EFLAGS: 00000246
[20429.203126] RAX: 0000000080000000 RBX: ffff9e5a3bd3a460 RCX: 0000000000000000
[20429.203321] RDX: 0017ffffc0000000 RSI: ffffffffb73ce993 RDI: ffffffffb73ce9b7
[20429.203519] RBP: ffff9e5a3bd2f200 R08: 0000000000000000 R09: 0000000000000000
[20429.203717] R10: 0000000000000000 R11: 0000000000000000 R12: ffff9e5a3bd3a480
[20429.203918] R13: ffffe16705ae1500 R14: 0000000000000000 R15: ffff9e5a3ffd3e00
[20429.204118]  ? get_page_from_freelist+0x9a3/0x16d0
[20429.204281]  ? get_page_from_freelist+0x9c7/0x16d0
[20429.204441]  ? seqcount_lockdep_reader_access+0x7b/0x90
[20429.204607]  ? rcu_read_lock_sched_held+0x12/0x60
[20429.204769]  ? prepare_alloc_pages+0xbc/0x1b0
[20429.204925]  __alloc_pages+0xd6/0x290
[20429.205068]  alloc_pages_vma+0x8f/0x2e0
[20429.205211]  wp_page_copy+0x5b/0x580
[20429.205348]  ? lock_release+0x1ed/0x2c0
[20429.205493]  ? _raw_spin_unlock+0x29/0x40
[20429.205637]  __handle_mm_fault+0xba9/0x1460
[20429.205791]  handle_mm_fault+0x11e/0x3a0
[20429.205940]  do_user_addr_fault+0x1e9/0x6b0
[20429.206092]  exc_page_fault+0x78/0x280
[20429.206232]  ? asm_exc_page_fault+0x8/0x30
[20429.206377]  asm_exc_page_fault+0x1e/0x30
[20429.206524] RIP: 0033:0x7f63a9f13050
[20429.206665] Code: 0c 48 83 fa 22 77 d3 48 89 04 d1 eb e7 4d 85 d2 74 79 49 8b 44 24 60 48 85 c0 74 04 4c 01 50 08 49 8b 44 24 58 48 85 c0 74 04 <4c> 01 50 08 49 8b 44 24 68 48 85 c0 74 04 4c 01 50 08 49 8b 44 24
[20429.207129] RSP: 002b:00007ffd6eeb5b40 EFLAGS: 00010202
[20429.207298] RAX: 00007f63a9f008b0 RBX: 000000006ffffdff RCX: 00007f63a9f02040
[20429.207495] RDX: 0000000000000000 RSI: 0000000000000029 RDI: 000000006fffffff
[20429.207693] RBP: 00007ffd6eeb5ca0 R08: 00000000effffef5 R09: 0000000070000022
[20429.207893] R10: 00007f63a9ed3000 R11: 0000000000000032 R12: 00007f63a9f02000
[20429.208089] R13: 000000006ffffeff R14: 000000006ffffe35 R15: 0000000000000000
[20429.208286]