microsoft / WSL

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

WSL2 cold start super slow (almost 1 minute) #10966

Closed imag0r closed 2 months ago

imag0r commented 10 months ago

Windows Version

Microsoft Windows [Version 10.0.22631.2861]

WSL Version

2.0.0.0

Are you using WSL 1 or WSL 2?

Kernel Version

5.15.123.1-1

Distro Version

Debian Testing, Kali Rolling, both up to date

Other Software

Windows Terminal 1.18.3181.0

Repro Steps

Make sure WSL is shut down (reboot or run wsl --shutdown) Start WSL2 session in Windows Terminal

Expected Behavior

WSL starts immediately

Actual Behavior

WSL needs almost a minute to start the first session. Once the first session starts, opening new WSL windows is instantaneous, even if starting different distro. dmesg indicates a significant delay between network and memory related messages.

Diagnostic Logs

dmesg: [ 0.000000] Linux version 5.15.123.1-microsoft-standard-WSL2 (root@5a891d5fa777) (gcc (GCC) 11.2.0, GNU ld (GNU Binutils) 2.37) #1 SMP Mon Aug 7 19:01:48 UTC 2023 [ 0.000000] Command line: initrd=\initrd.img WSL_ROOT_INIT=1 panic=-1 nr_cpus=8 bonding.max_bonds=0 dummy.numdummies=0 fb_tunnels=none swiotlb=force cgroup_no_v1=all 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[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-0x00000003fe9fffff] 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-2-0.2861
[    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 2995.211 MHz processor
[    0.000011] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.000013] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.000016] last_pfn = 0x3fea00 max_arch_pfn = 0x400000000
[    0.000041] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT
[    0.000055] last_pfn = 0xf8000 max_arch_pfn = 0x400000000
[    0.000063] Using GB pages for direct mapping
[    0.000126] RAMDISK: [mem 0x03dd6000-0x03fd0fff]
[    0.000128] ACPI: Early table checksum verification disabled
[    0.000131] ACPI: RSDP 0x00000000000E0000 000024 (v02 VRTUAL)
[    0.000135] ACPI: XSDT 0x0000000000100000 000044 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
[    0.000140] ACPI: FACP 0x0000000000101000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001)
[    0.000145] ACPI: DSDT 0x00000000001011B8 01E191 (v02 MSFTVM DSDT01   00000001 MSFT 05000000)
[    0.000149] ACPI: FACS 0x0000000000101114 000040
[    0.000152] ACPI: OEM0 0x0000000000101154 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
[    0.000155] ACPI: SRAT 0x000000000011F349 000330 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
[    0.000158] ACPI: APIC 0x000000000011F679 000088 (v04 VRTUAL MICROSFT 00000001 MSFT 00000001)
[    0.000160] ACPI: Reserving FACP table memory at [mem 0x101000-0x101113]
[    0.000162] ACPI: Reserving DSDT table memory at [mem 0x1011b8-0x11f348]
[    0.000163] ACPI: Reserving FACS table memory at [mem 0x101114-0x101153]
[    0.000164] ACPI: Reserving OEM0 table memory at [mem 0x101154-0x1011b7]
[    0.000165] ACPI: Reserving SRAT table memory at [mem 0x11f349-0x11f678]
[    0.000165] ACPI: Reserving APIC table memory at [mem 0x11f679-0x11f700]
[    0.000592] Zone ranges:
[    0.000593]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.000596]   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
[    0.000597]   Normal   [mem 0x0000000100000000-0x00000003fe9fffff]
[    0.000598]   Device   empty
[    0.000600] Movable zone start for each node
[    0.000600] Early memory node ranges
[    0.000601]   node   0: [mem 0x0000000000001000-0x000000000009ffff]
[    0.000602]   node   0: [mem 0x0000000000200000-0x00000000f7ffffff]
[    0.000603]   node   0: [mem 0x0000000100000000-0x00000003fe9fffff]
[    0.000606] Initmem setup node 0 [mem 0x0000000000001000-0x00000003fe9fffff]
[    0.000795] On node 0, zone DMA: 1 pages in unavailable ranges
[    0.000821] On node 0, zone DMA: 352 pages in unavailable ranges
[    0.010650] On node 0, zone Normal: 5632 pages in unavailable ranges
[    0.010683] ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1])
[    0.010903] IOAPIC[0]: apic_id 8, version 17, address 0xfec00000, GSI 0-23
[    0.010907] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.010910] ACPI: Using ACPI (MADT) for SMP configuration information
[    0.010911] TSC deadline timer available
[    0.010912] smpboot: Allowing 8 CPUs, 0 hotplug CPUs
[    0.010918] [mem 0xf8000000-0xffffffff] available for PCI devices
[    0.010919] Booting paravirtualized kernel on Hyper-V
[    0.010920] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.015568] setup_percpu: NR_CPUS:256 nr_cpumask_bits:256 nr_cpu_ids:8 nr_node_ids:1
[    0.016122] percpu: Embedded 53 pages/cpu s177624 r8192 d31272 u262144
[    0.016129] pcpu-alloc: s177624 r8192 d31272 u262144 alloc=1*2097152
[    0.016132] pcpu-alloc: [0] 0 1 2 3 4 5 6 7
[    0.016146] Hyper-V: PV spinlocks enabled
[    0.016148] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear)
[    0.016153] Built 1 zonelists, mobility grouping on.  Total pages: 4089949
[    0.016155] Kernel command line: initrd=\initrd.img WSL_ROOT_INIT=1 panic=-1 nr_cpus=8 bonding.max_bonds=0 dummy.numdummies=0 fb_tunnels=none swiotlb=force cgroup_no_v1=all console=hvc0 debug pty.legacy_count=0
[    0.016252] Unknown kernel command line parameters "WSL_ROOT_INIT=1", will be passed to user space.
[    0.017930] Dentry cache hash table entries: 2097152 (order: 12, 16777216 bytes, linear)
[    0.018714] Inode-cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear)
[    0.018803] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.038293] Memory: 4124432K/16622204K available (18452K kernel code, 2631K rwdata, 9732K rodata, 2012K init, 1780K bss, 398452K reserved, 0K cma-reserved)
[    0.038322] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=8, Nodes=1
[    0.038331] ftrace: allocating 53204 entries in 208 pages
[    0.055557] ftrace: allocated 208 pages with 3 groups
[    0.055792] rcu: Hierarchical RCU implementation.
[    0.055794] rcu:     RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=8.
[    0.055795]  Rude variant of Tasks RCU enabled.
[    0.055795]  Tracing variant of Tasks RCU enabled.
[    0.055796] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
[    0.055796] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=8
[    0.058534] Using NULL legacy PIC
[    0.058536] NR_IRQS: 16640, nr_irqs: 488, preallocated irqs: 0
[    0.058850] random: crng init done
[    0.058871] Console: colour dummy device 80x25
[    0.058878] ACPI: Core revision 20210730
[    0.058944] Failed to register legacy timer interrupt
[    0.058945] APIC: Switch to symmetric I/O mode setup
[    0.060259] x2apic enabled
[    0.061903] Switched APIC routing to physical x2apic.
[    0.061938] Hyper-V: Using IPI hypercalls
[    0.062039] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2b2c993ffe9, max_idle_ns: 440795229210 ns
[    0.062051] Calibrating delay loop (skipped), value calculated using timer frequency.. 5990.42 BogoMIPS (lpj=29952110)
[    0.062055] pid_max: default: 32768 minimum: 301
[    0.062077] LSM: Security Framework initializing
[    0.062085] landlock: Up and running.
[    0.062126] Mount-cache hash table entries: 32768 (order: 6, 262144 bytes, linear)
[    0.062152] Mountpoint-cache hash table entries: 32768 (order: 6, 262144 bytes, linear)
[    0.062344] Disabling cpuset control group subsystem in v1 mounts
[    0.062354] Disabling cpu control group subsystem in v1 mounts
[    0.062357] Disabling cpuacct control group subsystem in v1 mounts
[    0.062361] Disabling io control group subsystem in v1 mounts
[    0.062373] Disabling memory control group subsystem in v1 mounts
[    0.062379] Disabling devices control group subsystem in v1 mounts
[    0.062382] Disabling freezer control group subsystem in v1 mounts
[    0.062386] Disabling net_cls control group subsystem in v1 mounts
[    0.062392] Disabling perf_event control group subsystem in v1 mounts
[    0.062394] Disabling net_prio control group subsystem in v1 mounts
[    0.062397] Disabling hugetlb control group subsystem in v1 mounts
[    0.062399] Disabling pids control group subsystem in v1 mounts
[    0.062402] Disabling rdma control group subsystem in v1 mounts
[    0.062404] Disabling misc control group subsystem in v1 mounts
[    0.062597] x86/cpu: User Mode Instruction Prevention (UMIP) activated
[    0.062657] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.062658] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[    0.062662] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
[    0.062678] Spectre V2 : Mitigation: Enhanced IBRS
[    0.062679] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
[    0.062679] Spectre V2 : Spectre v2 / PBRSB-eIBRS: Retire a single CALL on VMEXIT
[    0.062680] RETBleed: Mitigation: Enhanced IBRS
[    0.062681] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier
[    0.062683] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl and seccomp
[    0.072046] Freeing SMP alternatives memory: 60K
[    0.072046] smpboot: CPU0: 11th Gen Intel(R) Core(TM) i7-1185G7 @ 3.00GHz (family: 0x6, model: 0x8c, stepping: 0x1)
[    0.072046] Performance Events:  AnyThread deprecated, Icelake events, 32-deep LBR, full-width counters, Intel PMU driver.
[    0.072046] ... version:                5
[    0.072046] ... bit width:              48
[    0.072046] ... generic registers:      8
[    0.072046] ... value mask:             0000ffffffffffff
[    0.072046] ... max period:             00007fffffffffff
[    0.072046] ... fixed-purpose events:   4
[    0.072046] ... event mask:             0001000f000000ff
[    0.072046] rcu: Hierarchical SRCU implementation.
[    0.072046] smp: Bringing up secondary CPUs ...
[    0.072046] x86: Booting SMP configuration:
[    0.072046] .... node  #0, CPUs:      #1 #2 #3 #4 #5 #6 #7
[    0.072046] smp: Brought up 1 node, 8 CPUs
[    0.072046] smpboot: Max logical packages: 1
[    0.072046] smpboot: Total of 8 processors activated (47923.37 BogoMIPS)
[    0.085918] node 0 deferred pages initialised in 20ms
[    0.085918] devtmpfs: initialized
[    0.085918] x86/mm: Memory block size: 128MB
[    0.085918] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.085918] futex hash table entries: 2048 (order: 5, 131072 bytes, linear)
[    0.092176] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[    0.092244] audit: initializing netlink subsys (disabled)
[    0.092258] thermal_sys: Registered thermal governor 'step_wise'
[    0.092258] audit: type=2000 audit(1704052851.030:1): state=initialized audit_enabled=0 res=1
[    0.092258] cpuidle: using governor menu
[    0.092258] ACPI: bus type PCI registered
[    0.092258] PCI: Fatal: No config space access function found
[    0.092891] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
[    0.092909] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
[    0.092909] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    0.102082] raid6: skip pq benchmark and using algorithm avx512x4
[    0.102085] raid6: using avx512x2 recovery algorithm
[    0.102095] ACPI: Added _OSI(Module Device)
[    0.102096] ACPI: Added _OSI(Processor Device)
[    0.102096] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.102097] ACPI: Added _OSI(Processor Aggregator Device)
[    0.102098] ACPI: Added _OSI(Linux-Dell-Video)
[    0.102098] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
[    0.102099] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics)
[    0.104659] ACPI: 1 ACPI AML tables successfully acquired and loaded
[    0.105209] ACPI: Interpreter enabled
[    0.105211] ACPI: PM: (supports S0 S5)
[    0.105212] ACPI: Using IOAPIC for interrupt routing
[    0.105221] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.105293] ACPI: Enabled 2 GPEs in block 00 to 0F
[    0.105985] iommu: Default domain type: Translated
[    0.105986] iommu: DMA domain TLB invalidation policy: lazy mode
[    0.106035] SCSI subsystem initialized
[    0.106055] ACPI: bus type USB registered
[    0.106060] usbcore: registered new interface driver usbfs
[    0.106064] usbcore: registered new interface driver hub
[    0.106067] usbcore: registered new device driver usb
[    0.106072] pps_core: LinuxPPS API ver. 1 registered
[    0.106072] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.106074] PTP clock support registered
[    0.106091] hv_vmbus: Vmbus version:5.3
[    0.106091] PCI: Using ACPI for IRQ routing
[    0.106091] PCI: System does not support PCI
[    0.106091] hv_vmbus: Unknown GUID: c376c1c3-d276-48d2-90a9-c04748072c60
[    0.106091] hv_vmbus: Unknown GUID: 6e382d18-3336-4f4b-acc4-2b7703d4df4a
[    0.106091] hv_vmbus: Unknown GUID: dde9cbc0-5060-4436-9448-ea1254a5d177
[    0.106091] clocksource: Switched to clocksource tsc-early
[    0.110991] VFS: Disk quotas dquot_6.6.0
[    0.111000] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.111012] FS-Cache: Loaded
[    0.111030] pnp: PnP ACPI init
[    0.111161] pnp: PnP ACPI: found 1 devices
[    0.117517] NET: Registered PF_INET protocol family
[    0.117857] IP idents hash table entries: 262144 (order: 9, 2097152 bytes, linear)
[    0.118715] tcp_listen_portaddr_hash hash table entries: 8192 (order: 5, 131072 bytes, linear)
[    0.118730] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
[    0.118733] TCP established hash table entries: 131072 (order: 8, 1048576 bytes, linear)
[    0.119001] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes, linear)
[    0.119321] TCP: Hash tables configured (established 131072 bind 65536)
[    0.119345] UDP hash table entries: 8192 (order: 6, 262144 bytes, linear)
[    0.119374] UDP-Lite hash table entries: 8192 (order: 6, 262144 bytes, linear)
[    0.119416] NET: Registered PF_UNIX/PF_LOCAL protocol family
[    0.119778] RPC: Registered named UNIX socket transport module.
[    0.119780] RPC: Registered udp transport module.
[    0.119781] RPC: Registered tcp transport module.
[    0.119782] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.119784] PCI: CLS 0 bytes, default 64
[    0.119800] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
[    0.119801] software IO TLB: mapped [mem 0x00000000f4000000-0x00000000f8000000] (64MB)
[    0.119823] Trying to unpack rootfs image as initramfs...
[    0.119859] KVM: vmx: using Hyper-V Enlightened VMCS
[    0.120492] Freeing initrd memory: 2028K
[    0.298394] kvm: already loaded the other module
[    0.301840] Initialise system trusted keyrings
[    0.302064] workingset: timestamp_bits=46 max_order=22 bucket_order=0
[    0.302763] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.303088] NFS: Registering the id_resolver key type
[    0.303098] Key type id_resolver registered
[    0.303099] Key type id_legacy registered
[    0.303101] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    0.303108] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
[    0.303109] Installing knfsd (copyright (C) 1996 okir@monad.swb.de).
[    0.304164] Key type cifs.idmap registered
[    0.304238] fuse: init (API version 7.34)
[    0.304390] SGI XFS with ACLs, security attributes, realtime, scrub, repair, quota, no debug enabled
[    0.304694] 9p: Installing v9fs 9p2000 file system support
[    0.304702] FS-Cache: Netfs '9p' registered for caching
[    0.304736] FS-Cache: Netfs 'ceph' registered for caching
[    0.304738] ceph: loaded (mds proto 32)
[    0.312686] NET: Registered PF_ALG protocol family
[    0.312696] xor: automatically using best checksumming function   avx
[    0.312700] Key type asymmetric registered
[    0.312715] Asymmetric key parser 'x509' registered
[    0.312858] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)
[    0.313368] hv_vmbus: registering driver hv_pci
[    0.315841] hv_pci 011664d7-87e9-471d-8e79-cdcc29f8d032: PCI VMBus probing: Using version 0x10004
[    0.319360] hv_pci 011664d7-87e9-471d-8e79-cdcc29f8d032: PCI host bridge to bus 87e9:00
[    0.319362] pci_bus 87e9:00: root bus resource [mem 0x9ffe00000-0x9ffe02fff window]
[    0.319365] pci_bus 87e9:00: No busn resource found for root bus, will use [bus 00-ff]
[    0.320142] pci 87e9:00:00.0: [1af4:1043] type 00 class 0x010000
[    0.320953] pci 87e9:00:00.0: reg 0x10: [mem 0x9ffe00000-0x9ffe00fff 64bit]
[    0.321470] pci 87e9:00:00.0: reg 0x18: [mem 0x9ffe01000-0x9ffe01fff 64bit]
[    0.321974] pci 87e9:00:00.0: reg 0x20: [mem 0x9ffe02000-0x9ffe02fff 64bit]
[    0.325087] pci_bus 87e9:00: busn_res: [bus 00-ff] end is updated to 00
[    0.325099] pci 87e9:00:00.0: BAR 0: assigned [mem 0x9ffe00000-0x9ffe00fff 64bit]
[    0.327116] pci 87e9:00:00.0: BAR 2: assigned [mem 0x9ffe01000-0x9ffe01fff 64bit]
[    0.327617] pci 87e9:00:00.0: BAR 4: assigned [mem 0x9ffe02000-0x9ffe02fff 64bit]
[    0.328745] hv_pci 678ca689-960f-40c6-b493-0074b803b58b: PCI VMBus probing: Using version 0x10004
[    0.329463] hv_pci 678ca689-960f-40c6-b493-0074b803b58b: PCI host bridge to bus 960f:00
[    0.329465] pci_bus 960f:00: No busn resource found for root bus, will use [bus 00-ff]
[    0.329815] pci 960f:00:00.0: [1414:008e] type 00 class 0x030200
[    0.333323] pci_bus 960f:00: busn_res: [bus 00-ff] end is updated to 00
[    0.333789] hv_pci 30a0ae7f-c7c1-4f66-82f2-15c8b8e306e8: PCI VMBus probing: Using version 0x10004
[    0.334736] hv_pci 30a0ae7f-c7c1-4f66-82f2-15c8b8e306e8: PCI host bridge to bus c7c1:00
[    0.334738] pci_bus c7c1:00: root bus resource [mem 0x9ffe04000-0x9ffe06fff window]
[    0.334740] pci_bus c7c1:00: No busn resource found for root bus, will use [bus 00-ff]
[    0.335411] pci c7c1:00:00.0: [1af4:1049] type 00 class 0x010000
[    0.336055] pci c7c1:00:00.0: reg 0x10: [mem 0x9ffe04000-0x9ffe04fff 64bit]
[    0.336489] pci c7c1:00:00.0: reg 0x18: [mem 0x9ffe05000-0x9ffe05fff 64bit]
[    0.336933] pci c7c1:00:00.0: reg 0x20: [mem 0x9ffe06000-0x9ffe06fff 64bit]
[    0.339372] pci_bus c7c1:00: busn_res: [bus 00-ff] end is updated to 00
[    0.339376] pci c7c1:00:00.0: BAR 0: assigned [mem 0x9ffe04000-0x9ffe04fff 64bit]
[    0.339693] pci c7c1:00:00.0: BAR 2: assigned [mem 0x9ffe05000-0x9ffe05fff 64bit]
[    0.339990] pci c7c1:00:00.0: BAR 4: assigned [mem 0x9ffe06000-0x9ffe06fff 64bit]
[    0.340411] ACPI: AC: AC Adapter [AC1] (off-line)
[    0.341015] ACPI: battery: Slot [BAT1] (battery present)
[    0.346716] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[    0.372075] Non-volatile memory driver v1.3
[    0.372253] [drm] Initialized vgem 1.0.0 20120112 for vgem on minor 0
[    0.373498] printk: console [hvc0] enabled
[    0.374882] brd: module loaded
[    0.376141] loop: module loaded
[    0.376600] hv_vmbus: registering driver hv_storvsc
[    0.377027] wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information.
[    0.377527] wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld <Jason@zx2c4.com>. All Rights Reserved.
[    0.378073] tun: Universal TUN/TAP device driver, 1.6
[    0.378398] PPP generic driver version 2.4.2
[    0.378645] scsi host0: storvsc_host_t
[    0.378723] PPP BSD Compression module registered
[    0.379177] PPP Deflate Compression module registered
[    0.379401] PPP MPPE Compression module registered
[    0.379609] NET: Registered PF_PPPOX protocol family
[    0.379838] usbcore: registered new interface driver cdc_ether
[    0.380140] usbcore: registered new interface driver cdc_ncm
[    0.380450] usbcore: registered new interface driver r8153_ecm
[    0.380753] hv_vmbus: registering driver hv_netvsc
[    0.381098] VFIO - User Level meta-driver version: 0.3
[    0.381458] usbcore: registered new interface driver cdc_acm
[    0.381790] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters
[    0.382165] usbcore: registered new interface driver ch341
[    0.382416] usbserial: USB Serial support registered for ch341-uart
[    0.382725] usbcore: registered new interface driver cp210x
[    0.382975] usbserial: USB Serial support registered for cp210x
[    0.383305] usbcore: registered new interface driver ftdi_sio
[    0.383618] usbserial: USB Serial support registered for FTDI USB Serial Device
[    0.384097] vhci_hcd vhci_hcd.0: USB/IP Virtual Host Controller
[    0.384416] vhci_hcd vhci_hcd.0: new USB bus registered, assigned bus number 1
[    0.384771] vhci_hcd: created sysfs vhci_hcd.0
[    0.385153] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15
[    0.385489] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.385818] usb usb1: Product: USB/IP Virtual Host Controller
[    0.386083] usb usb1: Manufacturer: Linux 5.15.123.1-microsoft-standard-WSL2 vhci_hcd
[    0.386395] usb usb1: SerialNumber: vhci_hcd.0
[    0.386717] hub 1-0:1.0: USB hub found
[    0.386933] hub 1-0:1.0: 8 ports detected
[    0.387315] vhci_hcd vhci_hcd.0: USB/IP Virtual Host Controller
[    0.387594] vhci_hcd vhci_hcd.0: new USB bus registered, assigned bus number 2
[    0.387972] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.
[    0.388428] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 5.15
[    0.388948] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.389472] usb usb2: Product: USB/IP Virtual Host Controller
[    0.389862] usb usb2: Manufacturer: Linux 5.15.123.1-microsoft-standard-WSL2 vhci_hcd
[    0.390295] usb usb2: SerialNumber: vhci_hcd.0
[    0.390655] hub 2-0:1.0: USB hub found
[    0.390898] hub 2-0:1.0: 8 ports detected
[    0.391308] hv_vmbus: registering driver hyperv_keyboard
[    0.391571] rtc_cmos 00:00: RTC can wake from S4
[    0.393209] rtc_cmos 00:00: registered as rtc0
[    0.393763] rtc_cmos 00:00: setting system clock to 2023-12-31T20:00:51 UTC (1704052851)
[    0.394298] rtc_cmos 00:00: alarms up to one month, 114 bytes nvram
[    0.394851] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com
[    0.395430] device-mapper: raid: Loading target version 1.15.1
[    0.395747] usbcore: registered new interface driver usbhid
[    0.395972] usbhid: USB HID core driver
[    0.396199] hv_utils: Registering HyperV Utility Driver
[    0.396434] hv_vmbus: registering driver hv_utils
[    0.396681] hv_vmbus: registering driver hv_balloon
[    0.397299] hv_vmbus: registering driver dxgkrnl
[    0.397312] hv_utils: TimeSync IC version 4.0
[    0.398056] hv_balloon: Using Dynamic Memory protocol version 2.0
[    0.398183] drop_monitor: Initializing network drop monitor service
[    0.399299] Mirror/redirect action on
[    0.399559] Free page reporting enabled
[    0.399560] hv_balloon: Cold memory discard hint enabled with order 9
[    0.399827] u32 classifier
[    0.400465]     Performance counters on
[    0.400670]     input device check on
[    0.400864]     Actions configured
[    0.401872] IPVS: Registered protocols (TCP, UDP)
[    0.402143] IPVS: Connection hash table configured (size=4096, memory=32Kbytes)
[    0.402486] IPVS: ipvs loaded.
[    0.402644] IPVS: [rr] scheduler registered.
[    0.402854] IPVS: [wrr] scheduler registered.
[    0.403070] IPVS: [sh] scheduler registered.
[    0.403392] ipip: IPv4 and MPLS over IPv4 tunneling driver
[    0.403682] ipt_CLUSTERIP: ClusterIP Version 0.8 loaded successfully
[    0.404008] Initializing XFRM netlink socket
[    0.404312] NET: Registered PF_INET6 protocol family
[    0.404998] Segment Routing with IPv6
[    0.405260] In-situ OAM (IOAM) with IPv6
[    0.405591] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[    0.406082] NET: Registered PF_PACKET protocol family
[    0.406353] Bridge firewalling registered
[    0.406636] 8021q: 802.1Q VLAN Support v1.8
[    0.406849] sctp: Hash tables configured (bind 256/256)
[    0.407129] 9pnet: Installing 9P2000 support
[    0.427500] Key type dns_resolver registered
[    0.427956] Key type ceph registered
[    0.428283] libceph: loaded (mon/osd proto 15/24)
[    0.428661] NET: Registered PF_VSOCK protocol family
[    0.428876] hv_vmbus: registering driver hv_sock
[    0.429105] IPI shorthand broadcast: enabled
[    0.429306] sched_clock: Marking stable (425404741, 3241500)->(450096300, -21450059)
[    0.429938] registered taskstats version 1
[    0.430425] Loading compiled-in X.509 certificates
[    0.431510] Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no
[    0.437147] Freeing unused kernel image (initmem) memory: 2012K
[    0.493427] Write protecting the kernel read-only data: 30720k
[    0.495705] Freeing unused kernel image (text/rodata gap) memory: 2024K
[    0.497051] Freeing unused kernel image (rodata/data gap) memory: 508K
[    0.497880] Run /init as init process
[    0.498330]   with arguments:
[    0.498781]     /init
[    0.499054]   with environment:
[    0.499506]     HOME=/
[    0.499785]     TERM=linux
[    0.500214]     WSL_ROOT_INIT=1
[    0.516007] scsi 0:0:0:0: Direct-Access     Msft     Virtual Disk     1.0  PQ: 0 ANSI: 5
[    0.521970] sd 0:0:0:0: Attached scsi generic sg0 type 0
[    0.522890] sd 0:0:0:0: [sda] 797608 512-byte logical blocks: (408 MB/389 MiB)
[    0.523631] sd 0:0:0:0: [sda] Write Protect is on
[    0.523911] sd 0:0:0:0: [sda] Mode Sense: 0f 00 80 00
[    0.524336] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
[    0.527242] sd 0:0:0:0: [sda] Attached SCSI disk
[    0.593512] scsi 0:0:0:1: Direct-Access     Msft     Virtual Disk     1.0  PQ: 0 ANSI: 5
[    0.598378] sd 0:0:0:1: Attached scsi generic sg1 type 0
[    0.599550] sd 0:0:0:1: [sdb] 8388616 512-byte logical blocks: (4.29 GB/4.00 GiB)
[    0.599998] sd 0:0:0:1: [sdb] 4096-byte physical blocks
[    0.600426] sd 0:0:0:1: [sdb] Write Protect is off
[    0.600678] sd 0:0:0:1: [sdb] Mode Sense: 0f 00 00 00
[    0.601093] sd 0:0:0:1: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    0.603525] sd 0:0:0:1: [sdb] Attached SCSI disk
[    0.632937] EXT4-fs (sda): mounted filesystem without journal. Opts: (null). Quota mode: none.
[    0.676726] Adding 4194304k swap on /dev/sdb.  Priority:-2 extents:1 across:4194304k
[    0.711742] hv_netvsc fc232fd7-4443-4791-a539-deef713ec4d4 loopback0: renamed from eth0
[    0.755651] IPv6: ADDRCONF(NETDEV_CHANGE): loopback0: link becomes ready
[    1.278037] hv_pci 47ccfe52-6f6c-4132-8a65-c6b0734d35ba: PCI VMBus probing: Using version 0x10004
[    1.280181] hv_pci 47ccfe52-6f6c-4132-8a65-c6b0734d35ba: PCI host bridge to bus 6f6c:00
[    1.280601] pci_bus 6f6c:00: root bus resource [mem 0xc00000000-0xe00001fff window]
[    1.280896] pci_bus 6f6c:00: No busn resource found for root bus, will use [bus 00-ff]
[    1.281743] pci 6f6c:00:00.0: [1af4:105a] type 00 class 0x088000
[    1.283585] pci 6f6c:00:00.0: reg 0x10: [mem 0xe00000000-0xe00000fff 64bit]
[    1.285563] pci 6f6c:00:00.0: reg 0x18: [mem 0xe00001000-0xe00001fff 64bit]
[    1.287314] pci 6f6c:00:00.0: reg 0x20: [mem 0xc00000000-0xdffffffff 64bit]
[    1.291208] pci_bus 6f6c:00: busn_res: [bus 00-ff] end is updated to 00
[    1.291579] pci 6f6c:00:00.0: BAR 4: assigned [mem 0xc00000000-0xdffffffff 64bit]
[    1.293978] pci 6f6c:00:00.0: BAR 0: assigned [mem 0xe00000000-0xe00000fff 64bit]
[    1.296396] pci 6f6c:00:00.0: BAR 2: assigned [mem 0xe00001000-0xe00001fff 64bit]
[    1.310057] virtiofs virtio2: Cache len: 0x200000000 @ 0xc00000000
[    1.343333] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2b2c993ffe9, max_idle_ns: 440795229210 ns
[    1.344557] clocksource: Switched to clocksource tsc
[    1.375899] memmap_init_zone_device initialised 2097152 pages in 20ms
[    1.378543] ip_local_port_range: prefer different parity for start/end values.
[    1.381918] FS-Cache: Duplicate cookie detected
[    1.382247] FS-Cache: O-cookie c=00000004 [p=00000002 fl=222 nc=0 na=1]
[    1.382517] FS-Cache: O-cookie d=00000000fc13a9b1{9P.session} n=00000000109f36df
[    1.382840] FS-Cache: O-key=[10] '34323934393337343237'
[    1.383104] FS-Cache: N-cookie c=00000005 [p=00000002 fl=2 nc=0 na=1]
[    1.383493] FS-Cache: N-cookie d=00000000fc13a9b1{9P.session} n=00000000ffd40f01
[    1.383802] FS-Cache: N-key=[10] '34323934393337343237'
[    1.398126] scsi 0:0:0:2: Direct-Access     Msft     Virtual Disk     1.0  PQ: 0 ANSI: 5
[    1.404666] sd 0:0:0:2: Attached scsi generic sg2 type 0
[    1.405641] sd 0:0:0:2: [sdc] 536870912 512-byte logical blocks: (275 GB/256 GiB)
[    1.406171] sd 0:0:0:2: [sdc] 4096-byte physical blocks
[    1.406565] sd 0:0:0:2: [sdc] Write Protect is off
[    1.406973] sd 0:0:0:2: [sdc] Mode Sense: 0f 00 00 00
[    1.407713] sd 0:0:0:2: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    1.411453] sd 0:0:0:2: [sdc] Attached SCSI disk
[    1.417680] EXT4-fs (sdc): mounted filesystem with ordered data mode. Opts: discard,errors=remount-ro,data=ordered. Quota mode: none.
[    1.823496] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   49.227236] hv_balloon: Max. dynamic memory size: 16234 MB
[   64.775015] hv_pci b1be81fc-b29c-4b70-b239-ad7bef356d6e: PCI VMBus probing: Using version 0x10004
[   64.776425] 9pnet_virtio: no channels available for device drvfs
[   64.776967] WSL (1) WARNING: mount: waiting for virtio device drvfs
[   64.777314] hv_pci b1be81fc-b29c-4b70-b239-ad7bef356d6e: PCI host bridge to bus b29c:00
[   64.777658] pci_bus b29c:00: root bus resource [mem 0x9ffe08000-0x9ffe0afff window]
[   64.777973] pci_bus b29c:00: No busn resource found for root bus, will use [bus 00-ff]
[   64.779182] pci b29c:00:00.0: [1af4:1049] type 00 class 0x010000
[   64.780332] pci b29c:00:00.0: reg 0x10: [mem 0x9ffe08000-0x9ffe08fff 64bit]
[   64.781573] pci b29c:00:00.0: reg 0x18: [mem 0x9ffe09000-0x9ffe09fff 64bit]
[   64.782669] pci b29c:00:00.0: reg 0x20: [mem 0x9ffe0a000-0x9ffe0afff 64bit]
[   64.785825] pci_bus b29c:00: busn_res: [bus 00-ff] end is updated to 00
[   64.786484] pci b29c:00:00.0: BAR 0: assigned [mem 0x9ffe08000-0x9ffe08fff 64bit]
[   64.787599] pci b29c:00:00.0: BAR 2: assigned [mem 0x9ffe09000-0x9ffe09fff 64bit]
[   64.788500] pci b29c:00:00.0: BAR 4: assigned [mem 0x9ffe0a000-0x9ffe0afff 64bit]
[   64.887100] hv_pci 35b87c0b-0d30-4735-866e-a65208a4e4cd: PCI VMBus probing: Using version 0x10004
[   64.889343] hv_pci 35b87c0b-0d30-4735-866e-a65208a4e4cd: PCI host bridge to bus 0d30:00
[   64.889728] pci_bus 0d30:00: root bus resource [mem 0x9ffe0c000-0x9ffe0efff window]
[   64.890060] pci_bus 0d30:00: No busn resource found for root bus, will use [bus 00-ff]
[   64.890983] pci 0d30:00:00.0: [1af4:1049] type 00 class 0x010000
[   64.892066] pci 0d30:00:00.0: reg 0x10: [mem 0x9ffe0c000-0x9ffe0cfff 64bit]
[   64.893952] pci 0d30:00:00.0: reg 0x18: [mem 0x9ffe0d000-0x9ffe0dfff 64bit]
[   64.894826] pci 0d30:00:00.0: reg 0x20: [mem 0x9ffe0e000-0x9ffe0efff 64bit]
[   64.897415] pci_bus 0d30:00: busn_res: [bus 00-ff] end is updated to 00
[   64.897813] pci 0d30:00:00.0: BAR 0: assigned [mem 0x9ffe0c000-0x9ffe0cfff 64bit]
[   64.898456] pci 0d30:00:00.0: BAR 2: assigned [mem 0x9ffe0d000-0x9ffe0dfff 64bit]
[   64.899171] pci 0d30:00:00.0: BAR 4: assigned [mem 0x9ffe0e000-0x9ffe0efff 64bit]
[   65.030524] hv_pci 0b00e603-6790-40c2-a0ac-5a4d35777ca1: PCI VMBus probing: Using version 0x10004
[   65.032234] 9pnet_virtio: no channels available for device drvfs
[   65.032945] WSL (1) WARNING: mount: waiting for virtio device drvfs
[   65.070488] hv_pci 0b00e603-6790-40c2-a0ac-5a4d35777ca1: PCI host bridge to bus 6790:00
[   65.070895] pci_bus 6790:00: root bus resource [mem 0xbffe10000-0xbffe12fff window]
[   65.071278] pci_bus 6790:00: No busn resource found for root bus, will use [bus 00-ff]
[   65.072274] pci 6790:00:00.0: [1af4:1049] type 00 class 0x010000
[   65.073225] pci 6790:00:00.0: reg 0x10: [mem 0xbffe10000-0xbffe10fff 64bit]
[   65.074145] pci 6790:00:00.0: reg 0x18: [mem 0xbffe11000-0xbffe11fff 64bit]
[   65.074996] pci 6790:00:00.0: reg 0x20: [mem 0xbffe12000-0xbffe12fff 64bit]
[   65.077937] pci_bus 6790:00: busn_res: [bus 00-ff] end is updated to 00
[   65.078369] pci 6790:00:00.0: BAR 0: assigned [mem 0xbffe10000-0xbffe10fff 64bit]
[   65.079070] pci 6790:00:00.0: BAR 2: assigned [mem 0xbffe11000-0xbffe11fff 64bit]
[   65.079785] pci 6790:00:00.0: BAR 4: assigned [mem 0xbffe12000-0xbffe12fff 64bit]
[   65.140290] hv_pci 0c4c316d-c879-4ea4-b59d-a52ab3a07e26: PCI VMBus probing: Using version 0x10004
[   65.187986] hv_pci 0c4c316d-c879-4ea4-b59d-a52ab3a07e26: PCI host bridge to bus c879:00
[   65.188631] pci_bus c879:00: root bus resource [mem 0xbffe14000-0xbffe16fff window]
[   65.189091] pci_bus c879:00: No busn resource found for root bus, will use [bus 00-ff]
[   65.190230] pci c879:00:00.0: [1af4:1049] type 00 class 0x010000
[   65.191457] pci c879:00:00.0: reg 0x10: [mem 0xbffe14000-0xbffe14fff 64bit]
[   65.192371] pci c879:00:00.0: reg 0x18: [mem 0xbffe15000-0xbffe15fff 64bit]
[   65.193354] pci c879:00:00.0: reg 0x20: [mem 0xbffe16000-0xbffe16fff 64bit]
[   65.196739] pci_bus c879:00: busn_res: [bus 00-ff] end is updated to 00
[   65.197319] pci c879:00:00.0: BAR 0: assigned [mem 0xbffe14000-0xbffe14fff 64bit]
[   65.198279] pci c879:00:00.0: BAR 2: assigned [mem 0xbffe15000-0xbffe15fff 64bit]
[   65.199408] pci c879:00:00.0: BAR 4: assigned [mem 0xbffe16000-0xbffe16fff 64bit]
[   65.225152] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -22
[   65.226053] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -22
[   65.226541] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -22
[   65.227177] misc dxg: dxgk: dxgkio_query_adapter_info: Ioctl failed: -22

WSL config: [wsl2]

[experimental]
autoMemoryReclaim=gradual
sparseVhd=true
networkingMode=mirrored
firewall=true
dnsTunneling=true
autoProxy=true
github-actions[bot] commented 10 months ago

Hi I'm an AI powered bot that finds similar issues based off the issue title.

Please view the issues below to see if they solve your problem, and if the issue describes your problem please consider closing this one and thumbs upping the other issue to help us prioritize it. Thank you!

Open similar issues:

Closed similar issues:

Note: You can give me feedback by thumbs upping or thumbs downing this comment.

ghost commented 9 months ago

If you use dropcache instead of gradual do you still have the problem?

imag0r commented 9 months ago

No difference. dmesg looks pretty much the same: [ 1.747028] EXT4-fs (sdc): mounted filesystem with ordered data mode. Opts: discard,errors=remount-ro,data=ordered. Quota mode: none. [ 2.242862] IPv6: ADDRCONF(NETDEV_CHANGE): loopback0: link becomes ready [ 49.253678] hv_balloon: Max. dynamic memory size: 16234 MB [ 65.136693] hv_pci 0aa6e9a2-6cb4-4172-bf22-461f42b87a9c: PCI VMBus probing: Using version 0x10004

imag0r commented 9 months ago

Actually, I'm seeing the same behavior after commenting out all flags from the experimental section.

OneBlue commented 2 months ago

@imag0r: Can you capture /logs after updating via: wsl --update --pre-release ?

imag0r commented 2 months ago

Hello, I can no longer reproduce the problem with the pre-release version of WSL.

OneBlue commented 2 months ago

Glad to hear ! Closing