[ 8862.223247] run fstests generic/271 at 2022-04-03 23:19:06
[ 8863.577553] BTRFS: device fsid c11dfea9-e5df-436e-b80b-f4d19d821c0e devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (1728597)
[ 8863.592323] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 8863.592544] BTRFS info (device dm-9): turning on async discard
[ 8863.592720] BTRFS info (device dm-9): disk space caching is enabled
[ 8863.592899] BTRFS info (device dm-9): has skinny extents
[ 8863.594518] BTRFS info (device dm-9): checking UUID tree
[ 8865.071026] BTRFS: device fsid 96086e02-6981-49d8-baf6-9d79a2624828 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (1728673)
[ 8865.154205] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 8865.154429] BTRFS info (device dm-11): turning on async discard
[ 8865.154606] BTRFS info (device dm-11): disk space caching is enabled
[ 8865.154788] BTRFS info (device dm-11): has skinny extents
[ 8865.157267] BTRFS info (device dm-11): checking UUID tree
[ 8866.030152] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 8866.031077] BTRFS info (device dm-11): turning on async discard
[ 8866.032295] BTRFS info (device dm-11): disk space caching is enabled
[ 8866.033112] BTRFS info (device dm-11): has skinny extents
[ 8866.566328] Buffer I/O error on dev dm-11, logical block 2621424, async page read
[ 8866.607132] btrfs_dev_stat_print_on_error: 3 callbacks suppressed
[ 8866.607138] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 1, rd 0, flush 0, corrupt 0, gen 0
[ 8866.608230] BTRFS warning (device dm-11): direct IO failed ino 259 rw 1,34817 sector 0x126800 len 1957888 err no 10
[ 8866.634718] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (1728188)
[ 8866.635681] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (1728188)
[ 8866.848825] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 8866.849824] BTRFS info (device dm-11): turning on async discard
[ 8866.850705] BTRFS info (device dm-11): disk space caching is enabled
[ 8866.882729] BTRFS info (device dm-11): has skinny extents
[ 8866.890402] BTRFS info (device dm-11): bdev /dev/mapper/error-test errs: wr 1, rd 0, flush 0, corrupt 0, gen 0
[ 8867.157014] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[ 8867.157416] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 1728796, name: fsck.btrfs
[ 8867.157785] preempt_count: 100, expected: 0
[ 8867.158017] RCU nest depth: 0, expected: 0
[ 8867.158235] INFO: lockdep is turned off.
[ 8867.158461] Preemption disabled at:
[ 8867.158463] [] __do_softirq+0x5e/0x517
[ 8867.158914] CPU: 0 PID: 1728796 Comm: fsck.btrfs Tainted: G        W         5.17.0+ #641
[ 8867.159280] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[ 8867.159647] Call Trace:
[ 8867.159818]  
[ 8867.159978]  dump_stack_lvl+0x56/0x6f
[ 8867.160184]  __might_resched.cold+0xff/0x13a
[ 8867.160399]  blk_release_queue+0x24/0x120
[ 8867.160604]  kobject_put+0x7c/0x1d0
[ 8867.160802]  ? rcu_do_batch+0x1ac/0x570
[ 8867.161009]  blkg_free.part.0+0x41/0x60
[ 8867.161213]  rcu_do_batch+0x1e1/0x570
[ 8867.161407]  ? rcu_do_batch+0x1ac/0x570
[ 8867.161613]  rcu_core+0x2cb/0x460
[ 8867.161803]  __do_softirq+0x178/0x517
[ 8867.162005]  __irq_exit_rcu+0xe3/0x160
[ 8867.162213]  irq_exit_rcu+0xa/0x20
[ 8867.162409]  sysvec_apic_timer_interrupt+0xa2/0xd0
[ 8867.162629]  
[ 8867.162792]  
[ 8867.162955]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[ 8867.163186] RIP: 0010:do_mmap+0x5/0x530
[ 8867.163399] Code: a2 09 00 4c 89 ef 49 89 dd e8 17 4b db ff 4c 8b 73 50 e9 11 fe ff ff 66 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 00 0f 1f 44 00 00 <41> 57 41 56 41 55 49 89 cd 41 54 49 c7 c4 ea ff ff ff 55 53 65 48
[ 8867.164058] RSP: 0018:ffffb12646117cd0 EFLAGS: 00000246
[ 8867.164289] RAX: ffffb12646117d08 RBX: 0000000000000012 RCX: 0000000000000005
[ 8867.164558] RDX: 00000000000d1000 RSI: 000055e07015e000 RDI: ffff9be2987dac00
[ 8867.164832] RBP: ffff9be2987dac00 R08: 0000000000000012 R09: 000000000000002d
[ 8867.165104] R10: 0000000000000000 R11: ffff9be2bb0d8ca8 R12: 0000000000000005
[ 8867.165382] R13: ffffb12646117d10 R14: 000000000000002d R15: ffff9be2ba2adb00
[ 8867.165658]  vm_mmap_pgoff+0xb8/0x150
[ 8867.165859]  ? __vm_munmap+0x85/0xf0
[ 8867.166063]  elf_map+0x64/0xf0
[ 8867.166252]  load_elf_binary+0x614/0x1720
[ 8867.166471]  bprm_execve+0x307/0x860
[ 8867.166672]  do_execveat_common+0x1b5/0x230
[ 8867.166878]  __x64_sys_execve+0x39/0x50
[ 8867.167080]  do_syscall_64+0x38/0x90
[ 8867.167284]  entry_SYSCALL_64_after_hwframe+0x44/0xae
[ 8867.167510] RIP: 0033:0x7f847dca52fb
[ 8867.167705] Code: Unable to access opcode bytes at RIP 0x7f847dca52d1.
[ 8867.167968] RSP: 002b:00007ffd3d771a38 EFLAGS: 00000202 ORIG_RAX: 000000000000003b
[ 8867.168318] RAX: ffffffffffffffda RBX: 0000559f031b7260 RCX: 00007f847dca52fb
[ 8867.168591] RDX: 00007ffd3d772ef8 RSI: 00007ffd3d771a80 RDI: 0000559f031b7260
[ 8867.168862] RBP: 0000559f031b7280 R08: 0000000000000000 R09: 00007f847dafb010
[ 8867.169128] R10: 00007f847daddc40 R11: 0000000000000202 R12: 0000000000000000
[ 8867.169404] R13: 0000559f031b7140 R14: 0000559f01dd7220 R15: 0000000000000003
[ 8867.169680]