QubesOS / qubes-issues

The Qubes OS Project issue tracker
https://www.qubes-os.org/doc/issue-tracking/
541 stars 48 forks source link

[Build 4.3.202411080858] openQA test fails in firstboot #9568

Closed marmarek closed 1 day ago

marmarek commented 3 days ago

Observation

openQA test in scenario qubesos-4.3-install-iso-x86_64-install_minimal@64bit fails in firstboot

Initial setup doesn't show after first reboot.

Test suite description

Reproducible

Fails since (at least) Build 4.3.202411080858 (current job)

Expected result

Last good: 4.3.202410222200 (or more recent)

Further details

Always latest result in this scenario: latest

marmarek commented 3 days ago

weston fails to start: initial-setup-fail

Worth looking at recent Fedora 41 updates (especially since last good job), I don't think there were any qubes changes in this area since then.

marmarek commented 3 days ago

It's definitely one of recent updates. It works before installing updates and breaks just after that.

Update info

``` Transaction ID : 3 Begin time : 2024-11-09 23:40:52 Begin rpmdb : b38fc958abfdeb018ddb1620db4dcbcfe51fabb10427df48e15d622804b84f03 End time : 2024-11-09 23:41:29 End rpmdb : a6d8d105787b2db7e61447ccea9775e51a28e67d450d5b0cee7ad9d5efe87a09 User : 1000 user Status : Ok Releasever : 4.3 Description : dnf upgrade --exclude=qubes-template-* --refresh Comment : Packages altered: Action Package Reason Repository Upgrade bluez-libs-0:5.79-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade cmake-filesystem-0:3.30.5-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade debugedit-0:5.1-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade gdb-minimal-0:15.2-2.fc41.x86_64 Dependency qubes-dom0-cached Upgrade gtk4-0:4.16.5-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade hwdata-0:0.389-1.fc41.noarch Dependency qubes-dom0-cached Upgrade libXcursor-0:1.2.3-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade librepo-0:1.19.0-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade libseat-0:0.9.1-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade libxcrypt-0:4.4.36-8.fc41.x86_64 Dependency qubes-dom0-cached Upgrade libxshmfence-0:1.3.2-5.fc41.x86_64 Dependency qubes-dom0-cached Upgrade mesa-dri-drivers-0:24.2.6-1.fc41.x86_64 Group qubes-dom0-cached Upgrade mesa-filesystem-0:24.2.6-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade mesa-libEGL-0:24.2.6-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade mesa-libGL-0:24.2.6-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade mesa-libgbm-0:24.2.6-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade mesa-libglapi-0:24.2.6-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade mesa-libxatracker-0:24.2.6-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade mesa-va-drivers-0:24.2.6-1.fc41.x86_64 Weak Dependency qubes-dom0-cached Upgrade mesa-vulkan-drivers-0:24.2.6-1.fc41.x86_64 Group qubes-dom0-cached Upgrade numactl-libs-0:2.0.19-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade ostree-libs-0:2024.9-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade python3-boto3-0:1.35.55-1.fc41.noarch Weak Dependency qubes-dom0-cached Upgrade python3-botocore-0:1.35.55-1.fc41.noarch Dependency qubes-dom0-cached Upgrade python3-librepo-0:1.19.0-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade python3-qubesimgconverter-0:4.3.5-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade qt6-qtdeclarative-0:6.8.0-2.fc41.x86_64 Dependency qubes-dom0-cached Upgrade qubes-desktop-linux-manager-0:4.3.5-1.fc41.noarch Group qubes-dom0-cached Upgrade qubes-desktop-linux-menu-0:1.2.2-1.fc41.noarch Group qubes-dom0-cached Upgrade qubes-input-proxy-0:1.0.39-1.fc41.x86_64 Group qubes-dom0-cached Upgrade qubes-input-proxy-receiver-0:1.0.39-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade qubes-input-proxy-sender-0:1.0.39-1.fc41.x86_64 Group qubes-dom0-cached Upgrade qubes-kernel-vm-support-0:4.3.5-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade qubes-utils-0:4.3.5-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade qubes-utils-libs-0:4.3.5-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade qubes-utils-selinux-0:4.3.5-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade rtkit-0:0.11-65.fc41.x86_64 Dependency qubes-dom0-cached Upgrade xen-hvm-stubdom-linux-0:4.3.1-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade xen-hvm-stubdom-linux-full-0:4.3.1-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade xorg-x11-drv-wacom-0:1.2.3-1.fc41.x86_64 Group qubes-dom0-cached Upgrade xorg-x11-drv-wacom-serial-support-0:1.2.3-1.fc41.x86_64 Dependency qubes-dom0-cached Upgrade xterm-0:395-1.fc41.x86_64 Group qubes-dom0-cached Replaced bluez-libs-0:5.78-1.fc41.x86_64 Dependency @System Replaced cmake-filesystem-0:3.28.3-7.fc41.x86_64 Dependency @System Replaced debugedit-0:5.0-18.fc41.x86_64 Dependency @System Replaced gdb-minimal-0:15.2-1.fc41.x86_64 Dependency @System Replaced gtk4-0:4.16.3-1.fc41.x86_64 Dependency @System Replaced hwdata-0:0.388-1.fc41.noarch Dependency @System Replaced libXcursor-0:1.2.2-2.fc41.x86_64 Dependency @System Replaced librepo-0:1.18.1-1.fc41.x86_64 Dependency @System Replaced libseat-0:0.8.0-3.fc41.x86_64 Dependency @System Replaced libxcrypt-0:4.4.36-7.fc41.x86_64 Dependency @System Replaced libxshmfence-0:1.3.2-4.fc41.x86_64 Dependency @System Replaced mesa-dri-drivers-0:24.2.5-1.fc41.x86_64 Group @System Replaced mesa-filesystem-0:24.2.5-1.fc41.x86_64 Dependency @System Replaced mesa-libEGL-0:24.2.5-1.fc41.x86_64 Dependency @System Replaced mesa-libGL-0:24.2.5-1.fc41.x86_64 Dependency @System Replaced mesa-libgbm-0:24.2.5-1.fc41.x86_64 Dependency @System Replaced mesa-libglapi-0:24.2.5-1.fc41.x86_64 Dependency @System Replaced mesa-libxatracker-0:24.2.5-1.fc41.x86_64 Dependency @System Replaced mesa-va-drivers-0:24.2.5-1.fc41.x86_64 Weak Dependency @System Replaced mesa-vulkan-drivers-0:24.2.5-1.fc41.x86_64 Group @System Replaced numactl-libs-0:2.0.18-2.fc41.x86_64 Dependency @System Replaced ostree-libs-0:2024.8-3.fc41.x86_64 Dependency @System Replaced python3-boto3-0:1.35.54-1.fc41.noarch Weak Dependency @System Replaced python3-botocore-0:1.35.54-1.fc41.noarch Dependency @System Replaced python3-librepo-0:1.18.1-1.fc41.x86_64 Dependency @System Replaced python3-qubesimgconverter-0:4.3.4-1.fc41.x86_64 Dependency @System Replaced qt6-qtdeclarative-0:6.8.0-1.fc41.x86_64 Dependency @System Replaced qubes-desktop-linux-manager-0:4.3.3-1.fc41.noarch Group @System Replaced qubes-desktop-linux-menu-0:1.2.1-1.fc41.noarch Group @System Replaced qubes-input-proxy-0:1.0.38-1.fc41.x86_64 Group @System Replaced qubes-input-proxy-receiver-0:1.0.38-1.fc41.x86_64 Dependency @System Replaced qubes-input-proxy-sender-0:1.0.38-1.fc41.x86_64 Group @System Replaced qubes-kernel-vm-support-0:4.3.4-1.fc41.x86_64 Dependency @System Replaced qubes-utils-0:4.3.4-1.fc41.x86_64 Dependency @System Replaced qubes-utils-libs-0:4.3.4-1.fc41.x86_64 Dependency @System Replaced qubes-utils-selinux-0:4.3.4-1.fc41.x86_64 Dependency @System Replaced rtkit-0:0.11-64.fc41.x86_64 Dependency @System Replaced xen-hvm-stubdom-linux-0:4.3.0-1.fc41.x86_64 Dependency @System Replaced xen-hvm-stubdom-linux-full-0:4.3.0-1.fc41.x86_64 Dependency @System Replaced xorg-x11-drv-wacom-0:1.2.2-2.fc41.x86_64 Group @System Replaced xorg-x11-drv-wacom-serial-support-0:1.2.2-2.fc41.x86_64 Dependency @System Replaced xterm-0:393-1.fc41.x86_64 Group @System ```

Logs when it works

``` Nov 09 18:37:42 dom0 systemd[1]: Starting initial-setup.service - Initial Setup configuration program... Nov 09 18:37:43 dom0 initial-setup[4612]: Starting Initial Setup GUI Nov 09 18:37:43 dom0 run-initial-setup[4621]: Date: 2024-11-09 EST Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.085] weston 14.0.0 Nov 09 18:37:43 dom0 run-initial-setup[4621]: https://wayland.freedesktop.org Nov 09 18:37:43 dom0 run-initial-setup[4621]: Bug reports to: https://gitlab.freedesktop.org/wayland/weston/issues/ Nov 09 18:37:43 dom0 run-initial-setup[4621]: Build: 14.0.0 Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.085] Command line: weston --config=/tmp/tmp.gXzKbl9khE-wl-weston-firstboot-ini --socket=wl-firstboot-0 Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.085] OS: Linux, 6.6.54-1.qubes.fc41.x86_64, #1 SMP PREEMPT_DYNAMIC Mon Oct 7 22:26:28 UTC 2024, x86_64 Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.085] Flight recorder: enabled Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.085] Using config file '/tmp/tmp.gXzKbl9khE-wl-weston-firstboot-ini' Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.085] Output repaint window is 7 ms maximum. Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.085] Loading module '/usr/lib64/libweston-14/drm-backend.so' Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.116] initializing drm backend Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.116] Trying libseat launcher... Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.116] [libseat/backend/seatd.c:64] Could not connect to socket /run/seatd.sock: No such file or directory Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.116] [libseat/libseat.c:76] Backend 'seatd' failed to open seat, skipping Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.127] [libseat/libseat.c:73] Seat opened with backend 'logind' Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.128] libseat: session control granted Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.133] using /dev/dri/card0 Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.133] DRM: supports atomic modesetting Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.133] DRM: supports GBM modifiers Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.133] DRM: does not support Atomic async page flip Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.133] DRM: supports picture aspect ratio Nov 09 18:37:43 dom0 run-initial-setup[4621]: pci id for fd 14: 1234:1111, driver (null) Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.147] Loading module '/usr/lib64/libweston-14/gl-renderer.so' Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.154] warning: failed to query rendering device from EGL Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.155] EGL version: 1.5 Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.155] EGL vendor: Mesa Project Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.155] EGL client APIs: OpenGL OpenGL_ES Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.155] warning: Disabling render GPU timeline and explicit synchronization due to missing EGL_ANDROID_native_fence_sync extension Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.155] EGL features: Nov 09 18:37:43 dom0 run-initial-setup[4621]: EGL Wayland extension: no Nov 09 18:37:43 dom0 run-initial-setup[4621]: context priority: no Nov 09 18:37:43 dom0 run-initial-setup[4621]: buffer age: yes Nov 09 18:37:43 dom0 run-initial-setup[4621]: partial update: no Nov 09 18:37:43 dom0 run-initial-setup[4621]: swap buffers with damage: no Nov 09 18:37:43 dom0 run-initial-setup[4621]: configless context: yes Nov 09 18:37:43 dom0 run-initial-setup[4621]: surfaceless context: yes Nov 09 18:37:43 dom0 run-initial-setup[4621]: dmabuf support: modifiers Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.186] GL version: OpenGL ES 3.2 Mesa 24.2.5 Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.186] GLSL version: OpenGL ES GLSL ES 3.20 Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.186] GL vendor: Mesa Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.186] GL renderer: llvmpipe (LLVM 19.1.0, 256 bits) Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.198] GL ES 3.2 - renderer features: Nov 09 18:37:43 dom0 run-initial-setup[4621]: read-back format: ARGB8888 Nov 09 18:37:43 dom0 run-initial-setup[4621]: glReadPixels supports y-flip: yes Nov 09 18:37:43 dom0 run-initial-setup[4621]: glReadPixels supports PBO: yes Nov 09 18:37:43 dom0 run-initial-setup[4621]: wl_shm 10 bpc formats: yes Nov 09 18:37:43 dom0 run-initial-setup[4621]: wl_shm 16 bpc formats: yes Nov 09 18:37:43 dom0 run-initial-setup[4621]: wl_shm half-float formats: yes Nov 09 18:37:43 dom0 run-initial-setup[4621]: internal R and RG formats: yes Nov 09 18:37:43 dom0 run-initial-setup[4621]: OES_EGL_image_external: yes Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.198] Using GL renderer Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.207] event0 - Power Button: is tagged by udev as: Keyboard Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.207] event0 - Power Button: device is a keyboard Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.210] event1 - AT Translated Set 2 keyboard: is tagged by udev as: Keyboard Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.210] event1 - AT Translated Set 2 keyboard: device is a keyboard Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.213] event2 - ImExPS/2 Generic Explorer Mouse: is tagged by udev as: Mouse Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.213] event2 - ImExPS/2 Generic Explorer Mouse: device is a pointer Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.216] event3 - PC Speaker: not tagged as supported input device Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.217] event3 - not using input device '/dev/input/event3' Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.220] event4 - sys-usb: QEMU QEMU USB Tablet: is tagged by udev as: Mouse Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.221] event4 - sys-usb: QEMU QEMU USB Tablet: device is a pointer Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.227] libinput: configuring device "Power Button". Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.227] libinput: configuring device "AT Translated Set 2 keyboard". Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.227] libinput: configuring device "ImExPS/2 Generic Explorer Mouse". Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.228] libinput: configuring device "sys-usb: QEMU QEMU USB Tablet". Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.228] input device event4 has no enabled output associated (none named), skipping calibration for now. Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.228] DRM: EDID for the following head fails conformity: Nov 09 18:37:43 dom0 run-initial-setup[4621]: Block 1, CTA-861 Extension Block: Nov 09 18:37:43 dom0 run-initial-setup[4621]: Padding: Contains non-zero bytes. Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.228] DRM: head 'Virtual-1' found, connector 31 is connected, EDID make 'Red Hat, Inc.', model 'QEMU Monitor', serial '' Nov 09 18:37:43 dom0 run-initial-setup[4621]: Supported EOTF modes: SDR Nov 09 18:37:43 dom0 run-initial-setup[4621]: Supported colorimetry modes: default Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.228] Registered plugin API 'weston_drm_output_api_v1' of size 40 Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.228] Registered plugin API 'weston_drm_virtual_output_api_v2' of size 48 Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.229] Color manager: no-op Nov 09 18:37:43 dom0 run-initial-setup[4621]: protocol support: no Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.229] Output 'Virtual-1' attempts EOTF mode SDR and colorimetry mode default. Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.229] Output 'Virtual-1' using color profile: stock sRGB color profile Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.229] Chosen EGL config details: id: 31 rgba: 8 8 8 0 buf: 24 dep: 0 stcl: 0 int: 1-1 type: win vis_id: XRGB8888 (0x34325258) Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.229] Output Virtual-1 (crtc 35) video modes: Nov 09 18:37:43 dom0 run-initial-setup[4621]: 1280x800@75.0, preferred, current, 107.3 MHz Nov 09 18:37:43 dom0 run-initial-setup[4621]: 1920x1080@60.0, 148.5 MHz Nov 09 18:37:43 dom0 run-initial-setup[4621]: 1920x1080@50.0 16:9, 148.5 MHz Nov 09 18:37:43 dom0 run-initial-setup[4621]: 1600x1200@60.0, 162.0 MHz Nov 09 18:37:43 dom0 run-initial-setup[4621]: 1680x1050@60.0, 146.2 MHz Nov 09 18:37:43 dom0 run-initial-setup[4621]: 1400x1050@60.0, 121.8 MHz Nov 09 18:37:43 dom0 run-initial-setup[4621]: 1280x1024@60.0, 108.0 MHz Nov 09 18:37:43 dom0 run-initial-setup[4621]: 1440x900@59.9, 106.5 MHz Nov 09 18:37:43 dom0 run-initial-setup[4621]: 1280x960@60.0, 108.0 MHz Nov 09 18:37:43 dom0 run-initial-setup[4621]: 1360x768@60.0, 85.5 MHz Nov 09 18:37:43 dom0 run-initial-setup[4621]: 1280x768@59.9, 79.5 MHz Nov 09 18:37:43 dom0 run-initial-setup[4621]: 1024x768@60.0, 65.0 MHz Nov 09 18:37:43 dom0 run-initial-setup[4621]: 800x600@60.3, 40.0 MHz Nov 09 18:37:43 dom0 run-initial-setup[4621]: 640x480@60.0 4:3, 25.2 MHz Nov 09 18:37:43 dom0 run-initial-setup[4621]: 640x480@59.9, 25.2 MHz Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.229] associating input device event0 with output Virtual-1 (none by udev) Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.229] associating input device event1 with output Virtual-1 (none by udev) Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.229] associating input device event2 with output Virtual-1 (none by udev) Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.229] associating input device event4 with output Virtual-1 (none by udev) Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.229] Output 'Virtual-1' enabled with head(s) Virtual-1 Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.229] Compositor capabilities: Nov 09 18:37:43 dom0 run-initial-setup[4621]: arbitrary surface rotation: yes Nov 09 18:37:43 dom0 run-initial-setup[4621]: screen capture uses y-flip: yes Nov 09 18:37:43 dom0 run-initial-setup[4621]: cursor planes: yes Nov 09 18:37:43 dom0 run-initial-setup[4621]: arbitrary resolutions: no Nov 09 18:37:43 dom0 run-initial-setup[4621]: view mask clipping: yes Nov 09 18:37:43 dom0 run-initial-setup[4621]: explicit sync: no Nov 09 18:37:43 dom0 run-initial-setup[4621]: color operations: yes Nov 09 18:37:43 dom0 run-initial-setup[4621]: presentation clock: CLOCK_MONOTONIC, id 1 Nov 09 18:37:43 dom0 run-initial-setup[4621]: presentation clock resolution: 0.000000001 s Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.229] Loading module '/usr/lib64/weston/kiosk-shell.so' Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.230] Loading module '/usr/lib64/libweston-14/xwayland.so' Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.239] Registered plugin API 'weston_xwayland_v3' of size 32 Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.239] Registered plugin API 'weston_xwayland_surface_v2' of size 24 Nov 09 18:37:43 dom0 run-initial-setup[4621]: [18:37:43.239] xserver listening on display :0 Nov 09 18:37:45 dom0 initial-setup[4636]: Initial Setup 0.3.101 Nov 09 18:37:45 dom0 initial-setup[4636]: running in GUI mode Nov 09 18:37:45 dom0 initial-setup[4636]: GI overrides imported Nov 09 18:37:45 dom0 initial-setup[4636]: found 2 addon modules: Nov 09 18:37:45 dom0 initial-setup[4636]: spokes Nov 09 18:37:45 dom0 initial-setup[4636]: categories Nov 09 18:37:45 dom0 initial-setup[4636]: initializing the Anaconda log Nov 09 18:37:45 dom0 anaconda[4636]: anaconda: misc: Configuration loaded from: ['/etc/anaconda/anaconda.conf', '/etc/anaconda/profile.d/qubesos.conf', '/etc/initial-setup/conf.d/10-initial-setup.conf'] Nov 09 18:37:45 dom0 dbus-daemon[4655]: Activating service name='org.fedoraproject.Anaconda.Boss' requested by ':1.0' (uid=0 pid=4636 comm="/usr/bin/python3 /usr/libexec/initial-setup/initia") Nov 09 18:37:48 dom0 initial-setup[4636]: using kickstart from Anaconda run for input Nov 09 18:37:48 dom0 initial-setup[4636]: parsing input kickstart /root/anaconda-ks.cfg Nov 09 18:37:48 dom0 initial-setup[4636]: kickstart parsing done Nov 09 18:37:49 dom0 initial-setup[4636]: setting up locale Nov 09 18:37:49 dom0 initial-setup[4636]: initializing network Nov 09 18:37:49 dom0 initial-setup[4636]: trying to import GUI Nov 09 18:37:49 dom0 run-initial-setup[4621]: [18:37:49.259] launching '/usr/bin/Xwayland' Nov 09 18:37:49 dom0 run-initial-setup[4759]: (WW) Option "-listen" for file descriptors is deprecated Nov 09 18:37:49 dom0 run-initial-setup[4759]: Please use "-listenfd" instead. Nov 09 18:37:49 dom0 run-initial-setup[4759]: (WW) Option "-listen" for file descriptors is deprecated Nov 09 18:37:49 dom0 run-initial-setup[4759]: Please use "-listenfd" instead. Nov 09 18:37:49 dom0 run-initial-setup[4759]: Xwayland glamor: GBM Wayland interfaces not available Nov 09 18:37:49 dom0 run-initial-setup[4759]: Failed to initialize glamor, falling back to sw Nov 09 18:37:49 dom0 run-initial-setup[4621]: [18:37:49.384] xfixes version: 6.0 Nov 09 18:37:49 dom0 run-initial-setup[4621]: [18:37:49.401] created wm, root 565 Nov 09 18:37:49 dom0 run-initial-setup[4763]: The XKEYBOARD keymap compiler (xkbcomp) reports: Nov 09 18:37:49 dom0 run-initial-setup[4763]: > Warning: Unsupported maximum keycode 708, clipping. Nov 09 18:37:49 dom0 run-initial-setup[4763]: > X11 cannot support keycodes above 255. Nov 09 18:37:49 dom0 run-initial-setup[4763]: > Warning: Could not resolve keysym XF86KbdInputAssistPrevgrou Nov 09 18:37:49 dom0 run-initial-setup[4763]: > Warning: Could not resolve keysym XF86KbdInputAssistNextgrou Nov 09 18:37:49 dom0 run-initial-setup[4763]: Errors from xkbcomp are not fatal to the X server Nov 09 18:37:49 dom0 initial-setup[4636]: initializing GUI Nov 09 18:37:49 dom0 initial-setup[4636]: setting up the UI Nov 09 18:37:50 dom0 initial-setup[4636]: starting the UI Nov 09 18:37:55 dom0 initial-setup[4636]: writing the Initial Setup kickstart file /root/initial-setup-ks.cfg Nov 09 18:37:55 dom0 initial-setup[4636]: finished writing the Initial Setup kickstart file Nov 09 18:37:55 dom0 initial-setup[4636]: all changes have been applied Nov 09 18:37:55 dom0 run-initial-setup[4621]: [18:37:55.512] xserver exited, will restart on demand Nov 09 18:37:55 dom0 run-initial-setup[4621]: [18:37:55.513] event0 - Power Button: device removed Nov 09 18:37:55 dom0 run-initial-setup[4621]: [18:37:55.516] event1 - AT Translated Set 2 keyboard: device removed Nov 09 18:37:55 dom0 run-initial-setup[4621]: [18:37:55.520] event2 - ImExPS/2 Generic Explorer Mouse: device removed Nov 09 18:37:55 dom0 run-initial-setup[4621]: [18:37:55.523] event4 - sys-usb: QEMU QEMU USB Tablet: device removed Nov 09 18:37:55 dom0 run-initial-setup[4759]: (EE) failed to write to Xwayland fd: Broken pipe Nov 09 18:37:55 dom0 initial-setup[4843]: Initial Setup finished successfully, disabling Nov 09 18:37:55 dom0 initial-setup[4847]: Initial Setup has been disabled Nov 09 18:37:55 dom0 systemd[1]: initial-setup.service: Deactivated successfully. Nov 09 18:37:55 dom0 systemd[1]: Finished initial-setup.service - Initial Setup configuration program. ```

Logs when it breaks

``` Nov 09 18:41:38 dom0 systemd[1]: Starting initial-setup.service - Initial Setup configuration program... Nov 09 18:41:39 dom0 initial-setup[8425]: Starting Initial Setup GUI Nov 09 18:41:39 dom0 run-initial-setup[8436]: Date: 2024-11-09 EST Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.061] weston 14.0.0 Nov 09 18:41:39 dom0 run-initial-setup[8436]: https://wayland.freedesktop.org Nov 09 18:41:39 dom0 run-initial-setup[8436]: Bug reports to: https://gitlab.freedesktop.org/wayland/weston/issues/ Nov 09 18:41:39 dom0 run-initial-setup[8436]: Build: 14.0.0 Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.061] Command line: weston --config=/tmp/tmp.0VdFJgn0M9-wl-weston-firstboot-ini --socket=wl-firstboot-0 Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.061] OS: Linux, 6.6.54-1.qubes.fc41.x86_64, #1 SMP PREEMPT_DYNAMIC Mon Oct 7 22:26:28 UTC 2024, x86_64 Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.061] Flight recorder: enabled Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.061] Using config file '/tmp/tmp.0VdFJgn0M9-wl-weston-firstboot-ini' Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.061] Output repaint window is 7 ms maximum. Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.061] Loading module '/usr/lib64/libweston-14/drm-backend.so' Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.093] initializing drm backend Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.094] Trying libseat launcher... Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.094] [libseat/backend/seatd.c:64] Could not connect to socket /run/seatd.sock: No such file or directory Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.094] [libseat/libseat.c:76] Backend 'seatd' failed to open seat, skipping Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.097] [libseat/libseat.c:73] Seat opened with backend 'logind' Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.097] libseat: session control granted Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.099] using /dev/dri/card0 Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.099] DRM: supports atomic modesetting Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.099] DRM: supports GBM modifiers Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.099] DRM: does not support Atomic async page flip Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.099] DRM: supports picture aspect ratio Nov 09 18:41:39 dom0 run-initial-setup[8436]: pci id for fd 14: 1234:1111, driver (null) Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.106] Loading module '/usr/lib64/libweston-14/gl-renderer.so' Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.109] warning: failed to query rendering device from EGL Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.109] EGL version: 1.5 Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.109] EGL vendor: Mesa Project Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.109] EGL client APIs: OpenGL OpenGL_ES Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.109] warning: Disabling render GPU timeline and explicit synchronization due to missing EGL_ANDROID_native_fence_sync extension Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.109] EGL features: Nov 09 18:41:39 dom0 run-initial-setup[8436]: EGL Wayland extension: no Nov 09 18:41:39 dom0 run-initial-setup[8436]: context priority: no Nov 09 18:41:39 dom0 run-initial-setup[8436]: buffer age: yes Nov 09 18:41:39 dom0 run-initial-setup[8436]: partial update: no Nov 09 18:41:39 dom0 run-initial-setup[8436]: swap buffers with damage: no Nov 09 18:41:39 dom0 run-initial-setup[8436]: configless context: yes Nov 09 18:41:39 dom0 run-initial-setup[8436]: surfaceless context: yes Nov 09 18:41:39 dom0 run-initial-setup[8436]: dmabuf support: modifiers Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.153] GL version: OpenGL ES 3.2 Mesa 24.2.6 Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.153] GLSL version: OpenGL ES GLSL ES 3.20 Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.153] GL vendor: Mesa Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.153] GL renderer: llvmpipe (LLVM 19.1.0, 256 bits) Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.173] GL ES 3.2 - renderer features: Nov 09 18:41:39 dom0 run-initial-setup[8436]: read-back format: ARGB8888 Nov 09 18:41:39 dom0 run-initial-setup[8436]: glReadPixels supports y-flip: yes Nov 09 18:41:39 dom0 run-initial-setup[8436]: glReadPixels supports PBO: yes Nov 09 18:41:39 dom0 run-initial-setup[8436]: wl_shm 10 bpc formats: yes Nov 09 18:41:39 dom0 run-initial-setup[8436]: wl_shm 16 bpc formats: yes Nov 09 18:41:39 dom0 run-initial-setup[8436]: wl_shm half-float formats: yes Nov 09 18:41:39 dom0 run-initial-setup[8436]: internal R and RG formats: yes Nov 09 18:41:39 dom0 run-initial-setup[8436]: OES_EGL_image_external: yes Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.173] Using GL renderer Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.193] event0 - not using input device '/dev/input/event0' Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.195] event1 - not using input device '/dev/input/event1' Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.197] event2 - not using input device '/dev/input/event2' Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.200] event3 - not using input device '/dev/input/event3' Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.204] event4 - not using input device '/dev/input/event4' Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.204] warning: no input devices on entering Weston. Possible causes: Nov 09 18:41:39 dom0 run-initial-setup[8436]: - no permissions to read /dev/input/event* Nov 09 18:41:39 dom0 run-initial-setup[8436]: - seats misconfigured (Weston backend option 'seat', udev device property ID_SEAT) Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.204] failed to create input devices Nov 09 18:41:39 dom0 run-initial-setup[8436]: [18:41:39.207] fatal: failed to create compositor backend Nov 09 18:41:39 dom0 run-initial-setup[8436]: Internal warning: debug scope 'drm-backend' has not been destroyed. Nov 09 18:41:39 dom0 initial-setup[8457]: Initial Setup finished successfully, disabling Nov 09 18:41:39 dom0 initial-setup[8463]: Initial Setup has been disabled Nov 09 18:41:39 dom0 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=initial-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 09 18:41:39 dom0 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=initial-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 09 18:41:39 dom0 systemd[1]: initial-setup.service: Deactivated successfully. Nov 09 18:41:39 dom0 systemd[1]: Finished initial-setup.service - Initial Setup configuration program. ```

marmarek commented 3 days ago

Downgrading libseat back to 0.8.0 fixes the issue.

marmarek commented 3 days ago

Upstream report: https://lists.sr.ht/~kennylevinsen/seatd-devel/%3CZy_-FRQnBTeNPXVj@mail-itl%3E

kennylevinsen commented 2 days ago

The primary change in 0.9 is that libseat will no longer issue an automatic VT change on startup when using the logind backend, to align with the earlier Weston behavior that allowed starting sessions in the background without having them all try to activate themselves at once.

This is likely your issue if you are trying to start Weston on an inactive VT (say, tty7 while tty1 is active). In that case the start script should issue a chvt before or after successful start. See https://gitlab.gnome.org/World/Phosh/phosh/-/merge_requests/1566 for an example.

There aren’t any known issues for seatd and its libseat backend for 0.9.1 at the current time.

marmarek commented 2 days ago

Thanks, I'll try this approach. But I think it tries to start weston on the current VT (I don't see any explicit option to choose some other...)

kennylevinsen commented 1 day ago

Thanks, I'll try this approach. But I think it tries to start weston on the current VT (I don't see any explicit option to choose some other...)

Still assuming systemd-logind/elogind, the VT is dictated by the VT associated with the logind session, which is set when the session is created by pam_systemd.so. This would be controlled by e.g., the service definition or set by the login manager.

(Login managers tend to perform a VT switch of their own when using background VTs for new sessions though.)

For anything else, more details would be required about the failure - full weston output for starters. If logind, sudo busctl monitor would reveal communication with logind if anything there has failed.

kennylevinsen commented 1 day ago

Assuming run-initial-setup is from here, an explicit decision to attempt tty7 can be seen here: https://github.com/rhinstaller/initial-setup/blob/master/systemd/initial-setup.service

This would be the exact same issue as phosh.

marmarek commented 1 day ago

I can confirm adding chvt 7 in that script fixes the issue, thanks!