[ 3905.803833] run fstests btrfs/160 at 2022-04-02 21:56:33
[ 3906.137568] BTRFS info (device dm-0): flagging fs with big metadata feature
[ 3906.137819] BTRFS info (device dm-0): using free space tree
[ 3906.138015] BTRFS info (device dm-0): has skinny extents
[ 3907.608600] BTRFS: device fsid 875a7d52-29b0-413a-be56-b7d68b9b8510 devid 1 transid 6 /dev/dm-11 scanned by systemd-udevd (492357)
[ 3907.617110] BTRFS: device fsid 875a7d52-29b0-413a-be56-b7d68b9b8510 devid 2 transid 6 /dev/dm-8 scanned by systemd-udevd (492396)
[ 3907.625416] BTRFS: device fsid 875a7d52-29b0-413a-be56-b7d68b9b8510 devid 3 transid 6 /dev/dm-7 scanned by systemd-udevd (492357)
[ 3907.629133] BTRFS: device fsid 875a7d52-29b0-413a-be56-b7d68b9b8510 devid 4 transid 6 /dev/dm-6 scanned by systemd-udevd (492467)
[ 3907.636901] BTRFS: device fsid 875a7d52-29b0-413a-be56-b7d68b9b8510 devid 5 transid 6 /dev/dm-5 scanned by systemd-udevd (492396)
[ 3907.637585] BTRFS: device fsid 875a7d52-29b0-413a-be56-b7d68b9b8510 devid 6 transid 6 /dev/mapper/vg0-lv4 scanned by mkfs.btrfs (492896)
[ 3907.638194] BTRFS: device fsid 875a7d52-29b0-413a-be56-b7d68b9b8510 devid 7 transid 6 /dev/mapper/vg0-lv3 scanned by mkfs.btrfs (492896)
[ 3907.638775] BTRFS: device fsid 875a7d52-29b0-413a-be56-b7d68b9b8510 devid 8 transid 6 /dev/mapper/vg0-lv2 scanned by mkfs.btrfs (492896)
[ 3907.640164] BTRFS: device fsid 875a7d52-29b0-413a-be56-b7d68b9b8510 devid 9 transid 6 /dev/mapper/vg0-lv1 scanned by mkfs.btrfs (492896)
[ 3907.653813] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 3907.654076] BTRFS info (device dm-11): turning on async discard
[ 3907.654291] BTRFS info (device dm-11): disk space caching is enabled
[ 3907.654496] BTRFS info (device dm-11): has skinny extents
[ 3907.656453] BTRFS info: devid 8 device path /dev/mapper/vg0-lv2 changed to /dev/dm-2 scanned by systemd-udevd (492467)
[ 3907.658296] BTRFS info: devid 8 device path /dev/dm-2 changed to /dev/mapper/vg0-lv2 scanned by systemd-udevd (492467)
[ 3907.658651] BTRFS info: devid 9 device path /dev/mapper/vg0-lv1 changed to /dev/dm-1 scanned by systemd-udevd (492901)
[ 3907.660496] BTRFS info: devid 9 device path /dev/dm-1 changed to /dev/mapper/vg0-lv1 scanned by systemd-udevd (492901)
[ 3907.677640] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (492396)
[ 3907.679457] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (492396)
[ 3907.686585] BTRFS info: devid 3 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (492906)
[ 3907.688412] BTRFS info: devid 3 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (492906)
[ 3907.694642] BTRFS info: devid 5 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (492469)
[ 3907.696855] BTRFS info: devid 5 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (492469)
[ 3907.704835] BTRFS info: devid 4 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (492464)
[ 3907.706978] BTRFS info: devid 4 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (492464)
[ 3907.709372] BTRFS info (device dm-11): checking UUID tree
[ 3907.711118] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (492937)
[ 3907.722525] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (492937)
[ 3907.764453] BTRFS info: devid 4 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (492357)
[ 3907.769498] BTRFS info: devid 4 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (492357)
[ 3907.871261] BTRFS info: devid 5 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (492396)
[ 3907.873128] BTRFS info: devid 5 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (492396)
[ 3907.874063] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (492467)
[ 3907.875778] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (492467)
[ 3907.878323] BTRFS info: devid 4 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (492357)
[ 3907.880146] BTRFS info: devid 4 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (492357)
[ 3907.885232] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (492902)
[ 3907.887114] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (492902)
[ 3907.906717] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (492467)
[ 3907.908521] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (492467)
[ 3907.919069] BTRFS info: devid 4 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (492357)
[ 3907.920903] BTRFS info: devid 4 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (492357)
[ 3907.942688] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (492396)
[ 3907.944493] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (492396)
[ 3907.953747] btrfs_dev_stat_print_on_error: 38 callbacks suppressed
[ 3907.953751] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 1, rd 0, flush 0, corrupt 0, gen 0
[ 3907.956426] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 2, rd 0, flush 0, corrupt 0, gen 0
[ 3907.956908] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 3, rd 0, flush 0, corrupt 0, gen 0
[ 3907.957766] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 4, rd 0, flush 0, corrupt 0, gen 0
[ 3907.958588] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 5, rd 0, flush 0, corrupt 0, gen 0
[ 3907.959199] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 6, rd 0, flush 0, corrupt 0, gen 0
[ 3907.959676] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 7, rd 0, flush 0, corrupt 0, gen 0
[ 3907.960365] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 8, rd 0, flush 0, corrupt 0, gen 0
[ 3907.965743] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 9, rd 0, flush 0, corrupt 0, gen 0
[ 3907.967211] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 10, rd 0, flush 0, corrupt 0, gen 0
[ 3907.968547] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (492357)
[ 3907.971729] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (492357)
[ 3908.101182] BTRFS warning (device dm-11): lost page write due to IO error on /dev/mapper/error-test (-5)
[ 3908.101567] BTRFS warning (device dm-11): lost page write due to IO error on /dev/mapper/error-test (-5)
[ 3908.102254] BTRFS error (device dm-11): error writing primary super block to device 1
[ 3908.139163] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (492357)
[ 3908.141113] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (492357)
[ 3908.229038] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[ 3908.229347] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 493004, name: udevadm
[ 3908.229634] preempt_count: 100, expected: 0
[ 3908.229795] RCU nest depth: 1, expected: 0
[ 3908.229954] INFO: lockdep is turned off.
[ 3908.230139] Preemption disabled at:
[ 3908.230140] [] __do_softirq+0x5e/0x517
[ 3908.230482] CPU: 0 PID: 493004 Comm: udevadm Tainted: G W 5.17.0+ #640
[ 3908.230757] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[ 3908.231052] Call Trace:
[ 3908.231184]
[ 3908.231312] dump_stack_lvl+0x56/0x6f
[ 3908.231467] __might_resched.cold+0xff/0x13a
[ 3908.231641] blk_release_queue+0x24/0x120
[ 3908.231805] kobject_put+0x7c/0x1d0
[ 3908.231961] ? rcu_do_batch+0x1ac/0x570
[ 3908.232152] blkg_free.part.0+0x41/0x60
[ 3908.232383] rcu_do_batch+0x1e1/0x570
[ 3908.238990] ? rcu_do_batch+0x1ac/0x570
[ 3908.239163] rcu_core+0x2cb/0x460
[ 3908.239317] __do_softirq+0x178/0x517
[ 3908.239480] __irq_exit_rcu+0xe3/0x160
[ 3908.239642] irq_exit_rcu+0xa/0x20
[ 3908.239794] sysvec_apic_timer_interrupt+0xa2/0xd0
[ 3908.239970]
[ 3908.240105]
[ 3908.240232] asm_sysvec_apic_timer_interrupt+0x12/0x20
[ 3908.240414] RIP: 0010:count_memcg_events.constprop.0+0x4a/0x50
[ 3908.240615] 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
[ 3908.241133] RSP: 0000:ffffb18fc37c3e90 EFLAGS: 00000246
[ 3908.241317] RAX: 0000000080000000 RBX: 0000000000000255 RCX: 0000000000000000
[ 3908.241543] RDX: 0000000000000002 RSI: ffffffffb87f78ef RDI: ffffffffb73a04a4
[ 3908.242322] RBP: ffff9e59c5294000 R08: 0000000000000000 R09: 0000000000000000
[ 3908.242554] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000014
[ 3908.242774] R13: 00007fc0685d4080 R14: ffffb18fc37c3f58 R15: ffff9e59c0840db8
[ 3908.242995] ? count_memcg_events.constprop.0+0x44/0x50
[ 3908.243184] handle_mm_fault+0xa8/0x3a0
[ 3908.243351] do_user_addr_fault+0x1e9/0x6b0
[ 3908.243519] exc_page_fault+0x78/0x280
[ 3908.243679] ? asm_exc_page_fault+0x8/0x30
[ 3908.243842] asm_exc_page_fault+0x1e/0x30
[ 3908.244017] RIP: 0033:0x7fc06983d5d3
[ 3908.244176] Code: 0f 7f 44 17 f0 f3 0f 7f 07 c3 48 83 fa 40 77 16 f3 0f 7f 07 f3 0f 7f 47 10 f3 0f 7f 44 17 f0 f3 0f 7f 44 17 e0 c3 48 8d 4f 40 0f 7f 07 48 83 e1 c0 f3 0f 7f 44 17 f0 f3 0f 7f 47 10 f3 0f 7f
[ 3908.244694] RSP: 002b:00007ffdc5efa808 EFLAGS: 00010202
[ 3908.244875] RAX: 00007fc0685d4080 RBX: 0000000000000004 RCX: 00007fc0685d40c0
[ 3908.245091] RDX: 0000000000000880 RSI: 0000000000000000 RDI: 00007fc0685d4080
[ 3908.245312] RBP: 00007ffdc5efabb0 R08: 00007fc0685d4080 R09: 0000000000026000
[ 3908.245527] R10: 0000000000000003 R11: 0000000000000206 R12: 00007fc0687e86a0
[ 3908.245751] R13: 00007ffdc5efa8a0 R14: 00007fc0685d4900 R15: 0000000000000000
[ 3908.245978]