[solved] Long delay before graphical programs start on Xorg / lxde

cdwijs · 2023-08-13 05:53:45

After booting, I login in text mode, and then issue the command "startx" to start LXDE.

Then when I start a program, I see a 30 second delay after starting the program, and seeing the graphical window. This delay also happens after closing the program and starting it again. It doesn't happen with console programs. I see this error in /var/log/everything:

xdg-desktop-portal-gnome.service: Job xdg-desktop-portal-gnome.service/start failed with result 'dependency'.

It looks like this problem: https://bbs.archlinux.org/viewtopic.php?id=285590

Testing with thunderbird:

$ time thunderbird
[ImapModuleLoader] Using nsImapService.cpp
ATTENTION: default value of option mesa_glthread overridden by environment.
ATTENTION: default value of option mesa_glthread overridden by environment.
ATTENTION: default value of option mesa_glthread overridden by environment.
ATTENTION: default value of option mesa_glthread overridden by environment.
ATTENTION: default value of option mesa_glthread overridden by environment.
ATTENTION: default value of option mesa_glthread overridden by environment.
console.debug: "Found 0 public keys and 0 secret keys (0 protected, 0 unprotected)"
console.warn: services.settings: Failed to load last_modified.json: TypeError: NetworkError when attempting to fetch resource.
console.debug: "Trying to load /usr/lib/thunderbird/libotr.so"
console.debug: "Trying to load libotr.so from system's standard library locations"
console.debug: "Successfully loaded OTR library libotr.so from system's standard library locations"

real	0m31.756s
user	0m5.046s
sys	0m0.691s

During the test with thunderbird, I see the following messages in /var/log/everything.log:

# tail -F /var/log/everything.log
Aug 13 07:44:11 cedric xdg-desktop-por[3334]: Failed to create settings proxy: Error calling StartServiceByName for org.freedesktop.impl.portal.desktop.gnome: Timeout was reached
Aug 13 07:44:21 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:44:21 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:44:24 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:44:24 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:44:24 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:44:24 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:44:51 cedric systemd[955]: xdg-desktop-portal.service: start operation timed out. Terminating.
Aug 13 07:44:51 cedric systemd[955]: xdg-desktop-portal.service: Failed with result 'timeout'.
Aug 13 07:44:51 cedric systemd[955]: Failed to start Portal service.
Aug 13 07:48:51 cedric dbus-daemon[1007]: [session uid=1000 pid=1007] Activating via systemd: service name='org.freedesktop.portal.Desktop' unit='xdg-desktop-portal.service' requested by ':1.79' (uid=1000 pid=3927 comm="/usr/lib/thunderbird/thunderbird")
Aug 13 07:48:51 cedric systemd[955]: Starting Portal service...
Aug 13 07:48:51 cedric dbus-daemon[1007]: [session uid=1000 pid=1007] Activating via systemd: service name='org.freedesktop.impl.portal.desktop.gnome' unit='xdg-desktop-portal-gnome.service' requested by ':1.80' (uid=1000 pid=3977 comm="/usr/lib/xdg-desktop-portal")
Aug 13 07:48:51 cedric systemd[955]: Current graphical user session is inactive.
Aug 13 07:48:51 cedric systemd[955]: Dependency failed for Portal service (GNOME implementation).
Aug 13 07:48:51 cedric systemd[955]: xdg-desktop-portal-gnome.service: Job xdg-desktop-portal-gnome.service/start failed with result 'dependency'.
Aug 13 07:49:16 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:49:16 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:49:16 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:49:17 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:49:17 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:49:17 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:49:17 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:49:17 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:49:17 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:49:17 cedric rtkit-daemon[1428]: Successfully made thread 4065 of process 3927 owned by '1000' RT at priority 10.
Aug 13 07:49:17 cedric rtkit-daemon[1428]: Supervising 8 threads of 5 processes of 1 users.
Aug 13 07:49:41 cedric xdg-desktop-por[3977]: Failed to create settings proxy: Error calling StartServiceByName for org.freedesktop.impl.portal.desktop.gnome: Timeout was reached

a command line program starts immediately:

$ cal
     August 2023    
Su Mo Tu We Th Fr Sa
       1  2  3  4  5
 6  7  8  9 10 11 12
13 14 15 16 17 18 19
20 21 22 23 24 25 26
27 28 29 30 31      

[cedric@cedric ~]$ date && cal && date
Sun Aug 13 07:42:09 AM CEST 2023
     August 2023    
Su Mo Tu We Th Fr Sa
       1  2  3  4  5
 6  7  8  9 10 11 12
13 14 15 16 17 18 19
20 21 22 23 24 25 26
27 28 29 30 31      
                    
Sun Aug 13 07:42:09 AM CEST 2023
$ time cal
     August 2023    
Su Mo Tu We Th Fr Sa
       1  2  3  4  5
 6  7  8  9 10 11 12
13 14 15 16 17 18 19
20 21 22 23 24 25 26
27 28 29 30 31      
                    

real	0m0.003s
user	0m0.003s
sys	0m0.000s

My .xinitrc:

$ cat ~/.xinitrc 
numlockx &
exec startlxde

my lspci

$ lspci
00:00.0 Host bridge: Advanced Micro Devices, Inc. [AMD] Starship/Matisse Root Complex
00:00.2 IOMMU: Advanced Micro Devices, Inc. [AMD] Starship/Matisse IOMMU
00:01.0 Host bridge: Advanced Micro Devices, Inc. [AMD] Starship/Matisse PCIe Dummy Host Bridge
00:01.1 PCI bridge: Advanced Micro Devices, Inc. [AMD] Starship/Matisse GPP Bridge
00:01.2 PCI bridge: Advanced Micro Devices, Inc. [AMD] Starship/Matisse GPP Bridge
00:02.0 Host bridge: Advanced Micro Devices, Inc. [AMD] Starship/Matisse PCIe Dummy Host Bridge
00:03.0 Host bridge: Advanced Micro Devices, Inc. [AMD] Starship/Matisse PCIe Dummy Host Bridge
00:03.1 PCI bridge: Advanced Micro Devices, Inc. [AMD] Starship/Matisse GPP Bridge
00:04.0 Host bridge: Advanced Micro Devices, Inc. [AMD] Starship/Matisse PCIe Dummy Host Bridge
00:05.0 Host bridge: Advanced Micro Devices, Inc. [AMD] Starship/Matisse PCIe Dummy Host Bridge
00:07.0 Host bridge: Advanced Micro Devices, Inc. [AMD] Starship/Matisse PCIe Dummy Host Bridge
00:07.1 PCI bridge: Advanced Micro Devices, Inc. [AMD] Starship/Matisse Internal PCIe GPP Bridge 0 to bus[E:B]
00:08.0 Host bridge: Advanced Micro Devices, Inc. [AMD] Starship/Matisse PCIe Dummy Host Bridge
00:08.1 PCI bridge: Advanced Micro Devices, Inc. [AMD] Starship/Matisse Internal PCIe GPP Bridge 0 to bus[E:B]
00:14.0 SMBus: Advanced Micro Devices, Inc. [AMD] FCH SMBus Controller (rev 61)
00:14.3 ISA bridge: Advanced Micro Devices, Inc. [AMD] FCH LPC Bridge (rev 51)
00:18.0 Host bridge: Advanced Micro Devices, Inc. [AMD] Matisse/Vermeer Data Fabric: Device 18h; Function 0
00:18.1 Host bridge: Advanced Micro Devices, Inc. [AMD] Matisse/Vermeer Data Fabric: Device 18h; Function 1
00:18.2 Host bridge: Advanced Micro Devices, Inc. [AMD] Matisse/Vermeer Data Fabric: Device 18h; Function 2
00:18.3 Host bridge: Advanced Micro Devices, Inc. [AMD] Matisse/Vermeer Data Fabric: Device 18h; Function 3
00:18.4 Host bridge: Advanced Micro Devices, Inc. [AMD] Matisse/Vermeer Data Fabric: Device 18h; Function 4
00:18.5 Host bridge: Advanced Micro Devices, Inc. [AMD] Matisse/Vermeer Data Fabric: Device 18h; Function 5
00:18.6 Host bridge: Advanced Micro Devices, Inc. [AMD] Matisse/Vermeer Data Fabric: Device 18h; Function 6
00:18.7 Host bridge: Advanced Micro Devices, Inc. [AMD] Matisse/Vermeer Data Fabric: Device 18h; Function 7
01:00.0 Non-Volatile memory controller: Samsung Electronics Co Ltd NVMe SSD Controller PM9A1/PM9A3/980PRO
02:00.0 USB controller: Advanced Micro Devices, Inc. [AMD] 500 Series Chipset USB 3.1 XHCI Controller
02:00.1 SATA controller: Advanced Micro Devices, Inc. [AMD] 500 Series Chipset SATA Controller
02:00.2 PCI bridge: Advanced Micro Devices, Inc. [AMD] 500 Series Chipset Switch Upstream Port
03:00.0 PCI bridge: Advanced Micro Devices, Inc. [AMD] Device 43ea
03:04.0 PCI bridge: Advanced Micro Devices, Inc. [AMD] Device 43ea
03:06.0 PCI bridge: Advanced Micro Devices, Inc. [AMD] Device 43ea
03:07.0 PCI bridge: Advanced Micro Devices, Inc. [AMD] Device 43ea
03:08.0 PCI bridge: Advanced Micro Devices, Inc. [AMD] Device 43ea
03:09.0 PCI bridge: Advanced Micro Devices, Inc. [AMD] Device 43ea
08:00.0 Ethernet controller: Realtek Semiconductor Co., Ltd. RTL8125 2.5GbE Controller (rev 05)
09:00.0 Network controller: Intel Corporation Wireless-AC 9260 (rev 29)
0a:00.0 PCI bridge: Advanced Micro Devices, Inc. [AMD/ATI] Navi 10 XL Upstream Port of PCI Express Switch (rev c4)
0b:00.0 PCI bridge: Advanced Micro Devices, Inc. [AMD/ATI] Navi 10 XL Downstream Port of PCI Express Switch
0c:00.0 VGA compatible controller: Advanced Micro Devices, Inc. [AMD/ATI] Navi 10 [Radeon RX 5600 OEM/5600 XT / 5700/5700 XT] (rev c4)
0c:00.1 Audio device: Advanced Micro Devices, Inc. [AMD/ATI] Navi 10 HDMI Audio
0d:00.0 Non-Essential Instrumentation [1300]: Advanced Micro Devices, Inc. [AMD] Starship/Matisse PCIe Dummy Function
0e:00.0 Non-Essential Instrumentation [1300]: Advanced Micro Devices, Inc. [AMD] Starship/Matisse Reserved SPP
0e:00.1 Encryption controller: Advanced Micro Devices, Inc. [AMD] Starship/Matisse Cryptographic Coprocessor PSPCPP
0e:00.3 USB controller: Advanced Micro Devices, Inc. [AMD] Matisse USB 3.0 Host Controller
0e:00.4 Audio device: Advanced Micro Devices, Inc. [AMD] Starship/Matisse HD Audio Controller

My versions

$ uname -a
Linux cedric 6.4.8-arch1-1 #1 SMP PREEMPT_DYNAMIC Thu, 03 Aug 2023 16:02:01 +0000 x86_64 GNU/Linux

Last edited by cdwijs (2023-08-13 05:57:28)

cdwijs · 2023-08-13 05:57:05

Removing xdg-desktop-portal-gnome solves the problem:

[root@cedric cedric]# pacman -R xdg-desktop-portal-gnome
checking dependencies...

Packages (1) xdg-desktop-portal-gnome-44.2-1

Total Removed Size:  0.64 MiB

:: Do you want to remove these packages? [Y/n] 
:: Processing package changes...
(1/1) removing xdg-desktop-portal-gnome                                            [###############################################] 100%
:: Running post-transaction hooks...
(1/3) Arming ConditionNeedsUpdate...
(2/3) Compiling GSettings XML schema files...
(3/3) Updating the desktop file MIME type cache...

Thunderbird starts immediately, and the timeout messages are gone in /var/log/everything.log:

# tail -F /var/log/everything.log
Aug 13 07:55:30 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:55:30 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:55:30 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:55:30 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:55:30 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:55:30 cedric rtkit-daemon[1428]: Supervising 7 threads of 4 processes of 1 users.
Aug 13 07:55:30 cedric rtkit-daemon[1428]: Successfully made thread 4590 of process 4461 owned by '1000' RT at priority 10.
Aug 13 07:55:30 cedric rtkit-daemon[1428]: Supervising 8 threads of 5 processes of 1 users.

Arch Linux

#1 2023-08-13 05:53:45

[solved] Long delay before graphical programs start on Xorg / lxde

#2 2023-08-13 05:57:05

Re: [solved] Long delay before graphical programs start on Xorg / lxde

Board footer