[25448.455957] run fstests btrfs/146 at 2022-04-03 04:06:35
[25449.587261] BTRFS: device fsid 535331fb-73fc-4598-8bfc-12044caba894 devid 1 transid 6 /dev/dm-11 scanned by systemd-udevd (2674784)
[25449.596533] BTRFS: device fsid 535331fb-73fc-4598-8bfc-12044caba894 devid 2 transid 6 /dev/dm-8 scanned by systemd-udevd (2674781)
[25449.607713] BTRFS: device fsid 535331fb-73fc-4598-8bfc-12044caba894 devid 3 transid 6 /dev/dm-7 scanned by systemd-udevd (2674784)
[25449.612720] BTRFS: device fsid 535331fb-73fc-4598-8bfc-12044caba894 devid 4 transid 6 /dev/dm-6 scanned by systemd-udevd (2672354)
[25449.623435] BTRFS: device fsid 535331fb-73fc-4598-8bfc-12044caba894 devid 5 transid 6 /dev/mapper/vg0-lv5 scanned by mkfs.btrfs (2674775)
[25449.624874] BTRFS: device fsid 535331fb-73fc-4598-8bfc-12044caba894 devid 6 transid 6 /dev/mapper/vg0-lv4 scanned by mkfs.btrfs (2674775)
[25449.626808] BTRFS: device fsid 535331fb-73fc-4598-8bfc-12044caba894 devid 7 transid 6 /dev/mapper/vg0-lv3 scanned by mkfs.btrfs (2674775)
[25449.627962] BTRFS: device fsid 535331fb-73fc-4598-8bfc-12044caba894 devid 8 transid 6 /dev/mapper/vg0-lv2 scanned by mkfs.btrfs (2674775)
[25449.630608] BTRFS: device fsid 535331fb-73fc-4598-8bfc-12044caba894 devid 9 transid 6 /dev/mapper/vg0-lv1 scanned by mkfs.btrfs (2674775)
[25449.644737] BTRFS info (device dm-11): flagging fs with big metadata feature
[25449.645441] BTRFS info (device dm-11): using free space tree
[25449.645710] BTRFS info: devid 7 device path /dev/mapper/vg0-lv3 changed to /dev/dm-3 scanned by systemd-udevd (2672294)
[25449.645908] BTRFS info (device dm-11): has skinny extents
[25449.648857] BTRFS info: devid 9 device path /dev/mapper/vg0-lv1 changed to /dev/dm-1 scanned by systemd-udevd (2672354)
[25449.650814] BTRFS info: devid 9 device path /dev/dm-1 changed to /dev/mapper/vg0-lv1 scanned by systemd-udevd (2672354)
[25449.651896] BTRFS info: devid 7 device path /dev/dm-3 changed to /dev/mapper/vg0-lv3 scanned by systemd-udevd (2672294)
[25449.662352] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (2674780)
[25449.665211] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (2674780)
[25449.673692] BTRFS info: devid 3 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (2674779)
[25449.676266] BTRFS info: devid 3 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (2674779)
[25449.679529] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (2674816)
[25449.681441] BTRFS info: devid 4 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (2673522)
[25449.682296] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (2674816)
[25449.683495] BTRFS info: devid 4 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (2673522)
[25449.688445] BTRFS info: devid 5 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (2672349)
[25449.689823] BTRFS info (device dm-11): checking UUID tree
[25449.691386] BTRFS info: devid 5 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (2672349)
[25449.760079] BTRFS info: devid 4 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (2674784)
[25449.762360] BTRFS info: devid 4 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (2674784)
[25449.778801] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (2674781)
[25449.781834] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (2674781)
[25450.968736] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (2674784)
[25450.970723] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (2674784)
[25451.039685] btrfs_dev_stat_print_on_error: 7 callbacks suppressed
[25451.039688] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 1, rd 0, flush 0, corrupt 0, gen 0
[25451.041061] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 2, rd 0, flush 0, corrupt 0, gen 0
[25451.041948] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 3, rd 0, flush 0, corrupt 0, gen 0
[25451.042836] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 4, rd 0, flush 0, corrupt 0, gen 0
[25451.043827] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 5, rd 0, flush 0, corrupt 0, gen 0
[25451.045051] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 6, rd 0, flush 0, corrupt 0, gen 0
[25451.045977] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 7, rd 0, flush 0, corrupt 0, gen 0
[25451.046839] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 8, rd 0, flush 0, corrupt 0, gen 0
[25451.047738] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 9, rd 0, flush 0, corrupt 0, gen 0
[25451.048927] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 10, rd 0, flush 0, corrupt 0, gen 0
[25452.524052] btrfs_end_super_write: 34 callbacks suppressed
[25452.524058] BTRFS warning (device dm-11): lost page write due to IO error on /dev/mapper/error-test (-5)
[25452.525678] BTRFS error (device dm-11): error writing primary super block to device 1
[25452.760790] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (2674784)
[25452.762649] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (2674784)
[25452.789955] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (2674784)
[25452.791827] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (2674784)
[25453.352541] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[25453.353115] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 2674362, name: 146
[25453.353674] preempt_count: 100, expected: 0
[25453.353971] RCU nest depth: 1, expected: 0
[25453.354264] INFO: lockdep is turned off.
[25453.354551] Preemption disabled at:
[25453.354552] [] __do_softirq+0x5e/0x517
[25453.355178] CPU: 1 PID: 2674362 Comm: 146 Tainted: G        W         5.17.0+ #640
[25453.355707] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[25453.356294] Call Trace:
[25453.356473]  
[25453.356623]  dump_stack_lvl+0x56/0x6f
[25453.356885]  __might_resched.cold+0xff/0x13a
[25453.357194]  blk_release_queue+0x24/0x120
[25453.357557]  kobject_put+0x7c/0x1d0
[25453.357810]  ? rcu_do_batch+0x1ac/0x570
[25453.358082]  blkg_free.part.0+0x41/0x60
[25453.358365]  rcu_do_batch+0x1e1/0x570
[25453.358626]  ? rcu_do_batch+0x1ac/0x570
[25453.358900]  rcu_core+0x2cb/0x460
[25453.359138]  __do_softirq+0x178/0x517
[25453.359402]  __irq_exit_rcu+0xe3/0x160
[25453.359672]  irq_exit_rcu+0xa/0x20
[25453.359917]  sysvec_apic_timer_interrupt+0xa2/0xd0
[25453.360257]  
[25453.360411]  
[25453.360566]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[25453.360927] RIP: 0010:count_memcg_events.constprop.0+0x4a/0x50
[25453.361342] Code: 00 00 00 41 5c e9 e6 a1 08 00 e8 41 bb f0 ff ba 01 00 00 00 44 89 e6 48 89 ef e8 d1 a1 08 00 e8 ac bd f0 ff fb 0f 1f 44 00 00 <5d> 41 5c c3 66 90 41 54 41 89 f4 55 48 89 fd 9c 58 0f 1f 40 00 48
[25453.362622] RSP: 0000:ffffa8c182ddfe90 EFLAGS: 00000246
[25453.362989] RAX: 0000000080000000 RBX: 0000000000000255 RCX: 0000000000000000
[25453.363486] RDX: 0000000000000018 RSI: ffffffffac7f78ef RDI: ffffffffab3a04a4
[25453.363980] RBP: ffff9da1288c6000 R08: 0000000000000000 R09: 0000000000000000
[25453.364476] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000014
[25453.364973] R13: 000055dbe66c7550 R14: ffffa8c182ddff58 R15: ffff9da110445bb8
[25453.365471]  ? count_memcg_events.constprop.0+0x44/0x50
[25453.365841]  handle_mm_fault+0xa8/0x3a0
[25453.366115]  do_user_addr_fault+0x1e9/0x6b0
[25453.366416]  ? restore_altstack+0x3c/0x50
[25453.366703]  exc_page_fault+0x78/0x280
[25453.366970]  ? asm_exc_page_fault+0x8/0x30
[25453.367265]  asm_exc_page_fault+0x1e/0x30
[25453.367549] RIP: 0033:0x7f9166737739
[25453.367803] Code: 48 f0 4c 39 f9 0f 84 ae 03 00 00 49 8b 57 18 4c 39 7a 10 0f 85 c8 0a 00 00 4c 8d 0d d1 92 13 00 4b 83 4c 2f 08 01 48 89 50 08 <48> 89 4a 10 4c 39 cd 74 05 49 83 4f 08 04 48 8b 15 02 86 13 00 64
[25453.369083] RSP: 002b:00007ffe896b4e30 EFLAGS: 00010206
[25453.369451] RAX: 00007f9166870a80 RBX: 0000000000000010 RCX: 00007f9166870a70
[25453.369947] RDX: 000055dbe66c7540 RSI: 00007f9166870a00 RDI: 00007f9166870a00
[25453.370443] RBP: 00007f9166870a00 R08: 0000000000000000 R09: 00007f9166870a00
[25453.370939] R10: 0000000000000000 R11: 0000000000000003 R12: 0000000000000002
[25453.371434] R13: 0000000000000020 R14: 000055dbe6950200 R15: 000055dbe6974070
[25453.371932]