[20409.315762] run fstests generic/271 at 2022-04-03 02:31:37
[20409.772244] BTRFS: device fsid 5c601dd7-2d9c-4dc9-b267-6060fe911386 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (766157)
[20409.785123] BTRFS info (device dm-9): flagging fs with big metadata feature
[20409.785361] BTRFS info (device dm-9): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[20409.785619] BTRFS info (device dm-9): use zstd compression, level 3
[20409.785804] BTRFS info (device dm-9): turning on async discard
[20409.785985] BTRFS info (device dm-9): disk space caching is enabled
[20409.786182] BTRFS info (device dm-9): has skinny extents
[20409.787992] BTRFS info (device dm-9): checking UUID tree
[20410.027477] BTRFS: device fsid 1d5d69b4-dd43-49ca-915e-5945b37a40fa devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (766233)
[20410.105617] BTRFS info (device dm-11): flagging fs with big metadata feature
[20410.105841] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[20410.106107] BTRFS info (device dm-11): use zstd compression, level 3
[20410.106307] BTRFS info (device dm-11): turning on async discard
[20410.106483] BTRFS info (device dm-11): disk space caching is enabled
[20410.106751] BTRFS info (device dm-11): has skinny extents
[20410.108149] BTRFS info (device dm-11): checking UUID tree
[20410.264720] BTRFS info (device dm-11): flagging fs with big metadata feature
[20410.265049] BTRFS info (device dm-11): use zstd compression, level 3
[20410.265264] BTRFS info (device dm-11): turning on async discard
[20410.265442] BTRFS info (device dm-11): disk space caching is enabled
[20410.265623] BTRFS info (device dm-11): has skinny extents
[20410.518188] Buffer I/O error on dev dm-11, logical block 2621424, async page read
[20410.533326] btrfs_dev_stat_print_on_error: 960 callbacks suppressed
[20410.533330] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 1, rd 0, flush 0, corrupt 0, gen 0
[20410.533838] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 2, rd 0, flush 0, corrupt 0, gen 0
[20410.534172] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 3, rd 0, flush 0, corrupt 0, gen 0
[20410.534482] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 4, rd 0, flush 0, corrupt 0, gen 0
[20410.534783] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 5, rd 0, flush 0, corrupt 0, gen 0
[20410.535103] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 6, rd 0, flush 0, corrupt 0, gen 0
[20410.535837] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 7, rd 0, flush 0, corrupt 0, gen 0
[20410.536177] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 8, rd 0, flush 0, corrupt 0, gen 0
[20410.536490] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 9, rd 0, flush 0, corrupt 0, gen 0
[20410.536801] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 10, rd 0, flush 0, corrupt 0, gen 0
[20410.557485] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (765974)
[20410.558391] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (765974)
[20410.605634] BTRFS info (device dm-11): flagging fs with big metadata feature
[20410.605859] BTRFS info (device dm-11): use zstd compression, level 3
[20410.606057] BTRFS info (device dm-11): turning on async discard
[20410.606253] BTRFS info (device dm-11): disk space caching is enabled
[20410.606442] BTRFS info (device dm-11): has skinny extents
[20410.607861] BTRFS info (device dm-11): bdev /dev/mapper/error-test errs: wr 64, rd 0, flush 0, corrupt 0, gen 0
[20410.786134] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[20410.786402] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 766356, name: fsck.btrfs
[20410.786663] preempt_count: 101, expected: 0
[20410.786808] RCU nest depth: 1, expected: 0
[20410.786966] INFO: lockdep is turned off.
[20410.787115] Preemption disabled at:
[20410.787116] [] kick_process+0x14/0x70
[20410.787440] CPU: 0 PID: 766356 Comm: fsck.btrfs Tainted: G        W         5.17.0+ #640
[20410.787688] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[20410.787949] Call Trace:
[20410.788072]  
[20410.788190]  dump_stack_lvl+0x56/0x6f
[20410.788332]  __might_resched.cold+0xff/0x13a
[20410.788485]  blk_release_queue+0x24/0x120
[20410.788636]  kobject_put+0x7c/0x1d0
[20410.788791]  ? rcu_do_batch+0x1ac/0x570
[20410.788934]  blkg_free.part.0+0x41/0x60
[20410.789080]  rcu_do_batch+0x1e1/0x570
[20410.789216]  ? rcu_do_batch+0x1ac/0x570
[20410.789356]  rcu_core+0x2cb/0x460
[20410.789490]  __do_softirq+0x178/0x517
[20410.789631]  __irq_exit_rcu+0xe3/0x160
[20410.789769]  irq_exit_rcu+0xa/0x20
[20410.789903]  sysvec_apic_timer_interrupt+0xa2/0xd0
[20410.790064]  
[20410.790174]  
[20410.790284]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[20410.790447] RIP: 0010:check_preemption_disabled+0x17/0xe0
[20410.790613] Code: 01 e8 d9 88 f8 ff e9 79 ff ff ff cc cc cc cc cc cc cc cc 41 54 55 53 48 83 ec 08 65 44 8b 25 b0 57 1c 48 65 8b 05 59 bc 1c 48  ff ff ff 7f 74 0c 48 83 c4 08 44 89 e0 5b 5d 41 5c c3 9c 58 0f
[20410.791075] RSP: 0018:ffffb18fc55e3d28 EFLAGS: 00000296
[20410.791238] RAX: 0000000080000001 RBX: 0000000080000000 RCX: 0000000000000000
[20410.791431] RDX: 0000000000000000 RSI: ffffffffb887e4d9 RDI: ffffffffb883354b
[20410.791625] RBP: ffffe1670578cf40 R08: 0000000000000000 R09: 0000000000000000
[20410.791816] R10: 0000000000000000 R11: ffffffffb73cd700 R12: 0000000000000000
[20410.792013] R13: ffff9e5a27157f40 R14: ffffb18fc55e3da8 R15: ffff9e59c01e7c00
[20410.792204]  ? free_unref_page_list+0xd0/0x560
[20410.792357]  ? refill_obj_stock+0x141/0x450
[20410.792501]  rcu_is_watching+0xd/0x40
[20410.792639]  memcg_slab_free_hook+0x1b9/0x2b0
[20410.792791]  ? memcg_slab_free_hook+0x14a/0x2b0
[20410.792945]  ? remove_vma+0x6c/0x80
[20410.793079]  kmem_cache_free+0x149/0x3e0
[20410.793223]  remove_vma+0x6c/0x80
[20410.793357]  exit_mmap+0xc5/0x1b0
[20410.793491]  __mmput+0x4a/0x150
[20410.793621]  do_exit+0x325/0xbf0
[20410.793754]  ? trace_hardirqs_on+0x1b/0xe0
[20410.793896]  do_group_exit+0x33/0xb0
[20410.794042]  __x64_sys_exit_group+0x14/0x20
[20410.794190]  do_syscall_64+0x38/0x90
[20410.794326]  entry_SYSCALL_64_after_hwframe+0x44/0xae
[20410.794485] RIP: 0033:0x7fcd5adcb2d1
[20410.794622] Code: Unable to access opcode bytes at RIP 0x7fcd5adcb2a7.
[20410.794805] RSP: 002b:00007fff20257318 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7
[20410.795785] RAX: ffffffffffffffda RBX: 00007fcd5aec3490 RCX: 00007fcd5adcb2d1
[20410.795995] RDX: 000000000000003c RSI: 00000000000000e7 RDI: 0000000000000000
[20410.796189] RBP: 0000000000000000 R08: ffffffffffffff88 R09: 0000000000000001
[20410.796383] R10: 0000000000000008 R11: 0000000000000246 R12: 00007fcd5aec3490
[20410.796576] R13: 0000000000000001 R14: 00007fcd5aec3968 R15: 0000000000000000
[20410.796773]