search

neutrinolabs / xrdp

xrdp: an open source RDP server
http://www.xrdp.org/
Apache License 2.0
5.72k stars 1.73k forks source link

XRDP stopped working on Debian 11. Only turquoise screen #2801

Closed ky8585 closed 1 year ago

ky8585 commented 1 year ago

xrdp version

0.9.21.1-1~deb11u1

Detailed xrdp version, build options

user@debian:~$ sudo xrdp --version
[sudo] password for user:
xrdp 0.9.21.1
  A Remote Desktop Protocol Server.
  Copyright (C) 2004-2020 Jay Sorg, Neutrino Labs, and all contributors.
  See https://github.com/neutrinolabs/xrdp for more information.

  Configure options:
      --enable-ipv6
      --enable-jpeg
      --enable-fuse
      --enable-rfxcodec
      --enable-opus
      --enable-painter
      --enable-vsock
      --build=x86_64-linux-gnu
      --prefix=/usr
      --includedir=${prefix}/include
      --mandir=${prefix}/share/man
      --infodir=${prefix}/share/info
      --sysconfdir=/etc
      --localstatedir=/var
      --disable-silent-rules
      --libdir=${prefix}/lib/x86_64-linux-gnu
      --libexecdir=${prefix}/lib/x86_64-linux-gnu
      --disable-maintainer-mode
      --disable-dependency-tracking
      --with-socketdir=/run/xrdp/sockdir
      build_alias=x86_64-linux-gnu
      CFLAGS=-g -O2 -ffile-prefix-map=/build/reproducible-path/xrdp-0.9.21.1=. -fstack-protector-strong -Wformat -Werror=format-security
      LDFLAGS=-Wl,-z,relro -Wl,-z,now -Wl,--as-needed
      CPPFLAGS=-Wdate-time -D_FORTIFY_SOURCE=2
      PKG_CONFIG_PATH=/build/reproducible-path/xrdp-0.9.21.1/pkgconfig

  Compiled with OpenSSL 1.1.1n  15 Mar 2022

Operating system & version

Debian 11

Installation method

dnf / apt / zypper / pkg / etc

Which backend do you use?

xorgrdp

What desktop environment do you use?

GNOME

Environment xrdp running on

Physical machine. Intel.

What's your client?

Happens with different clients

Area(s) with issue?

Session manager (sesman)

Steps to reproduce

Hello,

I'm not a developer - just a newbie user of xrdp. I came across the problem under Debian 11. After some upgrade xrdp stopped working and I only observe turquoise blank screen after credentials. My config is as follows:

user@debian:~$ dpkg -l| grep xrdp
ii  xorgxrdp                              1:0.2.15-1                       amd64        Remote Desktop Protocol (RDP) modules for X.org
ii  xrdp                                  0.9.21.1-1~deb11u1               amd64        Remote Desktop Protocol (RDP) server

And the log file looks like this:

[20230923-23:13:15] [INFO ] starting xrdp-sesman with pid 628
[20230923-23:13:51] [INFO ] Socket 12: AF_INET6 connection received from ::1 port 36310
[20230923-23:13:51] [INFO ] ++ created session (access granted): username user, ip ::ffff:192.168.29.168:56306 - socket: 12
[20230923-23:13:51] [INFO ] starting Xorg session...
[20230923-23:13:51] [INFO ] Starting session: session_pid 828, display :10.0, width 1920, height 1200, bpp 24, client ip ::ffff:192.168.29.168:56306 - socket: 12, user name user
[20230923-23:13:51] [ERROR] sesman_data_in: scp_process_msg failed
[20230923-23:13:51] [INFO ] [session start] (display 10): calling auth_start_session from pid 828
[20230923-23:13:51] [ERROR] sesman_main_loop: trans_check_wait_objs failed, removing trans
[20230923-23:13:51] [INFO ] Starting X server on display 10: /usr/lib/xorg/Xorg :10 -auth .Xauthority -config xrdp/xorg.conf -noreset -nolisten tcp -logfile .xorgxrdp.%s.log
[20230923-23:13:52] [INFO ] Found X server running at /tmp/.X11-unix/X10
[20230923-23:13:52] [INFO ] Found X server running at /tmp/.X11-unix/X10
[20230923-23:13:52] [INFO ] Found X server running at /tmp/.X11-unix/X10
[20230923-23:13:52] [INFO ] Starting the xrdp channel server for display 10
[20230923-23:13:52] [INFO ] Session started successfully for user user on display 10
[20230923-23:13:52] [INFO ] Starting the default window manager on display 10: /etc/xrdp/startwm.sh
[20230923-23:13:52] [INFO ] Session in progress on display 10, waiting until the window manager (pid 829) exits to end the session

Or after fresh reboot

[20230924-09:43:54] [INFO ] Starting session: session_pid 901, display :10.0, width 1920, height 1200, bpp 24, client ip ::ffff:192.168.29.168:59652 - socket: 12, user name user
[20230924-09:43:54] [ERROR] sesman_data_in: scp_process_msg failed
[20230924-09:43:54] [INFO ] [session start] (display 10): calling auth_start_session from pid 901
[20230924-09:43:54] [ERROR] sesman_main_loop: trans_check_wait_objs failed, removing trans
[20230924-09:43:54] [INFO ] Starting X server on display 10: /usr/lib/xorg/Xorg :10 -auth .Xauthority -config xrdp/xorg.conf -noreset -nolisten tcp -logfile .xorgxrdp.%s.log
[20230924-09:43:54] [INFO ] Found X server running at /tmp/.X11-unix/X10
[20230924-09:43:54] [INFO ] Found X server running at /tmp/.X11-unix/X10
[20230924-09:43:54] [INFO ] Found X server running at /tmp/.X11-unix/X10
[20230924-09:43:54] [INFO ] Session started successfully for user user on display 10
[20230924-09:43:54] [INFO ] Starting the xrdp channel server for display 10
[20230924-09:43:54] [INFO ] Starting the default window manager on display 10: /etc/xrdp/startwm.sh
[20230924-09:43:54] [INFO ] Session in progress on display 10, waiting until the window manager (pid 902) exits to end the session

I need to restore functionality of xrdp ASAP. Please, help.

✔️ Expected Behavior

Start XRDP session

❌ Actual Behavior

Only blank turquoise screen and nothing happening.

Anything else?

Hello,

I'm not a developer - just a newbie user of xrdp. I came across the problem under Debian 11. After some upgrade xrdp stopped working and I only observe turquoise blank screen after credentials. My config is as follows:

user@debian:~$ dpkg -l| grep xrdp
ii  xorgxrdp                              1:0.2.15-1                       amd64        Remote Desktop Protocol (RDP) modules for X.org
ii  xrdp                                  0.9.21.1-1~deb11u1               amd64        Remote Desktop Protocol (RDP) server

And the log file looks like this:

[20230923-23:13:15] [INFO ] starting xrdp-sesman with pid 628
[20230923-23:13:51] [INFO ] Socket 12: AF_INET6 connection received from ::1 port 36310
[20230923-23:13:51] [INFO ] ++ created session (access granted): username user, ip ::ffff:192.168.29.168:56306 - socket: 12
[20230923-23:13:51] [INFO ] starting Xorg session...
[20230923-23:13:51] [INFO ] Starting session: session_pid 828, display :10.0, width 1920, height 1200, bpp 24, client ip ::ffff:192.168.29.168:56306 - socket: 12, user name user
[20230923-23:13:51] [ERROR] sesman_data_in: scp_process_msg failed
[20230923-23:13:51] [INFO ] [session start] (display 10): calling auth_start_session from pid 828
[20230923-23:13:51] [ERROR] sesman_main_loop: trans_check_wait_objs failed, removing trans
[20230923-23:13:51] [INFO ] Starting X server on display 10: /usr/lib/xorg/Xorg :10 -auth .Xauthority -config xrdp/xorg.conf -noreset -nolisten tcp -logfile .xorgxrdp.%s.log
[20230923-23:13:52] [INFO ] Found X server running at /tmp/.X11-unix/X10
[20230923-23:13:52] [INFO ] Found X server running at /tmp/.X11-unix/X10
[20230923-23:13:52] [INFO ] Found X server running at /tmp/.X11-unix/X10
[20230923-23:13:52] [INFO ] Starting the xrdp channel server for display 10
[20230923-23:13:52] [INFO ] Session started successfully for user user on display 10
[20230923-23:13:52] [INFO ] Starting the default window manager on display 10: /etc/xrdp/startwm.sh
[20230923-23:13:52] [INFO ] Session in progress on display 10, waiting until the window manager (pid 829) exits to end the session

Or after fresh reboot

[20230924-09:43:54] [INFO ] Starting session: session_pid 901, display :10.0, width 1920, height 1200, bpp 24, client ip ::ffff:192.168.29.168:59652 - socket: 12, user name user
[20230924-09:43:54] [ERROR] sesman_data_in: scp_process_msg failed
[20230924-09:43:54] [INFO ] [session start] (display 10): calling auth_start_session from pid 901
[20230924-09:43:54] [ERROR] sesman_main_loop: trans_check_wait_objs failed, removing trans
[20230924-09:43:54] [INFO ] Starting X server on display 10: /usr/lib/xorg/Xorg :10 -auth .Xauthority -config xrdp/xorg.conf -noreset -nolisten tcp -logfile .xorgxrdp.%s.log
[20230924-09:43:54] [INFO ] Found X server running at /tmp/.X11-unix/X10
[20230924-09:43:54] [INFO ] Found X server running at /tmp/.X11-unix/X10
[20230924-09:43:54] [INFO ] Found X server running at /tmp/.X11-unix/X10
[20230924-09:43:54] [INFO ] Session started successfully for user user on display 10
[20230924-09:43:54] [INFO ] Starting the xrdp channel server for display 10
[20230924-09:43:54] [INFO ] Starting the default window manager on display 10: /etc/xrdp/startwm.sh
[20230924-09:43:54] [INFO ] Session in progress on display 10, waiting until the window manager (pid 902) exits to end the session

I need to restore functionality of xrdp ASAP. Please, help.

matt335672 commented 1 year ago

@ky8585 - before you do anything else, try updating again. See #2796 and #2797. You need the version of xorgxrdp to be 1:0.2.12-1+deb11u1 as reported by dpkg -l xorgxrdp.

ky8585 commented 1 year ago

What if I have xorgxrdp 1:0.2.15-1? How to safely downgrade?

metalefty commented 1 year ago

In Debian 11 case, you will have xorgxrdp 1:0.9.19-1.

metalefty commented 1 year ago

Your environment is somewhat odd. There's no Debian version that has xorgxrdp 0.2.15 now. How did you install 0.2.15? It cannot be installed the usual way.

https://tracker.debian.org/pkg/xorgxrdp

Here's mine. only xorgxrdp 0.2.12 is available. It is very strange you have installed 0.2.15.

debian@moobyfr-debug:~$ cat /etc/os-release
PRETTY_NAME="Debian GNU/Linux 11 (bullseye)"
NAME="Debian GNU/Linux"
VERSION_ID="11"
VERSION="11 (bullseye)"
VERSION_CODENAME=bullseye
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
debian@moobyfr-debug:~$ apt search xorgxrdp
Sorting... Done
Full Text Search... Done
xorgxrdp/oldstable-security,now 1:0.2.12-1+deb11u1 amd64 [installed,automatic]
  Remote Desktop Protocol (RDP) modules for X.org

xrdp/oldstable-security,now 0.9.21.1-1~deb11u1 amd64 [installed]
  Remote Desktop Protocol (RDP) server
ky8585 commented 1 year ago

That's a good question. I do not know because other people have installed XRDP on this machine. How to straighten this? Uninstall XRDP and install again? I've read terrible stories that after that people could not install any version of XRDP.

ky8585 commented 1 year ago

Below are mine

ky8585 commented 1 year ago

cat /etc/os-release

ky8585 commented 1 year ago 
user@debian:~$ cat /etc/os-release
PRETTY_NAME="Debian GNU/Linux 11 (bullseye)"
NAME="Debian GNU/Linux"
VERSION_ID="11"
VERSION="11 (bullseye)"
VERSION_CODENAME=bullseye
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
ky8585 commented 1 year ago 
user@debian:~$ apt search xorgxrdp
Sorting... Done
Full Text Search... Done
xorgxrdp/now 1:0.2.15-1 amd64 [installed,local]
  Remote Desktop Protocol (RDP) modules for X.org

xrdp/oldstable-security,now 0.9.21.1-1~deb11u1 amd64 [installed]
  Remote Desktop Protocol (RDP) server
matt335672 commented 1 year ago

@ky8585

Suggest you :-

sudo apt purge xorgxrdp
sudo apt install xorgxrdp

then re-check the version with dpkg -l xorgxrdp

metalefty commented 1 year ago

Then, the "other people" you mentioned should have done somewhat unusual. Only the person who did it knows what is done.

At least, the issue is promptly resolved by the Debian team. The problem will be resolved just by performing apt upgrade again for the people who have the usual environment.

ky8585 commented 1 year ago

Followed your recommendation.

ky8585 commented 1 year ago

The behaviour changed. Now I see the white screen with screams like 'Oh no! Something has gone wrong. A problem has occurred and the system can't recover"

ky8585 commented 1 year ago 
[20230925-05:50:57] [INFO ] starting Xorg session...
[20230925-05:50:57] [INFO ] Starting session: session_pid 2598, display :10.0, width 1920, height 1200, bpp 24, client ip ::ffff:192.168.29.168:63635 - socket: 12, user name user
[20230925-05:50:57] [ERROR] sesman_data_in: scp_process_msg failed
[20230925-05:50:57] [INFO ] [session start] (display 10): calling auth_start_session from pid 2598
[20230925-05:50:57] [ERROR] sesman_main_loop: trans_check_wait_objs failed, removing trans
[20230925-05:50:57] [INFO ] Starting X server on display 10: /usr/lib/xorg/Xorg :10 -auth .Xauthority -config xrdp/xorg.conf -noreset -nolisten tcp -logfile .xorgxrdp.%s.log
[20230925-05:50:58] [INFO ] Found X server running at /tmp/.X11-unix/X10
[20230925-05:50:58] [INFO ] Found X server running at /tmp/.X11-unix/X10
[20230925-05:50:58] [INFO ] Found X server running at /tmp/.X11-unix/X10
[20230925-05:50:58] [INFO ] Starting the xrdp channel server for display 10
[20230925-05:50:58] [INFO ] Session started successfully for user user on display 10
[20230925-05:50:58] [INFO ] Starting the default window manager on display 10: /etc/xrdp/startwm.sh
[20230925-05:50:58] [INFO ] Session in progress on display 10, waiting until the window manager (pid 2599) exits to end the session
[20230925-05:52:35] [INFO ] Calling auth_stop_session and auth_end from pid 2598
[20230925-05:52:35] [INFO ] Terminating X server (pid 2600) on display 10
[20230925-05:52:35] [INFO ] Terminating the xrdp channel server (pid 2636) on display 10
[20230925-05:52:35] [INFO ] X server on display 10 (pid 2600) returned exit code 0 and signal number 0
[20230925-05:52:35] [INFO ] xrdp channel server for display 10 (pid 2636) exit code 0 and signal number 0
[20230925-05:52:35] [INFO ] cleanup_sockets:
[20230925-05:52:35] [INFO ] Process 2598 has exited
[20230925-05:52:35] [INFO ] ++ terminated session:  username user, display :10.0, session_pid 2598, ip ::ffff:192.168.29.168:63635 - socket: 12
metalefty commented 1 year ago

BTW, you should follow all of our recommendations and let us know the result Please do no skip anything.

You didn't do this, right?

then re-check the version with dpkg -l xorgxrdp

matt335672 commented 1 year ago

Can you post ~/.xorgxrdp.10.log?

ky8585 commented 1 year ago 
user@debian:~$  dpkg -l xorgxrdp
Desired=Unknown/Install/Remove/Purge/Hold
| Status=Not/Inst/Conf-files/Unpacked/halF-conf/Half-inst/trig-aWait/Trig-pend
|/ Err?=(none)/Reinst-required (Status,Err: uppercase=bad)
||/ Name           Version            Architecture Description
+++-==============-==================-============-===============================================
ii  xorgxrdp       1:0.2.12-1+deb11u1 amd64        Remote Desktop Protocol (RDP) modules for X.org
ky8585 commented 1 year ago 

user@debian:~$ sudo cat ~/.xorgxrdp.10.log
[    58.071]
X.Org X Server 1.20.11
X Protocol Version 11, Revision 0
[    58.071] Build Operating System: linux Debian
[    58.071] Current Operating System: Linux debian 5.10.0-25-amd64 #1 SMP Debian 5.10.191-1 (2023-08-16) x86_64
[    58.071] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-5.10.0-25-amd64 root=UUID=428e818e-4076-4c59-81a8-9a5a73b6f246 ro quiet
[    58.071] Build Date: 23 March 2023  10:25:56AM
[    58.071] xorg-server 2:1.20.11-1+deb11u6 (https://www.debian.org/support)
[    58.071] Current version of pixman: 0.40.0
[    58.071]    Before reporting problems, check http://wiki.x.org
        to make sure that you have the latest version.
[    58.071] Markers: (--) probed, (**) from config file, (==) default setting,
        (++) from command line, (!!) notice, (II) informational,
        (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
[    58.071] (++) Log file: ".xorgxrdp.10.log", Time: Mon Sep 25 05:55:20 2023
[    58.072] (++) Using config file: "/etc/X11/xrdp/xorg.conf"
[    58.072] (==) Using system config directory "/usr/share/X11/xorg.conf.d"
[    58.073] (==) ServerLayout "X11 Server"
[    58.073] (**) |-->Screen "Screen (xrdpdev)" (0)
[    58.073] (**) |   |-->Monitor "Monitor"
[    58.073] (**) |   |-->Device "Video Card (xrdpdev)"
[    58.073] (**) |-->Input Device "xrdpMouse"
[    58.073] (**) |-->Input Device "xrdpKeyboard"
[    58.073] (**) Option "DontVTSwitch" "on"
[    58.073] (**) Option "AutoAddDevices" "off"
[    58.073] (**) Not automatically adding devices
[    58.073] (==) Automatically enabling devices
[    58.073] (==) Automatically adding GPU devices
[    58.073] (==) Max clients allowed: 256, resource mask: 0x1fffff
[    58.074] (WW) The directory "/usr/share/fonts/X11/cyrillic" does not exist.
[    58.074]    Entry deleted from font path.
[    58.075] (==) FontPath set to:
        /usr/share/fonts/X11/misc,
        /usr/share/fonts/X11/100dpi/:unscaled,
        /usr/share/fonts/X11/75dpi/:unscaled,
        /usr/share/fonts/X11/Type1,
        /usr/share/fonts/X11/100dpi,
        /usr/share/fonts/X11/75dpi,
        built-ins
[    58.075] (==) ModulePath set to "/usr/lib/xorg/modules"
[    58.075] (II) Loader magic: 0x5616fa2d8e40
[    58.075] (II) Module ABI versions:
[    58.075]    X.Org ANSI C Emulation: 0.4
[    58.075]    X.Org Video Driver: 24.1
[    58.075]    X.Org XInput driver : 24.1
[    58.075]    X.Org Server Extension : 10.0
[    58.077] (II) systemd-logind: took control of session /org/freedesktop/login1/session/c1
[    58.079] (--) PCI:*(0@0:2:0) 8086:4628:8086:2112 rev 12, Mem @ 0x605c000000/16777216, 0x4000000000/268435456, I/O @ 0x00003000/64, BIOS @ 0x????????/131072
[    58.079] (II) "glx" will be loaded. This was enabled by default and also specified in the config file.
[    58.079] (II) LoadModule: "dbe"
[    58.079] (II) Module "dbe" already built-in
[    58.079] (II) LoadModule: "ddc"
[    58.079] (II) Module "ddc" already built-in
[    58.079] (II) LoadModule: "extmod"
[    58.079] (II) Module "extmod" already built-in
[    58.079] (II) LoadModule: "glx"
[    58.079] (II) Loading /usr/lib/xorg/modules/extensions/libglx.so
[    58.080] (II) Module glx: vendor="X.Org Foundation"
[    58.080]    compiled for 1.20.11, module version = 1.0.0
[    58.080]    ABI class: X.Org Server Extension, version 10.0
[    58.080] (II) LoadModule: "int10"
[    58.080] (II) Loading /usr/lib/xorg/modules/libint10.so
[    58.081] (II) Module int10: vendor="X.Org Foundation"
[    58.081]    compiled for 1.20.11, module version = 1.0.0
[    58.081]    ABI class: X.Org Video Driver, version 24.1
[    58.081] (II) LoadModule: "record"
[    58.081] (II) Module "record" already built-in
[    58.081] (II) LoadModule: "vbe"
[    58.081] (II) Loading /usr/lib/xorg/modules/libvbe.so
[    58.081] (II) Module vbe: vendor="X.Org Foundation"
[    58.081]    compiled for 1.20.11, module version = 1.1.0
[    58.081]    ABI class: X.Org Video Driver, version 24.1
[    58.081] (II) LoadModule: "glamoregl"
[    58.081] (II) Loading /usr/lib/xorg/modules/libglamoregl.so
[    58.083] (II) Module glamoregl: vendor="X.Org Foundation"
[    58.083]    compiled for 1.20.11, module version = 1.0.1
[    58.083]    ABI class: X.Org ANSI C Emulation, version 0.4
[    58.083] (II) LoadModule: "xorgxrdp"
[    58.083] (II) Loading /usr/lib/xorg/modules/libxorgxrdp.so
[    58.084] (II) Module XORGXRDP: vendor="X.Org Foundation"
[    58.084]    compiled for 1.20.11, module version = 0.2.12
[    58.084]    ABI class: X.Org Video Driver, version 24.1
[    58.084] xorgxrdpSetup:
[    58.084] (II) LoadModule: "fb"
[    58.084] (II) Loading /usr/lib/xorg/modules/libfb.so
[    58.084] (II) Module fb: vendor="X.Org Foundation"
[    58.084]    compiled for 1.20.11, module version = 1.0.0
[    58.084]    ABI class: X.Org ANSI C Emulation, version 0.4
[    58.084] (II) LoadModule: "xrdpdev"
[    58.084] (II) Loading /usr/lib/xorg/modules/drivers/xrdpdev_drv.so
[    58.085] (II) Module XRDPDEV: vendor="X.Org Foundation"
[    58.085]    compiled for 1.20.11, module version = 0.2.12
[    58.085]    ABI class: X.Org Video Driver, version 24.1
[    58.085] xrdpdevSetup:
[    58.085] (II) LoadModule: "xrdpmouse"
[    58.085] (II) Loading /usr/lib/xorg/modules/input/xrdpmouse_drv.so
[    58.085] (II) Module XRDPMOUSE: vendor="X.Org Foundation"
[    58.085]    compiled for 1.20.11, module version = 0.2.12
[    58.085]    Module class: X.Org XInput Driver
[    58.085]    ABI class: X.Org XInput driver, version 24.1
[    58.085] rdpmousePlug:
[    58.085] (II) LoadModule: "xrdpkeyb"
[    58.085] (II) Loading /usr/lib/xorg/modules/input/xrdpkeyb_drv.so
[    58.085] (II) Module XRDPKEYB: vendor="X.Org Foundation"
[    58.085]    compiled for 1.20.11, module version = 0.2.12
[    58.085]    Module class: X.Org XInput Driver
[    58.085]    ABI class: X.Org XInput driver, version 24.1
[    58.085] rdpkeybPlug:
[    58.085] rdpIdentify:
[    58.085] (II) XRDPDEV: driver for xrdp: XRDPDEV
[    58.085] rdpDriverFunc: op 10
[    58.085] (WW) Falling back to old probe method for XRDPDEV
[    58.085] rdpProbe:
[    58.085] (II) Loading sub module "fb"
[    58.085] (II) LoadModule: "fb"
[    58.085] (II) Loading /usr/lib/xorg/modules/libfb.so
[    58.085] (II) Module fb: vendor="X.Org Foundation"
[    58.085]    compiled for 1.20.11, module version = 1.0.0
[    58.085]    ABI class: X.Org ANSI C Emulation, version 0.4
[    58.085] rdpProbe: found DRMDevice xorg.conf value [/dev/dri/renderD128]
[    58.085] rdpProbe: found DRI3 xorg.conf value [1]
[    58.085] (II) XRDPDEV(0): using default device
[    58.085] (WW) VGA arbiter: cannot open kernel arbiter, no multi-card support
[    58.085] rdpPreInit:
[    58.085] rdpPreInit: /dev/dri/renderD128 open failed
[    58.085] (**) XRDPDEV(0): Depth 24, (--) framebuffer bpp 32
[    58.085] (==) XRDPDEV(0): RGB weight 888
[    58.085] (==) XRDPDEV(0): Using gamma correction (1.0, 1.0, 1.0)
[    58.085] (==) XRDPDEV(0): Default visual is TrueColor
[    58.085] (==) XRDPDEV(0): DPI set to (96, 96)
[    58.085] (II) XRDPDEV(0):   mode "640x480" ok
[    58.085] (II) XRDPDEV(0):   mode "800x600" ok
[    58.085] (II) XRDPDEV(0): Virtual size is 800x600 (pitch 800)
[    58.085] (**) XRDPDEV(0):  Default mode "800x600": 36.0 MHz (scaled from 0.0 MHz), 35.2 kHz, 56.2 Hz
[    58.085] (II) XRDPDEV(0): Modeline "800x600"x0.0   36.00  800 824 896 1024  600 601 603 625 +hsync +vsync (35.2 kHz d)
[    58.085] rdpScreenInit: virtualX 800 virtualY 600 rgbBits 8 depth 24
[    58.085] rdpScreenInit: pfbMemory bytes 1920000
[    58.085] rdpScreenInit: pfbMemory 0x7fc8d21a9010
[    58.085] rdpSimdInit: assigning yuv functions
[    58.086] rdpSimdInit: cpuid ax 1 cx 0 return ax 0x000906a4 bx 0x16400800 cx 0x7ffafbff dx 0xbfebfbff
[    58.086] rdpSimdInit: sse2 amd64 yuv functions assigned
[    58.086] (==) XRDPDEV(0): Backing store enabled
[    58.086] rdpClientConInit: disconnect idle session after [0] sec
[    58.086] rdpClientConInit: kill disconnected [0] timeout [0] sec
[    58.086] rdpXvInit: depth 24
[    58.086] rdpScreenInit: out
[    58.086] (II) Initializing extension Generic Event Extension
[    58.086] (II) Initializing extension SHAPE
[    58.086] (II) Initializing extension MIT-SHM
[    58.086] (II) Initializing extension XInputExtension
[    58.087] (II) Initializing extension XTEST
[    58.087] (II) Initializing extension BIG-REQUESTS
[    58.087] (II) Initializing extension SYNC
[    58.087] (II) Initializing extension XKEYBOARD
[    58.087] (II) Initializing extension XC-MISC
[    58.087] (II) Initializing extension SECURITY
[    58.087] (II) Initializing extension XFIXES
[    58.087] (II) Initializing extension RENDER
[    58.087] (II) Initializing extension RANDR
[    58.087] (II) Initializing extension COMPOSITE
[    58.087] (II) Initializing extension DAMAGE
[    58.087] (II) Initializing extension MIT-SCREEN-SAVER
[    58.087] (II) Initializing extension DOUBLE-BUFFER
[    58.088] (II) Initializing extension RECORD
[    58.088] (II) Initializing extension DPMS
[    58.088] (II) Initializing extension Present
[    58.088] (II) Initializing extension DRI3
[    58.088] (II) Initializing extension X-Resource
[    58.088] (II) Initializing extension XVideo
[    58.088] (II) Initializing extension XVideo-MotionCompensation
[    58.088] (II) Initializing extension SELinux
[    58.088] (II) SELinux: Disabled on system
[    58.088] (II) Initializing extension GLX
[    58.088] (II) AIGLX: Screen 0 is not DRI2 capable
[    58.152] (II) IGLX: Loaded and initialized swrast
[    58.152] (II) GLX: Initialized DRISWRAST GL provider for screen 0
[    58.152] (II) Initializing extension XFree86-VidModeExtension
[    58.152] (II) Initializing extension XFree86-DGA
[    58.152] (II) Initializing extension XFree86-DRI
[    58.152] (II) Initializing extension DRI2
[    58.152] rdpCreateScreenResources:
[    58.184] (II) Using input driver 'XRDPMOUSE' for 'xrdpMouse'
[    58.184] (**) Option "CorePointer"
[    58.184] (**) xrdpMouse: always reports core events
[    58.184] rdpmousePreInit: drv 0x5616fb72ab60 info 0x5616fb944d50, flags 0x0
[    58.184] (II) XINPUT: Adding extended input device "xrdpMouse" (type: Mouse, id 6)
[    58.184] rdpmouseControl: what 0
[    58.184] rdpmouseDeviceInit:
[    58.184] rdpmouseCtrl:
[    58.184] rdpRegisterInputCallback: type 1 proc 0x7fc8d2897380
[    58.184] (**) xrdpMouse: (accel) keeping acceleration scheme 1
[    58.184] (**) xrdpMouse: (accel) acceleration profile 0
[    58.184] (**) xrdpMouse: (accel) acceleration factor: 2.000
[    58.184] (**) xrdpMouse: (accel) acceleration threshold: 4
[    58.184] rdpmouseControl: what 1
[    58.184] rdpmouseDeviceOn:
[    58.184] (II) Using input driver 'XRDPKEYB' for 'xrdpKeyboard'
[    58.184] (**) Option "CoreKeyboard"
[    58.184] (**) xrdpKeyboard: always reports core events
[    58.184] rdpkeybPreInit: drv 0x5616fb729150 info 0x5616fbab54f0, flags 0x0
[    58.184] (II) XINPUT: Adding extended input device "xrdpKeyboard" (type: Keyboard, id 7)
[    58.184] rdpkeybControl: what 0
[    58.184] rdpkeybDeviceInit:
[    58.191] rdpkeybChangeKeyboardControl:
[    58.191] rdpkeybChangeKeyboardControl: autoRepeat on
[    58.191] rdpRegisterInputCallback: type 0 proc 0x7fc8d2892a00
[    58.191] rdpkeybControl: what 1
[    58.191] rdpkeybDeviceOn:
[    58.194] (II) config/udev: Adding input device Power Button (/dev/input/event3)
[    58.194] (II) AutoAddDevices is off - not adding device.
[    58.194] (II) config/udev: Adding input device Power Button (/dev/input/event2)
[    58.194] (II) AutoAddDevices is off - not adding device.
[    58.194] (II) config/udev: Adding input device Sleep Button (/dev/input/event1)
[    58.194] (II) AutoAddDevices is off - not adding device.
[    58.195] (II) config/udev: Adding input device HID 04d9:1203 (/dev/input/event4)
[    58.195] (II) AutoAddDevices is off - not adding device.
[    58.195] (II) config/udev: Adding input device HID 04d9:1203 System Control (/dev/input/event5)
[    58.195] (II) AutoAddDevices is off - not adding device.
[    58.195] (II) config/udev: Adding input device HID 04d9:1203 Consumer Control (/dev/input/event6)
[    58.195] (II) AutoAddDevices is off - not adding device.
[    58.195] (II) config/udev: Adding input device Logitech USB Optical Mouse (/dev/input/event7)
[    58.195] (II) AutoAddDevices is off - not adding device.
[    58.196] (II) config/udev: Adding input device Logitech USB Optical Mouse (/dev/input/mouse0)
[    58.196] (II) AutoAddDevices is off - not adding device.
[    58.196] (II) config/udev: Adding input device AT Translated Set 2 keyboard (/dev/input/event0)
[    58.196] (II) AutoAddDevices is off - not adding device.
[    58.196] (II) config/udev: Adding input device PC Speaker (/dev/input/event8)
[    58.196] (II) AutoAddDevices is off - not adding device.
[    58.197] rdpDeferredRandR:
[    58.197] rdpResizeSession: width 1024 height 768
[    58.197]   calling RRScreenSizeSet
[    58.197] rdpRRScreenSetSize: width 1024 height 768 mmWidth 271 mmHeight 203
[    58.197] rdpRRGetInfo:
[    58.197]   screen resized to 1024x768
[    58.198]   RRScreenSizeSet ok 1
[    58.198] rdpResizeSession: width 1920 height 1200
[    58.198]   calling RRScreenSizeSet
[    58.198] rdpRRScreenSetSize: width 1920 height 1200 mmWidth 508 mmHeight 318
[    58.198] rdpRRGetInfo:
[    58.198]   screen resized to 1920x1200
[    58.200]   RRScreenSizeSet ok 1
[    58.200] rdpClientConGotConnection:
[    58.200] rdpClientConGotConnection: g_sck_accept ok new_sck 9
[    58.200] rdpClientConGetConnection: idle_disconnect_timeout set to non-positive value, idle timer turned off
[    58.200] rdpAddClientConToDev: adding first clientCon 0x5616fbb075f0
[    58.200] rdpClientConProcessMsgVersion: version 0 0 0 1
[    58.200] rdpClientConProcessScreenSizeMsg: set width 1920 height 1200 bpp 32
[    58.200] rdpClientConProcessScreenSizeMsg: shmemid 0 shmemptr 0x7fc87d668000
[    58.200] rdpClientConProcessMsgClientInput: invalidate x 0 y 0 cx 1920 cy 1200
[    58.200] KbdSync: toggling num lock
[    58.200] rdpkeybChangeKeyboardControl:
[    58.200] rdpkeybChangeKeyboardControl: autoRepeat on
[    58.292] rdpInDeferredRepeatCallback:
[    58.292] rdpkeybChangeKeyboardControl:
[    58.292] rdpkeybChangeKeyboardControl: autoRepeat off
[    58.300] rdpInDeferredRepeatCallback:
[    58.300] rdpkeybChangeKeyboardControl:
[    58.300] rdpkeybChangeKeyboardControl: autoRepeat off
[    58.366] rdpClientConProcessMsgClientInfo:
[    58.366]   got client info bytes 7072
[    58.366]   jpeg support 0
[    58.366]   offscreen support 1
[    58.366]   offscreen size 10485760
[    58.366]   offscreen entries 100
[    58.366]   client can not do offscreen to offscreen blits
[    58.366]   client can do new(color) cursor
[    58.366]   client can not do multimon
[    58.366] rdpRRSetRdpOutputs: numCrtcs 0 numOutputs 0 monitorCount 0
[    58.366] rdpRRSetRdpOutputs: add output 0 left 0 top 0 width 1920 height 1200
[    58.366] rdpLoadLayout: keylayout 0x00000409 variant  display 10
[    58.367] rdpkeybChangeKeyboardControl:
[    58.367] rdpkeybChangeKeyboardControl: autoRepeat on
[    58.368] rdpkeybChangeKeyboardControl:
[    58.368] rdpkeybChangeKeyboardControl: autoRepeat on
[    58.467] rdpInDeferredRepeatCallback:
[    58.467] rdpkeybChangeKeyboardControl:
[    58.467] rdpkeybChangeKeyboardControl: autoRepeat off
[    58.469] rdpInDeferredRepeatCallback:
[    58.469] rdpkeybChangeKeyboardControl:
[    58.469] rdpkeybChangeKeyboardControl: autoRepeat off
[    58.754] rdpRRGetInfo:
[    58.818] rdpRRScreenSetSize: width 1920 height 1200 mmWidth 508 mmHeight 318
[    58.818] rdpRRScreenSetSize: not allowing resize
[    58.850] rdpRRGetInfo:
[    58.925] rdpRRScreenSetSize: width 1920 height 1200 mmWidth 508 mmHeight 318
[    58.925] rdpRRScreenSetSize: not allowing resize
[    58.956] rdpRRGetInfo:
[    59.020] rdpRRScreenSetSize: width 1920 height 1200 mmWidth 508 mmHeight 318
[    59.020] rdpRRScreenSetSize: not allowing resize
[    59.060] rdpkeybChangeKeyboardControl:
[    59.060] rdpkeybChangeKeyboardControl: autoRepeat off
[    59.060] rdpkeybChangeKeyboardControl:
[    59.060] rdpkeybChangeKeyboardControl: autoRepeat off
[    61.755] rdpmouseControl: what 2
[    61.755] rdpmouseDeviceOff:
[    61.755] rdpkeybControl: what 2
[    61.755] rdpkeybDeviceOff:
[    61.756] rdpkeybControl: what 3
[    61.756] rdpkeybUnInit: drv 0x5616fb729150 info 0x5616fbab54f0, flags 0x0
[    61.756] rdpUnregisterInputCallback: proc 0x7fc8d2892a00
[    61.756] rdpmouseControl: what 3
[    61.756] rdpmouseUnInit: drv 0x5616fb72ab60 info 0x5616fb944d50, flags 0x0
[    61.756] rdpUnregisterInputCallback: proc 0x7fc8d2897380
[    61.758] rdpCloseScreen:
[    61.758] xorgxrdpDownDown:
[    61.758] xorgxrdpDownDown: 1
[    61.758] rdpClientConDeinit:
[    61.758] rdpClientConDeinit: disconnecting clientCon
[    61.758] rdpClientConDisconnect:
[    61.758] rdpRemoveClientConFromDev: removing clientCon 0x5616fbb075f0
[    61.758] rdpClientConDeinit: deleting file /run/xrdp/sockdir/xrdp_display_10
[    61.758] rdpClientConDeinit: deleting file /run/xrdp/sockdir/xrdp_disconnect_display_10
[    61.759] (II) Server terminated successfully (0). Closing log file.
matt335672 commented 1 year ago

Looks like neutrinolabs/xorgxrdp#156

To confirm, what do you get for sudo journalctl -S today | grep -B4 BadMatch?

ky8585 commented 1 year ago 
user@debian:~$ sudo journalctl -S today | grep -B4 BadMatch
[sudo] password for user:
Sep 25 05:48:34 debian systemd[757]: Failed to start Application launched by gnome-session-binary.
Sep 25 05:48:34 debian systemd[757]: Started Application launched by gnome-session-binary.
Sep 25 05:48:34 debian systemd[757]: app-gnome-pulseaudio-1328.scope: Succeeded.
Sep 25 05:48:34 debian gnome-shell[1329]: Xlib:  extension "DPMS" missing on display ":10.0".
Sep 25 05:48:34 debian gnome-shell[1329]: X Error of failed request:  BadMatch (invalid parameter attributes)
--
Sep 25 05:48:34 debian systemd[757]: org.gnome.Shell@x11.service: Scheduled restart job, restart counter is at 1.
Sep 25 05:48:34 debian systemd[757]: Stopped GNOME Shell on X11.
Sep 25 05:48:34 debian systemd[757]: Starting GNOME Shell on X11...
Sep 25 05:48:34 debian gnome-shell[1372]: Xlib:  extension "DPMS" missing on display ":10.0".
Sep 25 05:48:34 debian gnome-shell[1372]: X Error of failed request:  BadMatch (invalid parameter attributes)
--
Sep 25 05:48:34 debian systemd[757]: org.gnome.Shell@x11.service: Scheduled restart job, restart counter is at 2.
Sep 25 05:48:34 debian systemd[757]: Stopped GNOME Shell on X11.
Sep 25 05:48:34 debian systemd[757]: Starting GNOME Shell on X11...
Sep 25 05:48:34 debian gnome-shell[1407]: Xlib:  extension "DPMS" missing on display ":10.0".
Sep 25 05:48:34 debian gnome-shell[1407]: X Error of failed request:  BadMatch (invalid parameter attributes)
--
Sep 25 05:48:54 debian systemd[757]: Started Application launched by gnome-session-binary.
Sep 25 05:48:54 debian systemd[757]: app-gnome-at\x2dspi\x2ddbus\x2dbus-2159.scope: Succeeded.
Sep 25 05:48:54 debian systemd[757]: app-gnome-pulseaudio-2162.scope: Succeeded.
Sep 25 05:48:54 debian gnome-shell[2163]: Xlib:  extension "DPMS" missing on display ":10.0".
Sep 25 05:48:54 debian gnome-shell[2163]: X Error of failed request:  BadMatch (invalid parameter attributes)
--
Sep 25 05:48:54 debian systemd[757]: org.gnome.Shell@x11.service: Scheduled restart job, restart counter is at 1.
Sep 25 05:48:54 debian systemd[757]: Stopped GNOME Shell on X11.
Sep 25 05:48:54 debian systemd[757]: Starting GNOME Shell on X11...
Sep 25 05:48:54 debian gnome-shell[2205]: Xlib:  extension "DPMS" missing on display ":10.0".
Sep 25 05:48:54 debian gnome-shell[2205]: X Error of failed request:  BadMatch (invalid parameter attributes)
--
Sep 25 05:48:54 debian systemd[757]: org.gnome.Shell@x11.service: Scheduled restart job, restart counter is at 2.
Sep 25 05:48:54 debian systemd[757]: Stopped GNOME Shell on X11.
Sep 25 05:48:54 debian systemd[757]: Starting GNOME Shell on X11...
Sep 25 05:48:54 debian gnome-shell[2240]: Xlib:  extension "DPMS" missing on display ":10.0".
Sep 25 05:48:54 debian gnome-shell[2240]: X Error of failed request:  BadMatch (invalid parameter attributes)
--
Sep 25 05:50:58 debian systemd[757]: Failed to start Application launched by gnome-session-binary.
Sep 25 05:50:58 debian systemd[757]: Started Application launched by gnome-session-binary.
Sep 25 05:50:58 debian systemd[757]: app-gnome-pulseaudio-3004.scope: Succeeded.
Sep 25 05:50:58 debian gnome-shell[3006]: Xlib:  extension "DPMS" missing on display ":10.0".
Sep 25 05:50:58 debian gnome-shell[3006]: X Error of failed request:  BadMatch (invalid parameter attributes)
--
Sep 25 05:50:58 debian systemd[757]: org.gnome.Shell@x11.service: Scheduled restart job, restart counter is at 1.
Sep 25 05:50:58 debian systemd[757]: Stopped GNOME Shell on X11.
Sep 25 05:50:58 debian systemd[757]: Starting GNOME Shell on X11...
Sep 25 05:50:58 debian gnome-shell[3048]: Xlib:  extension "DPMS" missing on display ":10.0".
Sep 25 05:50:58 debian gnome-shell[3048]: X Error of failed request:  BadMatch (invalid parameter attributes)
--
Sep 25 05:50:58 debian systemd[757]: org.gnome.Shell@x11.service: Scheduled restart job, restart counter is at 2.
Sep 25 05:50:58 debian systemd[757]: Stopped GNOME Shell on X11.
Sep 25 05:50:58 debian systemd[757]: Starting GNOME Shell on X11...
Sep 25 05:50:58 debian gnome-shell[3084]: Xlib:  extension "DPMS" missing on display ":10.0".
Sep 25 05:50:58 debian gnome-shell[3084]: X Error of failed request:  BadMatch (invalid parameter attributes)
--
Sep 25 05:55:20 debian systemd[749]: Started Application launched by gnome-session-binary.
Sep 25 05:55:20 debian systemd[749]: app-gnome-pulseaudio-1307.scope: Succeeded.
Sep 25 05:55:20 debian systemd[749]: app-gnome-at\x2dspi\x2ddbus\x2dbus-1304.scope: Succeeded.
Sep 25 05:55:20 debian gnome-shell[1308]: Xlib:  extension "DPMS" missing on display ":10.0".
Sep 25 05:55:20 debian gnome-shell[1308]: X Error of failed request:  BadMatch (invalid parameter attributes)
--
Sep 25 05:55:20 debian systemd[749]: org.gnome.Shell@x11.service: Scheduled restart job, restart counter is at 1.
Sep 25 05:55:20 debian systemd[749]: Stopped GNOME Shell on X11.
Sep 25 05:55:20 debian systemd[749]: Starting GNOME Shell on X11...
Sep 25 05:55:20 debian gnome-shell[1350]: Xlib:  extension "DPMS" missing on display ":10.0".
Sep 25 05:55:20 debian gnome-shell[1350]: X Error of failed request:  BadMatch (invalid parameter attributes)
--
Sep 25 05:55:20 debian systemd[749]: org.gnome.Shell@x11.service: Scheduled restart job, restart counter is at 2.
Sep 25 05:55:20 debian systemd[749]: Stopped GNOME Shell on X11.
Sep 25 05:55:20 debian systemd[749]: Starting GNOME Shell on X11...
Sep 25 05:55:21 debian gnome-shell[1385]: Xlib:  extension "DPMS" missing on display ":10.0".
Sep 25 05:55:21 debian gnome-shell[1385]: X Error of failed request:  BadMatch (invalid parameter attributes)
user@debian:~$
matt335672 commented 1 year ago

That's not quite what I wanted - my fault.

Try this:-

sudo journalctl -S 05:55:10 -U 05:55:30
ky8585 commented 1 year ago 
ser@debian:~$ sudo journalctl -S 05:55:10 -U 05:55:30
[sudo] password for user:
-- Journal begins at Thu 2023-09-14 15:40:31 PDT, ends at Mon 2023-09-25 06:41:26 PDT. --
Sep 25 05:55:10 debian tracker-store[883]: OK
Sep 25 05:55:10 debian systemd[749]: tracker-store.service: Succeeded.
Sep 25 05:55:19 debian xrdp[897]: [DEBUG] Login state change request WMLS_USER_PROMPT -> WMLS_START_CONNECT
Sep 25 05:55:19 debian xrdp[897]: [DEBUG] xrdp_wm_login_mode_changed: login_mode is 2
Sep 25 05:55:19 debian xrdp[897]: [DEBUG] Login state change request WMLS_START_CONNECT -> WMLS_CONNECT_IN_PROGRESS
Sep 25 05:55:19 debian xrdp[897]: [DEBUG] xrdp_wm_log_msg: connecting to sesman on 127.0.0.1:3350
Sep 25 05:55:19 debian xrdp[897]: [INFO ] connecting to sesman on 127.0.0.1:3350
Sep 25 05:55:19 debian xrdp-sesman[655]: [INFO ] Socket 12: AF_INET6 connection received from ::1 port 42358
Sep 25 05:55:20 debian xrdp[897]: [INFO ] xrdp_wm_log_msg: sesman connect ok
Sep 25 05:55:20 debian xrdp[897]: [INFO ] sesman connect ok
Sep 25 05:55:20 debian xrdp[897]: [DEBUG] xrdp_wm_log_msg: sending login info to session manager. Please wait...
Sep 25 05:55:20 debian xrdp[897]: [INFO ] sending login info to session manager. Please wait...
Sep 25 05:55:20 debian xrdp[897]: [DEBUG] xrdp_wm_login_mode_changed: login_mode is 3
Sep 25 05:55:20 debian xrdp-sesman[655]: [INFO ] ++ created session (access granted): username user, ip ::ffff:192.168.>
Sep 25 05:55:20 debian xrdp-sesman[655]: [INFO ] starting Xorg session...
Sep 25 05:55:20 debian xrdp-sesman[655]: [INFO ] Starting session: session_pid 902, display :10.0, width 1920, height 1>
Sep 25 05:55:20 debian xrdp-sesman[902]: [INFO ] [session start] (display 10): calling auth_start_session from pid 902
Sep 25 05:55:20 debian xrdp-sesman[655]: [ERROR] sesman_data_in: scp_process_msg failed
Sep 25 05:55:20 debian xrdp[897]: [INFO ] xrdp_wm_log_msg: login successful for user user on display 10
Sep 25 05:55:20 debian xrdp-sesman[902]: pam_unix(xrdp-sesman:session): session opened for user user(uid=1000) by (uid=>
Sep 25 05:55:20 debian xrdp[897]: [INFO ] login successful for user user on display 10
Sep 25 05:55:20 debian xrdp-sesman[655]: [ERROR] sesman_main_loop: trans_check_wait_objs failed, removing trans
Sep 25 05:55:20 debian xrdp[897]: [INFO ] loaded module 'libxup.so' ok, interface size 10296, version 4
Sep 25 05:55:20 debian xrdp[897]: [DEBUG] xrdp_wm_log_msg: started connecting
Sep 25 05:55:20 debian xrdp[897]: [INFO ] started connecting
Sep 25 05:55:20 debian systemd-logind[615]: New session c1 of user user.
Sep 25 05:55:20 debian systemd[1]: Started Session c1 of user user.
Sep 25 05:55:20 debian xrdp[897]: [INFO ] lib_mod_connect: connecting via UNIX socket
lines 1-29
ky8585 commented 1 year ago

Sorry. That's not all

ky8585 commented 1 year ago 
user@debian:~$ sudo journalctl -S 05:55:10 -U 05:55:30
[sudo] password for user:
-- Journal begins at Thu 2023-09-14 15:40:31 PDT, ends at Mon 2023-09-25 06:41:26 PDT. --
Sep 25 05:55:10 debian tracker-store[883]: OK
Sep 25 05:55:10 debian systemd[749]: tracker-store.service: Succeeded.
Sep 25 05:55:19 debian xrdp[897]: [DEBUG] Login state change request WMLS_USER_PROMPT -> WMLS_START_CONNECT
Sep 25 05:55:19 debian xrdp[897]: [DEBUG] xrdp_wm_login_mode_changed: login_mode is 2
Sep 25 05:55:19 debian xrdp[897]: [DEBUG] Login state change request WMLS_START_CONNECT -> WMLS_CONNECT_IN_PROGRESS
Sep 25 05:55:19 debian xrdp[897]: [DEBUG] xrdp_wm_log_msg: connecting to sesman on 127.0.0.1:3350
Sep 25 05:55:19 debian xrdp[897]: [INFO ] connecting to sesman on 127.0.0.1:3350
Sep 25 05:55:19 debian xrdp-sesman[655]: [INFO ] Socket 12: AF_INET6 connection received from ::1 port 42358
Sep 25 05:55:20 debian xrdp[897]: [INFO ] xrdp_wm_log_msg: sesman connect ok
Sep 25 05:55:20 debian xrdp[897]: [INFO ] sesman connect ok
Sep 25 05:55:20 debian xrdp[897]: [DEBUG] xrdp_wm_log_msg: sending login info to session manager. Please wait...
Sep 25 05:55:20 debian xrdp[897]: [INFO ] sending login info to session manager. Please wait...
Sep 25 05:55:20 debian xrdp[897]: [DEBUG] xrdp_wm_login_mode_changed: login_mode is 3
Sep 25 05:55:20 debian xrdp-sesman[655]: [INFO ] ++ created session (access granted): username user, ip ::ffff:192.168.>
Sep 25 05:55:20 debian xrdp-sesman[655]: [INFO ] starting Xorg session...
Sep 25 05:55:20 debian xrdp-sesman[655]: [INFO ] Starting session: session_pid 902, display :10.0, width 1920, height 1>
Sep 25 05:55:20 debian xrdp-sesman[902]: [INFO ] [session start] (display 10): calling auth_start_session from pid 902
Sep 25 05:55:20 debian xrdp-sesman[655]: [ERROR] sesman_data_in: scp_process_msg failed
Sep 25 05:55:20 debian xrdp[897]: [INFO ] xrdp_wm_log_msg: login successful for user user on display 10
Sep 25 05:55:20 debian xrdp-sesman[902]: pam_unix(xrdp-sesman:session): session opened for user user(uid=1000) by (uid=>
Sep 25 05:55:20 debian xrdp[897]: [INFO ] login successful for user user on display 10
Sep 25 05:55:20 debian xrdp-sesman[655]: [ERROR] sesman_main_loop: trans_check_wait_objs failed, removing trans
Sep 25 05:55:20 debian xrdp[897]: [INFO ] loaded module 'libxup.so' ok, interface size 10296, version 4
Sep 25 05:55:20 debian xrdp[897]: [DEBUG] xrdp_wm_log_msg: started connecting
Sep 25 05:55:20 debian xrdp[897]: [INFO ] started connecting
Sep 25 05:55:20 debian systemd-logind[615]: New session c1 of user user.
Sep 25 05:55:20 debian systemd[1]: Started Session c1 of user user.
Sep 25 05:55:20 debian xrdp[897]: [INFO ] lib_mod_connect: connecting via UNIX socket
Sep 25 05:55:20 debian xrdp-sesman[904]: [INFO ] Starting X server on display 10: /usr/lib/xorg/Xorg :10 -auth .Xauthor>
Sep 25 05:55:20 debian dbus-daemon[781]: [session uid=1000 pid=781] Activating via systemd: service name='org.freedeskt>
Sep 25 05:55:20 debian systemd[749]: Starting Tracker metadata database store and lookup manager...
Sep 25 05:55:20 debian dbus-daemon[781]: [session uid=1000 pid=781] Successfully activated service 'org.freedesktop.Tra>
Sep 25 05:55:20 debian systemd[749]: Started Tracker metadata database store and lookup manager.
Sep 25 05:55:20 debian xrdp[897]: [INFO ] lib_mod_log_peer: xrdp_pid=897 connected to X11rdp_pid=904 X11rdp_uid=1000 X1>
Sep 25 05:55:20 debian xrdp[897]: [DEBUG] xrdp_wm_log_msg: connected ok
Sep 25 05:55:20 debian xrdp[897]: [INFO ] connected ok
Sep 25 05:55:20 debian xrdp-sesman[903]: [INFO ] Found X server running at /tmp/.X11-unix/X10
Sep 25 05:55:20 debian xrdp-sesman[902]: [INFO ] Found X server running at /tmp/.X11-unix/X10
Sep 25 05:55:20 debian xrdp-sesman[903]: [INFO ] Found X server running at /tmp/.X11-unix/X10
Sep 25 05:55:20 debian xrdp-sesman[902]: [INFO ] Session started successfully for user user on display 10
Sep 25 05:55:20 debian xrdp-sesman[946]: [INFO ] Starting the xrdp channel server for display 10
Sep 25 05:55:20 debian xrdp-sesman[903]: [INFO ] Starting the default window manager on display 10: /etc/xrdp/startwm.sh
Sep 25 05:55:20 debian xrdp-sesman[902]: [INFO ] Session in progress on display 10, waiting until the window manager (p>
Sep 25 05:55:20 debian xrdp[897]: [DEBUG] libxrdp_query_channel - Channel 0 name rdpdr
Sep 25 05:55:20 debian xrdp-chansrv[946]: [INFO ] Socket 12: AF_UNIX connection received
Sep 25 05:55:20 debian xrdp[897]: [DEBUG] libxrdp_query_channel - Channel 1 name rdpsnd
Sep 25 05:55:20 debian xrdp[897]: [DEBUG] libxrdp_query_channel - Channel 2 name cliprdr
Sep 25 05:55:20 debian xrdp[897]: [DEBUG] libxrdp_query_channel - Channel 3 name drdynvc
Sep 25 05:55:20 debian xrdp[897]: [DEBUG] xrdp_mm_chansrv_connect: chansrv connect successful
Sep 25 05:55:20 debian xrdp[897]: [DEBUG] status from xrdp_mm_connect() : 0
Sep 25 05:55:20 debian xrdp[897]: [DEBUG] Login state change request WMLS_CONNECT_IN_PROGRESS -> WMLS_CLEANUP
Sep 25 05:55:20 debian xrdp[897]: [DEBUG] Closed socket 18 (AF_INET6 ::1 port 42358)
Sep 25 05:55:20 debian xrdp[897]: [DEBUG] xrdp_wm_login_mode_changed: login_mode is 4
Sep 25 05:55:20 debian xrdp[897]: [DEBUG] Login state change request WMLS_CLEANUP -> WMLS_INACTIVE
Sep 25 05:55:20 debian xrdp[897]: [DEBUG] xrdp_wm_login_mode_changed: login_mode is 5
Sep 25 05:55:20 debian dbus-daemon[781]: [session uid=1000 pid=781] Activating service name='org.freedesktop.portal.IBu>
Sep 25 05:55:20 debian dbus-daemon[781]: [session uid=1000 pid=781] Successfully activated service 'org.freedesktop.por>
Sep 25 05:55:20 debian xrdp-chansrv[946]: [INFO ] sound_process_training: round trip time 101
Sep 25 05:55:20 debian xrdp-chansrv[946]: [INFO ] Detected remote printer 'PRN7' (not supported)
Sep 25 05:55:20 debian xrdp-chansrv[946]: [INFO ] Detected remote printer 'PRN15' (not supported)
Sep 25 05:55:20 debian xrdp-chansrv[946]: [INFO ] Detected remote printer 'PRN14' (not supported)
Sep 25 05:55:20 debian xrdp-chansrv[946]: [INFO ] Detected remote printer 'PRN13' (not supported)
Sep 25 05:55:20 debian xrdp-chansrv[946]: [INFO ] Detected remote printer 'PRN12' (not supported)
Sep 25 05:55:20 debian xrdp-chansrv[946]: [INFO ] Detected remote printer 'PRN11' (not supported)
Sep 25 05:55:20 debian xrdp-chansrv[946]: [INFO ] Detected remote printer 'PRN10' (not supported)
Sep 25 05:55:20 debian xrdp-chansrv[946]: [INFO ] Detected remote printer 'PRN9' (not supported)
Sep 25 05:55:20 debian xrdp-chansrv[946]: [INFO ] Detected remote printer 'PRN8' (not supported)
Sep 25 05:55:20 debian xrdp-chansrv[946]: [INFO ] Detected remote printer 'PRN6' (not supported)
Sep 25 05:55:20 debian xrdp-chansrv[946]: [INFO ] Detected remote printer 'PRN5' (not supported)
Sep 25 05:55:20 debian xrdp-chansrv[946]: [INFO ] Detected remote printer 'PRN4' (not supported)
Sep 25 05:55:20 debian xrdp-chansrv[946]: [INFO ] Detected remote printer 'PRN3' (not supported)
Sep 25 05:55:20 debian xrdp-chansrv[946]: [INFO ] Detected remote printer 'PRN2' (not supported)
Sep 25 05:55:20 debian xrdp-chansrv[946]: [INFO ] Detected remote printer 'PRN1' (not supported)
Sep 25 05:55:20 debian xrdp-chansrv[946]: [INFO ] Detected remote smartcard 'SCARD'
Sep 25 05:55:20 debian dbus-daemon[781]: [session uid=1000 pid=781] Activating via systemd: service name='org.a11y.Bus'>
Sep 25 05:55:20 debian systemd[749]: Starting Accessibility services bus...
Sep 25 05:55:20 debian dbus-daemon[781]: [session uid=1000 pid=781] Successfully activated service 'org.a11y.Bus'
Sep 25 05:55:20 debian systemd[749]: Started Accessibility services bus.
Sep 25 05:55:20 debian at-spi-bus-launcher[1115]: dbus-daemon[1115]: Activating service name='org.a11y.atspi.Registry' >
Sep 25 05:55:20 debian at-spi-bus-launcher[1115]: dbus-daemon[1115]: Successfully activated service 'org.a11y.atspi.Reg>
Sep 25 05:55:20 debian at-spi-bus-launcher[1166]: SpiRegistry daemon is running with well-known name - org.a11y.atspi.R>
Sep 25 05:55:20 debian dbus-daemon[781]: [session uid=1000 pid=781] Activating via systemd: service name='org.freedeskt>
Sep 25 05:55:20 debian systemd[749]: Starting Portal service...
Sep 25 05:55:20 debian dbus-daemon[781]: [session uid=1000 pid=781] Activating via systemd: service name='org.freedeskt>
Sep 25 05:55:20 debian systemd[749]: Starting flatpak document portal service...
Sep 25 05:55:20 debian dbus-daemon[781]: [session uid=1000 pid=781] Activating via systemd: service name='org.freedeskt>
Sep 25 05:55:20 debian systemd[749]: Starting sandboxed app permission store...
Sep 25 05:55:20 debian dbus-daemon[781]: [session uid=1000 pid=781] Successfully activated service 'org.freedesktop.imp>
Sep 25 05:55:20 debian systemd[749]: Started sandboxed app permission store.
Sep 25 05:55:20 debian dbus-daemon[781]: [session uid=1000 pid=781] Successfully activated service 'org.freedesktop.por>
Sep 25 05:55:20 debian systemd[749]: Started flatpak document portal service.
Sep 25 05:55:20 debian dbus-daemon[781]: [session uid=1000 pid=781] Activating via systemd: service name='org.freedeskt>
Sep 25 05:55:20 debian systemd[749]: Starting Portal service (GTK+/GNOME implementation)...
Sep 25 05:55:20 debian gnome-session[1040]: gnome-session-check-accelerated: GL Helper exited with code 512
Sep 25 05:55:20 debian dbus-daemon[781]: [session uid=1000 pid=781] Activating service name='ca.desrt.dconf' requested >
Sep 25 05:55:20 debian dbus-daemon[781]: [session uid=1000 pid=781] Successfully activated service 'ca.desrt.dconf'
Sep 25 05:55:20 debian gnome-session[1230]: libEGL warning: DRI2: failed to authenticate
Sep 25 05:55:20 debian dbus-daemon[781]: [session uid=1000 pid=781] Successfully activated service 'org.freedesktop.imp>
Sep 25 05:55:20 debian systemd[749]: Started Portal service (GTK+/GNOME implementation).
Sep 25 05:55:20 debian dbus-daemon[781]: [session uid=1000 pid=781] Activating service name='org.freedesktop.secrets' r>
Sep 25 05:55:20 debian gnome-keyring-daemon[1251]: couldn't access control socket: /run/user/1000/keyring/control: No s>
Sep 25 05:55:20 debian gnome-keyring-d[1251]: couldn't access control socket: /run/user/1000/keyring/control: No such f>
Sep 25 05:55:20 debian dbus-daemon[781]: [session uid=1000 pid=781] Successfully activated service 'org.freedesktop.sec>
Sep 25 05:55:20 debian dbus-daemon[781]: [session uid=1000 pid=781] Successfully activated service 'org.freedesktop.por>
Sep 25 05:55:20 debian systemd[749]: Started Portal service.
Sep 25 05:55:20 debian gnome-session[1040]: gnome-session-check-accelerated: GLES Helper exited with code 512
Sep 25 05:55:20 debian systemd[749]: Created slice app-gnome\x2dsession\x2dmanager.slice.
Sep 25 05:55:20 debian systemd[749]: Created slice User Core Session Slice.
Sep 25 05:55:20 debian systemd[749]: Reached target GNOME X11 Session.
Sep 25 05:55:20 debian systemd[749]: Reached target GNOME Shell.
Sep 25 05:55:20 debian systemd[749]: Starting Monitor Session leader for GNOME Session...
Sep 25 05:55:20 debian systemd[749]: Started OpenSSH Agent.
Sep 25 05:55:20 debian systemd[749]: Reached target Session services which should run early before the graphical sessio>
Sep 25 05:55:20 debian systemd[749]: Started Monitor Session leader for GNOME Session.
Sep 25 05:55:20 debian systemd[749]: Reached target Tasks to be run before GNOME Session starts.
Sep 25 05:55:20 debian systemd[749]: Starting GNOME Session Manager (session: gnome)...
Sep 25 05:55:20 debian systemd[749]: ssh-agent.service: Succeeded.
Sep 25 05:55:20 debian gnome-keyring-ssh.desktop[1299]: SSH_AUTH_SOCK=/run/user/1000/keyring/ssh
Sep 25 05:55:20 debian gnome-keyring-d[1251]: The Secret Service was already initialized
Sep 25 05:55:20 debian gnome-keyring-daemon[1251]: The Secret Service was already initialized
Sep 25 05:55:20 debian gnome-keyring-pkcs11.desktop[1301]: SSH_AUTH_SOCK=/run/user/1000/keyring/ssh
Sep 25 05:55:20 debian gnome-keyring-secrets.desktop[1300]: SSH_AUTH_SOCK=/run/user/1000/keyring/ssh
Sep 25 05:55:20 debian systemd[749]: Started Application launched by gnome-session-binary.
Sep 25 05:55:20 debian systemd[749]: Started Application launched by gnome-session-binary.
Sep 25 05:55:20 debian systemd[749]: app-gnome-gnome\x2dkeyring\x2dssh-1295.scope: Failed to add PIDs to scope's contro>
Sep 25 05:55:20 debian systemd[749]: app-gnome-gnome\x2dkeyring\x2dssh-1295.scope: Failed with result 'resources'.
Sep 25 05:55:20 debian systemd[749]: Failed to start Application launched by gnome-session-binary.
Sep 25 05:55:20 debian systemd[749]: Started GNOME Session Manager (session: gnome).
Sep 25 05:55:20 debian systemd[749]: app-gnome-gnome\x2dkeyring\x2dpkcs11-1298.scope: Succeeded.
Sep 25 05:55:20 debian systemd[749]: Reached target GNOME Session Manager is ready.
Sep 25 05:55:20 debian systemd[749]: Starting GNOME Shell on Wayland...
Sep 25 05:55:20 debian systemd[749]: Starting GNOME Shell on X11...
Sep 25 05:55:20 debian systemd[749]: org.gnome.Shell@wayland.service: Control process exited, code=exited, status=2/INV>
Sep 25 05:55:20 debian systemd[749]: org.gnome.Shell@wayland.service: Skipped due to 'exec-condition'.
Sep 25 05:55:20 debian systemd[749]: Condition check resulted in GNOME Shell on Wayland being skipped.
Sep 25 05:55:20 debian gnome-session[1290]: gnome-session-binary[1290]: GnomeDesktop-WARNING: Could not create transien>
Sep 25 05:55:20 debian gnome-session-binary[1290]: GnomeDesktop-WARNING: Could not create transient scope for PID 1302:>
Sep 25 05:55:20 debian systemd[749]: Started Application launched by gnome-session-binary.
Sep 25 05:55:20 debian systemd[749]: Started Application launched by gnome-session-binary.
Sep 25 05:55:20 debian systemd[749]: app-gnome-pulseaudio-1307.scope: Succeeded.
Sep 25 05:55:20 debian systemd[749]: app-gnome-at\x2dspi\x2ddbus\x2dbus-1304.scope: Succeeded.
Sep 25 05:55:20 debian gnome-shell[1308]: Xlib:  extension "DPMS" missing on display ":10.0".
Sep 25 05:55:20 debian gnome-shell[1308]: X Error of failed request:  BadMatch (invalid parameter attributes)
Sep 25 05:55:20 debian gnome-shell[1308]:   Major opcode of failed request:  140 (RANDR)
Sep 25 05:55:20 debian gnome-shell[1308]:   Minor opcode of failed request:  7 (RRSetScreenSize)
Sep 25 05:55:20 debian gnome-shell[1308]:   Serial number of failed request:  263
Sep 25 05:55:20 debian gnome-shell[1308]:   Current serial number in output stream:  264
Sep 25 05:55:20 debian systemd[749]: org.gnome.Shell@x11.service: Failed with result 'protocol'.
Sep 25 05:55:20 debian systemd[749]: Failed to start GNOME Shell on X11.
Sep 25 05:55:20 debian systemd[749]: org.gnome.Shell@x11.service: Scheduled restart job, restart counter is at 1.
Sep 25 05:55:20 debian systemd[749]: Stopped GNOME Shell on X11.
Sep 25 05:55:20 debian systemd[749]: Starting GNOME Shell on X11...
Sep 25 05:55:20 debian gnome-shell[1350]: Xlib:  extension "DPMS" missing on display ":10.0".
Sep 25 05:55:20 debian gnome-shell[1350]: X Error of failed request:  BadMatch (invalid parameter attributes)
Sep 25 05:55:20 debian gnome-shell[1350]:   Major opcode of failed request:  140 (RANDR)
Sep 25 05:55:20 debian gnome-shell[1350]:   Minor opcode of failed request:  7 (RRSetScreenSize)
Sep 25 05:55:20 debian gnome-shell[1350]:   Serial number of failed request:  263
Sep 25 05:55:20 debian gnome-shell[1350]:   Current serial number in output stream:  264
Sep 25 05:55:20 debian systemd[749]: org.gnome.Shell@x11.service: Failed with result 'protocol'.
Sep 25 05:55:20 debian systemd[749]: Failed to start GNOME Shell on X11.
Sep 25 05:55:20 debian systemd[749]: org.gnome.Shell@x11.service: Scheduled restart job, restart counter is at 2.
Sep 25 05:55:20 debian systemd[749]: Stopped GNOME Shell on X11.
Sep 25 05:55:20 debian systemd[749]: Starting GNOME Shell on X11...
Sep 25 05:55:21 debian gnome-shell[1385]: Xlib:  extension "DPMS" missing on display ":10.0".
Sep 25 05:55:21 debian gnome-shell[1385]: X Error of failed request:  BadMatch (invalid parameter attributes)
Sep 25 05:55:21 debian gnome-shell[1385]:   Major opcode of failed request:  140 (RANDR)
Sep 25 05:55:21 debian gnome-shell[1385]:   Minor opcode of failed request:  7 (RRSetScreenSize)
Sep 25 05:55:21 debian gnome-shell[1385]:   Serial number of failed request:  263
Sep 25 05:55:21 debian gnome-shell[1385]:   Current serial number in output stream:  264
Sep 25 05:55:21 debian systemd[749]: org.gnome.Shell@x11.service: Failed with result 'protocol'.
Sep 25 05:55:21 debian systemd[749]: Failed to start GNOME Shell on X11.
Sep 25 05:55:21 debian systemd[749]: org.gnome.Shell@x11.service: Scheduled restart job, restart counter is at 3.
Sep 25 05:55:21 debian systemd[749]: Stopped GNOME Shell on X11.
Sep 25 05:55:21 debian systemd[749]: org.gnome.Shell@x11.service: Start request repeated too quickly.
Sep 25 05:55:21 debian systemd[749]: org.gnome.Shell@x11.service: Failed with result 'protocol'.
Sep 25 05:55:21 debian systemd[749]: Failed to start GNOME Shell on X11.
Sep 25 05:55:21 debian systemd[749]: org.gnome.Shell@x11.service: Triggering OnFailure= dependencies.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME Session is initialized.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME session X11 services.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME Session (session: gnome).
Sep 25 05:55:21 debian systemd[749]: Started GNOME Session Failed lockdown screen (user).
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME Session Failed.
Sep 25 05:55:21 debian systemd[749]: Starting Signal initialization done to GNOME Session Manager...
Sep 25 05:55:21 debian systemd[749]: Starting GNOME accessibility service...
Sep 25 05:55:21 debian systemd[749]: Starting GNOME color management service...
Sep 25 05:55:21 debian systemd[749]: Starting GNOME date & time service...
Sep 25 05:55:21 debian systemd[749]: Starting GNOME maintenance of expirable data service...
Sep 25 05:55:21 debian systemd[749]: Starting GNOME keyboard configuration service...
Sep 25 05:55:21 debian systemd[749]: Starting GNOME keyboard shortcuts service...
Sep 25 05:55:21 debian systemd[749]: Starting GNOME power management service...
Sep 25 05:55:21 debian systemd[749]: Starting GNOME printer notifications service...
Sep 25 05:55:21 debian systemd[749]: Starting GNOME RFKill support service...
Sep 25 05:55:21 debian systemd[749]: Starting GNOME FreeDesktop screensaver service...
Sep 25 05:55:21 debian systemd[749]: Starting GNOME file sharing service...
Sep 25 05:55:21 debian systemd[749]: Starting GNOME smartcard service...
Sep 25 05:55:21 debian systemd[749]: Starting GNOME sound sample caching service...
Sep 25 05:55:21 debian systemd[749]: Starting GNOME USB protection service...
Sep 25 05:55:21 debian systemd[749]: Starting GNOME Wacom tablet support service...
Sep 25 05:55:21 debian systemd[749]: Starting GNOME XSettings service...
Sep 25 05:55:21 debian systemd[749]: Condition check resulted in Disable GNOME Shell extensions after failure being ski>
Sep 25 05:55:21 debian gnome-session-binary[1290]: Entering running state
Sep 25 05:55:21 debian systemd[749]: gnome-session-signal-init.service: Succeeded.
Sep 25 05:55:21 debian systemd[749]: Finished Signal initialization done to GNOME Session Manager.
Sep 25 05:55:21 debian dbus-daemon[610]: [system] Activating via systemd: service name='org.freedesktop.locale1' unit='>
Sep 25 05:55:21 debian systemd[1]: Starting Locale Service...
Sep 25 05:55:21 debian systemd[749]: Started GNOME smartcard service.
Sep 25 05:55:21 debian systemd[749]: Started GNOME USB protection service.
Sep 25 05:55:21 debian systemd[749]: Started GNOME keyboard configuration service.
Sep 25 05:55:21 debian systemd[749]: Started GNOME file sharing service.
Sep 25 05:55:21 debian systemd[749]: Started GNOME accessibility service.
Sep 25 05:55:21 debian systemd[749]: Started GNOME maintenance of expirable data service.
Sep 25 05:55:21 debian systemd[749]: Started GNOME sound sample caching service.
Sep 25 05:55:21 debian systemd[749]: Started Application launched by gnome-session-binary.
Sep 25 05:55:21 debian systemd[749]: Started Application launched by gnome-session-binary.
Sep 25 05:55:21 debian systemd[749]: Started Application launched by gnome-session-binary.
Sep 25 05:55:21 debian systemd[749]: Started Application launched by gnome-session-binary.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME accessibility target.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME maintenance of expirable data target.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME keyboard configuration target.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME file sharing target.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME smartcard target.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME sound sample caching target.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME USB protection target.
Sep 25 05:55:21 debian gsd-usb-protect[1448]: Failed to get screen saver status: Cannot invoke method; proxy is for the>
Sep 25 05:55:21 debian gsd-usb-protect[1448]: Failed to fetch USBGuard parameters: GDBus.Error:org.freedesktop.DBus.Err>
Sep 25 05:55:21 debian systemd[749]: Started GNOME power management service.
Sep 25 05:55:21 debian systemd[749]: Started GNOME printer notifications service.
Sep 25 05:55:21 debian gnome-session-binary[1290]: GnomeDesktop-WARNING: Could not create transient scope for PID 1440:>
Sep 25 05:55:21 debian gnome-session[1290]: gnome-session-binary[1290]: GnomeDesktop-WARNING: Could not create transien>
Sep 25 05:55:21 debian gnome-session[1290]: gnome-session-binary[1290]: GnomeDesktop-WARNING: Could not create transien>
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME power management target.
Sep 25 05:55:21 debian gnome-session-binary[1290]: GnomeDesktop-WARNING: Could not create transient scope for PID 1442:>
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME printer notifications target.
Sep 25 05:55:21 debian systemd[749]: Starting GNOME Remote Desktop...
Sep 25 05:55:21 debian systemd[749]: Starting gnome-user-share WebDAV server...
Sep 25 05:55:21 debian gnome-session[1290]: gnome-session-binary[1290]: GnomeDesktop-WARNING: Could not create transien>
Sep 25 05:55:21 debian systemd[749]: Starting Rygel DLNA/UPnP server...
Sep 25 05:55:21 debian gnome-session-binary[1290]: GnomeDesktop-WARNING: Could not create transient scope for PID 1456:>
Sep 25 05:55:21 debian systemd[749]: Started GNOME FreeDesktop screensaver service.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME FreeDesktop screensaver target.
Sep 25 05:55:21 debian dbus-daemon[610]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit>
Sep 25 05:55:21 debian systemd[749]: Started GNOME Wacom tablet support service.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME Wacom tablet support target.
Sep 25 05:55:21 debian systemd[749]: Started GNOME date & time service.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME date & time target.
Sep 25 05:55:21 debian systemd[749]: Started GNOME keyboard shortcuts service.
Sep 25 05:55:21 debian systemd[749]: app-gnome-anydesk_global_tray-1470.scope: Succeeded.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME keyboard shortcuts target.
Sep 25 05:55:21 debian systemd[1]: Starting Hostname Service...
Sep 25 05:55:21 debian systemd[749]: Started gnome-user-share WebDAV server.
Sep 25 05:55:21 debian gsd-xsettings[1455]: Failed to get current display configuration state: GDBus.Error:org.freedesk>
Sep 25 05:55:21 debian systemd[749]: Started GNOME color management service.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME color management target.
Sep 25 05:55:21 debian dbus-daemon[610]: [system] Successfully activated service 'org.freedesktop.locale1'
Sep 25 05:55:21 debian systemd[1]: Started Locale Service.
Sep 25 05:55:21 debian systemd[749]: Started GNOME XSettings service.
Sep 25 05:55:21 debian systemd[749]: GNOME session X11 services is not active.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME XSettings target.
Sep 25 05:55:21 debian rygel[1516]: Rygel v0.40.0 starting…
Sep 25 05:55:21 debian systemd[749]: Started Rygel DLNA/UPnP server.
Sep 25 05:55:21 debian rygel[1516]: New plugin “Playbin” available
Sep 25 05:55:21 debian systemd[749]: Started GNOME Remote Desktop.
Sep 25 05:55:21 debian gnome-user-share-webdav[1545]: AH00558: apache2: Could not reliably determine the server's fully>
Sep 25 05:55:21 debian dbus-daemon[610]: [system] Successfully activated service 'org.freedesktop.hostname1'
Sep 25 05:55:21 debian systemd[1]: Started Hostname Service.
Sep 25 05:55:21 debian dbus-daemon[781]: [session uid=1000 pid=781] Activating via systemd: service name='org.gnome.evo>
Sep 25 05:55:21 debian systemd[749]: Starting Evolution source registry...
Sep 25 05:55:21 debian kernel: rfkill: input handler disabled
Sep 25 05:55:21 debian systemd[749]: Started GNOME RFKill support service.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME RFKill support target.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME Session.
Sep 25 05:55:21 debian systemd[749]: Reached target GNOME X11 Session (session: gnome).
Sep 25 05:55:21 debian systemd[749]: Reached target Current graphical user session.
Sep 25 05:55:21 debian gsd-media-keys[1429]: Unable to inhibit keypresses: GDBus.Error:org.freedesktop.DBus.Error.Acces>
Sep 25 05:55:21 debian dbus-daemon[781]: [session uid=1000 pid=781] Activating service name='org.gnome.Shell.Screencast>
Sep 25 05:55:21 debian dbus-daemon[610]: [system] Activating via systemd: service name='org.freedesktop.fwupd' unit='fw>
Sep 25 05:55:21 debian systemd[1]: Starting Firmware update daemon...
Sep 25 05:55:21 debian dbus-daemon[781]: [session uid=1000 pid=781] Successfully activated service 'org.gnome.evolution>
Sep 25 05:55:21 debian systemd[749]: Started Evolution source registry.
Sep 25 05:55:21 debian dbus-daemon[781]: [session uid=1000 pid=781] Successfully activated service 'org.gnome.Shell.Scr>
Sep 25 05:55:21 debian rygel[1516]: New plugin “MediaExport” available
Sep 25 05:55:21 debian fwupd[1568]: 12:55:21:0325 GLib                 g_bytes_get_data: assertion 'bytes != NULL' fail>
Sep 25 05:55:21 debian fwupd[1568]: 12:55:21:0325 GLib                 g_bytes_get_data: assertion 'bytes != NULL' fail>
Sep 25 05:55:21 debian fwupd[1568]: 12:55:21:0325 GLib                 g_bytes_get_data: assertion 'bytes != NULL' fail>
Sep 25 05:55:21 debian fwupd[1568]: 12:55:21:0338 FuPluginUefiCapsule  failed to add /sys/firmware/efi/esrt/entries/ent>
Sep 25 05:55:21 debian fwupd[1568]: 12:55:21:0353 FuEngine             failed to get releases for Intel Management Engi>
Sep 25 05:55:21 debian mx-extract[1590]: rygel-media-export-extract.vala:180: Started with descriptors 3 (in) 4 (out)
Sep 25 05:55:21 debian dbus-daemon[781]: [session uid=1000 pid=781] Activating via systemd: service name='org.gnome.evo>
Sep 25 05:55:21 debian systemd[749]: Starting Evolution calendar service...
Sep 25 05:55:21 debian mx-extract[1592]: rygel-media-export-extract.vala:180: Started with descriptors 3 (in) 4 (out)
Sep 25 05:55:21 debian mx-extract[1591]: rygel-media-export-extract.vala:180: Started with descriptors 3 (in) 4 (out)
Sep 25 05:55:21 debian rygel[1516]: “file:///home/user/Music” harvested
Sep 25 05:55:21 debian rygel[1516]: rygel-media-export-harvesting-task.vala:309: Harvesting of file:///home/user/Music >
Sep 25 05:55:21 debian rygel[1516]: “file:///home/user/Videos” harvested
Sep 25 05:55:21 debian rygel[1516]: rygel-media-export-harvesting-task.vala:309: Harvesting of file:///home/user/Videos>
Sep 25 05:55:21 debian rygel[1516]: “file:///home/user/Pictures” harvested
Sep 25 05:55:21 debian rygel[1516]: rygel-media-export-harvesting-task.vala:309: Harvesting of file:///home/user/Pictur>
Sep 25 05:55:21 debian dbus-daemon[781]: [session uid=1000 pid=781] Successfully activated service 'org.gnome.evolution>
Sep 25 05:55:21 debian systemd[749]: Started Evolution calendar service.
Sep 25 05:55:21 debian dbus-daemon[781]: [session uid=1000 pid=781] Activating via systemd: service name='org.gnome.evo>
Sep 25 05:55:21 debian systemd[749]: Starting Evolution address book service...
Sep 25 05:55:21 debian dbus-daemon[781]: [session uid=1000 pid=781] Successfully activated service 'org.gnome.evolution>
Sep 25 05:55:21 debian systemd[749]: Started Evolution address book service.
Sep 25 05:55:21 debian fwupd[1568]: 12:55:21:0492 FuEngine             failed to get releases for Intel Management Engi>
Sep 25 05:55:21 debian dbus-daemon[610]: [system] Successfully activated service 'org.freedesktop.fwupd'
Sep 25 05:55:21 debian systemd[1]: Started Firmware update daemon.
Sep 25 05:55:21 debian fwupd[1568]: 12:55:21:0516 FuPluginPciMei       ME family not supported for 0:16.1.25.1865
Sep 25 05:55:21 debian dbus-daemon[610]: [system] Activating via systemd: service name='org.freedesktop.Accounts' unit=>
Sep 25 05:55:21 debian systemd[1]: Reached target User and Group Name Lookups.
Sep 25 05:55:21 debian systemd[1]: Starting Accounts Service...
Sep 25 05:55:21 debian accounts-daemon[1629]: started daemon version 0.6.55
Sep 25 05:55:21 debian dbus-daemon[610]: [system] Successfully activated service 'org.freedesktop.Accounts'
Sep 25 05:55:21 debian systemd[1]: Started Accounts Service.
Sep 25 05:55:21 debian gnome-software[1475]: enabled plugins: desktop-categories, fwupd, os-release, packagekit, packag>
Sep 25 05:55:21 debian gnome-software[1475]: disabled plugins: dpkg, dummy, repos
Sep 25 05:55:21 debian dbus-daemon[610]: [system] Activating via systemd: service name='org.freedesktop.PackageKit' uni>
Sep 25 05:55:21 debian systemd[1]: Starting PackageKit Daemon...
Sep 25 05:55:21 debian PackageKit[1634]: daemon start
Sep 25 05:55:21 debian dbus-daemon[610]: [system] Successfully activated service 'org.freedesktop.PackageKit'
Sep 25 05:55:21 debian systemd[1]: Started PackageKit Daemon.
Sep 25 05:55:21 debian PackageKit[1634]: uid 1000 is trying to obtain org.freedesktop.packagekit.system-sources-refresh>
Sep 25 05:55:21 debian PackageKit[1634]: uid 1000 failed to obtain auth
Sep 25 05:55:21 debian gnome-software[1475]: not handling error no-security for action refresh: Failed to obtain authen>
Sep 25 05:55:21 debian gnome-software[1475]: adding wildcard app */*/*/*/org.gnome.Builder.desktop/* to plugin cache
Sep 25 05:55:21 debian gnome-software[1475]: adding wildcard app */*/*/*/org.gnome.Calculator.desktop/* to plugin cache
Sep 25 05:55:21 debian gnome-software[1475]: adding wildcard app */*/*/*/org.gnome.clocks.desktop/* to plugin cache
Sep 25 05:55:21 debian gnome-software[1475]: adding wildcard app */*/*/*/org.gnome.Dictionary.desktop/* to plugin cache
Sep 25 05:55:21 debian gnome-software[1475]: Only 0 apps for recent list, hiding
Sep 25 05:55:21 debian gnome-software[1475]: adding wildcard app */*/*/*/org.gnome.Documents.desktop/* to plugin cache
Sep 25 05:55:21 debian gnome-software[1475]: adding wildcard app */*/*/*/org.gnome.Evince/* to plugin cache
Sep 25 05:55:21 debian gnome-software[1475]: adding wildcard app */*/*/*/org.gnome.gedit.desktop/* to plugin cache
Sep 25 05:55:21 debian gnome-software[1475]: adding wildcard app */*/*/*/org.gnome.Maps.desktop/* to plugin cache
Sep 25 05:55:21 debian gnome-software[1475]: adding wildcard app */*/*/*/org.gnome.Weather/* to plugin cache
Sep 25 05:55:21 debian gnome-software[1475]: hiding category productivity featured applications: found only 0 to show, >
Sep 25 05:55:21 debian gnome-software[1475]: hiding category graphics featured applications: found only 0 to show, need>
Sep 25 05:55:21 debian PackageKit[1634]: resolve transaction /314_ceaebbdd from uid 1000 finished with success after 12>
Sep 25 05:55:21 debian gnome-software[1475]: CSS parse error 1:107: Using one color stop with linear-gradient() is depr>
Sep 25 05:55:21 debian PackageKit[1634]: resolve transaction /315_debdbdeb from uid 1000 finished with success after 10>
Sep 25 05:55:21 debian gnome-software[1475]: FIXME: Unknown progress handling is not yet implemented for GsProgressButt>
Sep 25 05:55:21 debian gnome-software[1475]: FIXME: Unknown progress handling is not yet implemented for GsProgressButt>
Sep 25 05:55:21 debian gnome-software[1475]: FIXME: Unknown progress handling is not yet implemented for GsProgressButt>
Sep 25 05:55:21 debian gnome-software[1475]: FIXME: Unknown progress handling is not yet implemented for GsProgressButt>
Sep 25 05:55:21 debian gnome-software[1475]: automatically prevented from changing kind on system/package/*/generic/org>
Sep 25 05:55:22 debian PackageKit[1634]: get-updates transaction /316_debbcbbd from uid 1000 finished with success afte>
Sep 25 05:55:22 debian PackageKit[1634]: resolve transaction /317_dbbbbcdb from uid 1000 finished with success after 10>
Sep 25 05:55:22 debian PackageKit[1634]: search-file transaction /318_cdabcead from uid 1000 finished with success afte>
Sep 25 05:55:22 debian PackageKit[1634]: get-details transaction /319_dccaebad from uid 1000 finished with success afte>
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME Session Failed.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME X11 Session (session: gnome).
Sep 25 05:55:23 debian systemd[749]: Stopped target Current graphical user session.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME Session.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME X11 Session.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME Session (session: gnome).
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME accessibility target.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME color management target.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME date & time target.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME maintenance of expirable data target.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME keyboard configuration target.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME keyboard shortcuts target.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME power management target.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME printer notifications target.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME RFKill support target.
Sep 25 05:55:23 debian kernel: rfkill: input handler enabled
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME FreeDesktop screensaver target.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME file sharing target.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME smartcard target.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME sound sample caching target.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME USB protection target.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME Wacom tablet support target.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME XSettings target.
Sep 25 05:55:23 debian systemd[749]: Stopping GNOME accessibility service...
Sep 25 05:55:23 debian systemd[749]: Stopping GNOME color management service...
Sep 25 05:55:23 debian systemd[749]: Stopping GNOME date & time service...
Sep 25 05:55:23 debian systemd[749]: Stopping GNOME maintenance of expirable data service...
Sep 25 05:55:23 debian systemd[749]: Stopping GNOME keyboard configuration service...
Sep 25 05:55:23 debian systemd[749]: Stopping GNOME keyboard shortcuts service...
Sep 25 05:55:23 debian systemd[749]: Stopping GNOME power management service...
Sep 25 05:55:23 debian systemd[749]: Stopping GNOME printer notifications service...
Sep 25 05:55:23 debian systemd[749]: Stopping GNOME RFKill support service...
Sep 25 05:55:23 debian systemd[749]: Stopping GNOME FreeDesktop screensaver service...
Sep 25 05:55:23 debian systemd[749]: Stopping GNOME file sharing service...
Sep 25 05:55:23 debian systemd[749]: Stopping GNOME smartcard service...
Sep 25 05:55:23 debian systemd[749]: Stopping GNOME sound sample caching service...
Sep 25 05:55:23 debian systemd[749]: Stopping GNOME USB protection service...
Sep 25 05:55:23 debian systemd[749]: Stopping GNOME Wacom tablet support service...
Sep 25 05:55:23 debian systemd[749]: Stopping GNOME XSettings service...
Sep 25 05:55:23 debian systemd[749]: gnome-session-failed.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped GNOME Session Failed lockdown screen (user).
Sep 25 05:55:23 debian systemd[749]: org.gnome.SettingsDaemon.A11ySettings.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped GNOME accessibility service.
Sep 25 05:55:23 debian systemd[749]: org.gnome.SettingsDaemon.Housekeeping.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped GNOME maintenance of expirable data service.
Sep 25 05:55:23 debian systemd[749]: org.gnome.SettingsDaemon.Sound.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped GNOME sound sample caching service.
Sep 25 05:55:23 debian systemd[749]: org.gnome.SettingsDaemon.Color.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped GNOME color management service.
Sep 25 05:55:23 debian systemd[749]: org.gnome.SettingsDaemon.Datetime.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped GNOME date & time service.
Sep 25 05:55:23 debian systemd[749]: org.gnome.SettingsDaemon.Keyboard.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped GNOME keyboard configuration service.
Sep 25 05:55:23 debian systemd[749]: org.gnome.SettingsDaemon.PrintNotifications.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped GNOME printer notifications service.
Sep 25 05:55:23 debian systemd[749]: org.gnome.SettingsDaemon.Rfkill.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped GNOME RFKill support service.
Sep 25 05:55:23 debian systemd[749]: org.gnome.SettingsDaemon.MediaKeys.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped GNOME keyboard shortcuts service.
Sep 25 05:55:23 debian systemd[749]: org.gnome.SettingsDaemon.Power.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped GNOME power management service.
Sep 25 05:55:23 debian systemd[749]: org.gnome.SettingsDaemon.Sharing.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped GNOME file sharing service.
Sep 25 05:55:23 debian systemd[749]: org.gnome.SettingsDaemon.ScreensaverProxy.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped GNOME FreeDesktop screensaver service.
Sep 25 05:55:23 debian systemd[749]: org.gnome.SettingsDaemon.Smartcard.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped GNOME smartcard service.
Sep 25 05:55:23 debian systemd[749]: org.gnome.SettingsDaemon.UsbProtection.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped GNOME USB protection service.
Sep 25 05:55:23 debian systemd[749]: org.gnome.SettingsDaemon.Wacom.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped GNOME Wacom tablet support service.
Sep 25 05:55:23 debian systemd[749]: org.gnome.SettingsDaemon.XSettings.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped GNOME XSettings service.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME session X11 services.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME Session is initialized.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME Session Manager is ready.
Sep 25 05:55:23 debian systemd[749]: Stopped target GNOME Shell.
Sep 25 05:55:23 debian systemd[749]: Stopping GNOME Session Manager (session: gnome)...
Sep 25 05:55:23 debian systemd[749]: at-spi-dbus-bus.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: gnome-session-manager@gnome.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped GNOME Session Manager (session: gnome).
Sep 25 05:55:23 debian systemd[749]: Stopped target Tasks to be run before GNOME Session starts.
Sep 25 05:55:23 debian systemd[749]: Stopped target Session services which should run early before the graphical sessio>
Sep 25 05:55:23 debian systemd[749]: Reached target Shutdown running GNOME Session.
Sep 25 05:55:23 debian systemd[749]: Stopping Monitor Session leader for GNOME Session...
Sep 25 05:55:23 debian systemd[749]: Starting Restart DBus after GNOME Session shutdown...
Sep 25 05:55:23 debian systemd[749]: Stopped target Shutdown running GNOME Session.
Sep 25 05:55:23 debian systemd[749]: Reached target Shutdown running GNOME Session.
Sep 25 05:55:23 debian systemd[749]: Stopped target Shutdown running GNOME Session.
Sep 25 05:55:23 debian systemd[749]: gnome-session-monitor.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped Monitor Session leader for GNOME Session.
Sep 25 05:55:23 debian systemd[749]: Started Restart DBus after GNOME Session shutdown.
Sep 25 05:55:23 debian xrdp-sesman[902]: [WARN ] Window manager (pid 903, display 10) exited quickly (3 secs). This cou>
Sep 25 05:55:23 debian xrdp-sesman[902]: [INFO ] Calling auth_stop_session and auth_end from pid 902
Sep 25 05:55:23 debian systemd[749]: Stopping D-Bus User Message Bus...
Sep 25 05:55:23 debian xrdp-sesman[902]: pam_unix(xrdp-sesman:session): session closed for user user
Sep 25 05:55:23 debian systemd[749]: gnome-session-restart-dbus.service: Succeeded.
Sep 25 05:55:23 debian gvfsd[788]: A connection to the bus can't be made
Sep 25 05:55:23 debian tracker-miner-fs[767]: Received signal:15->'Terminated'
Sep 25 05:55:23 debian tracker-miner-f[767]: Error while sending AddMatch() message: The connection is closed
Sep 25 05:55:23 debian tracker-miner-f[767]: Error while sending AddMatch() message: The connection is closed
Sep 25 05:55:23 debian tracker-miner-f[767]: Error while sending AddMatch() message: The connection is closed
Sep 25 05:55:23 debian systemd[749]: gvfs-mtp-volume-monitor.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: gvfs-gphoto2-volume-monitor.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: gvfs-goa-volume-monitor.service: Succeeded.
Sep 25 05:55:23 debian xrdp-sesman[902]: [INFO ] Terminating X server (pid 904) on display 10
Sep 25 05:55:23 debian gnome-software[1475]: lost session service
Sep 25 05:55:23 debian evolution-calen[1596]: Error setting property 'ConnectionStatus' on interface org.gnome.evolutio>
Sep 25 05:55:23 debian evolution-calen[1596]: Error setting property 'ConnectionStatus' on interface org.gnome.evolutio>
Sep 25 05:55:23 debian systemd[749]: run-user-1000-doc.mount: Succeeded.
Sep 25 05:55:23 debian xrdp-sesman[902]: [INFO ] Terminating the xrdp channel server (pid 946) on display 10
Sep 25 05:55:23 debian tracker-store[907]: Received signal:15->'Terminated'
Sep 25 05:55:23 debian tracker-store[907]: OK
Sep 25 05:55:23 debian systemd[749]: run-user-1000-gvfs.mount: Succeeded.
Sep 25 05:55:23 debian systemd[1]: run-user-1000-doc.mount: Succeeded.
Sep 25 05:55:23 debian systemd[1]: run-user-1000-gvfs.mount: Succeeded.
Sep 25 05:55:23 debian xrdp[897]: [DEBUG] Closed socket 20 (AF_UNIX)
Sep 25 05:55:23 debian systemd[749]: xdg-permission-store.service: Main process exited, code=exited, status=1/FAILURE
Sep 25 05:55:23 debian systemd[749]: xdg-permission-store.service: Failed with result 'exit-code'.
Sep 25 05:55:23 debian systemd[749]: gnome-remote-desktop.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: gvfs-daemon.service: Succeeded.
Sep 25 05:55:23 debian evolution-addre[1608]: Error setting property 'ConnectionStatus' on interface org.gnome.evolutio>
Sep 25 05:55:23 debian systemd[749]: app-gnome-org.gnome.SettingsDaemon.DiskUtilityNotify-1436.scope: Succeeded.
Sep 25 05:55:23 debian systemd[749]: home-user-thinclient_drives.mount: Succeeded.
Sep 25 05:55:23 debian systemd[1]: home-user-thinclient_drives.mount: Succeeded.
Sep 25 05:55:23 debian systemd[749]: tracker-store.service: Succeeded.
Sep 25 05:55:23 debian tracker-miner-fs[767]: OK
Sep 25 05:55:23 debian systemd[749]: xdg-document-portal.service: Main process exited, code=exited, status=20/n/a
Sep 25 05:55:23 debian systemd[749]: xdg-document-portal.service: Failed with result 'exit-code'.
Sep 25 05:55:23 debian xrdp[897]: [DEBUG] Closed socket 12 (AF_INET6 ::ffff:192.168.29.203 port 3389)
Sep 25 05:55:23 debian systemd-logind[615]: Failed to restore VT, ignoring: Bad file descriptor
Sep 25 05:55:23 debian xrdp[897]: [DEBUG] xrdp_mm_module_cleanup
Sep 25 05:55:23 debian xrdp[897]: [DEBUG] Closed socket 19 (AF_UNIX)
Sep 25 05:55:23 debian xrdp-sesman[902]: [INFO ] X server on display 10 (pid 904) returned exit code 0 and signal numbe>
Sep 25 05:55:23 debian xrdp-sesman[902]: [INFO ] xrdp channel server for display 10 (pid 946) exit code 0 and signal nu>
Sep 25 05:55:23 debian xrdp-sesman[902]: [INFO ] cleanup_sockets:
Sep 25 05:55:23 debian xrdp-sesman[655]: [INFO ] Process 902 has exited
Sep 25 05:55:23 debian systemd[749]: tracker-miner-fs.service: Succeeded.
Sep 25 05:55:23 debian xrdp-sesman[655]: [INFO ] ++ terminated session:  username user, display :10.0, session_pid 902,>
Sep 25 05:55:23 debian systemd-logind[615]: Session c1 logged out. Waiting for processes to exit.
Sep 25 05:55:23 debian systemd[749]: dbus.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: Stopped D-Bus User Message Bus.
Sep 25 05:55:23 debian systemd[749]: gvfs-udisks2-volume-monitor.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: gvfs-afc-volume-monitor.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: xdg-desktop-portal.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: xdg-desktop-portal-gtk.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: rygel.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: evolution-source-registry.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: evolution-calendar-factory.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: evolution-addressbook-factory.service: Succeeded.
Sep 25 05:55:23 debian systemd[749]: app-gnome-gnome\x2dsoftware\x2dservice-1475.scope: Succeeded.
Sep 25 05:55:23 debian systemd[749]: app-gnome-org.gnome.Evolution\x2dalarm\x2dnotify-1465.scope: Succeeded.
Sep 25 05:55:24 debian systemd[749]: gnome-user-share-webdav.service: Main process exited, code=exited, status=2/INVALI>
Sep 25 05:55:24 debian systemd[749]: gnome-user-share-webdav.service: Failed with result 'exit-code'.
Sep 25 05:55:24 debian systemd[749]: gnome-user-share-webdav.service: Scheduled restart job, restart counter is at 1.
Sep 25 05:55:24 debian systemd[749]: Stopped gnome-user-share WebDAV server.
Sep 25 05:55:24 debian systemd[749]: Starting gnome-user-share WebDAV server...
Sep 25 05:55:24 debian systemd[749]: Started D-Bus User Message Bus.
Sep 25 05:55:24 debian systemd[749]: Started gnome-user-share WebDAV server.
Sep 25 05:55:24 debian gnome-user-share-webdav[1723]: AH00558: apache2: Could not reliably determine the server's fully>
Sep 25 05:55:26 debian kernel: snd_hda_intel 0000:00:1f.3: couldn't bind with audio component
Sep 25 05:55:26 debian kernel: snd_hda_codec_realtek hdaudioC0D0: autoconfig for ALC269VB: line_outs=1 (0x14/0x0/0x0/0x>
Sep 25 05:55:26 debian kernel: snd_hda_codec_realtek hdaudioC0D0:    speaker_outs=0 (0x0/0x0/0x0/0x0/0x0)
Sep 25 05:55:26 debian kernel: snd_hda_codec_realtek hdaudioC0D0:    hp_outs=1 (0x21/0x0/0x0/0x0/0x0)
Sep 25 05:55:26 debian kernel: snd_hda_codec_realtek hdaudioC0D0:    mono: mono_out=0x0
Sep 25 05:55:26 debian kernel: snd_hda_codec_realtek hdaudioC0D0:    inputs:
Sep 25 05:55:26 debian kernel: snd_hda_codec_realtek hdaudioC0D0:      Internal Mic=0x19
Sep 25 05:55:26 debian kernel: snd_hda_codec_realtek hdaudioC0D0:      Mic=0x18
Sep 25 05:55:26 debian kernel: input: HDA Digital PCBeep as /devices/pci0000:00/0000:00:1f.3/sound/card0/input9
Sep 25 05:55:26 debian kernel: input: HDA Intel PCH Mic as /devices/pci0000:00/0000:00:1f.3/sound/card0/input10
Sep 25 05:55:26 debian kernel: input: HDA Intel PCH Headphone as /devices/pci0000:00/0000:00:1f.3/sound/card0/input11
Sep 25 05:55:26 debian systemd[1]: Condition check resulted in Manage Sound Card State (restore and store) being skippe>
Sep 25 05:55:26 debian systemd[749]: Reached target Sound Card.
Sep 25 05:55:26 debian systemd[1]: Starting Save/Restore Sound Card State...
Sep 25 05:55:26 debian systemd[1]: Finished Save/Restore Sound Card State.
Sep 25 05:55:26 debian systemd[1]: Reached target Sound Card.
lines 496-524/524 (END)
matt335672 commented 1 year ago

Yes - this is neutrinolabs/xorgxrdp#156. Here are the relevant lines:-

Sep 25 05:55:20 debian gnome-shell[1308]: X Error of failed request:  BadMatch (invalid parameter attributes)
Sep 25 05:55:20 debian gnome-shell[1308]:   Major opcode of failed request:  140 (RANDR)
Sep 25 05:55:20 debian gnome-shell[1308]:   Minor opcode of failed request:  7 (RRSetScreenSize)
Sep 25 05:55:20 debian gnome-shell[1308]:   Serial number of failed request:  263
Sep 25 05:55:20 debian gnome-shell[1308]:   Current serial number in output stream:  264

The fix was delivered in version 0.2.14 of xorgxrdp.

What seems to have happened in your case is that the previous administrator has built v0.2.15 of xorgxrdp from scratch, installed it manually and then not documented what has been done. This version has the fix for neutrinolabs/xorgxrdp#156, but isn't compatible with the security update which has just been installed.

I think you have the following courses of action available to you:- 1) Ask the previous administrator of the machine (if still available) to rebuild the xorgxrdp package against the new xrdp version. 2) If you can locate the previous xorgxrdp package, you could back-out the security fix and re-install the version you were using before. Depending on your network environment, this may or may not be a good idea. 3) Use the Xvnc backend to xrdp. This does not have the same problem. 4) Learn how to rebuild the xorgxrdp package yourself. 5) Use a desktop environment other than GNOME

It's not clear to me what would be your best course of action. Not only have you got to fix this fault, you've got to consider what to do in the future if this happens again.

ky8585 commented 1 year ago

XVNC backend isn't working as well (I assume this is the easiest solution)"

[20230925-07:27:18] [INFO ] starting Xvnc session...
[20230925-07:27:18] [INFO ] Starting session: session_pid 2808, display :11.0, width 1920, height 1200, bpp 32, client ip ::ffff:192.168.29.168:63954 - socket: 12, user name user
[20230925-07:27:18] [ERROR] sesman_data_in: scp_process_msg failed
[20230925-07:27:18] [INFO ] [session start] (display 11): calling auth_start_session from pid 2808
[20230925-07:27:18] [ERROR] sesman_main_loop: trans_check_wait_objs failed, removing trans
[20230925-07:27:18] [INFO ] Starting X server on display 11: Xvnc :11 -auth .Xauthority -geometry 1920x1200 -depth 32 -rfbauth /home/user/.vnc/sesman_passwd-user@debian:11 -bs -nolisten tcp -localhost -dpi 96
[20230925-07:27:18] [ERROR] Error calling exec (executable: Xvnc, arguments: Xvnc :11 -auth .Xauthority -geometry 1920x1200 -depth 32 -rfbauth /home/user/.vnc/sesman_passwd-user@debian:11 -bs -nolisten tcp -localhost -dpi 96) returned errno: 2, description: No such file or directory
[20230925-07:27:18] [ERROR] Error starting X server on display 11
[20230925-07:27:18] [ERROR] A fatal error has occurred attempting to start the X server on display 11, aborting connection
[20230925-07:27:28] [WARN ] Timed out waiting for X server on display 11 to startup
[20230925-07:27:28] [INFO ] Session started successfully for user user on display 11
[20230925-07:27:28] [INFO ] Starting the xrdp channel server for display 11
[20230925-07:27:28] [INFO ] Session in progress on display 11, waiting until the window manager (pid 2809) exits to end the session
[20230925-07:27:28] [WARN ] Timed out waiting for X server on display 11 to startup
[20230925-07:27:28] [ERROR] There is no X server active on display 11
[20230925-07:27:29] [ERROR] A fatal error has occurred attempting to start the window manager on display 11, aborting connection
[20230925-07:27:29] [WARN ] Window manager (pid 2809, display 11) exited quickly (1 secs). This could indicate a window manager config problem
[20230925-07:27:29] [INFO ] Calling auth_stop_session and auth_end from pid 2808
[20230925-07:27:29] [INFO ] Terminating X server (pid 2810) on display 11
[20230925-07:27:29] [INFO ] Terminating the xrdp channel server (pid 2813) on display 11
[20230925-07:27:29] [INFO ] X server on display 11 (pid 2810) returned exit code 1 and signal number 0
[20230925-07:27:29] [INFO ] xrdp channel server for display 11 (pid 2813) exit code 0 and signal number 0
[20230925-07:27:29] [INFO ] cleanup_sockets:
[20230925-07:27:29] [INFO ] Process 2808 has exited
[20230925-07:27:29] [INFO ] ++ terminated session:  username user, display :11.0, session_pid 2808, ip ::ffff:192.168.29.168:63954 - socket: 12
ky8585 commented 1 year ago

Is that a good idea to purge both xrdp and xorgxrdp and install xrdp from scratch?

matt335672 commented 1 year ago

Xvnc backend is the simplest solution, but requires a version of Xvnc to be installed. At the moment it isn't:-

[20230925-07:27:18] [ERROR] Error calling exec (executable: Xvnc, arguments: Xvnc :11 -auth .Xauthority -geometry 1920x1200 -depth 32 -rfbauth /home/user/.vnc/sesman_passwd-user@debian:11 -bs -nolisten tcp -localhost -dpi 96) returned errno: 2, description: No such file or directory

On Debian, use sudo apt install tigervnc-standalone-server.

I wouldn't purge xrdp. You'll lose all your config changes, and that bit seems to be working OK at the moment:-

ky8585 commented 1 year ago

That worked!!!!!!!!!!!!!!!!!!!!!!

ky8585 commented 1 year ago

Thanks a lot!!!!!!!!!!!!!!!!!!

matt335672 commented 1 year ago

Do some more testing and make sure you're happy with it. The other options are still possible, but (as you correctly deduce) they are more complex and may give you maintenance issues moving forwards.