[27796.953092] run fstests btrfs/159 at 2022-04-02 04:34:43
[27797.160262] BTRFS info (device dm-0): flagging fs with big metadata feature
[27797.160479] BTRFS info (device dm-0): using free space tree
[27797.160648] BTRFS info (device dm-0): has skinny extents
[27797.343736] BTRFS: device fsid 67cece29-c6be-425d-b9ba-7ce9a7ea6b4e devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (2710181)
[27797.412801] BTRFS info (device dm-11): flagging fs with big metadata feature
[27797.413054] BTRFS info (device dm-11): turning on sync discard
[27797.413236] BTRFS info (device dm-11): enabling free space tree
[27797.413412] BTRFS info (device dm-11): using free space tree
[27797.413582] BTRFS info (device dm-11): has skinny extents
[27797.415975] BTRFS info (device dm-11): creating free space tree
[27797.416260] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[27797.416528] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[27797.423619] BTRFS info (device dm-11): cleaning free space cache v1
[27797.429724] BTRFS info (device dm-11): checking UUID tree
[27801.129276] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (2711893)
[27801.130142] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (2711893)
[27801.226303] BTRFS info (device dm-11): flagging fs with big metadata feature
[27801.226524] BTRFS info (device dm-11): turning on sync discard
[27801.226704] BTRFS info (device dm-11): using free space tree
[27801.226905] BTRFS info (device dm-11): has skinny extents
[27801.229309] BTRFS info (device dm-11): start tree-log replay
[27802.173822] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[27802.174138] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/1
[27802.174386] preempt_count: 101, expected: 0
[27802.174531] RCU nest depth: 0, expected: 0
[27802.174799] INFO: lockdep is turned off.
[27802.175100] Preemption disabled at:
[27802.175101] [] ___slab_alloc+0x961/0xf50
[27802.175409] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G W 5.17.0+ #639
[27802.175651] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[27802.175906] Call Trace:
[27802.176026]
[27802.176136] dump_stack_lvl+0x56/0x6f
[27802.176278] __might_resched.cold+0xff/0x13a
[27802.176430] blk_release_queue+0x24/0x120
[27802.176573] kobject_put+0x7c/0x1d0
[27802.176706] ? rcu_do_batch+0x1ac/0x570
[27802.176854] blkg_free.part.0+0x41/0x60
[27802.176996] rcu_do_batch+0x1e1/0x570
[27802.177133] ? rcu_do_batch+0x1ac/0x570
[27802.177274] rcu_core+0x2cb/0x460
[27802.177408] __do_softirq+0x178/0x517
[27802.177547] __irq_exit_rcu+0xe3/0x160
[27802.177685] irq_exit_rcu+0xa/0x20
[27802.177822] sysvec_apic_timer_interrupt+0xa2/0xd0
[27802.177976]
[27802.178088]
[27802.178201] asm_sysvec_apic_timer_interrupt+0x12/0x20
[27802.178361] RIP: 0010:native_safe_halt+0xb/0x10
[27802.178510] 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
[27802.178968] RSP: 0018:ffffb835c0093ef8 EFLAGS: 00000246
[27802.179133] RAX: ffffffffb8e64a80 RBX: ffff941840378000 RCX: 0000000000000000
[27802.179322] RDX: ffff941840378000 RSI: ffffffffb987e4d9 RDI: ffffffffb8e64bf6
[27802.179514] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
[27802.179702] R10: 0000000000000000 R11: ffff9418bbd20c88 R12: 0000000000000000
[27802.179897] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[27802.180089] ? mwait_idle+0x80/0x80
[27802.180222] ? default_idle_call+0x26/0xa0
[27802.180368] default_idle+0xa/0x10
[27802.180503] default_idle_call+0x5e/0xa0
[27802.180644] do_idle+0x1e9/0x240
[27802.180774] cpu_startup_entry+0x19/0x20
[27802.180920] secondary_startup_64_no_verify+0xd5/0xdb
[27802.181082]
[27802.238004] BTRFS: device fsid 4850457b-8c55-44af-b5d7-e5b42143a085 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (2711935)
[27802.302013] BTRFS info (device dm-11): flagging fs with big metadata feature
[27802.302236] BTRFS info (device dm-11): turning on sync discard
[27802.302409] BTRFS info (device dm-11): enabling free space tree
[27802.302584] BTRFS info (device dm-11): using free space tree
[27802.302750] BTRFS info (device dm-11): has skinny extents
[27802.304663] BTRFS info (device dm-11): creating free space tree
[27802.304962] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[27802.305230] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[27802.311620] BTRFS info (device dm-11): cleaning free space cache v1
[27802.322073] BTRFS info (device dm-11): checking UUID tree
[27806.128828] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (2713647)
[27806.129676] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (2713647)
[27806.226438] BTRFS info (device dm-11): flagging fs with big metadata feature
[27806.226661] BTRFS info (device dm-11): turning on sync discard
[27806.226861] BTRFS info (device dm-11): using free space tree
[27806.227038] BTRFS info (device dm-11): has skinny extents
[27806.229457] BTRFS info (device dm-11): start tree-log replay
[27807.181776] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[27807.182050] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/1
[27807.182318] preempt_count: 101, expected: 0
[27807.182464] RCU nest depth: 0, expected: 0
[27807.182611] INFO: lockdep is turned off.
[27807.182774] Preemption disabled at:
[27807.182775] [] ___slab_alloc+0x961/0xf50
[27807.183086] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G W 5.17.0+ #639
[27807.183327] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[27807.183578] Call Trace:
[27807.183699]
[27807.183818] dump_stack_lvl+0x56/0x6f
[27807.183965] __might_resched.cold+0xff/0x13a
[27807.184120] blk_release_queue+0x24/0x120
[27807.184265] kobject_put+0x7c/0x1d0
[27807.184401] ? rcu_do_batch+0x1ac/0x570
[27807.184547] blkg_free.part.0+0x41/0x60
[27807.184688] rcu_do_batch+0x1e1/0x570
[27807.184829] ? rcu_do_batch+0x1ac/0x570
[27807.184973] rcu_core+0x2cb/0x460
[27807.185109] __do_softirq+0x178/0x517
[27807.185251] __irq_exit_rcu+0xe3/0x160
[27807.185395] irq_exit_rcu+0xa/0x20
[27807.185530] sysvec_apic_timer_interrupt+0xa2/0xd0
[27807.185688]
[27807.185802]
[27807.185920] asm_sysvec_apic_timer_interrupt+0x12/0x20
[27807.186082] RIP: 0010:native_safe_halt+0xb/0x10
[27807.186234] 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
[27807.186703] RSP: 0018:ffffb835c0093ef8 EFLAGS: 00000246
[27807.186871] RAX: ffffffffb8e64a80 RBX: ffff941840378000 RCX: 0000000000000000
[27807.187064] RDX: ffff941840378000 RSI: ffffffffb987e4d9 RDI: ffffffffb8e64bf6
[27807.187259] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
[27807.187450] R10: 0000000000000000 R11: ffff9418bbd20c88 R12: 0000000000000000
[27807.193183] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[27807.193381] ? mwait_idle+0x80/0x80
[27807.193521] ? default_idle_call+0x26/0xa0
[27807.193670] default_idle+0xa/0x10
[27807.193806] default_idle_call+0x5e/0xa0
[27807.193953] do_idle+0x1e9/0x240
[27807.194087] cpu_startup_entry+0x19/0x20
[27807.194229] secondary_startup_64_no_verify+0xd5/0xdb
[27807.194396]