[ 3552.069322] run fstests btrfs/160 at 2022-04-01 21:49:42
[ 3552.240034] BTRFS info (device dm-0): flagging fs with big metadata feature
[ 3552.240253] BTRFS info (device dm-0): using free space tree
[ 3552.240441] BTRFS info (device dm-0): has skinny extents
[ 3552.957401] BTRFS: device fsid 6c6c464f-ee15-4a09-bb20-445adeaf8b86 devid 1 transid 6 /dev/dm-9 scanned by systemd-udevd (501106)
[ 3552.971188] BTRFS: device fsid 6c6c464f-ee15-4a09-bb20-445adeaf8b86 devid 2 transid 6 /dev/dm-6 scanned by systemd-udevd (501215)
[ 3552.980089] BTRFS: device fsid 6c6c464f-ee15-4a09-bb20-445adeaf8b86 devid 3 transid 6 /dev/mapper/vg0-lv5 scanned by mkfs.btrfs (501594)
[ 3552.980457] BTRFS: device fsid 6c6c464f-ee15-4a09-bb20-445adeaf8b86 devid 4 transid 6 /dev/mapper/vg0-lv4 scanned by mkfs.btrfs (501594)
[ 3552.980850] BTRFS: device fsid 6c6c464f-ee15-4a09-bb20-445adeaf8b86 devid 5 transid 6 /dev/mapper/vg0-lv3 scanned by mkfs.btrfs (501594)
[ 3552.981292] BTRFS: device fsid 6c6c464f-ee15-4a09-bb20-445adeaf8b86 devid 6 transid 6 /dev/mapper/vg0-lv2 scanned by mkfs.btrfs (501594)
[ 3552.981715] BTRFS: device fsid 6c6c464f-ee15-4a09-bb20-445adeaf8b86 devid 7 transid 6 /dev/mapper/vg0-lv1 scanned by mkfs.btrfs (501594)
[ 3552.993512] BTRFS info: devid 6 device path /dev/dm-2 changed to /dev/mapper/vg0-lv2 scanned by systemd-udevd (501215)
[ 3552.993852] BTRFS info (device dm-9): flagging fs with big metadata feature
[ 3552.994058] BTRFS info (device dm-9): using free space tree
[ 3552.994224] BTRFS info (device dm-9): has skinny extents
[ 3552.994928] BTRFS info: devid 3 device path /dev/dm-5 changed to /dev/mapper/vg0-lv5 scanned by systemd-udevd (501204)
[ 3552.998060] BTRFS info: devid 7 device path /dev/mapper/vg0-lv1 changed to /dev/dm-1 scanned by systemd-udevd (501597)
[ 3552.999537] BTRFS info: devid 7 device path /dev/dm-1 changed to /dev/mapper/vg0-lv1 scanned by systemd-udevd (501597)
[ 3553.010011] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-9 scanned by systemd-udevd (501598)
[ 3553.011324] BTRFS info: devid 1 device path /dev/dm-9 changed to /dev/mapper/error-test scanned by systemd-udevd (501598)
[ 3553.021693] BTRFS info: devid 2 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (501601)
[ 3553.023218] BTRFS info: devid 2 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (501601)
[ 3553.042618] BTRFS info (device dm-9): checking UUID tree
[ 3553.051741] BTRFS info: devid 2 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (501106)
[ 3553.056247] BTRFS info: devid 2 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (501106)
[ 3553.072852] BTRFS info: devid 2 device path /dev/mapper/vg0-lv6 changed to /dev/dm-6 scanned by systemd-udevd (501106)
[ 3553.074166] BTRFS info: devid 2 device path /dev/dm-6 changed to /dev/mapper/vg0-lv6 scanned by systemd-udevd (501106)
[ 3553.173244] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-9 scanned by systemd-udevd (501106)
[ 3553.175224] BTRFS info: devid 1 device path /dev/dm-9 changed to /dev/mapper/error-test scanned by systemd-udevd (501106)
[ 3553.215492] btrfs_dev_stat_print_on_error: 38 callbacks suppressed
[ 3553.215496] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 1, rd 0, flush 0, corrupt 0, gen 0
[ 3553.216699] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 2, rd 0, flush 0, corrupt 0, gen 0
[ 3553.217870] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 3, rd 0, flush 0, corrupt 0, gen 0
[ 3553.219340] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 4, rd 0, flush 0, corrupt 0, gen 0
[ 3553.220593] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 5, rd 0, flush 0, corrupt 0, gen 0
[ 3553.221541] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 6, rd 0, flush 0, corrupt 0, gen 0
[ 3553.222997] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 7, rd 0, flush 0, corrupt 0, gen 0
[ 3553.223806] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 8, rd 0, flush 0, corrupt 0, gen 0
[ 3553.225070] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 9, rd 0, flush 0, corrupt 0, gen 0
[ 3553.225701] BTRFS error (device dm-9): bdev /dev/mapper/error-test errs: wr 10, rd 0, flush 0, corrupt 0, gen 0
[ 3553.334674] BTRFS warning (device dm-9): lost page write due to IO error on /dev/mapper/error-test (-5)
[ 3553.334996] BTRFS warning (device dm-9): lost page write due to IO error on /dev/mapper/error-test (-5)
[ 3553.335442] BTRFS error (device dm-9): error writing primary super block to device 1
[ 3553.368185] BTRFS info: devid 1 device path /dev/mapper/error-test changed to /dev/dm-9 scanned by systemd-udevd (501106)
[ 3553.370419] BTRFS info: devid 1 device path /dev/dm-9 changed to /dev/mapper/error-test scanned by systemd-udevd (501106)
[ 3553.431345] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[ 3553.431623] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 501681, name: udevadm
[ 3553.431877] preempt_count: 100, expected: 0
[ 3553.432026] RCU nest depth: 0, expected: 0
[ 3553.432170] INFO: lockdep is turned off.
[ 3553.432314] Preemption disabled at:
[ 3553.432315] [] __do_softirq+0x5e/0x517
[ 3553.432634] CPU: 0 PID: 501681 Comm: udevadm Tainted: G        W         5.17.0+ #639
[ 3553.432872] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[ 3553.433131] Call Trace:
[ 3553.433248]  
[ 3553.433365]  dump_stack_lvl+0x56/0x6f
[ 3553.433504]  __might_resched.cold+0xff/0x13a
[ 3553.433655]  blk_release_queue+0x24/0x120
[ 3553.433801]  kobject_put+0x7c/0x1d0
[ 3553.433941]  ? rcu_do_batch+0x1ac/0x570
[ 3553.434864]  blkg_free.part.0+0x41/0x60
[ 3553.435018]  rcu_do_batch+0x1e1/0x570
[ 3553.435160]  ? rcu_do_batch+0x1ac/0x570
[ 3553.435302]  rcu_core+0x2cb/0x460
[ 3553.435438]  __do_softirq+0x178/0x517
[ 3553.435581]  __irq_exit_rcu+0xe3/0x160
[ 3553.435720]  irq_exit_rcu+0xa/0x20
[ 3553.435853]  sysvec_apic_timer_interrupt+0xa2/0xd0
[ 3553.436021]  
[ 3553.436135]  
[ 3553.436275]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[ 3553.436441] RIP: 0010:get_page_from_freelist+0x125f/0x16d0
[ 3553.436614] Code: 45 f8 a8 04 0f 84 a7 fc ff ff 48 8b 44 24 38 48 0f ba 30 02 e9 98 fc ff ff 48 c7 c6 98 9f 80 93 4c 89 ff e8 d3 b0 fc ff 0f 0b <8b> 54 24 54 44 89 ee 4c 89 ff e8 e2 c0 ff ff 8b 54 24 10 83 e2 04
[ 3553.437068] RSP: 0000:ffffa59283623c18 EFLAGS: 00000246
[ 3553.437231] RAX: ffff9360fffd5e00 RBX: ffff9360fffd5e00 RCX: 0000000000000000
[ 3553.437428] RDX: 0000000000000002 RSI: ffffffff923c86e6 RDI: ffffffff923c869b
[ 3553.437622] RBP: ffff9360fbc2f200 R08: 0000000000100000 R09: 0000000000000000
[ 3553.437819] R10: ffff9360954d3560 R11: ffff936092efbce0 R12: ffff9360fbc3a480
[ 3553.438018] R13: 0000000000000000 R14: ffff9360fffd5e00 R15: fffff95dc5188f40
[ 3553.438216]  ? page_outside_zone_boundaries+0x36/0xa0
[ 3553.438381]  ? seqcount_lockdep_reader_access+0x7b/0x90
[ 3553.438546]  ? get_page_from_freelist+0xa8d/0x16d0
[ 3553.438702]  ? lock_release+0x1ed/0x2c0
[ 3553.438848]  ? rcu_read_lock_sched_held+0x12/0x60
[ 3553.439011]  ? prepare_alloc_pages+0xbc/0x1b0
[ 3553.439162]  __alloc_pages+0xd6/0x290
[ 3553.439303]  alloc_pages_vma+0x8f/0x2e0
[ 3553.439446]  __handle_mm_fault+0x747/0x1460
[ 3553.439597]  handle_mm_fault+0x11e/0x3a0
[ 3553.439739]  do_user_addr_fault+0x1e9/0x6b0
[ 3553.439889]  exc_page_fault+0x78/0x280
[ 3553.440035]  ? asm_exc_page_fault+0x8/0x30
[ 3553.440182]  asm_exc_page_fault+0x1e/0x30
[ 3553.440325] RIP: 0033:0x7f5a47dd3945
[ 3553.440465] Code: 20 66 0f 7f 41 30 48 83 c1 40 48 39 ca 75 e4 f3 c3 66 48 0f 7e c1 80 fa 08 73 0f 80 fa 04 73 13 80 fa 01 77 15 72 02 88 0f c3 <48> 89 4c 17 f8 48 89 0f c3 89 4c 17 fc 89 0f c3 66 89 4c 17 fe 66
[ 3553.440929] RSP: 002b:00007ffd6fff28d8 EFLAGS: 00010246
[ 3553.441095] RAX: 00007f5a47aee028 RBX: 0000000000000004 RCX: 0000000000000000
[ 3553.441289] RDX: 0000000000000008 RSI: 0000000000000000 RDI: 00007f5a47aee028
[ 3553.441482] RBP: 00007ffd6fff2c40 R08: 00007f5a47aee028 R09: 0000000000017000
[ 3553.441679] R10: 0000000000000003 R11: 0000000000000206 R12: 00007ffd6fff2970
[ 3553.441876] R13: 00007ffd6fff2cd0 R14: 00007f5a47aee030 R15: 00007f5a47dac520
[ 3553.442079]