[28910.826444] run fstests btrfs/201 at 2022-04-02 04:53:16
[28911.221447] BTRFS: device fsid 740581f0-3ea1-482a-ba28-d6f2dc654af5 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (3081574)
[28911.286932] BTRFS info (device dm-11): flagging fs with big metadata feature
[28911.287147] BTRFS info (device dm-11): turning on sync discard
[28911.287327] BTRFS info (device dm-11): enabling free space tree
[28911.288156] BTRFS info (device dm-11): using free space tree
[28911.288334] BTRFS info (device dm-11): has skinny extents
[28911.290787] BTRFS info (device dm-11): creating free space tree
[28911.291073] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[28911.291338] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[28911.303152] BTRFS info (device dm-11): cleaning free space cache v1
[28911.313340] BTRFS info (device dm-11): checking UUID tree
[28911.487841] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (3080768)
[28911.488769] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (3080768)
[28911.537237] BTRFS info (device dm-11): flagging fs with big metadata feature
[28911.537455] BTRFS info (device dm-11): turning on sync discard
[28911.537679] BTRFS info (device dm-11): using free space tree
[28911.537853] BTRFS info (device dm-11): has skinny extents
[28911.539864] BTRFS info (device dm-11): start tree-log replay
[28911.634511] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[28911.634954] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 3081359, name: 201
[28911.635350] preempt_count: 100, expected: 0
[28911.635621] RCU nest depth: 0, expected: 0
[28911.635864] INFO: lockdep is turned off.
[28911.636097] Preemption disabled at:
[28911.636098] [] __do_softirq+0x5e/0x517
[28911.636672] CPU: 0 PID: 3081359 Comm: 201 Tainted: G W 5.17.0+ #639
[28911.637067] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[28911.637512] Call Trace:
[28911.637707]
[28911.637895] dump_stack_lvl+0x56/0x6f
[28911.638123] __might_resched.cold+0xff/0x13a
[28911.638366] blk_release_queue+0x24/0x120
[28911.638614] kobject_put+0x7c/0x1d0
[28911.638842] ? rcu_do_batch+0x1ac/0x570
[28911.639074] blkg_free.part.0+0x41/0x60
[28911.639310] rcu_do_batch+0x1e1/0x570
[28911.639543] ? rcu_do_batch+0x1ac/0x570
[28911.639775] rcu_core+0x2cb/0x460
[28911.639989] __do_softirq+0x178/0x517
[28911.640223] __irq_exit_rcu+0xe3/0x160
[28911.640452] irq_exit_rcu+0xa/0x20
[28911.640686] sysvec_apic_timer_interrupt+0xa2/0xd0
[28911.640948]
[28911.641136]
[28911.641323] asm_sysvec_apic_timer_interrupt+0x12/0x20
[28911.641607] RIP: 0010:syscall_enter_from_user_mode+0x27/0x70
[28911.641891] Code: 00 00 00 41 54 49 89 f4 55 48 89 fd 48 8b 7c 24 10 e8 9d f6 ff ff 66 90 66 90 e8 a4 86 45 ff e8 bf 85 45 ff fb 0f 1f 44 00 00 <65> 48 8b 04 25 c0 fe 01 00 48 8b 70 08 40 f6 c6 3f 75 19 4c 89 e0
[28911.642635] RSP: 0018:ffffb835c4b3ff28 EFLAGS: 00000246
[28911.642902] RAX: 0000000080000000 RBX: 0000000000000000 RCX: 0000000000000000
[28911.651933] RDX: 0000000000000000 RSI: ffffffffb8e53c8c RDI: ffffffffb8e53c91
[28911.652173] RBP: ffffb835c4b3ff58 R08: 0000000000000000 R09: 0000000000000000
[28911.652409] R10: 0000000000000000 R11: 0000000000000000 R12: 000000000000000e
[28911.652661] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[28911.652901] ? syscall_enter_from_user_mode+0x1c/0x70
[28911.653099] ? syscall_enter_from_user_mode+0x21/0x70
[28911.653297] ? syscall_enter_from_user_mode+0x21/0x70
[28911.653500] do_syscall_64+0x16/0x90
[28911.653678] entry_SYSCALL_64_after_hwframe+0x44/0xae
[28911.653875] RIP: 0033:0x7f4d6f043e4b
[28911.654043] Code: 48 85 f6 74 15 48 b9 00 00 00 80 01 00 00 00 48 8b 06 48 85 c8 75 48 49 89 f0 41 ba 08 00 00 00 4c 89 c6 b8 0e 00 00 00 0f 05 <89> c2 f7 da 3d 00 f0 ff ff b8 00 00 00 00 0f 47 c2 48 8b 8c 24 88
[28911.654613] RSP: 002b:00007ffdac952490 EFLAGS: 00000246 ORIG_RAX: 000000000000000e
[28911.654906] RAX: ffffffffffffffda RBX: 00000000002f05d8 RCX: 00007f4d6f043e4b
[28911.655117] RDX: 00007ffdac952550 RSI: 00007ffdac9525d0 RDI: 0000000000000000
[28911.655331] RBP: 00007ffdac9525d0 R08: 00007ffdac9525d0 R09: 007665642d737473
[28911.655545] R10: 0000000000000008 R11: 0000000000000246 R12: 00000000ffffffff
[28911.655759] R13: 00007ffdac952550 R14: 0000000000000000 R15: 0000000000000000
[28911.655973]
[28911.760122] BTRFS: device fsid d8de95e8-ee2a-448e-81f5-27344616cb6d devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (3081688)
[28911.846354] BTRFS info (device dm-11): flagging fs with big metadata feature
[28911.846602] BTRFS info (device dm-11): turning on sync discard
[28911.846784] BTRFS info (device dm-11): enabling free space tree
[28911.846962] BTRFS info (device dm-11): using free space tree
[28911.847140] BTRFS info (device dm-11): has skinny extents
[28911.849295] BTRFS info (device dm-11): creating free space tree
[28911.849595] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[28911.849859] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[28911.861110] BTRFS info (device dm-11): cleaning free space cache v1
[28911.870964] BTRFS info (device dm-11): checking UUID tree
[28917.367859] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (3085742)
[28917.368888] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (3085742)
[28917.457364] BTRFS info (device dm-11): flagging fs with big metadata feature
[28917.457606] BTRFS info (device dm-11): turning on sync discard
[28917.457786] BTRFS info (device dm-11): using free space tree
[28917.457957] BTRFS info (device dm-11): has skinny extents
[28917.460474] BTRFS info (device dm-11): start tree-log replay
[28917.838453] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[28917.838790] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 3085785, name: dmsetup
[28917.839110] preempt_count: 100, expected: 0
[28917.839291] RCU nest depth: 0, expected: 0
[28917.839497] INFO: lockdep is turned off.
[28917.839678] Preemption disabled at:
[28917.839679] [] __do_softirq+0x5e/0x517
[28917.840064] CPU: 1 PID: 3085785 Comm: dmsetup Tainted: G W 5.17.0+ #639
[28917.840366] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[28917.840699] Call Trace:
[28917.840847]
[28917.840992] dump_stack_lvl+0x56/0x6f
[28917.841167] __might_resched.cold+0xff/0x13a
[28917.841353] blk_release_queue+0x24/0x120
[28917.841545] kobject_put+0x7c/0x1d0
[28917.841753] ? rcu_do_batch+0x1ac/0x570
[28917.841954] blkg_free.part.0+0x41/0x60
[28917.842213] rcu_do_batch+0x1e1/0x570
[28917.842396] ? rcu_do_batch+0x1ac/0x570
[28917.842594] rcu_core+0x2cb/0x460
[28917.842762] __do_softirq+0x178/0x517
[28917.843060] __irq_exit_rcu+0xe3/0x160
[28917.843241] irq_exit_rcu+0xa/0x20
[28917.843420] sysvec_apic_timer_interrupt+0x54/0xd0
[28917.843698] ? asm_sysvec_apic_timer_interrupt+0xa/0x20
[28917.843914] asm_sysvec_apic_timer_interrupt+0x12/0x20
[28917.844120] RIP: 0033:0x7f2a6a9cb95c
[28917.844298] Code: 00 85 c0 75 6f 44 89 c8 0f a2 85 c0 0f 84 c0 00 00 00 44 89 c8 0f a2 41 89 da 41 89 c0 85 c0 0f 8e ad 00 00 00 44 89 c8 0f a2 <85> c0 0f 84 a0 00 00 00 b8 01 00 00 00 0f a2 89 d6 89 cf 89 c2 89
[28917.844970] RSP: 002b:00007ffce27c58e8 EFLAGS: 00000202
[28917.845181] RAX: 000000000000000d RBX: 00000000756e6547 RCX: 000000006c65746e
[28917.845424] RDX: 0000000049656e69 RSI: 00007ffce27c5978 RDI: 0000000000000006
[28917.845677] RBP: 00007f2a6a9e21d0 R08: 000000000000000d R09: 0000000000000000
[28917.845919] R10: 00000000756e6547 R11: 0000000000000246 R12: 00007ffce27c5978
[28917.846163] R13: 00007ffce27c59b0 R14: 00007f2a6a9e1dd0 R15: 0000000000000000
[28917.846408]
[28917.928510] BTRFS: device fsid 066ccef7-cc04-40b2-ae6c-e89f37a672a1 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (3085784)
[28917.994779] BTRFS info (device dm-11): flagging fs with big metadata feature
[28917.994998] BTRFS info (device dm-11): turning on sync discard
[28917.995173] BTRFS info (device dm-11): enabling free space tree
[28917.995348] BTRFS info (device dm-11): using free space tree
[28917.995550] BTRFS info (device dm-11): has skinny extents
[28917.997729] BTRFS info (device dm-11): creating free space tree
[28917.998021] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[28917.998290] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[28918.010023] BTRFS info (device dm-11): cleaning free space cache v1
[28918.019836] BTRFS info (device dm-11): checking UUID tree
[28923.547594] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (3089838)
[28923.548627] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (3089838)
[28923.638037] BTRFS info (device dm-11): flagging fs with big metadata feature
[28923.638264] BTRFS info (device dm-11): turning on sync discard
[28923.638470] BTRFS info (device dm-11): using free space tree
[28923.638644] BTRFS info (device dm-11): has skinny extents
[28923.640962] BTRFS info (device dm-11): start tree-log replay
[28924.010394] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[28924.010672] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/1
[28924.011002] preempt_count: 101, expected: 0
[28924.011159] RCU nest depth: 0, expected: 0
[28924.011330] INFO: lockdep is turned off.
[28924.011518] Preemption disabled at:
[28924.011519] [] ___slab_alloc+0x961/0xf50
[28924.011836] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G W 5.17.0+ #639
[28924.012074] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[28924.012335] Call Trace:
[28924.012547]
[28924.012662] dump_stack_lvl+0x56/0x6f
[28924.012848] __might_resched.cold+0xff/0x13a
[28924.012996] blk_release_queue+0x24/0x120
[28924.013141] kobject_put+0x7c/0x1d0
[28924.013280] ? rcu_do_batch+0x1ac/0x570
[28924.013431] blkg_free.part.0+0x41/0x60
[28924.013573] rcu_do_batch+0x1e1/0x570
[28924.013712] ? rcu_do_batch+0x1ac/0x570
[28924.013858] rcu_core+0x2cb/0x460
[28924.013989] __do_softirq+0x178/0x517
[28924.014129] __irq_exit_rcu+0xe3/0x160
[28924.014272] irq_exit_rcu+0xa/0x20
[28924.014413] sysvec_apic_timer_interrupt+0xa2/0xd0
[28924.014571]
[28924.014681]
[28924.014794] asm_sysvec_apic_timer_interrupt+0x12/0x20
[28924.014956] RIP: 0010:native_safe_halt+0xb/0x10
[28924.015108] 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
[28924.015590] RSP: 0018:ffffb835c0093ef8 EFLAGS: 00000246
[28924.015753] RAX: ffffffffb8e64a80 RBX: ffff941840378000 RCX: 0000000000000000
[28924.015999] RDX: ffff941840378000 RSI: ffffffffb987e4d9 RDI: ffffffffb8e64bf6
[28924.016191] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
[28924.016390] R10: 0000000000000000 R11: ffff9418bbd20c88 R12: 0000000000000000
[28924.016625] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[28924.016836] ? mwait_idle+0x80/0x80
[28924.016983] ? default_idle_call+0x26/0xa0
[28924.017132] default_idle+0xa/0x10
[28924.017283] default_idle_call+0x5e/0xa0
[28924.017448] do_idle+0x1e9/0x240
[28924.017582] cpu_startup_entry+0x19/0x20
[28924.017749] secondary_startup_64_no_verify+0xd5/0xdb
[28924.017913]
[28924.107050] BTRFS: device fsid fcf7de1a-8a2b-4596-a076-a79481b126d9 devid 1 transid 6 /dev/mapper/vg0-lv9 scanned by mkfs.btrfs (3089880)
[28924.175065] BTRFS info (device dm-11): flagging fs with big metadata feature
[28924.175289] BTRFS info (device dm-11): turning on sync discard
[28924.175490] BTRFS info (device dm-11): enabling free space tree
[28924.175666] BTRFS info (device dm-11): using free space tree
[28924.175841] BTRFS info (device dm-11): has skinny extents
[28924.178054] BTRFS info (device dm-11): creating free space tree
[28924.178343] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE (0x1)
[28924.178630] BTRFS info (device dm-11): setting compat-ro feature flag for FREE_SPACE_TREE_VALID (0x2)
[28924.190130] BTRFS info (device dm-11): cleaning free space cache v1
[28924.201324] BTRFS info (device dm-11): checking UUID tree
[28929.744475] BTRFS info: devid 1 device path /dev/mapper/flakey-test changed to /dev/dm-11 scanned by systemd-udevd (3093934)
[28929.745312] BTRFS info: devid 1 device path /dev/dm-11 changed to /dev/mapper/flakey-test scanned by systemd-udevd (3093934)
[28929.833356] BTRFS info (device dm-11): flagging fs with big metadata feature
[28929.833580] BTRFS info (device dm-11): turning on sync discard
[28929.833761] BTRFS info (device dm-11): using free space tree
[28929.833933] BTRFS info (device dm-11): has skinny extents
[28929.836570] BTRFS info (device dm-11): start tree-log replay
[28930.242335] BUG: sleeping function called from invalid context at block/blk-sysfs.c:766
[28930.242729] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 3093976, name: udevadm
[28930.243102] preempt_count: 100, expected: 0
[28930.243337] RCU nest depth: 0, expected: 0
[28930.243555] INFO: lockdep is turned off.
[28930.243763] Preemption disabled at:
[28930.243764] [] __do_softirq+0x5e/0x517
[28930.244207] CPU: 1 PID: 3093976 Comm: udevadm Tainted: G W 5.17.0+ #639
[28930.244567] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.13.0-2.fc32 04/01/2014
[28930.244944] Call Trace:
[28930.245117]
[28930.245284] dump_stack_lvl+0x56/0x6f
[28930.245493] __might_resched.cold+0xff/0x13a
[28930.245710] blk_release_queue+0x24/0x120
[28930.245925] kobject_put+0x7c/0x1d0
[28930.246125] ? rcu_do_batch+0x1ac/0x570
[28930.246334] blkg_free.part.0+0x41/0x60
[28930.246545] rcu_do_batch+0x1e1/0x570
[28930.246750] ? rcu_do_batch+0x1ac/0x570
[28930.246962] rcu_core+0x2cb/0x460
[28930.247132] __do_softirq+0x178/0x517
[28930.247312] __irq_exit_rcu+0xe3/0x160
[28930.247496] irq_exit_rcu+0xa/0x20
[28930.247668] sysvec_apic_timer_interrupt+0xa2/0xd0
[28930.247871]
[28930.248016]
[28930.248159] asm_sysvec_apic_timer_interrupt+0x12/0x20
[28930.248373] RIP: 0010:alloc_pages_vma+0xf6/0x2e0
[28930.248574] Code: 47 83 f8 ff 0f 84 6c ff ff ff 48 63 c8 48 89 c8 48 c1 e0 04 48 01 c8 48 c1 e0 04 48 8d 88 80 06 28 bb 66 83 b8 84 06 28 bb 00 <48> 0f 45 e9 e9 43 ff ff ff 48 8b 3d 52 ef ec 02 48 89 ee 48 89 04
[28930.249153] RSP: 0000:ffffb835c5667da8 EFLAGS: 00000202
[28930.249365] RAX: 0000000000000000 RBX: 00007f3b8b926000 RCX: ffffffffbb280680
[28930.249616] RDX: ffff941854c124b0 RSI: 00007f3b8b926000 RDI: ffff941854c124b0
[28930.249863] RBP: ffffffffb9c8c000 R08: 0000000000000000 R09: 0000000000000001
[28930.250114] R10: ffff94184592c178 R11: ffff9418454a2ae0 R12: 0000000000100dca
[28930.250366] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[28930.251494] ? alloc_pages_vma+0x36/0x2e0
[28930.251683] __handle_mm_fault+0xb31/0x1460
[28930.251881] ? mmap_region+0x2da/0x620
[28930.252044] handle_mm_fault+0x11e/0x3a0
[28930.252210] do_user_addr_fault+0x1e9/0x6b0
[28930.252380] exc_page_fault+0x78/0x280
[28930.252537] ? asm_exc_page_fault+0x8/0x30
[28930.252703] asm_exc_page_fault+0x1e/0x30
[28930.252869] RIP: 0033:0x7f3b8c14e6db
[28930.253023] Code: 89 5c 24 20 be 01 00 00 00 48 89 54 24 18 ff 15 5b 17 02 00 48 89 c5 48 85 c0 0f 84 4c 02 00 00 48 8b 54 24 18 4c 8b 5c 24 20 <48> 89 40 28 4c 89 e6 4c 8d 8c 10 80 04 00 00 4c 89 da 4c 89 88 d0
[28930.253554] RSP: 002b:00007fff9622c280 EFLAGS: 00010206
[28930.253741] RAX: 00007f3b8b926000 RBX: 0000000000000000 RCX: 00007f3b8b9264aa
[28930.253957] RDX: 0000000000000000 RSI: 0000000000002000 RDI: 0000000000000000
[28930.254176] RBP: 00007f3b8b926000 R08: 00000000ffffffff R09: 0000000000000000
[28930.254396] R10: 0000000000000022 R11: 000000000000000a R12: 00007f3b8c12217c
[28930.254615] R13: 00007f3b8c140510 R14: 0000000000000009 R15: 0000000000000000
[28930.254834]