[31186.701545] run fstests btrfs/146 at 2022-04-04 05:30:40
[31187.760728] BTRFS: device fsid c3c3e9f8-f0a7-4286-8933-4038447c797d devid 1 transid 6 /dev/dm-11 scanned by systemd-udevd (2800783)
[31187.764645] BTRFS: device fsid c3c3e9f8-f0a7-4286-8933-4038447c797d devid 3 transid 6 /dev/dm-7 scanned by systemd-udevd (2800781)
[31187.773455] BTRFS: device fsid c3c3e9f8-f0a7-4286-8933-4038447c797d devid 2 transid 6 /dev/mapper/vg0-lv8 scanned by mkfs.btrfs (2800775)
[31187.777689] BTRFS: device fsid c3c3e9f8-f0a7-4286-8933-4038447c797d devid 4 transid 6 /dev/mapper/vg0-lv6 scanned by mkfs.btrfs (2800775)
[31187.778935] BTRFS: device fsid c3c3e9f8-f0a7-4286-8933-4038447c797d devid 5 transid 6 /dev/mapper/vg0-lv5 scanned by mkfs.btrfs (2800775)
[31187.781127] BTRFS: device fsid c3c3e9f8-f0a7-4286-8933-4038447c797d devid 6 transid 6 /dev/mapper/vg0-lv4 scanned by mkfs.btrfs (2800775)
[31187.782825] BTRFS: device fsid c3c3e9f8-f0a7-4286-8933-4038447c797d devid 7 transid 6 /dev/mapper/vg0-lv3 scanned by mkfs.btrfs (2800775)
[31187.784767] BTRFS: device fsid c3c3e9f8-f0a7-4286-8933-4038447c797d devid 8 transid 6 /dev/mapper/vg0-lv2 scanned by mkfs.btrfs (2800775)
[31187.788182] BTRFS: device fsid c3c3e9f8-f0a7-4286-8933-4038447c797d devid 9 transid 6 /dev/mapper/vg0-lv1 scanned by mkfs.btrfs (2800775)
[31187.803099] BTRFS info: devid 6 device path /dev/mapper/vg0-lv4 changed to /dev/dm-4 scanned by systemd-udevd (2797747)
[31187.803959] BTRFS info (device dm-11): flagging fs with big metadata feature
[31187.804526] BTRFS info (device dm-11): using free space tree
[31187.804891] BTRFS info (device dm-11): has skinny extents
[31187.805124] BTRFS info: devid 6 device path /dev/dm-4 changed to /dev/mapper/vg0-lv4 scanned by systemd-udevd (2797747)
[31187.808364] BTRFS info: devid 5 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (2800778)
[31187.810432] BTRFS info: devid 5 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (2800778)
[31187.815023] BTRFS info: devid 9 device path /dev/mapper/vg0-lv1 changed to /dev/dm-1 scanned by systemd-udevd (2800779)
[31187.817209] BTRFS info: devid 9 device path /dev/dm-1 changed to /dev/mapper/vg0-lv1 scanned by systemd-udevd (2800779)
[31187.828175] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (2797805)
[31187.830450] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (2797805)
[31187.850209] BTRFS info: devid 3 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (2797815)
[31187.850588] BTRFS info (device dm-11): checking UUID tree
[31187.852499] BTRFS info: devid 3 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (2797815)
[31187.859943] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (2800817)
[31187.862244] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (2800817)
[31187.918648] BTRFS info: devid 3 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (2800783)
[31187.921542] BTRFS info: devid 3 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (2800783)
[31187.930647] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (2797805)
[31187.938156] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (2797805)
[31187.942709] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (2800781)
[31187.951956] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (2800781)
[31187.971441] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (2800783)
[31187.973689] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (2800783)
[31187.992877] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (2800783)
[31187.995115] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (2800783)
[31188.014313] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (2800783)
[31188.016610] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (2800783)
[31188.997130] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (2800783)
[31188.999172] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (2800783)
[31189.072019] btrfs_dev_stat_print_on_error: 23 callbacks suppressed
[31189.072024] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 1, rd 0, flush 0, corrupt 0, gen 0
[31189.073558] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 2, rd 0, flush 0, corrupt 0, gen 0
[31189.074535] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 3, rd 0, flush 0, corrupt 0, gen 0
[31189.075499] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 4, rd 0, flush 0, corrupt 0, gen 0
[31189.076537] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 5, rd 0, flush 0, corrupt 0, gen 0
[31189.077861] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 6, rd 0, flush 0, corrupt 0, gen 0
[31189.078900] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 7, rd 0, flush 0, corrupt 0, gen 0
[31189.079866] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 8, rd 0, flush 0, corrupt 0, gen 0
[31189.080881] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 9, rd 0, flush 0, corrupt 0, gen 0
[31189.082266] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 10, rd 0, flush 0, corrupt 0, gen 0
[31189.804837] btrfs_end_super_write: 34 callbacks suppressed
[31189.804841] BTRFS warning (device dm-11): lost page write due to IO error on /dev/mapper/error-test (-5)
[31189.805982] BTRFS error (device dm-11): error writing primary super block to device 1
[31189.901638] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (2800783)
[31189.904047] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (2800783)
[31189.935812] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (2800783)
[31189.938053] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (2800783)
[31190.034420] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[31190.034945] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/0
[31190.035461] preempt_count: 101, expected: 0
[31190.035726] RCU nest depth: 0, expected: 0
[31190.035989] INFO: lockdep is turned off.
[31190.036243] Preemption disabled at:
[31190.036244] [] schedule_preempt_disabled+0x1e/0x20
[31190.036881] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G        W         5.17.0+ #641
[31190.037392] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[31190.037923] Call Trace:
[31190.038083]  
[31190.038226]  dump_stack_lvl+0x56/0x6f
[31190.038464]  __might_resched.cold+0xff/0x13a
[31190.038740]  blk_release_queue+0x24/0x120
[31190.038997]  kobject_put+0x7c/0x1d0
[31190.039231]  ? rcu_do_batch+0x1ac/0x570
[31190.039476]  blkg_free.part.0+0x41/0x60
[31190.039723]  rcu_do_batch+0x1e1/0x570
[31190.039962]  ? rcu_do_batch+0x1ac/0x570
[31190.040221]  rcu_core+0x2cb/0x460
[31190.040444]  __do_softirq+0x178/0x517
[31190.040680]  __irq_exit_rcu+0xe3/0x160
[31190.040922]  irq_exit_rcu+0xa/0x20
[31190.041141]  sysvec_apic_timer_interrupt+0xa2/0xd0
[31190.041453]  
[31190.041590]  
[31190.041730]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[31190.042059] RIP: 0010:native_safe_halt+0xb/0x10
[31190.042385] Code: 56 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
[31190.043574] RSP: 0018:ffffffffaaa03ea8 EFLAGS: 00000246
[31190.043913] RAX: ffffffffa9e64a80 RBX: ffffffffaaa30a00 RCX: 0000000000000000
[31190.044379] RDX: ffffffffaaa30a00 RSI: ffffffffaa87e4d9 RDI: ffffffffa9e64bf6
[31190.044840] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000
[31190.045412] R10: 0000000000000000 R11: ffff94fcbbc20c88 R12: 0000000000000000
[31190.045867] R13: 0000000000000000 R14: ffffffffaaa30118 R15: 0000000000000073
[31190.046336]  ? mwait_idle+0x80/0x80
[31190.046569]  ? default_idle_call+0x26/0xa0
[31190.046839]  default_idle+0xa/0x10
[31190.047065]  default_idle_call+0x5e/0xa0
[31190.047332]  do_idle+0x1e9/0x240
[31190.047549]  cpu_startup_entry+0x19/0x20
[31190.047808]  start_kernel+0x98c/0x99e
[31190.048048]  ? copy_bootdata+0x18/0x55
[31190.048302]  secondary_startup_64_no_verify+0xd5/0xdb
[31190.048635]