[ 3655.602596] run fstests btrfs/160 at 2022-04-01 21:52:21
[ 3655.791046] BTRFS info (device dm-0): flagging fs with big metadata feature
[ 3655.791261] BTRFS info (device dm-0): using free space tree
[ 3655.791429] BTRFS info (device dm-0): has skinny extents
[ 3656.710715] BTRFS: device fsid 5545466f-3647-4fea-b649-66e185646499 devid 1 transid 6 /dev/dm-11 scanned by systemd-udevd (491561)
[ 3656.720896] BTRFS: device fsid 5545466f-3647-4fea-b649-66e185646499 devid 2 transid 6 /dev/dm-8 scanned by systemd-udevd (491055)
[ 3656.722906] BTRFS: device fsid 5545466f-3647-4fea-b649-66e185646499 devid 3 transid 6 /dev/dm-7 scanned by systemd-udevd (491559)
[ 3656.728608] BTRFS: device fsid 5545466f-3647-4fea-b649-66e185646499 devid 4 transid 6 /dev/dm-6 scanned by systemd-udevd (491561)
[ 3656.731112] BTRFS: device fsid 5545466f-3647-4fea-b649-66e185646499 devid 5 transid 6 /dev/dm-5 scanned by systemd-udevd (491133)
[ 3656.734076] BTRFS: device fsid 5545466f-3647-4fea-b649-66e185646499 devid 6 transid 6 /dev/mapper/vg0-lv4 scanned by mkfs.btrfs (491554)
[ 3656.734552] BTRFS: device fsid 5545466f-3647-4fea-b649-66e185646499 devid 7 transid 6 /dev/mapper/vg0-lv3 scanned by mkfs.btrfs (491554)
[ 3656.735020] BTRFS: device fsid 5545466f-3647-4fea-b649-66e185646499 devid 8 transid 6 /dev/mapper/vg0-lv2 scanned by mkfs.btrfs (491554)
[ 3656.735835] BTRFS: device fsid 5545466f-3647-4fea-b649-66e185646499 devid 9 transid 6 /dev/mapper/vg0-lv1 scanned by mkfs.btrfs (491554)
[ 3656.747289] BTRFS info (device dm-11): flagging fs with big metadata feature
[ 3656.747530] BTRFS info (device dm-11): turning on async discard
[ 3656.747733] BTRFS info (device dm-11): disk space caching is enabled
[ 3656.747945] BTRFS info (device dm-11): has skinny extents
[ 3656.748842] BTRFS info: devid 7 device path /dev/mapper/vg0-lv3 changed to /dev/dm-3 scanned by systemd-udevd (491557)
[ 3656.750182] BTRFS info: devid 7 device path /dev/dm-3 changed to /dev/mapper/vg0-lv3 scanned by systemd-udevd (491557)
[ 3656.750491] BTRFS info: devid 9 device path /dev/mapper/vg0-lv1 changed to /dev/dm-1 scanned by systemd-udevd (491561)
[ 3656.752315] BTRFS info: devid 9 device path /dev/dm-1 changed to /dev/mapper/vg0-lv1 scanned by systemd-udevd (491561)
[ 3656.755616] BTRFS info: devid 8 device path /dev/mapper/vg0-lv2 changed to /dev/dm-2 scanned by systemd-udevd (491055)
[ 3656.757371] BTRFS info: devid 8 device path /dev/dm-2 changed to /dev/mapper/vg0-lv2 scanned by systemd-udevd (491055)
[ 3656.773234] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (491559)
[ 3656.774978] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (491559)
[ 3656.779376] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (491560)
[ 3656.781716] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (491560)
[ 3656.782968] BTRFS info: devid 3 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (491016)
[ 3656.784729] BTRFS info: devid 4 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (491125)
[ 3656.785238] BTRFS info: devid 3 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (491016)
[ 3656.786237] BTRFS info: devid 4 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (491125)
[ 3656.788869] BTRFS info (device dm-11): checking UUID tree
[ 3656.801770] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (491559)
[ 3656.804456] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (491559)
[ 3656.810323] BTRFS info: devid 5 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (491133)
[ 3656.811963] BTRFS info: devid 5 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (491133)
[ 3656.841596] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (491561)
[ 3656.843539] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (491561)
[ 3656.928264] BTRFS info: devid 4 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (491562)
[ 3656.935508] BTRFS info: devid 4 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (491562)
[ 3656.937561] BTRFS info: devid 3 device path /dev/mapper/vg0-lv7 changed to /dev/dm-7 scanned by systemd-udevd (491055)
[ 3656.946380] BTRFS info: devid 5 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (491559)
[ 3656.947787] BTRFS info: devid 2 device path /dev/mapper/vg0-lv8 changed to /dev/dm-8 scanned by systemd-udevd (491561)
[ 3656.953939] BTRFS info: devid 2 device path /dev/dm-8 changed to /dev/mapper/vg0-lv8 scanned by systemd-udevd (491561)
[ 3656.959620] BTRFS info: devid 5 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (491559)
[ 3656.962096] BTRFS info: devid 3 device path /dev/dm-7 changed to /dev/mapper/vg0-lv7 scanned by systemd-udevd (491055)
[ 3656.975198] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (491133)
[ 3656.977243] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (491133)
[ 3656.994749] BTRFS info: devid 4 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (491055)
[ 3657.001967] BTRFS info: devid 4 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (491055)
[ 3657.003306] BTRFS info: devid 5 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (491561)
[ 3657.004889] BTRFS info: devid 5 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (491561)
[ 3657.022654] BTRFS info: devid 5 device path /dev/mapper/vg0-lv5 changed to /dev/dm-5 scanned by systemd-udevd (491561)
[ 3657.024840] BTRFS info: devid 5 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (491561)
[ 3657.037449] btrfs_dev_stat_print_on_error: 38 callbacks suppressed
[ 3657.037452] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 1, rd 0, flush 0, corrupt 0, gen 0
[ 3657.038108] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 2, rd 0, flush 0, corrupt 0, gen 0
[ 3657.038509] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 3, rd 0, flush 0, corrupt 0, gen 0
[ 3657.038924] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 4, rd 0, flush 0, corrupt 0, gen 0
[ 3657.039318] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 5, rd 0, flush 0, corrupt 0, gen 0
[ 3657.041276] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 6, rd 0, flush 0, corrupt 0, gen 0
[ 3657.042515] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 7, rd 0, flush 0, corrupt 0, gen 0
[ 3657.043769] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 8, rd 0, flush 0, corrupt 0, gen 0
[ 3657.044581] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 9, rd 0, flush 0, corrupt 0, gen 0
[ 3657.045182] BTRFS error (device dm-11): bdev /dev/mapper/error-test errs: wr 10, rd 0, flush 0, corrupt 0, gen 0
[ 3657.174111] BTRFS warning (device dm-11): lost page write due to IO error on /dev/mapper/error-test (-5)
[ 3657.174589] BTRFS warning (device dm-11): lost page write due to IO error on /dev/mapper/error-test (-5)
[ 3657.175451] BTRFS error (device dm-11): error writing primary super block to device 1
[ 3657.212065] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-11 scanned by systemd-udevd (491561)
[ 3657.217816] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/error-test scanned by systemd-udevd (491561)
[ 3657.314699] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[ 3657.315063] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/1
[ 3657.315389] preempt_count: 101, expected: 0
[ 3657.315592] RCU nest depth: 0, expected: 0
[ 3657.315805] INFO: lockdep is turned off.
[ 3657.315994] Preemption disabled at:
[ 3657.315995] [] ___slab_alloc+0x961/0xf50
[ 3657.316406] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G W 5.17.0+ #639
[ 3657.316734] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[ 3657.317080] Call Trace:
[ 3657.317237]
[ 3657.317385] dump_stack_lvl+0x56/0x6f
[ 3657.317580] __might_resched.cold+0xff/0x13a
[ 3657.317777] blk_release_queue+0x24/0x120
[ 3657.317968] kobject_put+0x7c/0x1d0
[ 3657.318154] ? rcu_do_batch+0x1ac/0x570
[ 3657.318341] blkg_free.part.0+0x41/0x60
[ 3657.318532] rcu_do_batch+0x1e1/0x570
[ 3657.318722] ? rcu_do_batch+0x1ac/0x570
[ 3657.318915] rcu_core+0x2cb/0x460
[ 3657.319093] __do_softirq+0x178/0x517
[ 3657.319281] __irq_exit_rcu+0xe3/0x160
[ 3657.319471] irq_exit_rcu+0xa/0x20
[ 3657.319654] sysvec_apic_timer_interrupt+0xa2/0xd0
[ 3657.319866]
[ 3657.320019]
[ 3657.320169] asm_sysvec_apic_timer_interrupt+0x12/0x20
[ 3657.320384] RIP: 0010:native_safe_halt+0xb/0x10
[ 3657.320596] Code: 47 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
[ 3657.321212] RSP: 0018:ffffb835c0093ef8 EFLAGS: 00000246
[ 3657.321429] RAX: ffffffffb8e64a80 RBX: ffff941840378000 RCX: 0000000000000000
[ 3657.321691] RDX: ffff941840378000 RSI: ffffffffb987e4d9 RDI: ffffffffb8e64bf6
[ 3657.321942] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
[ 3657.322196] R10: 0000000000000000 R11: ffff9418bbd20c88 R12: 0000000000000000
[ 3657.322453] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[ 3657.322718] ? mwait_idle+0x80/0x80
[ 3657.322903] ? default_idle_call+0x26/0xa0
[ 3657.323102] default_idle+0xa/0x10
[ 3657.323280] default_idle_call+0x5e/0xa0
[ 3657.323474] do_idle+0x1e9/0x240
[ 3657.323656] cpu_startup_entry+0x19/0x20
[ 3657.323847] secondary_startup_64_no_verify+0xd5/0xdb
[ 3657.324066]