[19487.459892] run fstests btrfs/146 at 2022-04-04 02:16:11
[19488.586115] BTRFS: device fsid 228e6d89-d103-4239-8a20-624753d20afa devid 1 transid 6 /dev/dm-11 scanned by systemd-udevd (3151041)
[19488.598845] BTRFS: device fsid 228e6d89-d103-4239-8a20-624753d20afa devid 2 transid 6 /dev/dm-8 scanned by systemd-udevd (3153999)
[19488.602166] BTRFS: device fsid 228e6d89-d103-4239-8a20-624753d20afa devid 3 transid 6 /dev/mapper/vg0-lv7 scanned by mkfs.btrfs (3153995)
[19488.602548] BTRFS: device fsid 228e6d89-d103-4239-8a20-624753d20afa devid 4 transid 6 /dev/mapper/vg0-lv6 scanned by mkfs.btrfs (3153995)
[19488.602982] BTRFS: device fsid 228e6d89-d103-4239-8a20-624753d20afa devid 5 transid 6 /dev/mapper/vg0-lv5 scanned by mkfs.btrfs (3153995)
[19488.603496] BTRFS: device fsid 228e6d89-d103-4239-8a20-624753d20afa devid 6 transid 6 /dev/mapper/vg0-lv4 scanned by mkfs.btrfs (3153995)
[19488.603941] BTRFS: device fsid 228e6d89-d103-4239-8a20-624753d20afa devid 7 transid 6 /dev/mapper/vg0-lv3 scanned by mkfs.btrfs (3153995)
[19488.604599] BTRFS: device fsid 228e6d89-d103-4239-8a20-624753d20afa devid 8 transid 6 /dev/mapper/vg0-lv2 scanned by mkfs.btrfs (3153995)
[19488.606300] BTRFS: device fsid 228e6d89-d103-4239-8a20-624753d20afa devid 9 transid 6 /dev/mapper/vg0-lv1 scanned by mkfs.btrfs (3153995)
[19488.623687] _btrfs_printk: 8 callbacks suppressed
[19488.623690] BTRFS info (device dm-11): flagging fs with big metadata feature
[19488.624160] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_ZSTD (0x10)
[19488.624477] BTRFS info (device dm-11): use zstd compression, level 3
[19488.624681] BTRFS info (device dm-11): turning on async discard
[19488.624873] BTRFS info (device dm-11): disk space caching is enabled
[19488.625074] BTRFS info (device dm-11): has skinny extents
[19488.632595] BTRFS info: devid 9 device path /dev/mapper/vg0-lv1 changed to /dev/dm-1 scanned by systemd-udevd (3154002)
[19488.637840] BTRFS info: devid 8 device path /dev/mapper/vg0-lv2 changed to /dev/dm-2 scanned by systemd-udevd (3151030)
[19488.642826] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (3153999)
[19488.644390] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (3153999)
[19488.645998] BTRFS info: devid 9 device path /dev/dm-1 changed to /dev/mapper/vg0-lv1 scanned by systemd-udevd (3154002)
[19488.649115] BTRFS info: devid 8 device path /dev/dm-2 changed to /dev/mapper/vg0-lv2 scanned by systemd-udevd (3151030)
[19488.650292] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (3151026)
[19488.652690] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (3151026)
[19488.659849] BTRFS info: devid 6 device path /dev/mapper/vg0-lv4 changed to /dev/dm-4 scanned by systemd-udevd (3154001)
[19488.662278] BTRFS info: devid 5 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (3154003)
[19488.664161] BTRFS info: devid 5 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (3154003)
[19488.665657] BTRFS info: devid 6 device path /dev/dm-4 changed to /dev/mapper/vg0-lv4 scanned by systemd-udevd (3154001)
[19488.679315] BTRFS info (device dm-11): checking UUID tree
[19488.729005] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (3151041)
[19488.731989] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (3151041)
[19489.071529] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (3151041)
[19489.073239] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (3151041)
[19489.149954] btrfs_dev_stat_print_on_error: 23 callbacks suppressed
[19489.149959] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 1, rd 0, flush 0, corrupt 0, gen 0
[19489.150838] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 2, rd 0, flush 0, corrupt 0, gen 0
[19489.151773] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 3, rd 0, flush 0, corrupt 0, gen 0
[19489.155130] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 4, rd 0, flush 0, corrupt 0, gen 0
[19489.161207] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 5, rd 0, flush 0, corrupt 0, gen 0
[19489.168136] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 6, rd 0, flush 0, corrupt 0, gen 0
[19489.174228] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 7, rd 0, flush 0, corrupt 0, gen 0
[19489.181164] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 8, rd 0, flush 0, corrupt 0, gen 0
[19489.181703] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 9, rd 0, flush 0, corrupt 0, gen 0
[19489.182184] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 10, rd 0, flush 0, corrupt 0, gen 0
[19489.340063] btrfs_end_super_write: 34 callbacks suppressed
[19489.340300] BTRFS warning (device dm-11): lost page write due to IO error on /dev/mapper/error-test (-5)
[19489.340679] BTRFS error (device dm-11): error writing primary super block to device 1
[19489.433481] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (3151041)
[19489.435402] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (3151041)
[19489.467393] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (3151041)
[19489.469212] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (3151041)
[19489.656093] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[19489.656396] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/1
[19489.656670] preempt_count: 101, expected: 0
[19489.656828] RCU nest depth: 0, expected: 0
[19489.656991] INFO: lockdep is turned off.
[19489.657163] Preemption disabled at:
[19489.657164] [] ___slab_alloc+0x961/0xf50
[19489.657506] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G        W         5.17.0+ #641
[19489.657768] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[19489.658044] Call Trace:
[19489.658179]  
[19489.658302]  dump_stack_lvl+0x56/0x6f
[19489.658466]  __might_resched.cold+0xff/0x13a
[19489.658632]  blk_release_queue+0x24/0x120
[19489.658791]  kobject_put+0x7c/0x1d0
[19489.658940]  ? rcu_do_batch+0x1ac/0x570
[19489.659099]  blkg_free.part.0+0x41/0x60
[19489.659255]  rcu_do_batch+0x1e1/0x570
[19489.659415]  ? rcu_do_batch+0x1ac/0x570
[19489.659575]  rcu_core+0x2cb/0x460
[19489.659722]  __do_softirq+0x178/0x517
[19489.659875]  __irq_exit_rcu+0xe3/0x160
[19489.660031]  irq_exit_rcu+0xa/0x20
[19489.660190]  sysvec_apic_timer_interrupt+0xa2/0xd0
[19489.660374]  
[19489.660498]  
[19489.660622]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[19489.660812] RIP: 0010:native_safe_halt+0xb/0x10
[19489.660978] Code: 5d ff ff ff 7f 5b c3 65 48 8b 04 25 c0 fe 01 00 f0 80 48 02 20 48 8b 00 a8 08 75 c3 eb 80 cc eb 07 0f 00 2d 79 b7 5b 00 fb f4  0f 1f 40 00 eb 07 0f 00 2d 69 b7 5b 00 f4 c3 cc cc cc cc cc 0f
[19489.662157] RSP: 0018:ffffb12640093ef8 EFLAGS: 00000246
[19489.662356] RAX: ffffffffa2e64a80 RBX: ffff9be280378000 RCX: 0000000000000000
[19489.662586] RDX: ffff9be280378000 RSI: ffffffffa387e4d9 RDI: ffffffffa2e64bf6
[19489.662800] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
[19489.663025] R10: 0000000000000000 R11: ffff9be2fbd20c88 R12: 0000000000000000
[19489.663248] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[19489.663480]  ? mwait_idle+0x80/0x80
[19489.663643]  ? default_idle_call+0x26/0xa0
[19489.663823]  default_idle+0xa/0x10
[19489.663972]  default_idle_call+0x5e/0xa0
[19489.664145]  do_idle+0x1e9/0x240
[19489.664295]  cpu_startup_entry+0x19/0x20
[19489.664459]  secondary_startup_64_no_verify+0xd5/0xdb
[19489.664671]