microsoft / wslg

Enabling the Windows Subsystem for Linux to include support for Wayland and X server related scenarios
MIT License
10.27k stars 310 forks source link

WSLg Firefox crashes loading extension web page for Ublock Origin #276

Open SteveF4 opened 3 years ago

SteveF4 commented 3 years ago

Windows Build Number

Microsoft Windows [Version 10.0.21390.1]

WSL Version

Kernel Version

5.10.16

Distro Version

Ubuntu 20.04

Other Software

WSL2g Ubuntu 20.04 WSL image Firefox (sudo apt install firefox)

Repro Steps

  1. Install Firefox from the Ubuntu repository under WSL2g.
  2. Start Firefox (in Windows Terminal if you want to see what Firefox says when it exits).
  3. Browse to https://addons.mozilla.org/en-US/firefox/addon/ublock-origin/?utm_source=addons.mozilla.org&utm_medium=referral&utm_content=search
  4. Firefox exits with an I/O error that suggests the X server is unavailable.

Expected Behavior

Was hoping to be able to view the extension web page in Firefox.

Actual Behavior

Firefox crashes. Other pages seem to load okay under Firefox. This only happens with the Ublock Origin extension page, as far as I have found. 2YDunkzJoB

Diagnostic Logs

Example output from Windows Terminal:

user@DESKTOP-RSKE9GV:/mnt/c/Users/User$ firefox

[GFX1-]: glxtest: libEGL initialize failed
[GFX1-]: glxtest: libEGL initialize failed
Gdk-Message: 16:30:01.806: /usr/lib/firefox/firefox: Fatal IO error 11 (Resource temporarily unavailable) on X server :0.

Gdk-Message: 16:30:01.807: /usr/lib/firefox/firefox: Fatal IO error 11 (Resource temporarily unavailable) on X server :0.

###!!! [Parent][MessageChannel] Error: (msgtype=0x390011,name=PContent::Msg_ReinitRenderingForDeviceReset) Channel error: cannot send/recv

###!!! [Parent][MessageChannel] Error: (msgtype=0x390143,name=PContent::Msg_CommitBrowsingContextTransaction) Channel error: cannot send/recv

Gdk-Message: 16:30:01.824: /usr/lib/firefox/firefox: Fatal IO error 11 (Resource temporarily unavailable) on X server :0.

###!!! [Parent][MessageChannel] Error: (msgtype=0x23006C,name=PBrowser::Msg_Deactivate) Channel error: cannot send/recv

Gdk-Message: 16:30:01.827: firefox: Fatal IO error 11 (Resource temporarily unavailable) on X server :0.
OneBlue commented 3 years ago

/logs

ghost commented 3 years ago

Hello! Could you please provide more logs to help us better diagnose your issue? You can find instructions on how to attach logs here, please make sure to post the link to the Feedback Hub item in this chat so we can see it.

Thank you!

bpulliam commented 3 years ago

I've moved this issue from the wsl to wslg for easier tracking.

OneBlue commented 3 years ago

Thanks for reporting this @SteveF4.

Can you please attach logs, and the output of dmesg ?

SteveF4 commented 3 years ago

Hi @OneBlue,

Happy to help! Below is the output from dmesg. I'm still working on getting the wpr logging to work, and will post that as soon as I can.

dmesg
[    0.000000] Linux version 5.10.16.3-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 Fri Apr 2 22:23:49 UTC 2021
[    0.000000] Command line: initrd=\initrd.img panic=-1 nr_cpus=6 swiotlb=force 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: xstate_offset[2]:  576, xstate_sizes[2]:  256
[    0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format.
[    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-0x0000000107dfffff] 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: features 0x2e7f, privilege high: 0x3b8030, hints 0x24c2c, misc 0xe0bed7b2
[    0.000000] Hyper-V Host Build:21390-10.0-1-0.1000
[    0.000000] Hyper-V: LAPIC Timer Frequency: 0x1e8480
[    0.000000] tsc: Marking TSC unstable due to running on Hyper-V
[    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.000019] tsc: Detected 3792.005 MHz processor
[    0.000332] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.000334] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.000344] last_pfn = 0x107e00 max_arch_pfn = 0x400000000
[    0.000460] MTRR default type: uncachable
[    0.000460] MTRR fixed ranges enabled:
[    0.000467]   00000-3FFFF write-back
[    0.000467]   40000-7FFFF uncachable
[    0.000467]   80000-8FFFF write-back
[    0.000468]   90000-FFFFF uncachable
[    0.000468] MTRR variable ranges enabled:
[    0.000469]   0 base 00000000000 mask 7FF00000000 write-back
[    0.000470]   1 base 00100000000 mask 7F000000000 write-back
[    0.000470]   2 disabled
[    0.000470]   3 disabled
[    0.000476]   4 disabled
[    0.000477]   5 disabled
[    0.000477]   6 disabled
[    0.000477]   7 disabled
[    0.000531] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT
[    0.000600] last_pfn = 0xf8000 max_arch_pfn = 0x400000000
[    0.000694] Using GB pages for direct mapping
[    0.000836] RAMDISK: [mem 0x03035000-0x03043fff]
[    0.000874] ACPI: Early table checksum verification disabled
[    0.000963] ACPI: RSDP 0x00000000000E0000 000024 (v02 VRTUAL)
[    0.000976] ACPI: XSDT 0x0000000000100000 000044 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
[    0.001006] ACPI: FACP 0x0000000000101000 000114 (v06 VRTUAL MICROSFT 00000001 MSFT 00000001)
[    0.001016] ACPI: DSDT 0x00000000001011B8 01E184 (v02 MSFTVM DSDT01   00000001 MSFT 05000000)
[    0.001023] ACPI: FACS 0x0000000000101114 000040
[    0.001025] ACPI: OEM0 0x0000000000101154 000064 (v01 VRTUAL MICROSFT 00000001 MSFT 00000001)
[    0.001032] ACPI: SRAT 0x000000000011F33C 000310 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
[    0.001038] ACPI: APIC 0x000000000011F64C 000078 (v04 VRTUAL MICROSFT 00000001 MSFT 00000001)
[    0.001078] ACPI: Local APIC address 0xfee00000
[    0.002725] Zone ranges:
[    0.002733]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.002739]   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
[    0.002740]   Normal   [mem 0x0000000100000000-0x0000000107dfffff]
[    0.002744]   Device   empty
[    0.002749] Movable zone start for each node
[    0.002749] Early memory node ranges
[    0.002750]   node   0: [mem 0x0000000000001000-0x000000000009ffff]
[    0.002757]   node   0: [mem 0x0000000000200000-0x00000000f7ffffff]
[    0.002757]   node   0: [mem 0x0000000100000000-0x0000000107dfffff]
[    0.004036] Zeroed struct page in unavailable ranges: 865 pages
[    0.004045] Initmem setup node 0 [mem 0x0000000000001000-0x0000000107dfffff]
[    0.004051] On node 0 totalpages: 1047711
[    0.004058]   DMA zone: 59 pages used for memmap
[    0.004059]   DMA zone: 22 pages reserved
[    0.004059]   DMA zone: 3743 pages, LIFO batch:0
[    0.004357]   DMA32 zone: 16320 pages used for memmap
[    0.004358]   DMA32 zone: 1011712 pages, LIFO batch:63
[    0.094240]   Normal zone: 504 pages used for memmap
[    0.094242]   Normal zone: 32256 pages, LIFO batch:7
[    0.096418] ACPI: Local APIC address 0xfee00000
[    0.096440] ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1])
[    0.097446] IOAPIC[0]: apic_id 6, version 17, address 0xfec00000, GSI 0-23
[    0.097457] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.097473] ACPI: IRQ9 used by override.
[    0.097474] Using ACPI (MADT) for SMP configuration information
[    0.097498] smpboot: Allowing 6 CPUs, 0 hotplug CPUs
[    0.097536] [mem 0xf8000000-0xffffffff] available for PCI devices
[    0.097541] Booting paravirtualized kernel on Hyper-V
[    0.097542] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.103597] setup_percpu: NR_CPUS:256 nr_cpumask_bits:256 nr_cpu_ids:6 nr_node_ids:1
[    0.104898] percpu: Embedded 52 pages/cpu s173272 r8192 d31528 u262144
[    0.104912] pcpu-alloc: s173272 r8192 d31528 u262144 alloc=1*2097152
[    0.104913] pcpu-alloc: [0] 0 1 2 3 4 5 - -
[    0.105038] Built 1 zonelists, mobility grouping on.  Total pages: 1030806
[    0.105039] Kernel command line: initrd=\initrd.img panic=-1 nr_cpus=6 swiotlb=force pty.legacy_count=0
[    0.107235] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
[    0.108265] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
[    0.108436] mem auto-init: stack:off, heap alloc:off, heap free:off
[    0.137661] Memory: 4018724K/4190844K available (16403K kernel code, 2459K rwdata, 3464K rodata, 1444K init, 1164K bss, 171864K reserved, 0K cma-reserved)
[    0.137760] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=6, Nodes=1
[    0.137814] ftrace: allocating 49613 entries in 194 pages
[    0.160565] ftrace: allocated 194 pages with 3 groups
[    0.161856] rcu: Hierarchical RCU implementation.
[    0.161861] rcu:     RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=6.
[    0.161866]  Rude variant of Tasks RCU enabled.
[    0.161866]  Tracing variant of Tasks RCU enabled.
[    0.161867] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
[    0.161867] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=6
[    0.167119] Using NULL legacy PIC
[    0.167121] NR_IRQS: 16640, nr_irqs: 472, preallocated irqs: 0
[    0.168871] random: crng done (trusting CPU's manufacturer)
[    0.168959] Console: colour dummy device 80x25
[    0.168965] printk: console [tty0] enabled
[    0.168988] ACPI: Core revision 20200925
[    0.169223] Failed to register legacy timer interrupt
[    0.169224] APIC: Switch to symmetric I/O mode setup
[    0.169329] Hyper-V: Using IPI hypercalls
[    0.169330] Hyper-V: Using enlightened APIC (xapic mode)
[    0.170176] Calibrating delay loop (skipped), value calculated using timer frequency.. 7584.01 BogoMIPS (lpj=37920050)
[    0.170178] pid_max: default: 32768 minimum: 301
[    0.170210] LSM: Security Framework initializing
[    0.170280] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    0.170344] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    0.171141] Last level iTLB entries: 4KB 64, 2MB 8, 4MB 8
[    0.171142] Last level dTLB entries: 4KB 64, 2MB 0, 4MB 0, 1GB 4
[    0.171146] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
[    0.171147] Spectre V2 : Mitigation: Enhanced IBRS
[    0.171147] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
[    0.171148] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier
[    0.171148] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl and seccomp
[    0.171365] Freeing SMP alternatives memory: 52K
[    0.171644] smpboot: CPU0: Intel(R) Core(TM) i7-10700K CPU @ 3.80GHz (family: 0x6, model: 0xa5, stepping: 0x5)
[    0.171967] Performance Events: unsupported p6 CPU model 165 no PMU driver, software events only.
[    0.172044] rcu: Hierarchical SRCU implementation.
[    0.172612] smp: Bringing up secondary CPUs ...
[    0.172929] x86: Booting SMP configuration:
[    0.172939] .... node  #0, CPUs:      #1 #2 #3 #4 #5
[    0.180862] smp: Brought up 1 node, 6 CPUs
[    0.180863] smpboot: Max logical packages: 1
[    0.180864] smpboot: Total of 6 processors activated (45504.06 BogoMIPS)
[    0.182700] devtmpfs: initialized
[    0.182700] x86/mm: Memory block size: 128MB
[    0.182700] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.182700] futex hash table entries: 2048 (order: 5, 131072 bytes, linear)
[    0.182700] NET: Registered protocol family 16
[    0.182700] thermal_sys: Registered thermal governor 'step_wise'
[    0.182700] cpuidle: using governor menu
[    0.182700] ACPI: bus type PCI registered
[    0.182700] PCI: Fatal: No config space access function found
[    0.190242] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages
[    0.190252] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[    0.200513] raid6: skip pq benchmark and using algorithm avx2x4
[    0.200513] raid6: using avx2x2 recovery algorithm
[    0.200513] ACPI: Added _OSI(Module Device)
[    0.200513] ACPI: Added _OSI(Processor Device)
[    0.200513] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.200513] ACPI: Added _OSI(Processor Aggregator Device)
[    0.200513] ACPI: Added _OSI(Linux-Dell-Video)
[    0.200513] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
[    0.200513] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics)
[    0.203388] ACPI: 1 ACPI AML tables successfully acquired and loaded
[    0.206414] ACPI: Interpreter enabled
[    0.206417] ACPI: (supports S0 S5)
[    0.206426] ACPI: Using IOAPIC for interrupt routing
[    0.206435] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.206652] ACPI: Enabled 1 GPEs in block 00 to 0F
[    0.208398] iommu: Default domain type: Translated
[    0.208662] SCSI subsystem initialized
[    0.210382] hv_vmbus: Vmbus version:5.2
[    0.210585] PCI: Using ACPI for IRQ routing
[    0.210593] PCI: System does not support PCI
[    0.211123] clocksource: Switched to clocksource hyperv_clocksource_tsc_page
[    0.210893] hv_vmbus: Unknown GUID: c376c1c3-d276-48d2-90a9-c04748072c60
[    0.305482] VFS: Disk quotas dquot_6.6.0
[    0.305500] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.305534] FS-Cache: Loaded
[    0.305598] pnp: PnP ACPI init
[    0.305699] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[    0.305736] pnp: PnP ACPI: found 1 devices
[    0.321688] NET: Registered protocol family 2
[    0.322423] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
[    0.322477] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
[    0.323552] TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear)
[    0.324157] TCP: Hash tables configured (established 32768 bind 32768)
[    0.324361] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
[    0.324442] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
[    0.324580] NET: Registered protocol family 1
[    0.326085] RPC: Registered named UNIX socket transport module.
[    0.326085] RPC: Registered udp transport module.
[    0.326086] RPC: Registered tcp transport module.
[    0.326086] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.326098] PCI: CLS 0 bytes, default 64
[    0.326219] Trying to unpack rootfs image as initramfs...
[    0.326563] Freeing initrd memory: 60K
[    0.326565] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
[    0.326567] software IO TLB: mapped [mem 0x00000000f4000000-0x00000000f8000000] (64MB)
[    0.326611] KVM: vmx: using Hyper-V Enlightened VMCS
[    0.332043] kvm: already loaded the other module
[    0.339756] Initialise system trusted keyrings
[    0.340123] workingset: timestamp_bits=46 max_order=20 bucket_order=0
[    0.342336] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.342883] NFS: Registering the id_resolver key type
[    0.342887] Key type id_resolver registered
[    0.342887] Key type id_legacy registered
[    0.342893] Installing knfsd (copyright (C) 1996 okir@monad.swb.de).
[    0.344710] Key type cifs.idmap registered
[    0.344920] fuse: init (API version 7.32)
[    0.345421] SGI XFS with ACLs, security attributes, realtime, scrub, repair, quota, no debug enabled
[    0.346322] 9p: Installing v9fs 9p2000 file system support
[    0.346346] FS-Cache: Netfs '9p' registered for caching
[    0.346433] FS-Cache: Netfs 'ceph' registered for caching
[    0.346435] ceph: loaded (mds proto 32)
[    0.352094] NET: Registered protocol family 38
[    0.352096] xor: automatically using best checksumming function   avx
[    0.352097] Key type asymmetric registered
[    0.352098] Asymmetric key parser 'x509' registered
[    0.352105] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
[    0.353281] hv_vmbus: registering driver hv_pci
[    0.354145] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[    0.355285] Non-volatile memory driver v1.3
[    0.361946] brd: module loaded
[    0.365518] loop: module loaded
[    0.365598] hv_vmbus: registering driver hv_storvsc
[    0.366419] wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information.
[    0.366419] wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld <Jason@zx2c4.com>. All Rights Reserved.
[    0.366438] tun: Universal TUN/TAP device driver, 1.6
[    0.366773] PPP generic driver version 2.4.2
[    0.367001] PPP BSD Compression module registered
[    0.367002] PPP Deflate Compression module registered
[    0.367006] PPP MPPE Compression module registered
[    0.367007] NET: Registered protocol family 24
[    0.367034] hv_vmbus: registering driver hv_netvsc
[    0.367355] VFIO - User Level meta-driver version: 0.3
[    0.367849] hv_vmbus: registering driver hyperv_keyboard
[    0.368996] rtc_cmos 00:00: RTC can wake from S4
[    0.370854] scsi host0: storvsc_host_t
[    0.376869] rtc_cmos 00:00: registered as rtc0
[    0.378405] rtc_cmos 00:00: setting system clock to 2021-06-08T16:13:21 UTC (1623168801)
[    0.378414] rtc_cmos 00:00: alarms up to one month, 114 bytes nvram
[    0.379092] device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com
[    0.379520] device-mapper: raid: Loading target version 1.15.1
[    0.379803] hv_utils: Registering HyperV Utility Driver
[    0.379804] hv_vmbus: registering driver hv_utils
[    0.379878] hv_vmbus: registering driver hv_balloon
[    0.379928] hv_vmbus: registering driver dxgkrnl
[    0.379933] (NULL device *): dxgk: dxg_drv_init  Version: 2103
[    0.379977] drop_monitor: Initializing network drop monitor service
[    0.379994] Mirror/redirect action on
[    0.380486] IPVS: Registered protocols (TCP, UDP)
[    0.380533] hv_utils: cannot register PTP clock: 0
[    0.380577] IPVS: Connection hash table configured (size=4096, memory=64Kbytes)
[    0.380710] IPVS: ipvs loaded.
[    0.380711] IPVS: [rr] scheduler registered.
[    0.380712] IPVS: [wrr] scheduler registered.
[    0.380712] IPVS: [sh] scheduler registered.
[    0.380788] ipip: IPv4 and MPLS over IPv4 tunneling driver
[    0.381978] hv_utils: TimeSync IC version 4.0
[    0.382497] hv_balloon: Using Dynamic Memory protocol version 2.0
[    0.384745] Free page reporting enabled
[    0.384746] hv_balloon: Cold memory discard hint enabled
[    0.385690] ipt_CLUSTERIP: ClusterIP Version 0.8 loaded successfully
[    0.386906] Initializing XFRM netlink socket
[    0.387001] NET: Registered protocol family 10
[    0.387803] Segment Routing with IPv6
[    0.391801] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[    0.391936] NET: Registered protocol family 17
[    0.391969] Bridge firewalling registered
[    0.391984] 8021q: 802.1Q VLAN Support v1.8
[    0.392023] sctp: Hash tables configured (bind 256/256)
[    0.392149] 9pnet: Installing 9P2000 support
[    0.392171] Key type dns_resolver registered
[    0.392218] Key type ceph registered
[    0.392726] libceph: loaded (mon/osd proto 15/24)
[    0.393160] NET: Registered protocol family 40
[    0.393162] hv_vmbus: registering driver hv_sock
[    0.393250] IPI shorthand broadcast: enabled
[    0.393506] registered taskstats version 1
[    0.393543] Loading compiled-in X.509 certificates
[    0.394367] Btrfs loaded, crc32c=crc32c-generic
[    0.394952] Unstable clock detected, switching default tracing clock to "global"
               If you want to keep using the local clock, then add:
                 "trace_clock=local"
               on the kernel command line
[    0.396668] Freeing unused kernel image (initmem) memory: 1444K
[    0.440918] Write protecting the kernel read-only data: 22528k
[    0.443958] Freeing unused kernel image (text/rodata gap) memory: 2028K
[    0.445316] Freeing unused kernel image (rodata/data gap) memory: 632K
[    0.445320] Run /init as init process
[    0.445320]   with arguments:
[    0.445320]     /init
[    0.445320]   with environment:
[    0.445321]     HOME=/
[    0.445321]     TERM=linux
[    0.831134] scsi 0:0:0:0: Direct-Access     Msft     Virtual Disk     1.0  PQ: 0 ANSI: 5
[    0.832581] sd 0:0:0:0: Attached scsi generic sg0 type 0
[    0.835812] sd 0:0:0:0: [sda] 536870912 512-byte logical blocks: (275 GB/256 GiB)
[    0.835814] sd 0:0:0:0: [sda] 4096-byte physical blocks
[    0.836354] sd 0:0:0:0: [sda] Write Protect is off
[    0.836356] sd 0:0:0:0: [sda] Mode Sense: 0f 00 00 00
[    0.837475] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    0.889515] hv_pci eacb0b80-57ca-41b6-8293-e2f6a2e0f51a: PCI VMBus probing: Using version 0x10003
[    0.895995] hv_pci eacb0b80-57ca-41b6-8293-e2f6a2e0f51a: PCI host bridge to bus 57ca:00
[    0.895998] pci_bus 57ca:00: root bus resource [mem 0xa00000000-0xc00001fff window]
[    0.900570] pci 57ca:00:00.0: [1af4:105a] type 00 class 0x088000
[    0.908544] pci 57ca:00:00.0: reg 0x10: [mem 0xc00000000-0xc00000fff 64bit]
[    0.914924] pci 57ca:00:00.0: reg 0x18: [mem 0xc00001000-0xc00001fff 64bit]
[    0.921280] pci 57ca:00:00.0: reg 0x20: [mem 0xa00000000-0xbffffffff 64bit]
[    0.943036] pci 57ca:00:00.0: BAR 4: assigned [mem 0xa00000000-0xbffffffff 64bit]
[    0.948788] pci 57ca:00:00.0: BAR 0: assigned [mem 0xc00000000-0xc00000fff 64bit]
[    0.954469] pci 57ca:00:00.0: BAR 2: assigned [mem 0xc00001000-0xc00001fff 64bit]
[    1.011916] virtiofs virtio0: Cache len: 0x200000000 @ 0xa00000000
[    1.248537] memmap_init_zone_device initialised 2097152 pages in 190ms
[    1.441079] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[    1.667377] EXT4-fs (sda): mounted filesystem with ordered data mode. Opts: (null)
[    1.881241] sd 0:0:0:0: [sda] Attached SCSI disk
[    2.770507] Adding 1048576k swap on /swap/file.  Priority:-2 extents:2 across:1056768k
[    3.180710] scsi 0:0:0:1: Direct-Access     Msft     Virtual Disk     1.0  PQ: 0 ANSI: 5
[    3.182526] sd 0:0:0:1: Attached scsi generic sg1 type 0
[    3.183166] scsi 0:0:0:2: Direct-Access     Msft     Virtual Disk     1.0  PQ: 0 ANSI: 5
[    3.184513] sd 0:0:0:2: Attached scsi generic sg2 type 0
[    3.185020] sd 0:0:0:1: [sdb] 711544 512-byte logical blocks: (364 MB/347 MiB)
[    3.185424] sd 0:0:0:1: [sdb] Write Protect is on
[    3.185425] sd 0:0:0:1: [sdb] Mode Sense: 0f 00 80 00
[    3.186121] sd 0:0:0:1: [sdb] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
[    3.187023] sd 0:0:0:2: [sdc] 536870912 512-byte logical blocks: (275 GB/256 GiB)
[    3.187024] sd 0:0:0:2: [sdc] 4096-byte physical blocks
[    3.187360] sd 0:0:0:2: [sdc] Write Protect is off
[    3.187362] sd 0:0:0:2: [sdc] Mode Sense: 0f 00 00 00
[    3.187976] sd 0:0:0:2: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    3.191085] sd 0:0:0:1: [sdb] Attached SCSI disk
[    3.193052] sd 0:0:0:2: [sdc] Attached SCSI disk
[    3.193794] EXT4-fs (sdb): mounted filesystem without journal. Opts: (null)
[    3.207401] EXT4-fs (sdc): mounted filesystem with ordered data mode. Opts: discard,errors=remount-ro,data=ordered
[    3.269804] hv_pci ce2580c3-9c5d-4f77-a60b-e00d623f478e: PCI VMBus probing: Using version 0x10003
[    3.273751] hv_pci ce2580c3-9c5d-4f77-a60b-e00d623f478e: PCI host bridge to bus 9c5d:00
[    3.273753] pci_bus 9c5d:00: root bus resource [mem 0x9ffe00000-0x9ffe02fff window]
[    3.278451] pci 9c5d:00:00.0: [1af4:1049] type 00 class 0x010000
[    3.282751] pci 9c5d:00:00.0: reg 0x10: [mem 0x9ffe00000-0x9ffe00fff 64bit]
[    3.285477] pci 9c5d:00:00.0: reg 0x18: [mem 0x9ffe01000-0x9ffe01fff 64bit]
[    3.288330] pci 9c5d:00:00.0: reg 0x20: [mem 0x9ffe02000-0x9ffe02fff 64bit]
[    3.307730] pci 9c5d:00:00.0: BAR 0: assigned [mem 0x9ffe00000-0x9ffe00fff 64bit]
[    3.310224] pci 9c5d:00:00.0: BAR 2: assigned [mem 0x9ffe01000-0x9ffe01fff 64bit]
[    3.312841] pci 9c5d:00:00.0: BAR 4: assigned [mem 0x9ffe02000-0x9ffe02fff 64bit]
[    3.691020] hv_pci f1e7c320-cc8f-4ab0-b65d-043ae91f13f6: PCI VMBus probing: Using version 0x10003
[    3.697543] hv_pci f1e7c320-cc8f-4ab0-b65d-043ae91f13f6: PCI host bridge to bus cc8f:00
[    3.697545] pci_bus cc8f:00: root bus resource [mem 0x9ffe04000-0x9ffe06fff window]
[    3.718217] pci cc8f:00:00.0: [1af4:1049] type 00 class 0x010000
[    3.723453] pci cc8f:00:00.0: reg 0x10: [mem 0x9ffe04000-0x9ffe04fff 64bit]
[    3.726587] pci cc8f:00:00.0: reg 0x18: [mem 0x9ffe05000-0x9ffe05fff 64bit]
[    3.729668] pci cc8f:00:00.0: reg 0x20: [mem 0x9ffe06000-0x9ffe06fff 64bit]
[    3.755556] pci cc8f:00:00.0: BAR 0: assigned [mem 0x9ffe04000-0x9ffe04fff 64bit]
[    3.759790] pci cc8f:00:00.0: BAR 2: assigned [mem 0x9ffe05000-0x9ffe05fff 64bit]
[    3.764526] pci cc8f:00:00.0: BAR 4: assigned [mem 0x9ffe06000-0x9ffe06fff 64bit]
[    4.212890] hv_pci ab8f80b3-722c-48c5-a166-d0b17f47960e: PCI VMBus probing: Using version 0x10003
[    4.218436] hv_pci ab8f80b3-722c-48c5-a166-d0b17f47960e: PCI host bridge to bus 722c:00
[    4.218438] pci_bus 722c:00: root bus resource [mem 0x9ffe08000-0x9ffe0afff window]
[    4.226098] pci 722c:00:00.0: [1af4:1049] type 00 class 0x010000
[    4.231077] pci 722c:00:00.0: reg 0x10: [mem 0x9ffe08000-0x9ffe08fff 64bit]
[    4.233863] pci 722c:00:00.0: reg 0x18: [mem 0x9ffe09000-0x9ffe09fff 64bit]
[    4.237430] pci 722c:00:00.0: reg 0x20: [mem 0x9ffe0a000-0x9ffe0afff 64bit]
[    4.263975] pci 722c:00:00.0: BAR 0: assigned [mem 0x9ffe08000-0x9ffe08fff 64bit]
[    4.266315] pci 722c:00:00.0: BAR 2: assigned [mem 0x9ffe09000-0x9ffe09fff 64bit]
[    4.270859] pci 722c:00:00.0: BAR 4: assigned [mem 0x9ffe0a000-0x9ffe0afff 64bit]
[   49.230961] hv_balloon: Max. dynamic memory size: 4094 MB
[ 1919.162859] TCP: eth0: Driver has suspect GRO implementation, TCP performance may be compromised.
[ 3359.974363] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[ 4187.226673] potentially unexpected fatal signal 6.
[ 4187.226728] CPU: 4 PID: 202 Comm: weston Not tainted 5.10.16.3-microsoft-standard-WSL2 #1
[ 4187.226897] RIP: 0033:0x7fd92495e115
[ 4187.226900] Code: c2 b8 ea 00 00 00 0f 05 48 3d 00 f0 ff ff 77 3d 41 89 c0 41 ba 08 00 00 00 31 d2 4c 89 ce bf 02 00 00 00 b8 0e 00 00 00 0f 05 <48> 8b 84 24 08 01 00 00 64 48 33 04 25 28 00 00 00 75 24 44 89 c0
[ 4187.226902] RSP: 002b:00007fd911ffa8b0 EFLAGS: 00000246 ORIG_RAX: 000000000000000e
[ 4187.226909] RAX: 0000000000000000 RBX: 00007fd9202fc000 RCX: 00007fd92495e115
[ 4187.226910] RDX: 0000000000000000 RSI: 00007fd911ffa8b0 RDI: 0000000000000002
[ 4187.226911] RBP: 00007fd924aae630 R08: 0000000000000000 R09: 00007fd911ffa8b0
[ 4187.226912] R10: 0000000000000008 R11: 0000000000000246 R12: 00007fd923ba1440
[ 4187.226913] R13: 00000000000004ec R14: 00007fd923ba10fd R15: 0000557ae44a66e0
[ 4187.226914] FS:  00007fd911ffb700 GS:  0000000000000000
[ 4187.266942] WSLGd: /usr/bin/weston terminated with signal 6.
[ 4187.502389] WSLGd: /mnt/c/Windows/System32/mstsc.exe exited with status 0.
[ 8056.493668] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[ 9776.642705] potentially unexpected fatal signal 6.
[ 9776.642725] CPU: 2 PID: 3370 Comm: weston Not tainted 5.10.16.3-microsoft-standard-WSL2 #1
[ 9776.642960] RIP: 0033:0x7f2837690115
[ 9776.642970] Code: c2 b8 ea 00 00 00 0f 05 48 3d 00 f0 ff ff 77 3d 41 89 c0 41 ba 08 00 00 00 31 d2 4c 89 ce bf 02 00 00 00 b8 0e 00 00 00 0f 05 <48> 8b 84 24 08 01 00 00 64 48 33 04 25 28 00 00 00 75 24 44 89 c0
[ 9776.642979] RSP: 002b:00007f2824ff88b0 EFLAGS: 00000246 ORIG_RAX: 000000000000000e
[ 9776.642987] RAX: 0000000000000000 RBX: 00007f282c7de000 RCX: 00007f2837690115
[ 9776.642988] RDX: 0000000000000000 RSI: 00007f2824ff88b0 RDI: 0000000000000002
[ 9776.642989] RBP: 00007f28377e0630 R08: 0000000000000000 R09: 00007f2824ff88b0
[ 9776.642990] R10: 0000000000000008 R11: 0000000000000246 R12: 00007f28368d3440
[ 9776.642991] R13: 00000000000004ec R14: 00007f28368d30fd R15: 0000558cbadf8d00
[ 9776.642993] FS:  00007f2824ff9700 GS:  0000000000000000
[ 9776.705641] WSLGd: /usr/bin/weston terminated with signal 6.
[ 9777.300756] WSLGd: /mnt/c/Windows/System32/mstsc.exe exited with status 0.
[11359.645378] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[11809.870460] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[11824.875087] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[11944.923034] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[12365.141467] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[14180.755477] init: (134) ERROR: LogException:33: TELEMETRY: (null) No such file or directory @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[14510.868665] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[14510.869013] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[14615.893871] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[14645.911665] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[15006.067998] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[15126.090860] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[15321.119892] init: (134) ERROR: LogException:33: TELEMETRY: (null) No such file or directory @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[15981.313321] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[16000.382244] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[16129.311490] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[17016.764898] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[19147.631128] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[22014.040140] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)

[22720.964875] potentially unexpected fatal signal 6.
[22720.964908] CPU: 0 PID: 5722 Comm: weston Not tainted 5.10.16.3-microsoft-standard-WSL2 #1
[22720.965207] RIP: 0033:0x7fcf72da4115
[22720.965210] Code: c2 b8 ea 00 00 00 0f 05 48 3d 00 f0 ff ff 77 3d 41 89 c0 41 ba 08 00 00 00 31 d2 4c 89 ce bf 02 00 00 00 b8 0e 00 00 00 0f 05 <48> 8b 84 24 08 01 00 00 64 48 33 04 25 28 00 00 00 75 24 44 89 c0
[22720.965212] RSP: 002b:00007ffebcf4d110 EFLAGS: 00000246 ORIG_RAX: 000000000000000e
[22720.965221] RAX: 0000000000000000 RBX: 00007ffebcf4d380 RCX: 00007fcf72da4115
[22720.965222] RDX: 0000000000000000 RSI: 00007ffebcf4d110 RDI: 0000000000000002
[22720.965223] RBP: 00007ffebcf4d460 R08: 0000000000000000 R09: 00007ffebcf4d110
[22720.965224] R10: 0000000000000008 R11: 0000000000000246 R12: 0000000000001000
[22720.965225] R13: 00007ffebcf4d380 R14: 0000000000000010 R15: 00007fcf70187000
[22720.965227] FS:  00007fcf724f4900 GS:  0000000000000000
[22721.009511] WSLGd: /usr/bin/weston terminated with signal 6.
[22721.243396] WSLGd: /mnt/c/Windows/System32/mstsc.exe exited with status 0.
[22727.416183] init: (134) ERROR: LogException:33: TELEMETRY: (null) Invalid argument @d:\os\src\onecore\VM\linux\mountutil\mountutilcpp.h:19 (MountEnum)
SteveF4 commented 3 years ago

wsl-etl.zip

@OneBlue I now have a 1.8 MB file wsl.etl, attached to this ticket in a zip archive.

Thanks for looking into the issue! You and your team are doing amazing work.

OneBlue commented 3 years ago

[22721.009511] WSLGd: /usr/bin/weston terminated with signal 6.

That's what I suspected, weston is crashing so this is indeed a wslg issue.

hideyukn88 commented 3 years ago

@SteveF4, sorry for late response, I have tried the repro step with WSLg 1.0.27, and firefox can brose to webpage and extension can be installed successfully, please update WSLg and try again, thanks!

image

matan7890 commented 2 years ago

Sorry for bumping, but this exact issue is happening for me now too. I believe it has something to do with the fact that my laptop has two different GPUs (Nvidia's and Intel's) but I'm not sure it is. I'm attaching my wsl logs during the crash: WslLogs-2022-08-14_13-58-01.zip

matan7890 commented 2 years ago

Tested on 1.0.27, still crashing.