microsoft / WSL

Issues found on WSL
https://docs.microsoft.com/windows/wsl
MIT License
17.4k stars 819 forks source link

WSL slow startup after 22h2 #9377

Closed eduardopilati closed 1 year ago

eduardopilati commented 1 year ago

Version

Microsoft Windows [versão 10.0.22621.963]

WSL Version

Kernel Version

Linux version 5.15.79.1-microsoft-standard-WSL2

Distro Version

Ubuntu 22.04

Other Software

No response

Repro Steps

Launch WSL

Expected Behavior

Wsl start in a few seconds

Actual Behavior

Wsl taking too long to start for no reason

Diagnostic Logs

[    0.000000] Linux version 5.15.79.1-microsoft-standard-WSL2 (oe-user@oe-host) (x86_64-msft-linux-gcc (GCC) 9.3.0, GNU ld (GNU Binutils) 2.34.0.20200220) #1 SMP Wed Nov 23 01:01:46 UTC 2022
[    0.000000] Command line: initrd=\initrd.img WSL_ROOT_INIT=1 panic=-1 nr_cpus=16 swiotlb=force console=hvc0 debug pty.legacy_count=0
[    0.000000] KERNEL supported cpus:
[    0.000000]   Intel GenuineIntel
[    0.000000]   AMD AuthenticAMD
[    0.000000]   Centaur CentaurHauls
[    0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'
[    0.000000] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'
[    0.000000] x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
[    0.000000] x86/fpu: xstate_offset[5]:  832, xstate_sizes[5]:   64
[    0.000000] x86/fpu: xstate_offset[6]:  896, xstate_sizes[6]:  512
[    0.000000] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024
[    0.000000] x86/fpu: Enabled xstate features 0xe7, context size is 2432 bytes, using 'compacted' format.
[    0.000000] signal: max sigframe size: 3632
[    0.000000] BIOS-provided physical RAM map:
[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable
[    0.000000] BIOS-e820: [mem 0x00000000000e0000-0x00000000000e0fff] reserved
[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000001fffff] ACPI data
[    0.000000] BIOS-e820: [mem 0x0000000000200000-0x00000000f7ffffff] usable
[    0.000000] BIOS-e820: [mem 0x0000000100000000-0x0000000207ffffff] usable
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] DMI not present or invalid.
[    0.000000] Hypervisor detected: Microsoft Hyper-V
[    0.000000] Hyper-V: privilege flags low 0xae7f, high 0x3b8030, hints 0xa4e24, misc 0xe4bed7b6
[    0.000000] Hyper-V Host Build:22621-10.0-0-0.963
[    0.000000] Hyper-V: Nested features: 0x3e0101
[    0.000000] Hyper-V: LAPIC Timer Frequency: 0x1e8480
[    0.000000] Hyper-V: Using hypercall for remote TLB flush
[    0.000000] clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns
[    0.000002] tsc: Detected 2304.001 MHz processor
[    0.000010] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.000012] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.000014] last_pfn = 0x208000 max_arch_pfn = 0x400000000
[    0.000034] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT
[    0.000042] last_pfn = 0xf8000 max_arch_pfn = 0x400000000
[    0.000049] Using GB pages for direct mapping
[    0.000311] RAMDISK: [mem 0x03a35000-0x03c0efff]
[    0.000313] ACPI: Early table checksum verification disabled
[    0.000326] ACPI: RSDP 0x00000000000E0000 000024 (v02 VRTUAL)
[    0.000329] ACPI: XSDT 0x0000000000100000 000044 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
[    0.000333] ACPI: FACP 0x0000000000101000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001)
[    0.000337] ACPI: DSDT 0x00000000001011B8 01E191 (v02 MSFTVM DSDT01   00000001 MSFT 05000000)
[    0.000340] ACPI: FACS 0x0000000000101114 000040
[    0.000342] ACPI: OEM0 0x0000000000101154 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
[    0.000344] ACPI: SRAT 0x000000000011F349 0003B0 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
[    0.000346] ACPI: APIC 0x000000000011F6F9 0000C8 (v04 VRTUAL MICROSFT 00000001 MSFT 00000001)
[    0.000349] ACPI: Reserving FACP table memory at [mem 0x101000-0x101113]
[    0.000351] ACPI: Reserving DSDT table memory at [mem 0x1011b8-0x11f348]
[    0.000351] ACPI: Reserving FACS table memory at [mem 0x101114-0x101153]
[    0.000352] ACPI: Reserving OEM0 table memory at [mem 0x101154-0x1011b7]
[    0.000353] ACPI: Reserving SRAT table memory at [mem 0x11f349-0x11f6f8]
[    0.000353] ACPI: Reserving APIC table memory at [mem 0x11f6f9-0x11f7c0]
[    0.000550] Zone ranges:
[    0.000552]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.000553]   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
[    0.000554]   Normal   [mem 0x0000000100000000-0x0000000207ffffff]
[    0.000555]   Device   empty
[    0.000556] Movable zone start for each node
[    0.000557] Early memory node ranges
[    0.000557]   node   0: [mem 0x0000000000001000-0x000000000009ffff]
[    0.000559]   node   0: [mem 0x0000000000200000-0x00000000f7ffffff]
[    0.000560]   node   0: [mem 0x0000000100000000-0x0000000207ffffff]
[    0.000561] Initmem setup node 0 [mem 0x0000000000001000-0x0000000207ffffff]
[    0.000692] On node 0, zone DMA: 1 pages in unavailable ranges
[    0.000711] On node 0, zone DMA: 352 pages in unavailable ranges
[    0.011316] ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1])
[    0.011537] IOAPIC[0]: apic_id 16, version 17, address 0xfec00000, GSI 0-23
[    0.011541] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.011545] ACPI: Using ACPI (MADT) for SMP configuration information
[    0.011546] TSC deadline timer available
[    0.011547] smpboot: Allowing 16 CPUs, 0 hotplug CPUs
[    0.011555] [mem 0xf8000000-0xffffffff] available for PCI devices
[    0.011556] Booting paravirtualized kernel on Hyper-V
[    0.011558] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.015776] setup_percpu: NR_CPUS:256 nr_cpumask_bits:256 nr_cpu_ids:16 nr_node_ids:1
[    0.016326] percpu: Embedded 53 pages/cpu s177496 r8192 d31400 u262144
[    0.016333] pcpu-alloc: s177496 r8192 d31400 u262144 alloc=1*2097152
[    0.016336] pcpu-alloc: [0] 00 01 02 03 04 05 06 07 [0] 08 09 10 11 12 13 14 15
[    0.016355] Hyper-V: PV spinlocks enabled
[    0.016357] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear)
[    0.016363] Built 1 zonelists, mobility grouping on.  Total pages: 2063365
[    0.016365] Kernel command line: initrd=\initrd.img WSL_ROOT_INIT=1 panic=-1 nr_cpus=16 swiotlb=force console=hvc0 debug pty.legacy_count=0
[    0.016442] Unknown kernel command line parameters "WSL_ROOT_INIT=1", will be passed to user space.
[    0.017460] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear)
[    0.017971] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
[    0.018150] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.036808] Memory: 4081508K/8387196K available (18452K kernel code, 2627K rwdata, 9760K rodata, 2028K init, 1876K bss, 258708K reserved, 0K cma-reserved)
[    0.036845] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=16, Nodes=1
[    0.036852] ftrace: allocating 54585 entries in 214 pages
[    0.056670] ftrace: allocated 214 pages with 5 groups
[    0.056932] rcu: Hierarchical RCU implementation.
[    0.056934] rcu:     RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=16.
[    0.056936]  Rude variant of Tasks RCU enabled.
[    0.056936]  Tracing variant of Tasks RCU enabled.
[    0.056937] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
[    0.056937] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=16
[    0.060162] Using NULL legacy PIC
[    0.060164] NR_IRQS: 16640, nr_irqs: 552, preallocated irqs: 0
[    0.060408] random: crng init done
[    0.060430] Console: colour dummy device 80x25
[    0.060439] ACPI: Core revision 20210730
[    0.060501] Failed to register legacy timer interrupt
[    0.060501] APIC: Switch to symmetric I/O mode setup
[    0.061805] x2apic enabled
[    0.063098] Switched APIC routing to physical x2apic.
[    0.063113] Hyper-V: Using IPI hypercalls
[    0.063154] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2135f8984a8, max_idle_ns: 440795232764 ns
[    0.063160] Calibrating delay loop (skipped), value calculated using timer frequency.. 4608.00 BogoMIPS (lpj=23040010)
[    0.063163] pid_max: default: 32768 minimum: 301
[    0.063175] LSM: Security Framework initializing
[    0.063179] landlock: Up and running.
[    0.063197] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear)
[    0.063206] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear)
[    0.063395] x86/cpu: User Mode Instruction Prevention (UMIP) activated
[    0.063408] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.063410] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[    0.063413] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
[    0.063415] Spectre V2 : Mitigation: Enhanced IBRS
[    0.063416] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
[    0.063417] Spectre V2 : Spectre v2 / PBRSB-eIBRS: Retire a single CALL on VMEXIT
[    0.063417] RETBleed: Mitigation: Enhanced IBRS
[    0.063418] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier
[    0.063419] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl and seccomp
[    0.073157] Freeing SMP alternatives memory: 60K
[    0.073157] smpboot: CPU0: 11th Gen Intel(R) Core(TM) i7-11800H @ 2.30GHz (family: 0x6, model: 0x8d, stepping: 0x1)
[    0.073157] Performance Events:  AnyThread deprecated, Icelake events, 32-deep LBR, full-width counters, Intel PMU driver.
[    0.073157] ... version:                5
[    0.073157] ... bit width:              48
[    0.073157] ... generic registers:      8
[    0.073157] ... value mask:             0000ffffffffffff
[    0.073157] ... max period:             00007fffffffffff
[    0.073157] ... fixed-purpose events:   4
[    0.073157] ... event mask:             0001000f000000ff
[    0.073157] rcu: Hierarchical SRCU implementation.
[    0.073157] smp: Bringing up secondary CPUs ...
[    0.073157] x86: Booting SMP configuration:
[    0.073157] .... node  #0, CPUs:        #1  #2  #3  #4  #5  #6  #7  #8  #9 #10 #11 #12 #13 #14 #15
[    0.073157] smp: Brought up 1 node, 16 CPUs
[    0.073157] smpboot: Max logical packages: 1
[    0.073157] smpboot: Total of 16 processors activated (73728.03 BogoMIPS)
[    0.073505] node 0 deferred pages initialised in 10ms
[    0.075063] devtmpfs: initialized
[    0.075063] x86/mm: Memory block size: 128MB
[    0.075063] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.075063] futex hash table entries: 4096 (order: 6, 262144 bytes, linear)
[    0.075063] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[    0.075063] thermal_sys: Registered thermal governor 'step_wise'
[    0.075063] cpuidle: using governor menu
[    0.075063] ACPI: bus type PCI registered
[    0.075063] PCI: Fatal: No config space access function found
[    0.075063] Kprobes globally optimized
[    0.075063] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
[    0.075063] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    0.075063] raid6: skip pq benchmark and using algorithm avx512x4
[    0.075063] raid6: using avx512x2 recovery algorithm
[    0.075063] ACPI: Added _OSI(Module Device)
[    0.075063] ACPI: Added _OSI(Processor Device)
[    0.075063] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.075063] ACPI: Added _OSI(Processor Aggregator Device)
[    0.075063] ACPI: Added _OSI(Linux-Dell-Video)
[    0.075063] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
[    0.075063] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics)
[    0.085341] ACPI: 1 ACPI AML tables successfully acquired and loaded
[    0.085911] ACPI: Interpreter enabled
[    0.085913] ACPI: PM: (supports S0 S5)
[    0.085914] ACPI: Using IOAPIC for interrupt routing
[    0.085919] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.086020] ACPI: Enabled 2 GPEs in block 00 to 0F
[    0.086887] iommu: Default domain type: Translated
[    0.086888] iommu: DMA domain TLB invalidation policy: lazy mode
[    0.086937] SCSI subsystem initialized
[    0.086943] ACPI: bus type USB registered
[    0.086948] usbcore: registered new interface driver usbfs
[    0.086952] usbcore: registered new interface driver hub
[    0.086956] usbcore: registered new device driver usb
[    0.086962] pps_core: LinuxPPS API ver. 1 registered
[    0.086962] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.086963] PTP clock support registered
[    0.086985] hv_vmbus: Vmbus version:5.3
[    0.086985] PCI: Using ACPI for IRQ routing
[    0.086985] PCI: System does not support PCI
[    0.086985] hv_vmbus: Unknown GUID: c376c1c3-d276-48d2-90a9-c04748072c60
[    0.086985] clocksource: Switched to clocksource tsc-early
[    0.086985] hv_vmbus: Unknown GUID: 6e382d18-3336-4f4b-acc4-2b7703d4df4a
[    0.086985] hv_vmbus: Unknown GUID: dde9cbc0-5060-4436-9448-ea1254a5d177
[    0.086985] hv_vmbus: Unknown GUID: 6e382d18-3336-4f4b-acc4-2b7703d4df4a
[    0.091708] VFS: Disk quotas dquot_6.6.0
[    0.091722] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.091739] FS-Cache: Loaded
[    0.091760] pnp: PnP ACPI init
[    0.091942] pnp: PnP ACPI: found 1 devices
[    0.097079] NET: Registered PF_INET protocol family
[    0.097142] IP idents hash table entries: 131072 (order: 8, 1048576 bytes, linear)
[    0.097585] tcp_listen_portaddr_hash hash table entries: 4096 (order: 4, 65536 bytes, linear)
[    0.097592] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
[    0.097594] TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear)
[    0.097788] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes, linear)
[    0.097856] TCP: Hash tables configured (established 65536 bind 65536)
[    0.097876] UDP hash table entries: 4096 (order: 5, 131072 bytes, linear)
[    0.097888] UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes, linear)
[    0.098055] NET: Registered PF_UNIX/PF_LOCAL protocol family
[    0.098376] RPC: Registered named UNIX socket transport module.
[    0.098378] RPC: Registered udp transport module.
[    0.098378] RPC: Registered tcp transport module.
[    0.098379] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.098380] PCI: CLS 0 bytes, default 64
[    0.098395] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
[    0.098396] software IO TLB: mapped [mem 0x00000000f4000000-0x00000000f8000000] (64MB)
[    0.098424] KVM: vmx: using Hyper-V Enlightened VMCS
[    0.098431] Trying to unpack rootfs image as initramfs...
[    0.099144] Freeing initrd memory: 1896K
[    0.274561] kvm: already loaded the other module
[    0.277883] Initialise system trusted keyrings
[    0.277986] workingset: timestamp_bits=46 max_order=21 bucket_order=0
[    0.278553] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.278745] NFS: Registering the id_resolver key type
[    0.278751] Key type id_resolver registered
[    0.278752] Key type id_legacy registered
[    0.278754] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    0.278756] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
[    0.278757] Installing knfsd (copyright (C) 1996 okir@monad.swb.de).
[    0.279346] Key type cifs.idmap registered
[    0.279414] fuse: init (API version 7.34)
[    0.279539] SGI XFS with ACLs, security attributes, realtime, scrub, repair, quota, no debug enabled
[    0.279857] 9p: Installing v9fs 9p2000 file system support
[    0.279864] FS-Cache: Netfs '9p' registered for caching
[    0.279890] FS-Cache: Netfs 'ceph' registered for caching
[    0.279891] ceph: loaded (mds proto 32)
[    0.286762] NET: Registered PF_ALG protocol family
[    0.286765] xor: automatically using best checksumming function   avx
[    0.286767] Key type asymmetric registered
[    0.286767] Asymmetric key parser 'x509' registered
[    0.286784] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)
[    0.287656] hv_vmbus: registering driver hv_pci
[    0.287977] hv_pci fa12e333-ce2c-4814-a385-951ebd1ef99e: PCI VMBus probing: Using version 0x10004
[    0.288741] hv_pci fa12e333-ce2c-4814-a385-951ebd1ef99e: PCI host bridge to bus ce2c:00
[    0.288743] pci_bus ce2c:00: root bus resource [mem 0x9ffe00000-0x9ffe02fff window]
[    0.288745] pci_bus ce2c:00: No busn resource found for root bus, will use [bus 00-ff]
[    0.289230] pci ce2c:00:00.0: [1af4:1043] type 00 class 0x010000
[    0.289801] pci ce2c:00:00.0: reg 0x10: [mem 0x9ffe00000-0x9ffe00fff 64bit]
[    0.290167] pci ce2c:00:00.0: reg 0x18: [mem 0x9ffe01000-0x9ffe01fff 64bit]
[    0.290538] pci ce2c:00:00.0: reg 0x20: [mem 0x9ffe02000-0x9ffe02fff 64bit]
[    0.292378] pci_bus ce2c:00: busn_res: [bus 00-ff] end is updated to 00
[    0.292383] pci ce2c:00:00.0: BAR 0: assigned [mem 0x9ffe00000-0x9ffe00fff 64bit]
[    0.292636] pci ce2c:00:00.0: BAR 2: assigned [mem 0x9ffe01000-0x9ffe01fff 64bit]
[    0.292894] pci ce2c:00:00.0: BAR 4: assigned [mem 0x9ffe02000-0x9ffe02fff 64bit]
[    0.293416] hv_pci 114bfba2-6b19-4280-9ecb-1d72e843736b: PCI VMBus probing: Using version 0x10004
[    0.293930] hv_pci 114bfba2-6b19-4280-9ecb-1d72e843736b: PCI host bridge to bus 6b19:00
[    0.293933] pci_bus 6b19:00: No busn resource found for root bus, will use [bus 00-ff]
[    0.294148] pci 6b19:00:00.0: [1414:008e] type 00 class 0x030200
[    0.296629] pci_bus 6b19:00: busn_res: [bus 00-ff] end is updated to 00
[    0.296895] hv_pci 819f55e9-4518-4a2f-9caa-335207a05aaf: PCI VMBus probing: Using version 0x10004
[    0.297379] hv_pci 819f55e9-4518-4a2f-9caa-335207a05aaf: PCI host bridge to bus 4518:00
[    0.297381] pci_bus 4518:00: No busn resource found for root bus, will use [bus 00-ff]
[    0.297594] pci 4518:00:00.0: [1414:008e] type 00 class 0x030200
[    0.300042] pci_bus 4518:00: busn_res: [bus 00-ff] end is updated to 00
[    0.300804] hv_pci 35697c47-baf8-486e-8e06-b61cb94b440d: PCI VMBus probing: Using version 0x10004
[    0.301459] hv_pci 35697c47-baf8-486e-8e06-b61cb94b440d: PCI host bridge to bus baf8:00
[    0.301461] pci_bus baf8:00: root bus resource [mem 0x9ffe04000-0x9ffe06fff window]
[    0.301462] pci_bus baf8:00: No busn resource found for root bus, will use [bus 00-ff]
[    0.302032] pci baf8:00:00.0: [1af4:1049] type 00 class 0x010000
[    0.302590] pci baf8:00:00.0: reg 0x10: [mem 0x9ffe04000-0x9ffe04fff 64bit]
[    0.302978] pci baf8:00:00.0: reg 0x18: [mem 0x9ffe05000-0x9ffe05fff 64bit]
[    0.303405] pci baf8:00:00.0: reg 0x20: [mem 0x9ffe06000-0x9ffe06fff 64bit]
[    0.305597] pci_bus baf8:00: busn_res: [bus 00-ff] end is updated to 00
[    0.305601] pci baf8:00:00.0: BAR 0: assigned [mem 0x9ffe04000-0x9ffe04fff 64bit]
[    0.305884] pci baf8:00:00.0: BAR 2: assigned [mem 0x9ffe05000-0x9ffe05fff 64bit]
[    0.306160] pci baf8:00:00.0: BAR 4: assigned [mem 0x9ffe06000-0x9ffe06fff 64bit]
[    0.306526] ACPI: AC: AC Adapter [AC1] (on-line)
[    0.307152] ACPI: battery: Slot [BAT1] (battery present)
[    0.311885] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[    0.335260] Non-volatile memory driver v1.3
[    0.335485] [drm] Initialized vgem 1.0.0 20120112 for vgem on minor 0
[    0.336423] printk: console [hvc0] enabled
[    0.338600] brd: module loaded
[    0.339770] loop: module loaded
[    0.340092] hv_vmbus: registering driver hv_storvsc
[    0.340865] wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information.
[    0.341371] wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld <Jason@zx2c4.com>. All Rights Reserved.
[    0.341854] tun: Universal TUN/TAP device driver, 1.6
[    0.342202] PPP generic driver version 2.4.2
[    0.342504] scsi host0: storvsc_host_t
[    0.342596] PPP BSD Compression module registered
[    0.343076] PPP Deflate Compression module registered
[    0.343532] PPP MPPE Compression module registered
[    0.343850] NET: Registered PF_PPPOX protocol family
[    0.344215] usbcore: registered new interface driver cdc_ether
[    0.344641] usbcore: registered new interface driver cdc_ncm
[    0.345058] usbcore: registered new interface driver r8153_ecm
[    0.345522] hv_vmbus: registering driver hv_netvsc
[    0.346080] VFIO - User Level meta-driver version: 0.3
[    0.346516] usbcore: registered new interface driver cdc_acm
[    0.346868] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters
[    0.347267] usbcore: registered new interface driver ch341
[    0.347579] usbserial: USB Serial support registered for ch341-uart
[    0.347924] usbcore: registered new interface driver cp210x
[    0.348216] usbserial: USB Serial support registered for cp210x
[    0.348564] usbcore: registered new interface driver ftdi_sio
[    0.348907] usbserial: USB Serial support registered for FTDI USB Serial Device
[    0.349490] vhci_hcd vhci_hcd.0: USB/IP Virtual Host Controller
[    0.349892] vhci_hcd vhci_hcd.0: new USB bus registered, assigned bus number 1
[    0.350306] vhci_hcd: created sysfs vhci_hcd.0
[    0.350769] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15
[    0.351192] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.351612] usb usb1: Product: USB/IP Virtual Host Controller
[    0.351933] usb usb1: Manufacturer: Linux 5.15.79.1-microsoft-standard-WSL2 vhci_hcd
[    0.352370] usb usb1: SerialNumber: vhci_hcd.0
[    0.352797] hub 1-0:1.0: USB hub found
[    0.353049] hub 1-0:1.0: 8 ports detected
[    0.353553] vhci_hcd vhci_hcd.0: USB/IP Virtual Host Controller
[    0.353928] vhci_hcd vhci_hcd.0: new USB bus registered, assigned bus number 2
[    0.354404] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.
[    0.354956] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.15
[    0.355362] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.355741] usb usb2: Product: USB/IP Virtual Host Controller
[    0.356038] usb usb2: Manufacturer: Linux 5.15.79.1-microsoft-standard-WSL2 vhci_hcd
[    0.356418] usb usb2: SerialNumber: vhci_hcd.0
[    0.356806] hub 2-0:1.0: USB hub found
[    0.357121] hub 2-0:1.0: 8 ports detected
[    0.357728] hv_vmbus: registering driver hyperv_keyboard
[    0.358135] rtc_cmos 00:00: RTC can wake from S4
[    0.359484] rtc_cmos 00:00: registered as rtc0
[    0.359997] rtc_cmos 00:00: setting system clock to 2022-12-20T13:41:35 UTC (1671543695)
[    0.360431] rtc_cmos 00:00: alarms up to one month, 114 bytes nvram
[    0.361005] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com
[    0.361605] device-mapper: raid: Loading target version 1.15.1
[    0.361947] usbcore: registered new interface driver usbhid
[    0.362227] usbhid: USB HID core driver
[    0.362482] hv_utils: Registering HyperV Utility Driver
[    0.362733] hv_vmbus: registering driver hv_utils
[    0.363004] hv_vmbus: registering driver hv_balloon
[    0.363391] hv_vmbus: registering driver dxgkrnl
[    0.363411] hv_utils: TimeSync IC version 4.0
[    0.364170] hv_balloon: Using Dynamic Memory protocol version 2.0
[    0.365028] Free page reporting enabled
[    0.365263] hv_balloon: Cold memory discard hint enabled with order 9
[    0.366261] drop_monitor: Initializing network drop monitor service
[    0.366667] Mirror/redirect action on
[    0.366876] u32 classifier
[    0.367013]     Performance counters on
[    0.367203]     input device check on
[    0.367398]     Actions configured
[    0.368267] IPVS: Registered protocols (TCP, UDP)
[    0.368597] IPVS: Connection hash table configured (size=4096, memory=32Kbytes)
[    0.368994] IPVS: ipvs loaded.
[    0.369212] IPVS: [rr] scheduler registered.
[    0.369482] IPVS: [wrr] scheduler registered.
[    0.369743] IPVS: [sh] scheduler registered.
[    0.370011] ipip: IPv4 and MPLS over IPv4 tunneling driver
[    0.370390] ipt_CLUSTERIP: ClusterIP Version 0.8 loaded successfully
[    0.370742] Initializing XFRM netlink socket
[    0.371054] NET: Registered PF_INET6 protocol family
[    0.371694] Segment Routing with IPv6
[    0.371900] In-situ OAM (IOAM) with IPv6
[    0.372106] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[    0.372486] NET: Registered PF_PACKET protocol family
[    0.372753] Bridge firewalling registered
[    0.372947] 8021q: 802.1Q VLAN Support v1.8
[    0.373145] sctp: Hash tables configured (bind 256/256)
[    0.373477] 9pnet: Installing 9P2000 support
[    0.383651] Key type dns_resolver registered
[    0.384021] Key type ceph registered
[    0.384376] libceph: loaded (mon/osd proto 15/24)
[    0.384734] NET: Registered PF_VSOCK protocol family
[    0.385030] hv_vmbus: registering driver hv_sock
[    0.385335] IPI shorthand broadcast: enabled
[    0.385650] sched_clock: Marking stable (381944864, 2774500)->(405941500, -21222136)
[    0.386515] registered taskstats version 1
[    0.387487] Loading compiled-in X.509 certificates
[    0.389202] Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no
[    0.391905] Freeing unused kernel image (initmem) memory: 2028K
[    0.443228] Write protecting the kernel read-only data: 30720k
[    0.444335] Freeing unused kernel image (text/rodata gap) memory: 2024K
[    0.444980] Freeing unused kernel image (rodata/data gap) memory: 480K
[    0.445295] Run /init as init process
[    0.445476]   with arguments:
[    0.445718]     /init
[    0.445858]   with environment:
[    0.446089]     HOME=/
[    0.446207]     TERM=linux
[    0.446326]     WSL_ROOT_INIT=1
[    0.515479] scsi 0:0:0:0: Direct-Access     Msft     Virtual Disk     1.0  PQ: 0 ANSI: 5
[    0.516712] sd 0:0:0:0: Attached scsi generic sg0 type 0
[    0.517640] sd 0:0:0:0: [sda] 743696 512-byte logical blocks: (381 MB/363 MiB)
[    0.518203] sd 0:0:0:0: [sda] Write Protect is on
[    0.518468] sd 0:0:0:0: [sda] Mode Sense: 0f 00 80 00
[    0.518865] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
[    0.973783] EXT4-fs (sda): mounted filesystem without journal. Opts: (null). Quota mode: none.
[    1.013396] sd 0:0:0:0: [sda] Attached SCSI disk
[    1.216205] hv_pci c1836fb2-8137-4c33-b93e-9ccbfc366d9e: PCI VMBus probing: Using version 0x10004
[    1.218029] hv_pci c1836fb2-8137-4c33-b93e-9ccbfc366d9e: PCI host bridge to bus 8137:00
[    1.218485] pci_bus 8137:00: root bus resource [mem 0xc00000000-0xe00001fff window]
[    1.218933] pci_bus 8137:00: No busn resource found for root bus, will use [bus 00-ff]
[    1.219944] pci 8137:00:00.0: [1af4:105a] type 00 class 0x088000
[    1.222054] pci 8137:00:00.0: reg 0x10: [mem 0xe00000000-0xe00000fff 64bit]
[    1.224234] pci 8137:00:00.0: reg 0x18: [mem 0xe00001000-0xe00001fff 64bit]
[    1.225971] pci 8137:00:00.0: reg 0x20: [mem 0xc00000000-0xdffffffff 64bit]
[    1.229554] pci_bus 8137:00: busn_res: [bus 00-ff] end is updated to 00
[    1.229940] pci 8137:00:00.0: BAR 4: assigned [mem 0xc00000000-0xdffffffff 64bit]
[    1.231744] pci 8137:00:00.0: BAR 0: assigned [mem 0xe00000000-0xe00000fff 64bit]
[    1.233569] pci 8137:00:00.0: BAR 2: assigned [mem 0xe00001000-0xe00001fff 64bit]
[    1.244337] virtiofs virtio2: Cache len: 0x200000000 @ 0xc00000000
[    1.302491] memmap_init_zone_device initialised 2097152 pages in 10ms
[    1.309493] FS-Cache: Duplicate cookie detected
[    1.309936] FS-Cache: O-cookie c=00000004 [p=00000002 fl=222 nc=0 na=1]
[    1.310223] FS-Cache: O-cookie d=0000000099e72a05{9P.session} n=00000000565fd912
[    1.310617] FS-Cache: O-key=[10] '34323934393337343231'
[    1.310855] FS-Cache: N-cookie c=00000005 [p=00000002 fl=2 nc=0 na=1]
[    1.311169] FS-Cache: N-cookie d=0000000099e72a05{9P.session} n=00000000360127f4
[    1.311629] FS-Cache: N-key=[10] '34323934393337343231'
[    1.333225] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2135f8984a8, max_idle_ns: 440795232764 ns
[    1.334180] clocksource: Switched to clocksource tsc
[    1.343263] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[    2.423425] scsi 0:0:0:1: Direct-Access     Msft     Virtual Disk     1.0  PQ: 0 ANSI: 5
[    2.424345] sd 0:0:0:1: Attached scsi generic sg1 type 0
[    2.424830] scsi 0:0:0:2: Direct-Access     Msft     Virtual Disk     1.0  PQ: 0 ANSI: 5
[    2.424977] sd 0:0:0:1: [sdb] 4194312 512-byte logical blocks: (2.15 GB/2.00 GiB)
[    2.425667] sd 0:0:0:1: [sdb] 4096-byte physical blocks
[    2.426032] sd 0:0:0:1: [sdb] Write Protect is off
[    2.426134] sd 0:0:0:2: Attached scsi generic sg2 type 0
[    2.426299] sd 0:0:0:1: [sdb] Mode Sense: 0f 00 00 00
[    2.426687] sd 0:0:0:2: [sdc] 536870912 512-byte logical blocks: (275 GB/256 GiB)
[    2.426988] sd 0:0:0:1: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    2.427211] sd 0:0:0:2: [sdc] 4096-byte physical blocks
[    2.427301] sd 0:0:0:2: [sdc] Write Protect is off
[    2.428225] sd 0:0:0:2: [sdc] Mode Sense: 0f 00 00 00
[    2.428611] sd 0:0:0:2: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    2.430005] sd 0:0:0:1: [sdb] Attached SCSI disk
[    2.431307] sd 0:0:0:2: [sdc] Attached SCSI disk
[    2.474244] EXT4-fs (sdc): 4 orphan inodes deleted
[    2.474802] EXT4-fs (sdc): recovery complete
[    2.484293] EXT4-fs (sdc): mounted filesystem with ordered data mode. Opts: discard,errors=remount-ro,data=ordered. Quota mode: none.
[    2.484978] Adding 2097152k swap on /dev/sdb.  Priority:-2 extents:1 across:2097152k
[   49.213793] hv_balloon: Max. dynamic memory size: 8192 MB
[   86.691672] /sbin/ldconfig:
[   86.691675] /usr/lib/wsl/lib/libcuda.so.1 is not a symbolic link

[   86.821814] hv_pci 09f4da49-fe66-406b-90d2-70456760fe09: PCI VMBus probing: Using version 0x10004
[   86.822791] 9pnet_virtio: no channels available for device drvfs
[   86.823082] hv_pci 09f4da49-fe66-406b-90d2-70456760fe09: PCI host bridge to bus fe66:00
[   86.823544] WSL (1) WARNING: mount: waiting for virtio device drvfs
[   86.823900] pci_bus fe66:00: root bus resource [mem 0x9ffe08000-0x9ffe0afff window]
[   86.824621] pci_bus fe66:00: No busn resource found for root bus, will use [bus 00-ff]
[   86.825566] pci fe66:00:00.0: [1af4:1049] type 00 class 0x010000
[   86.826604] pci fe66:00:00.0: reg 0x10: [mem 0x9ffe08000-0x9ffe08fff 64bit]
[   86.827380] pci fe66:00:00.0: reg 0x18: [mem 0x9ffe09000-0x9ffe09fff 64bit]
[   86.828103] pci fe66:00:00.0: reg 0x20: [mem 0x9ffe0a000-0x9ffe0afff 64bit]
[   86.830715] pci_bus fe66:00: busn_res: [bus 00-ff] end is updated to 00
[   86.831107] pci fe66:00:00.0: BAR 0: assigned [mem 0x9ffe08000-0x9ffe08fff 64bit]
[   86.831798] pci fe66:00:00.0: BAR 2: assigned [mem 0x9ffe09000-0x9ffe09fff 64bit]
[   86.832480] pci fe66:00:00.0: BAR 4: assigned [mem 0x9ffe0a000-0x9ffe0afff 64bit]
[   86.928186] hv_pci 93d7b0ed-53fe-43b4-b45f-2fd7fe5a8952: PCI VMBus probing: Using version 0x10004
[   86.929484] hv_pci 93d7b0ed-53fe-43b4-b45f-2fd7fe5a8952: PCI host bridge to bus 53fe:00
[   86.929878] pci_bus 53fe:00: root bus resource [mem 0x9ffe0c000-0x9ffe0efff window]
[   86.930319] pci_bus 53fe:00: No busn resource found for root bus, will use [bus 00-ff]
[   86.931285] pci 53fe:00:00.0: [1af4:1049] type 00 class 0x010000
[   86.932155] pci 53fe:00:00.0: reg 0x10: [mem 0x9ffe0c000-0x9ffe0cfff 64bit]
[   86.932911] pci 53fe:00:00.0: reg 0x18: [mem 0x9ffe0d000-0x9ffe0dfff 64bit]
[   86.933660] pci 53fe:00:00.0: reg 0x20: [mem 0x9ffe0e000-0x9ffe0efff 64bit]
[   86.936284] pci_bus 53fe:00: busn_res: [bus 00-ff] end is updated to 00
[   86.936704] pci 53fe:00:00.0: BAR 0: assigned [mem 0x9ffe0c000-0x9ffe0cfff 64bit]
[   86.937428] pci 53fe:00:00.0: BAR 2: assigned [mem 0x9ffe0d000-0x9ffe0dfff 64bit]
[   86.938201] pci 53fe:00:00.0: BAR 4: assigned [mem 0x9ffe0e000-0x9ffe0efff 64bit]
[   87.005869] /sbin/ldconfig.real:
[   87.005872] /usr/lib/wsl/lib/libcuda.so.1 is not a symbolic link

[   87.119533] hv_pci 403104ce-3898-40dd-be14-e1f7098fef54: PCI VMBus probing: Using version 0x10004
[   87.120820] 9pnet_virtio: no channels available for device drvfs
[   87.121184] WSL (1) WARNING: mount: waiting for virtio device drvfs
[   87.160911] hv_pci 403104ce-3898-40dd-be14-e1f7098fef54: PCI host bridge to bus 3898:00
[   87.161502] pci_bus 3898:00: root bus resource [mem 0xbffe10000-0xbffe12fff window]
[   87.161928] pci_bus 3898:00: No busn resource found for root bus, will use [bus 00-ff]
[   87.162918] pci 3898:00:00.0: [1af4:1049] type 00 class 0x010000
[   87.163917] pci 3898:00:00.0: reg 0x10: [mem 0xbffe10000-0xbffe10fff 64bit]
[   87.164693] pci 3898:00:00.0: reg 0x18: [mem 0xbffe11000-0xbffe11fff 64bit]
[   87.165497] pci 3898:00:00.0: reg 0x20: [mem 0xbffe12000-0xbffe12fff 64bit]
[   87.168329] pci_bus 3898:00: busn_res: [bus 00-ff] end is updated to 00
[   87.168713] pci 3898:00:00.0: BAR 0: assigned [mem 0xbffe10000-0xbffe10fff 64bit]
[   87.169374] pci 3898:00:00.0: BAR 2: assigned [mem 0xbffe11000-0xbffe11fff 64bit]
[   87.170033] pci 3898:00:00.0: BAR 4: assigned [mem 0xbffe12000-0xbffe12fff 64bit]
[   87.209451] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -22
[   87.209938] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -22
[   87.210246] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -22
[   87.210784] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -2
[   87.211769] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -22
[   87.212187] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -22
[   87.212563] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -22
[   87.213021] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -2
[   87.225430] hv_pci fee78f50-c45e-48d6-a577-395dcec04126: PCI VMBus probing: Using version 0x10004
[   87.263864] hv_pci fee78f50-c45e-48d6-a577-395dcec04126: PCI host bridge to bus c45e:00
[   87.264317] pci_bus c45e:00: root bus resource [mem 0xbffe14000-0xbffe16fff window]
[   87.264692] pci_bus c45e:00: No busn resource found for root bus, will use [bus 00-ff]
[   87.265621] pci c45e:00:00.0: [1af4:1049] type 00 class 0x010000
[   87.266572] pci c45e:00:00.0: reg 0x10: [mem 0xbffe14000-0xbffe14fff 64bit]
[   87.267375] pci c45e:00:00.0: reg 0x18: [mem 0xbffe15000-0xbffe15fff 64bit]
[   87.268151] pci c45e:00:00.0: reg 0x20: [mem 0xbffe16000-0xbffe16fff 64bit]
[   87.270828] pci_bus c45e:00: busn_res: [bus 00-ff] end is updated to 00
[   87.271363] pci c45e:00:00.0: BAR 0: assigned [mem 0xbffe14000-0xbffe14fff 64bit]
[   87.272304] pci c45e:00:00.0: BAR 2: assigned [mem 0xbffe15000-0xbffe15fff 64bit]
[   87.273005] pci c45e:00:00.0: BAR 4: assigned [mem 0xbffe16000-0xbffe16fff 64bit]
[   88.848424] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -2
[   89.090857] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -2
[   89.091562] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -2
[   89.092152] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -2
[   89.092698] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -2
[   89.093203] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -2
[   89.093809] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -2
[   89.094390] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -2
[   89.094883] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -2
[   89.095465] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -2
[   89.095937] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -2
[   89.517970] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -2
eduardopilati commented 1 year ago

Before the 22h2 update wsl took less than 10 seconds to start, now it takes 2 minutes

eduardopilati commented 1 year ago

disabling swap by including setting swap=0 in wslconf solved the problem

mlocati commented 1 year ago

disabling swap by including setting swap=0 in wslconf solved the problem

I've just tried to create the file %USERPROFILE%\.wslconfig with this swap=0 line, but WSL 2 startup is still much slower than it used to be before I updated Windows 11 to 22H2...

tilenkranjc commented 1 year ago

I'm not sure if it's related, but disconnecting inaccessible mapped network drives solved it for me. Here's an issue -> #9358

oomek commented 1 year ago

Disconnectting mapped drives is not a solution. I have 6 mostly offline mapped drives and WSL start takes 4 minutes and 17 seconds. This issue should be reopened.

joehays commented 9 months ago

@eduardopilati This is not fixed. This issue should not have been closed.