[21022.894587] run fstests generic/331 at 2022-04-03 02:41:50
[21023.133726] BTRFS info (device dm-0): flagging fs with big metadata feature
[21023.133947] BTRFS info (device dm-0): using free space tree
[21023.134141] BTRFS info (device dm-0): has skinny extents
[21023.254293] BTRFS: device fsid 9d71a2af-bac0-4f4c-91c9-607ddbf13d74 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (815523)
[21023.283407] BTRFS info (device dm-9): flagging fs with big metadata feature
[21023.283626] BTRFS info (device dm-9): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[21023.283881] BTRFS info (device dm-9): use zstd compression, level 3
[21023.284066] BTRFS info (device dm-9): turning on async discard
[21023.284261] BTRFS info (device dm-9): disk space caching is enabled
[21023.284444] BTRFS info (device dm-9): has skinny extents
[21023.286194] BTRFS info (device dm-9): checking UUID tree
[21023.448811] BTRFS: device fsid 95ed59b3-d621-41c7-902d-73cbb8d1f573 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (815600)
[21023.546412] BTRFS info (device dm-11): flagging fs with big metadata feature
[21023.546638] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[21023.546896] BTRFS info (device dm-11): use zstd compression, level 3
[21023.547085] BTRFS info (device dm-11): turning on async discard
[21023.547288] BTRFS info (device dm-11): disk space caching is enabled
[21023.547476] BTRFS info (device dm-11): has skinny extents
[21023.549081] BTRFS info (device dm-11): checking UUID tree
[21023.649811] BTRFS info (device dm-11): flagging fs with big metadata feature
[21023.650035] BTRFS info (device dm-11): use zstd compression, level 3
[21023.650248] BTRFS info (device dm-11): turning on async discard
[21023.650431] BTRFS info (device dm-11): disk space caching is enabled
[21023.650617] BTRFS info (device dm-11): has skinny extents
[21024.084361] Buffer I/O error on dev dm-11, logical block 2621424, async page read
[21024.172414] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (813562)
[21024.173233] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (813562)
[21024.209964] BTRFS info (device dm-11): flagging fs with big metadata feature
[21024.210275] BTRFS info (device dm-11): use zstd compression, level 3
[21024.210541] BTRFS info (device dm-11): turning on async discard
[21024.210747] BTRFS info (device dm-11): disk space caching is enabled
[21024.210941] BTRFS info (device dm-11): has skinny extents
[21024.212482] BTRFS info (device dm-11): bdev /dev/mapper/error-test errs: wr 320, rd 0, flush 0, corrupt 0, gen 0
[21024.437118] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[21024.437391] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 815728, name: fsck.btrfs
[21024.437644] preempt_count: 100, expected: 0
[21024.437789] RCU nest depth: 0, expected: 0
[21024.437942] INFO: lockdep is turned off.
[21024.438082] Preemption disabled at:
[21024.438083] [] __do_softirq+0x5e/0x517
[21024.438401] CPU: 1 PID: 815728 Comm: fsck.btrfs Tainted: G        W         5.17.0+ #640
[21024.438654] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[21024.438905] Call Trace:
[21024.439025]  
[21024.439138]  dump_stack_lvl+0x56/0x6f
[21024.439277]  __might_resched.cold+0xff/0x13a
[21024.439428]  blk_release_queue+0x24/0x120
[21024.439576]  kobject_put+0x7c/0x1d0
[21024.439711]  ? rcu_do_batch+0x1ac/0x570
[21024.445295]  blkg_free.part.0+0x41/0x60
[21024.445437]  rcu_do_batch+0x1e1/0x570
[21024.445577]  ? rcu_do_batch+0x1ac/0x570
[21024.445720]  rcu_core+0x2cb/0x460
[21024.445852]  __do_softirq+0x178/0x517
[21024.445993]  __irq_exit_rcu+0xe3/0x160
[21024.446135]  irq_exit_rcu+0xa/0x20
[21024.446266]  sysvec_apic_timer_interrupt+0xa2/0xd0
[21024.446421]  
[21024.446534]  
[21024.446647]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[21024.446808] RIP: 0010:release_pages+0xd0/0x6b0
[21024.446965] Code: 20 0f 84 63 03 00 00 48 8b 05 fc 4b b1 01 48 39 c5 74 c0 48 8b 45 00 48 c1 e8 33 83 e0 07 83 f8 04 0f 84 79 ff ff ff 8b 45 34 <85> c0 0f 84 97 03 00 00 f0 ff 4d 34 75 9b 48 8b 45 00 a9 00 00 01
[21024.447421] RSP: 0018:ffffb18fc1933d68 EFLAGS: 00000293
[21024.447582] RAX: 000000000000008d RBX: ffff9e59c08850e8 RCX: 0000000000000000
[21024.447773] RDX: 0017ffffc0000000 RSI: 00000000000000c8 RDI: ffff9e59c0885010
[21024.447968] RBP: ffffe16704613100 R08: ffff9e5a3bd2e8f0 R09: 0000000000000000
[21024.448158] R10: 0000000000000001 R11: ffffffffb73cd75c R12: ffff9e59c0885650
[21024.448353] R13: ffff9e5a25415538 R14: 0000000025415538 R15: 0000000000000000
[21024.448545]  ? free_unref_page_list+0x12c/0x560
[21024.448704]  tlb_finish_mmu+0x7a/0x1a0
[21024.448847]  exit_mmap+0xa8/0x1b0
[21024.448983]  __mmput+0x4a/0x150
[21024.449114]  do_exit+0x325/0xbf0
[21024.449247]  ? trace_hardirqs_on+0x1b/0xe0
[21024.449391]  do_group_exit+0x33/0xb0
[21024.449528]  __x64_sys_exit_group+0x14/0x20
[21024.449675]  do_syscall_64+0x38/0x90
[21024.449811]  entry_SYSCALL_64_after_hwframe+0x44/0xae
[21024.449973] RIP: 0033:0x7f14cd7942d1
[21024.450113] Code: Unable to access opcode bytes at RIP 0x7f14cd7942a7.
[21024.450297] RSP: 002b:00007ffd90c24f38 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7
[21024.450535] RAX: ffffffffffffffda RBX: 00007f14cd88c490 RCX: 00007f14cd7942d1
[21024.450728] RDX: 000000000000003c RSI: 00000000000000e7 RDI: 0000000000000000
[21024.450924] RBP: 0000000000000000 R08: ffffffffffffff88 R09: 0000000000000001
[21024.451119] R10: 0000000000000008 R11: 0000000000000246 R12: 00007f14cd88c490
[21024.451313] R13: 0000000000000001 R14: 00007f14cd88c968 R15: 0000000000000000
[21024.451511]