[18041.323128] run fstests btrfs/159 at 2022-04-04 01:51:35
[18041.560113] BTRFS info (device dm-0): flagging fs with big metadata feature
[18041.560565] BTRFS info (device dm-0): using free space tree
[18041.560897] BTRFS info (device dm-0): has skinny extents
[18041.810150] BTRFS: device fsid c9a41321-9239-4fc5-af5e-194d15092e7d devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (3206551)
[18041.874448] BTRFS info (device dm-11): flagging fs with big metadata feature
[18041.874883] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_LZO (0x8)
[18041.875362] BTRFS info (device dm-11): use lzo compression, level 0
[18041.875747] BTRFS info (device dm-11): disk space caching is enabled
[18041.876110] BTRFS info (device dm-11): has skinny extents
[18041.877939] BTRFS info (device dm-11): checking UUID tree
[18047.588764] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (3208263)
[18047.590009] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (3208263)
[18047.689502] BTRFS info (device dm-11): flagging fs with big metadata feature
[18047.689949] BTRFS info (device dm-11): use lzo compression, level 0
[18047.690327] BTRFS info (device dm-11): disk space caching is enabled
[18047.690717] BTRFS info (device dm-11): has skinny extents
[18047.693154] BTRFS info (device dm-11): start tree-log replay
[18049.014457] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[18049.015216] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/0
[18049.015905] preempt_count: 101, expected: 0
[18049.016292] RCU nest depth: 0, expected: 0
[18049.016716] INFO: lockdep is turned off.
[18049.017035] Preemption disabled at:
[18049.017036] [] schedule_preempt_disabled+0x1e/0x20
[18049.017842] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G        W         5.17.0+ #641
[18049.018401] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[18049.018993] Call Trace:
[18049.019176]  
[18049.019326]  dump_stack_lvl+0x56/0x6f
[18049.019590]  __might_resched.cold+0xff/0x13a
[18049.019896]  blk_release_queue+0x24/0x120
[18049.020187]  kobject_put+0x7c/0x1d0
[18049.020443]  ? rcu_do_batch+0x1ac/0x570
[18049.020719]  blkg_free.part.0+0x41/0x60
[18049.020992]  rcu_do_batch+0x1e1/0x570
[18049.021259]  ? rcu_do_batch+0x1ac/0x570
[18049.021536]  rcu_core+0x2cb/0x460
[18049.021775]  __do_softirq+0x178/0x517
[18049.022039]  __irq_exit_rcu+0xe3/0x160
[18049.022312]  irq_exit_rcu+0xa/0x20
[18049.022558]  sysvec_apic_timer_interrupt+0xa2/0xd0
[18049.022898]  
[18049.023052]  
[18049.023213]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[18049.023575] RIP: 0010:native_safe_halt+0xb/0x10
[18049.023898] 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
[18049.025186] RSP: 0018:ffffffffaaa03ea8 EFLAGS: 00000246
[18049.025553] RAX: ffffffffa9e64a80 RBX: ffffffffaaa30a00 RCX: 0000000000000000
[18049.026049] RDX: ffffffffaaa30a00 RSI: ffffffffaa87e4d9 RDI: ffffffffa9e64bf6
[18049.026547] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000
[18049.027042] R10: 0000000000000002 R11: ffff94fcbbc20c88 R12: 0000000000000000
[18049.027542] R13: 0000000000000000 R14: ffffffffaaa30118 R15: 0000000000000073
[18049.028040]  ? mwait_idle+0x80/0x80
[18049.028293]  ? default_idle_call+0x26/0xa0
[18049.028587]  default_idle+0xa/0x10
[18049.028831]  default_idle_call+0x5e/0xa0
[18049.029111]  do_idle+0x1e9/0x240
[18049.029348]  cpu_startup_entry+0x19/0x20
[18049.029629]  start_kernel+0x98c/0x99e
[18049.029893]  ? copy_bootdata+0x18/0x55
[18049.030167]  secondary_startup_64_no_verify+0xd5/0xdb
[18049.030527]  
[18049.435170] BTRFS: device fsid 57ef9823-7455-46bf-be11-046446c70cf7 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (3208305)
[18049.507843] BTRFS info (device dm-11): flagging fs with big metadata feature
[18049.508828] BTRFS info (device dm-11): setting incompat feature flag for COMPRESS_LZO (0x8)
[18049.509942] BTRFS info (device dm-11): use lzo compression, level 0
[18049.510786] BTRFS info (device dm-11): disk space caching is enabled
[18049.511748] BTRFS info (device dm-11): has skinny extents
[18049.515420] BTRFS info (device dm-11): checking UUID tree
[18054.686325] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (3210017)
[18054.687569] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (3210017)
[18054.785231] BTRFS info (device dm-11): flagging fs with big metadata feature
[18054.785696] BTRFS info (device dm-11): use lzo compression, level 0
[18054.786075] BTRFS info (device dm-11): disk space caching is enabled
[18054.786488] BTRFS info (device dm-11): has skinny extents
[18054.789042] BTRFS info (device dm-11): start tree-log replay
[18056.245389] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[18056.245886] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/0
[18056.246349] preempt_count: 101, expected: 0
[18056.246609] RCU nest depth: 0, expected: 0
[18056.246854] INFO: lockdep is turned off.
[18056.247097] Preemption disabled at:
[18056.247097] [] schedule_preempt_disabled+0x1e/0x20
[18056.247697] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G        W         5.17.0+ #641
[18056.248147] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[18056.248648] Call Trace:
[18056.248800]  
[18056.248927]  dump_stack_lvl+0x56/0x6f
[18056.249152]  __might_resched.cold+0xff/0x13a
[18056.249410]  blk_release_queue+0x24/0x120
[18056.249652]  kobject_put+0x7c/0x1d0
[18056.249864]  ? rcu_do_batch+0x1ac/0x570
[18056.250099]  blkg_free.part.0+0x41/0x60
[18056.250330]  rcu_do_batch+0x1e1/0x570
[18056.250551]  ? rcu_do_batch+0x1ac/0x570
[18056.250783]  rcu_core+0x2cb/0x460
[18056.250984]  __do_softirq+0x178/0x517
[18056.251208]  __irq_exit_rcu+0xe3/0x160
[18056.251435]  irq_exit_rcu+0xa/0x20
[18056.251640]  sysvec_apic_timer_interrupt+0xa2/0xd0
[18056.251926]  
[18056.252056]  
[18056.252189]  asm_sysvec_apic_timer_interrupt+0x12/0x20
[18056.252494] RIP: 0010:native_safe_halt+0xb/0x10
[18056.252766] 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
[18056.253853] RSP: 0018:ffffffffaaa03ea8 EFLAGS: 00000246
[18056.254165] RAX: ffffffffa9e64a80 RBX: ffffffffaaa30a00 RCX: 0000000000000000
[18056.254584] RDX: ffffffffaaa30a00 RSI: ffffffffaa87e4d9 RDI: ffffffffa9e64bf6
[18056.255003] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000
[18056.255423] R10: 0000000000000000 R11: ffff94fcbbc20c88 R12: 0000000000000000
[18056.255841] R13: 0000000000000000 R14: ffffffffaaa30118 R15: 0000000000000073
[18056.256263]  ? mwait_idle+0x80/0x80
[18056.256475]  ? default_idle_call+0x26/0xa0
[18056.256721]  default_idle+0xa/0x10
[18056.256926]  default_idle_call+0x5e/0xa0
[18056.257164]  do_idle+0x1e9/0x240
[18056.257362]  cpu_startup_entry+0x19/0x20
[18056.257597]  start_kernel+0x98c/0x99e
[18056.257819]  ? copy_bootdata+0x18/0x55
[18056.258046]  secondary_startup_64_no_verify+0xd5/0xdb
[18056.258350]