[Xrdp-devel] reconnection to X11rdp occasionally fails

classic Classic list List threaded Threaded
5 messages Options
Reply | Threaded
Open this post in threaded view
|  
Report Content as Inappropriate

[Xrdp-devel] reconnection to X11rdp occasionally fails

Lionel Rocket
Hello,

I'm having problems reconnecting to X11rdp sessions. I can't reproduce this but its occurring quite often.

Log output shows only the following lines, it finds the correct X11rdp session on display 11 but after that it immediately closes the connection and the Microsoft RDP client freezes.

2014-12-15T12:42:33.759+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769365440)[INFO ] A connection received from: 127.0.0.1 port 46705
2014-12-15T12:42:33.759+01:00 srv1 XRDP[25753] debug: (25753)(140019385399232)[DEBUG] returnvalue from xrdp_mm_connect 0
2014-12-15T12:42:33.759+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769365440)[INFO ] scp thread on sck 8 started successfully
2014-12-15T12:42:33.760+01:00 srv1 XRDP-sesman[8213] notice: pam_unix(xrdp-sesman:auth): authentication failure; logname= uid=0 euid=0 tty= ruser= rhost=  user=usr1
2014-12-15T12:42:33.769+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769144064)[INFO ] ++ reconnected session: username usr1, display :11.0, session_pid 3526, ip 172.16.51.68:50662 - socket: 8
2014-12-15T12:42:33.770+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769144064)[INFO ] An established connection closed to endpoint: 127.0.0.1:46705 - socket: 8

The process tree looks like this:

    1  8209  8194  1670 ?           -1 S       0:00 /usr/sbin/xrdp
 8209  3500  8194  1670 ?           -1 S       0:30  \_ /usr/sbin/xrdp
 8209 13964  8194  1670 ?           -1 S       0:00  \_ /usr/sbin/xrdp
    1  8213  8194  1670 ?           -1 S       0:00 /usr/sbin/xrdp-sesman
 8213  3526  8194  1670 ?           -1 S       0:00  \_ /usr/sbin/xrdp-sessvc 3528 3527
 3526  3527  8194  1670 ?           -1 S       0:00      \_ /usr/sbin/xrdp-sesman
 3527  3531  8194  1670 ?           -1 S       0:00      |   \_ /usr/bin/ck-xinit-session /usr/bin/ssh-agent /etc/X11/xinit/Xclients
 3531  3579  8194  1670 ?           -1 Sl      0:00      |       \_ /usr/bin/gnome-session
 3579  3580  3580  3580 ?           -1 Ss      0:00      |           \_ /usr/bin/ssh-agent /etc/X11/xinit/Xclients
 3579  3607  8194  1670 ?           -1 S       0:00      |           \_ metacity
 3579  3612  8194  1670 ?           -1 S       0:02      |           \_ gnome-panel
 3579  3622  8194  1670 ?           -1 S       0:15      |           \_ nautilus
 3579  3628  8194  1670 ?           -1 S       0:00      |           \_ /usr/libexec/polkit-gnome-authentication-agent-1
 3526  3528  8194  1670 ?           -1 S       0:44      \_ X11rdp :11 -geometry 1600x900 -depth 24 -bs -ac -nolisten tcp -uds
 3526  3532  8194  1670 ?           -1 Sl      0:00      \_ xrdp-chansrv


xrdp.ini content looks like this

[globals]
# xrdp.ini file version number
ini_version=1

bitmap_cache=yes
bitmap_compression=yes
port=3389
crypt_level=high
allow_channels=true
max_bpp=24
fork=yes

# regulate if the listening socket use socket option tcp_nodelay
# no buffering will be performed in the TCP stack
tcp_nodelay=yes

# regulate if the listening socket use socket option keepalive
# if the network connection disappear without close messages the connection will be closed
tcp_keepalive=yes

#tcp_send_buffer_bytes=32768
#tcp_recv_buffer_bytes=32768

# when true, userid/password *must* be passed on cmd line
# require_credentials=yes

bulk_compression=yes

# You can set the PAM error text in a gateway setup (MAX 256 chars)
#pamerrortxt=change your password according to policy at http://url
#new_cursors=no
#nego_sec_layer=0
allow_multimon=true

#
# configure login screen
#

# top level window background color in RGB format
ls_top_window_bg_color=003399

# width and height of login screen
ls_width=350
ls_height=430

# login screen background color in RGB format
ls_bg_color=ffffff

# logo
ls_logo_filename=/usr/share/logo.bmp
ls_logo_x_pos=35
ls_logo_y_pos=55

# for positioning labels such as username, password etc
ls_label_x_pos=30
ls_label_width=60

# for positioning text and combo boxes next to above labels
ls_input_x_pos=110
ls_input_width=210

# y pos for first label and combo box
ls_input_y_pos=220

# OK button
ls_btn_ok_x_pos=142
ls_btn_ok_y_pos=370
ls_btn_ok_width=85
ls_btn_ok_height=30

# Cancel button
ls_btn_cancel_x_pos=237
ls_btn_cancel_y_pos=370
ls_btn_cancel_width=85
ls_btn_cancel_height=30

[Logging]
EnableSyslog=1
SyslogLevel=DEBUG

[channels]
# Channel names not listed here will be blocked by XRDP.
# You can block any channel by setting its value to false.
# IMPORTANT! All channels are not supported in all use
# cases even if you set all values to true.
# You can override these settings on each session type
# These settings are only used if allow_channels=true
rdpdr=true
rdpsnd=true
drdynvc=true
cliprdr=true
rail=true
xrdpvr=true

# for debugging xrdp, in section xrdp1, change port=-1 to this:
# port=/tmp/.xrdp/xrdp_display_10

# for debugging xrdp, add following line to section xrdp1
# chansrvport=/tmp/.xrdp/xrdp_chansrv_socket_7210

[xrdp1]
name=sesman-X11rdp
lib=libxup.so
username=ask
password=ask
ip=127.0.0.1
port=-1
xserverbpp=24
code=10

# You can override the common channel settings for each session type
#channel.rdpdr=true
#channel.rdpsnd=true
#channel.drdynvc=true
#channel.cliprdr=true
#channel.rail=true
#channel.xrdpvr=true


Content of sesman.ini:

[Globals]
ListenAddress=127.0.0.1
ListenPort=3350
EnableUserWindowManager=1
UserWindowManager=startwm.sh
DefaultWindowManager=startwm.sh

[Security]
AllowRootLogin=1
MaxLoginRetry=4
TerminalServerUsers=tsusers
TerminalServerAdmins=tsadmins
# When AlwaysGroupCheck = false access will be permitted
# if the group TerminalServerUsers is not defined.
AlwaysGroupCheck = false

[Sessions]
X11DisplayOffset=10
MaxSessions=50
# if 1, true, or yes, kill session after 60 seconds
KillDisconnected=0
# if not zero, the seconds without mouse or keyboard input before disconnect
# not complete yet
IdleTimeLimit=0
# if not zero, the seconds before a disconnected session is killed
# min 60 seconds
DisconnectedTimeLimit=0

[Logging]
EnableSyslog=1
SyslogLevel=DEBUG

[X11rdp]
param1=-bs
param2=-ac
param3=-nolisten
param4=tcp
param5=-uds

[Xvnc]
param1=-bs
param2=-ac
param3=-nolisten
param4=tcp
param5=-localhost
param6=-dpi
param7=96

[Chansrv]
# drive redirection, defaults to xrdp_client if not set
FuseMountName=thinclient_drives


I have to kill the X11rdp thats making trouble and a new Session is created. It is not possible to reconnect to this session any more.
Is there any info i can provide to make debugging easier?

Used software is xrdp 0.8.0 running on rhel6.3. Connected via Windows 7 RDP client.


BR,
Lionel

------------------------------------------------------------------------------
Download BIRT iHub F-Type - The Free Enterprise-Grade BIRT Server
from Actuate! Instantly Supercharge Your Business Reports and Dashboards
with Interactivity, Sharing, Native Excel Exports, App Integration & more
Get technology previously reserved for billion-dollar corporations, FREE
http://pubads.g.doubleclick.net/gampad/clk?id=164703151&iu=/4140/ostg.clktrk
_______________________________________________
xrdp-devel mailing list
[hidden email]
https://lists.sourceforge.net/lists/listinfo/xrdp-devel
Reply | Threaded
Open this post in threaded view
|  
Report Content as Inappropriate

Re: [Xrdp-devel] reconnection to X11rdp occasionally fails

Lionel Rocket
Hello,

Another occurrence now shows failing connects:

2014-12-16T15:33:42.274+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769365440)[INFO ] A connection received from: 127.0.0.1 port 43983
2014-12-16T15:33:42.274+01:00 srv1 XRDP[7005] debug: (7005)(140019385399232)[DEBUG] returnvalue from xrdp_mm_connect 0
2014-12-16T15:33:42.274+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769365440)[INFO ] scp thread on sck 8 started successfully
2014-12-16T15:33:42.276+01:00 srv1 XRDP-sesman[8213] notice: pam_unix(xrdp-sesman:auth): authentication failure; logname= uid=0 euid=0 tty= ruser= rhost=  user=usr1
2014-12-16T15:33:42.284+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769144064)[INFO ] ++ reconnected session: username usr1, display :12.0, session_pid 15489, ip 172.xx.xx.xx:56097 - socket: 8
2014-12-16T15:33:42.285+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769144064)[INFO ] An established connection closed to endpoint: 127.0.0.1:43983 - socket: 8
2014-12-16T15:33:42.286+01:00 srv1 XRDP[7005] info: (7005)(140019385399232)[INFO ] lib_mod_log_peer: xrdp_pid=7005 connected to X11rdp_pid=15491 X11rdp_uid=20991 X11rdp_gid=2991 client_ip=172.xx.xx.xx client_port=56097
2014-12-16T15:33:43.286+01:00 srv1 XRDP[7005] err: (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: connect failed trying again...
2014-12-16T15:33:43.286+01:00 srv1 XRDP[7005] info: (7005)(140019385399232)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 13
2014-12-16T15:33:44.287+01:00 srv1 XRDP[7005] err: (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: connect failed trying again...
2014-12-16T15:33:44.287+01:00 srv1 XRDP[7005] info: (7005)(140019385399232)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 13
2014-12-16T15:33:45.287+01:00 srv1 XRDP[7005] err: (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: connect failed trying again...
2014-12-16T15:33:45.287+01:00 srv1 XRDP[7005] info: (7005)(140019385399232)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 13
2014-12-16T15:33:46.288+01:00 srv1 XRDP[7005] err: (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: connect failed trying again...
2014-12-16T15:33:46.288+01:00 srv1 XRDP[7005] err: (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: error intrans_connect chan
2014-12-16T15:33:46.288+01:00 srv1 XRDP[7005] info: (7005)(140019385399232)[INFO ] An established connection closed to endpoint: 127.0.0.1:3350 - socket: 11

any ideas that i can try?


BR,
Lionel

On Mon, Dec 15, 2014 at 3:28 PM, Lionel Rocket <[hidden email]> wrote:
Hello,

I'm having problems reconnecting to X11rdp sessions. I can't reproduce this but its occurring quite often.

Log output shows only the following lines, it finds the correct X11rdp session on display 11 but after that it immediately closes the connection and the Microsoft RDP client freezes.

2014-12-15T12:42:33.759+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769365440)[INFO ] A connection received from: 127.0.0.1 port 46705
2014-12-15T12:42:33.759+01:00 srv1 XRDP[25753] debug: (25753)(140019385399232)[DEBUG] returnvalue from xrdp_mm_connect 0
2014-12-15T12:42:33.759+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769365440)[INFO ] scp thread on sck 8 started successfully
2014-12-15T12:42:33.760+01:00 srv1 XRDP-sesman[8213] notice: pam_unix(xrdp-sesman:auth): authentication failure; logname= uid=0 euid=0 tty= ruser= rhost=  user=usr1
2014-12-15T12:42:33.769+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769144064)[INFO ] ++ reconnected session: username usr1, display :11.0, session_pid 3526, ip 172.16.51.68:50662 - socket: 8
2014-12-15T12:42:33.770+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769144064)[INFO ] An established connection closed to endpoint: 127.0.0.1:46705 - socket: 8

The process tree looks like this:

    1  8209  8194  1670 ?           -1 S       0:00 /usr/sbin/xrdp
 8209  3500  8194  1670 ?           -1 S       0:30  \_ /usr/sbin/xrdp
 8209 13964  8194  1670 ?           -1 S       0:00  \_ /usr/sbin/xrdp
    1  8213  8194  1670 ?           -1 S       0:00 /usr/sbin/xrdp-sesman
 8213  3526  8194  1670 ?           -1 S       0:00  \_ /usr/sbin/xrdp-sessvc 3528 3527
 3526  3527  8194  1670 ?           -1 S       0:00      \_ /usr/sbin/xrdp-sesman
 3527  3531  8194  1670 ?           -1 S       0:00      |   \_ /usr/bin/ck-xinit-session /usr/bin/ssh-agent /etc/X11/xinit/Xclients
 3531  3579  8194  1670 ?           -1 Sl      0:00      |       \_ /usr/bin/gnome-session
 3579  3580  3580  3580 ?           -1 Ss      0:00      |           \_ /usr/bin/ssh-agent /etc/X11/xinit/Xclients
 3579  3607  8194  1670 ?           -1 S       0:00      |           \_ metacity
 3579  3612  8194  1670 ?           -1 S       0:02      |           \_ gnome-panel
 3579  3622  8194  1670 ?           -1 S       0:15      |           \_ nautilus
 3579  3628  8194  1670 ?           -1 S       0:00      |           \_ /usr/libexec/polkit-gnome-authentication-agent-1
 3526  3528  8194  1670 ?           -1 S       0:44      \_ X11rdp :11 -geometry 1600x900 -depth 24 -bs -ac -nolisten tcp -uds
 3526  3532  8194  1670 ?           -1 Sl      0:00      \_ xrdp-chansrv


xrdp.ini content looks like this

[globals]
# xrdp.ini file version number
ini_version=1

bitmap_cache=yes
bitmap_compression=yes
port=3389
crypt_level=high
allow_channels=true
max_bpp=24
fork=yes

# regulate if the listening socket use socket option tcp_nodelay
# no buffering will be performed in the TCP stack
tcp_nodelay=yes

# regulate if the listening socket use socket option keepalive
# if the network connection disappear without close messages the connection will be closed
tcp_keepalive=yes

#tcp_send_buffer_bytes=32768
#tcp_recv_buffer_bytes=32768

# when true, userid/password *must* be passed on cmd line
# require_credentials=yes

bulk_compression=yes

# You can set the PAM error text in a gateway setup (MAX 256 chars)
#pamerrortxt=change your password according to policy at http://url
#new_cursors=no
#nego_sec_layer=0
allow_multimon=true

#
# configure login screen
#

# top level window background color in RGB format
ls_top_window_bg_color=003399

# width and height of login screen
ls_width=350
ls_height=430

# login screen background color in RGB format
ls_bg_color=ffffff

# logo
ls_logo_filename=/usr/share/logo.bmp
ls_logo_x_pos=35
ls_logo_y_pos=55

# for positioning labels such as username, password etc
ls_label_x_pos=30
ls_label_width=60

# for positioning text and combo boxes next to above labels
ls_input_x_pos=110
ls_input_width=210

# y pos for first label and combo box
ls_input_y_pos=220

# OK button
ls_btn_ok_x_pos=142
ls_btn_ok_y_pos=370
ls_btn_ok_width=85
ls_btn_ok_height=30

# Cancel button
ls_btn_cancel_x_pos=237
ls_btn_cancel_y_pos=370
ls_btn_cancel_width=85
ls_btn_cancel_height=30

[Logging]
EnableSyslog=1
SyslogLevel=DEBUG

[channels]
# Channel names not listed here will be blocked by XRDP.
# You can block any channel by setting its value to false.
# IMPORTANT! All channels are not supported in all use
# cases even if you set all values to true.
# You can override these settings on each session type
# These settings are only used if allow_channels=true
rdpdr=true
rdpsnd=true
drdynvc=true
cliprdr=true
rail=true
xrdpvr=true

# for debugging xrdp, in section xrdp1, change port=-1 to this:
# port=/tmp/.xrdp/xrdp_display_10

# for debugging xrdp, add following line to section xrdp1
# chansrvport=/tmp/.xrdp/xrdp_chansrv_socket_7210

[xrdp1]
name=sesman-X11rdp
lib=libxup.so
username=ask
password=ask
ip=127.0.0.1
port=-1
xserverbpp=24
code=10

# You can override the common channel settings for each session type
#channel.rdpdr=true
#channel.rdpsnd=true
#channel.drdynvc=true
#channel.cliprdr=true
#channel.rail=true
#channel.xrdpvr=true


Content of sesman.ini:

[Globals]
ListenAddress=127.0.0.1
ListenPort=3350
EnableUserWindowManager=1
UserWindowManager=startwm.sh
DefaultWindowManager=startwm.sh

[Security]
AllowRootLogin=1
MaxLoginRetry=4
TerminalServerUsers=tsusers
TerminalServerAdmins=tsadmins
# When AlwaysGroupCheck = false access will be permitted
# if the group TerminalServerUsers is not defined.
AlwaysGroupCheck = false

[Sessions]
X11DisplayOffset=10
MaxSessions=50
# if 1, true, or yes, kill session after 60 seconds
KillDisconnected=0
# if not zero, the seconds without mouse or keyboard input before disconnect
# not complete yet
IdleTimeLimit=0
# if not zero, the seconds before a disconnected session is killed
# min 60 seconds
DisconnectedTimeLimit=0

[Logging]
EnableSyslog=1
SyslogLevel=DEBUG

[X11rdp]
param1=-bs
param2=-ac
param3=-nolisten
param4=tcp
param5=-uds

[Xvnc]
param1=-bs
param2=-ac
param3=-nolisten
param4=tcp
param5=-localhost
param6=-dpi
param7=96

[Chansrv]
# drive redirection, defaults to xrdp_client if not set
FuseMountName=thinclient_drives


I have to kill the X11rdp thats making trouble and a new Session is created. It is not possible to reconnect to this session any more.
Is there any info i can provide to make debugging easier?

Used software is xrdp 0.8.0 running on rhel6.3. Connected via Windows 7 RDP client.


BR,
Lionel

------------------------------------------------------------------------------
Download BIRT iHub F-Type - The Free Enterprise-Grade BIRT Server
from Actuate! Instantly Supercharge Your Business Reports and Dashboards
with Interactivity, Sharing, Native Excel Exports, App Integration & more
Get technology previously reserved for billion-dollar corporations, FREE
http://pubads.g.doubleclick.net/gampad/clk?id=164703151&iu=/4140/ostg.clktrk
_______________________________________________
xrdp-devel mailing list
[hidden email]
https://lists.sourceforge.net/lists/listinfo/xrdp-devel
Reply | Threaded
Open this post in threaded view
|  
Report Content as Inappropriate

[Xrdp-devel] Fwd: reconnection to X11rdp occasionally fails

Lionel Rocket
Hi everyone!

i think i got a little bit farther by disabling channels in the xrdp.ini file.
but now starting the X11rdp session occasionaly times out. im having a hard time investigating here because i can not reproduce the issue and after some time it starts working again. so now i found something that might be an indicator why the X11rdp session times out.

so first, connecting to sesman, channels are disabled:

10:52:45.205 srv1 XRDP[932] info: (932)(140270395066304)[INFO ] A connection received from: 192.xx.xx.xx port 52860
10:52:45.206 srv1 XRDP[932] info: (932)(140270395066304)[INFO ] An established connection closed to endpoint: 192.xx.xx.xx:52860 - socket: 8
10:52:45.206 srv1 XRDP[13257] info: (13257)(140270395066304)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 7
10:52:45.207 srv1 XRDP[13257] debug: (13257)(140270395066304)[DEBUG] Info - All channels are disabled
10:52:45.240 srv1 XRDP[13257] info: (13257)(140270395066304)[INFO ] An established connection closed to endpoint: 192.xx.xx.xx:52860 - socket: 8
10:52:45.355 srv1 XRDP[932] info: (932)(140270395066304)[INFO ] A connection received from: 192.xx.xx.xx port 52861
10:52:45.355 srv1 XRDP[932] info: (932)(140270395066304)[INFO ] An established connection closed to endpoint: 192.xx.xx.xx:52861 - socket: 8
10:52:45.356 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 7
10:52:45.356 srv1 XRDP[13258] debug: (13258)(140270395066304)[DEBUG] Info - All channels are disabled
10:52:45.800 srv1 XRDP[13258] debug: (13258)(140270395066304)[DEBUG] xrdp_000033ca_wm_login_mode_event_00000001
10:52:45.805 srv1 XRDP[13258] warning: (13258)(140270395066304)[WARN ] local keymap file for 0x0409 found and dosen't match built in keymap, using local keymap file


then logging in with ldap user, some connection at socket 12 is tried to be closed some times

10:53:20.142 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] A connection received from: 127.0.0.1 port 60721
10:53:20.142 srv1 XRDP[13258] debug: (13258)(140270395066304)[DEBUG] returnvalue from xrdp_mm_connect 0
10:53:20.142 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] scp thread on sck 8 started successfully
10:53:20.144 srv1 XRDP-sesman[936] notice: pam_unix(xrdp-sesman:auth): authentication failure; logname= uid=0 euid=0 tty= ruser= rhost=  user=usr1
10:53:20.152 srv1 XRDP-sesman[936] info: (936)(139898864195328)[INFO ] ++ created session (access granted): username usr1, ip 192.xx.xx.xx:52861 - socket: 8
10:53:20.152 srv1 XRDP-sesman[936] info: (936)(139898864195328)[INFO ] starting X11rdp session...
10:53:20.152 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 14
10:53:20.152 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 14
10:53:20.153 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 14
10:53:20.153 srv1 XRDP-sesman[936] info: (936)(139898864195328)[INFO ] An established connection closed to endpoint: 127.0.0.1:60721 - socket: 8
10:53:20.153 srv1 XRDP-sesman[14290] info: (14290)(139898864416704)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 7
10:53:20.154 srv1 XRDP-sesman[14290] info: (14290)(139898864416704)[INFO ] An established connection closed to endpoint: 127.0.0.1:60721 - socket: 8
10:53:20.154 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 12
10:53:20.155 srv1 XRDP-sesman[14293] info: (14293)(139898864416704)[INFO ] X11rdp start:X11rdp :10 -geometry 1024x768 -depth 24 -bs -ac -nolisten tcp -uds
10:53:20.654 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 12
10:53:21.154 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 12


then the X11rdp session timeout is logged and connection at socket 12 ist tried to be closed some more

10:53:29.159 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 12
10:53:29.659 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 12
10:53:29.918 srv1 XRDP-sesman[14290] err: (14290)(139898864416704)[ERROR] X server for display 10 startup timeout
10:53:29.918 srv1 XRDP-sesman[14290] info: (14290)(139898864416704)[INFO ] starting xrdp-sessvc - xpid=14293 - wmpid=14292
10:53:30.159 srv1 XRDP-sesman[14292] err: (14292)(139898864416704)[ERROR] X server for display 10 startup timeout
10:53:30.159 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 12
10:53:30.160 srv1 XRDP-sesman[14292] info: pam_unix(xrdp-sesman:session): session opened for user usr1 by (uid=0)
10:53:30.162 srv1 XRDP-sesman[14799] err: (14799)(139898864416704)[ERROR] another Xserver might already be active on display 10 - see log
10:53:30.162 srv1 XRDP-sesman[14799] debug: (14799)(139898864416704)[DEBUG] aborting connection...
10:53:30.162 srv1 XRDP-sesman[14292] info: pam_unix(xrdp-sesman:session): session closed for user usr1
10:53:30.164 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] ++ terminated session:  username usr1, display :10.0, session_pid 14290, ip 192.xx.xx.xx:52861 - socket: 8
10:53:30.660 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 12
10:53:31.160 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 12


and finally, it gives up

10:53:29.159 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 12
10:53:29.659 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 12
10:53:29.918 srv1 XRDP-sesman[14290] err: (14290)(139898864416704)[ERROR] X server for display 10 startup timeout
10:53:29.918 srv1 XRDP-sesman[14290] info: (14290)(139898864416704)[INFO ] starting xrdp-sessvc - xpid=14293 - wmpid=14292
10:53:30.159 srv1 XRDP-sesman[14292] err: (14292)(139898864416704)[ERROR] X server for display 10 startup timeout
10:53:30.159 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 12
10:53:30.160 srv1 XRDP-sesman[14292] info: pam_unix(xrdp-sesman:session): session opened for user usr1 by (uid=0)
10:53:30.162 srv1 XRDP-sesman[14799] err: (14799)(139898864416704)[ERROR] another Xserver might already be active on display 10 - see log
10:53:30.162 srv1 XRDP-sesman[14799] debug: (14799)(139898864416704)[DEBUG] aborting connection...
10:53:30.162 srv1 XRDP-sesman[14292] info: pam_unix(xrdp-sesman:session): session closed for user usr1
10:53:30.164 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] ++ terminated session:  username usr1, display :10.0, session_pid 14290, ip 192.xx.xx.xx:52861 - socket: 8
10:53:30.660 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 12
10:53:31.160 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 12


i then looked into the process list and didn't see any X11rdp process so i tried to start one by hand. it didn't start with the following errors.
after some time the command worked, the X11rdp session started. I stopped it on the command line and tried via win7 rdp client and it worked again.

[root@srv1 ~]# X11rdp :10 -geometry 1024x768 -depth 24 -bs -ac -nolisten tcp -uds
InitOutput:

X11rdp, an X server for xrdp
Version 0.7.0
Copyright (C) 2005-2012 Jay Sorg
See http://xrdp.sf.net for information on xrdp.
Underlying X server release 10903000, The X.Org Foundation
Screen width 1024 height 768 depth 24 bpp 32
dpix 100 dpiy 100
buffer size 3145728
rdpup_init: g_tcp_local_bind failed
rdpScreenInit: rdpup_init failed
pRRScrPriv 0x244f820
rdpScreenInit: ret 0

Fatal server error:
Couldn't add screen

ddxGiveUp:


Can anyone give me a hint where i have to look for those X11rdp startup errors?


BR,
Lionel


---------- Forwarded message ----------
From: Lionel Rocket <[hidden email]>
Date: Tue, Dec 16, 2014 at 3:58 PM
Subject: Re: reconnection to X11rdp occasionally fails
To: [hidden email]


Hello,

Another occurrence now shows failing connects:

2014-12-16T15:33:42.274+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769365440)[INFO ] A connection received from: 127.0.0.1 port 43983
2014-12-16T15:33:42.274+01:00 srv1 XRDP[7005] debug: (7005)(140019385399232)[DEBUG] returnvalue from xrdp_mm_connect 0
2014-12-16T15:33:42.274+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769365440)[INFO ] scp thread on sck 8 started successfully
2014-12-16T15:33:42.276+01:00 srv1 XRDP-sesman[8213] notice: pam_unix(xrdp-sesman:auth): authentication failure; logname= uid=0 euid=0 tty= ruser= rhost=  user=usr1
2014-12-16T15:33:42.284+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769144064)[INFO ] ++ reconnected session: username usr1, display :12.0, session_pid 15489, ip 172.xx.xx.xx:56097 - socket: 8
2014-12-16T15:33:42.285+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769144064)[INFO ] An established connection closed to endpoint: 127.0.0.1:43983 - socket: 8
2014-12-16T15:33:42.286+01:00 srv1 XRDP[7005] info: (7005)(140019385399232)[INFO ] lib_mod_log_peer: xrdp_pid=7005 connected to X11rdp_pid=15491 X11rdp_uid=20991 X11rdp_gid=2991 client_ip=172.xx.xx.xx client_port=56097
2014-12-16T15:33:43.286+01:00 srv1 XRDP[7005] err: (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: connect failed trying again...
2014-12-16T15:33:43.286+01:00 srv1 XRDP[7005] info: (7005)(140019385399232)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 13
2014-12-16T15:33:44.287+01:00 srv1 XRDP[7005] err: (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: connect failed trying again...
2014-12-16T15:33:44.287+01:00 srv1 XRDP[7005] info: (7005)(140019385399232)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 13
2014-12-16T15:33:45.287+01:00 srv1 XRDP[7005] err: (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: connect failed trying again...
2014-12-16T15:33:45.287+01:00 srv1 XRDP[7005] info: (7005)(140019385399232)[INFO ] An established connection closed to endpoint: NULL:NULL - socket: 13
2014-12-16T15:33:46.288+01:00 srv1 XRDP[7005] err: (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: connect failed trying again...
2014-12-16T15:33:46.288+01:00 srv1 XRDP[7005] err: (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: error intrans_connect chan
2014-12-16T15:33:46.288+01:00 srv1 XRDP[7005] info: (7005)(140019385399232)[INFO ] An established connection closed to endpoint: 127.0.0.1:3350 - socket: 11

any ideas that i can try?


BR,
Lionel


On Mon, Dec 15, 2014 at 3:28 PM, Lionel Rocket <[hidden email]> wrote:
Hello,

I'm having problems reconnecting to X11rdp sessions. I can't reproduce this but its occurring quite often.

Log output shows only the following lines, it finds the correct X11rdp session on display 11 but after that it immediately closes the connection and the Microsoft RDP client freezes.

2014-12-15T12:42:33.759+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769365440)[INFO ] A connection received from: 127.0.0.1 port 46705
2014-12-15T12:42:33.759+01:00 srv1 XRDP[25753] debug: (25753)(140019385399232)[DEBUG] returnvalue from xrdp_mm_connect 0
2014-12-15T12:42:33.759+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769365440)[INFO ] scp thread on sck 8 started successfully
2014-12-15T12:42:33.760+01:00 srv1 XRDP-sesman[8213] notice: pam_unix(xrdp-sesman:auth): authentication failure; logname= uid=0 euid=0 tty= ruser= rhost=  user=usr1
2014-12-15T12:42:33.769+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769144064)[INFO ] ++ reconnected session: username usr1, display :11.0, session_pid 3526, ip 172.16.51.68:50662 - socket: 8
2014-12-15T12:42:33.770+01:00 srv1 XRDP-sesman[8213] info: (8213)(140565769144064)[INFO ] An established connection closed to endpoint: 127.0.0.1:46705 - socket: 8

The process tree looks like this:

    1  8209  8194  1670 ?           -1 S       0:00 /usr/sbin/xrdp
 8209  3500  8194  1670 ?           -1 S       0:30  \_ /usr/sbin/xrdp
 8209 13964  8194  1670 ?           -1 S       0:00  \_ /usr/sbin/xrdp
    1  8213  8194  1670 ?           -1 S       0:00 /usr/sbin/xrdp-sesman
 8213  3526  8194  1670 ?           -1 S       0:00  \_ /usr/sbin/xrdp-sessvc 3528 3527
 3526  3527  8194  1670 ?           -1 S       0:00      \_ /usr/sbin/xrdp-sesman
 3527  3531  8194  1670 ?           -1 S       0:00      |   \_ /usr/bin/ck-xinit-session /usr/bin/ssh-agent /etc/X11/xinit/Xclients
 3531  3579  8194  1670 ?           -1 Sl      0:00      |       \_ /usr/bin/gnome-session
 3579  3580  3580  3580 ?           -1 Ss      0:00      |           \_ /usr/bin/ssh-agent /etc/X11/xinit/Xclients
 3579  3607  8194  1670 ?           -1 S       0:00      |           \_ metacity
 3579  3612  8194  1670 ?           -1 S       0:02      |           \_ gnome-panel
 3579  3622  8194  1670 ?           -1 S       0:15      |           \_ nautilus
 3579  3628  8194  1670 ?           -1 S       0:00      |           \_ /usr/libexec/polkit-gnome-authentication-agent-1
 3526  3528  8194  1670 ?           -1 S       0:44      \_ X11rdp :11 -geometry 1600x900 -depth 24 -bs -ac -nolisten tcp -uds
 3526  3532  8194  1670 ?           -1 Sl      0:00      \_ xrdp-chansrv


xrdp.ini content looks like this

[globals]
# xrdp.ini file version number
ini_version=1

bitmap_cache=yes
bitmap_compression=yes
port=3389
crypt_level=high
allow_channels=true
max_bpp=24
fork=yes

# regulate if the listening socket use socket option tcp_nodelay
# no buffering will be performed in the TCP stack
tcp_nodelay=yes

# regulate if the listening socket use socket option keepalive
# if the network connection disappear without close messages the connection will be closed
tcp_keepalive=yes

#tcp_send_buffer_bytes=32768
#tcp_recv_buffer_bytes=32768

# when true, userid/password *must* be passed on cmd line
# require_credentials=yes

bulk_compression=yes

# You can set the PAM error text in a gateway setup (MAX 256 chars)
#pamerrortxt=change your password according to policy at http://url
#new_cursors=no
#nego_sec_layer=0
allow_multimon=true

#
# configure login screen
#

# top level window background color in RGB format
ls_top_window_bg_color=003399

# width and height of login screen
ls_width=350
ls_height=430

# login screen background color in RGB format
ls_bg_color=ffffff

# logo
ls_logo_filename=/usr/share/logo.bmp
ls_logo_x_pos=35
ls_logo_y_pos=55

# for positioning labels such as username, password etc
ls_label_x_pos=30
ls_label_width=60

# for positioning text and combo boxes next to above labels
ls_input_x_pos=110
ls_input_width=210

# y pos for first label and combo box
ls_input_y_pos=220

# OK button
ls_btn_ok_x_pos=142
ls_btn_ok_y_pos=370
ls_btn_ok_width=85
ls_btn_ok_height=30

# Cancel button
ls_btn_cancel_x_pos=237
ls_btn_cancel_y_pos=370
ls_btn_cancel_width=85
ls_btn_cancel_height=30

[Logging]
EnableSyslog=1
SyslogLevel=DEBUG

[channels]
# Channel names not listed here will be blocked by XRDP.
# You can block any channel by setting its value to false.
# IMPORTANT! All channels are not supported in all use
# cases even if you set all values to true.
# You can override these settings on each session type
# These settings are only used if allow_channels=true
rdpdr=true
rdpsnd=true
drdynvc=true
cliprdr=true
rail=true
xrdpvr=true

# for debugging xrdp, in section xrdp1, change port=-1 to this:
# port=/tmp/.xrdp/xrdp_display_10

# for debugging xrdp, add following line to section xrdp1
# chansrvport=/tmp/.xrdp/xrdp_chansrv_socket_7210

[xrdp1]
name=sesman-X11rdp
lib=libxup.so
username=ask
password=ask
ip=127.0.0.1
port=-1
xserverbpp=24
code=10

# You can override the common channel settings for each session type
#channel.rdpdr=true
#channel.rdpsnd=true
#channel.drdynvc=true
#channel.cliprdr=true
#channel.rail=true
#channel.xrdpvr=true


Content of sesman.ini:

[Globals]
ListenAddress=127.0.0.1
ListenPort=3350
EnableUserWindowManager=1
UserWindowManager=startwm.sh
DefaultWindowManager=startwm.sh

[Security]
AllowRootLogin=1
MaxLoginRetry=4
TerminalServerUsers=tsusers
TerminalServerAdmins=tsadmins
# When AlwaysGroupCheck = false access will be permitted
# if the group TerminalServerUsers is not defined.
AlwaysGroupCheck = false

[Sessions]
X11DisplayOffset=10
MaxSessions=50
# if 1, true, or yes, kill session after 60 seconds
KillDisconnected=0
# if not zero, the seconds without mouse or keyboard input before disconnect
# not complete yet
IdleTimeLimit=0
# if not zero, the seconds before a disconnected session is killed
# min 60 seconds
DisconnectedTimeLimit=0

[Logging]
EnableSyslog=1
SyslogLevel=DEBUG

[X11rdp]
param1=-bs
param2=-ac
param3=-nolisten
param4=tcp
param5=-uds

[Xvnc]
param1=-bs
param2=-ac
param3=-nolisten
param4=tcp
param5=-localhost
param6=-dpi
param7=96

[Chansrv]
# drive redirection, defaults to xrdp_client if not set
FuseMountName=thinclient_drives


I have to kill the X11rdp thats making trouble and a new Session is created. It is not possible to reconnect to this session any more.
Is there any info i can provide to make debugging easier?

Used software is xrdp 0.8.0 running on rhel6.3. Connected via Windows 7 RDP client.


BR,
Lionel


------------------------------------------------------------------------------
Dive into the World of Parallel Programming. The Go Parallel Website,
sponsored by Intel and developed in partnership with Slashdot Media, is your
hub for all things parallel software development, from weekly thought
leadership blogs to news, videos, case studies, tutorials and more. Take a
look and join the conversation now. http://goparallel.sourceforge.net/
_______________________________________________
xrdp-devel mailing list
[hidden email]
https://lists.sourceforge.net/lists/listinfo/xrdp-devel
Reply | Threaded
Open this post in threaded view
|  
Report Content as Inappropriate

Re: [Xrdp-devel] Fwd: reconnection to X11rdp occasionally fails

jsorg71
Oh, it looks like a file /tmp/.xrdp/xrdp_display_10 already exists or
is owned by someone else.
sesman should be looking for that file and use a different display if it exists.

Can you check whats in /tmp/.xrdp/ ?

Jay


On Fri, Feb 6, 2015 at 2:16 AM, Lionel Rocket <[hidden email]> wrote:

> Hi everyone!
>
> i think i got a little bit farther by disabling channels in the xrdp.ini
> file.
> but now starting the X11rdp session occasionaly times out. im having a hard
> time investigating here because i can not reproduce the issue and after some
> time it starts working again. so now i found something that might be an
> indicator why the X11rdp session times out.
>
> so first, connecting to sesman, channels are disabled:
>
> 10:52:45.205 srv1 XRDP[932] info: (932)(140270395066304)[INFO ] A connection
> received from: 192.xx.xx.xx port 52860
> 10:52:45.206 srv1 XRDP[932] info: (932)(140270395066304)[INFO ] An
> established connection closed to endpoint: 192.xx.xx.xx:52860 - socket: 8
> 10:52:45.206 srv1 XRDP[13257] info: (13257)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 7
> 10:52:45.207 srv1 XRDP[13257] debug: (13257)(140270395066304)[DEBUG] Info -
> All channels are disabled
> 10:52:45.240 srv1 XRDP[13257] info: (13257)(140270395066304)[INFO ] An
> established connection closed to endpoint: 192.xx.xx.xx:52860 - socket: 8
> 10:52:45.355 srv1 XRDP[932] info: (932)(140270395066304)[INFO ] A connection
> received from: 192.xx.xx.xx port 52861
> 10:52:45.355 srv1 XRDP[932] info: (932)(140270395066304)[INFO ] An
> established connection closed to endpoint: 192.xx.xx.xx:52861 - socket: 8
> 10:52:45.356 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 7
> 10:52:45.356 srv1 XRDP[13258] debug: (13258)(140270395066304)[DEBUG] Info -
> All channels are disabled
> 10:52:45.800 srv1 XRDP[13258] debug: (13258)(140270395066304)[DEBUG]
> xrdp_000033ca_wm_login_mode_event_00000001
> 10:52:45.805 srv1 XRDP[13258] warning: (13258)(140270395066304)[WARN ] local
> keymap file for 0x0409 found and dosen't match built in keymap, using local
> keymap file
>
>
> then logging in with ldap user, some connection at socket 12 is tried to be
> closed some times
>
> 10:53:20.142 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] A
> connection received from: 127.0.0.1 port 60721
> 10:53:20.142 srv1 XRDP[13258] debug: (13258)(140270395066304)[DEBUG]
> returnvalue from xrdp_mm_connect 0
> 10:53:20.142 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] scp
> thread on sck 8 started successfully
> 10:53:20.144 srv1 XRDP-sesman[936] notice: pam_unix(xrdp-sesman:auth):
> authentication failure; logname= uid=0 euid=0 tty= ruser= rhost=  user=usr1
> 10:53:20.152 srv1 XRDP-sesman[936] info: (936)(139898864195328)[INFO ] ++
> created session (access granted): username usr1, ip 192.xx.xx.xx:52861 -
> socket: 8
> 10:53:20.152 srv1 XRDP-sesman[936] info: (936)(139898864195328)[INFO ]
> starting X11rdp session...
> 10:53:20.152 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 14
> 10:53:20.152 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 14
> 10:53:20.153 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 14
> 10:53:20.153 srv1 XRDP-sesman[936] info: (936)(139898864195328)[INFO ] An
> established connection closed to endpoint: 127.0.0.1:60721 - socket: 8
> 10:53:20.153 srv1 XRDP-sesman[14290] info: (14290)(139898864416704)[INFO ]
> An established connection closed to endpoint: NULL:NULL - socket: 7
> 10:53:20.154 srv1 XRDP-sesman[14290] info: (14290)(139898864416704)[INFO ]
> An established connection closed to endpoint: 127.0.0.1:60721 - socket: 8
> 10:53:20.154 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:20.155 srv1 XRDP-sesman[14293] info: (14293)(139898864416704)[INFO ]
> X11rdp start:X11rdp :10 -geometry 1024x768 -depth 24 -bs -ac -nolisten tcp
> -uds
> 10:53:20.654 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:21.154 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
>
>
> then the X11rdp session timeout is logged and connection at socket 12 ist
> tried to be closed some more
>
> 10:53:29.159 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:29.659 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:29.918 srv1 XRDP-sesman[14290] err: (14290)(139898864416704)[ERROR] X
> server for display 10 startup timeout
> 10:53:29.918 srv1 XRDP-sesman[14290] info: (14290)(139898864416704)[INFO ]
> starting xrdp-sessvc - xpid=14293 - wmpid=14292
> 10:53:30.159 srv1 XRDP-sesman[14292] err: (14292)(139898864416704)[ERROR] X
> server for display 10 startup timeout
> 10:53:30.159 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:30.160 srv1 XRDP-sesman[14292] info: pam_unix(xrdp-sesman:session):
> session opened for user usr1 by (uid=0)
> 10:53:30.162 srv1 XRDP-sesman[14799] err: (14799)(139898864416704)[ERROR]
> another Xserver might already be active on display 10 - see log
> 10:53:30.162 srv1 XRDP-sesman[14799] debug: (14799)(139898864416704)[DEBUG]
> aborting connection...
> 10:53:30.162 srv1 XRDP-sesman[14292] info: pam_unix(xrdp-sesman:session):
> session closed for user usr1
> 10:53:30.164 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] ++
> terminated session:  username usr1, display :10.0, session_pid 14290, ip
> 192.xx.xx.xx:52861 - socket: 8
> 10:53:30.660 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:31.160 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
>
>
> and finally, it gives up
>
> 10:53:29.159 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:29.659 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:29.918 srv1 XRDP-sesman[14290] err: (14290)(139898864416704)[ERROR] X
> server for display 10 startup timeout
> 10:53:29.918 srv1 XRDP-sesman[14290] info: (14290)(139898864416704)[INFO ]
> starting xrdp-sessvc - xpid=14293 - wmpid=14292
> 10:53:30.159 srv1 XRDP-sesman[14292] err: (14292)(139898864416704)[ERROR] X
> server for display 10 startup timeout
> 10:53:30.159 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:30.160 srv1 XRDP-sesman[14292] info: pam_unix(xrdp-sesman:session):
> session opened for user usr1 by (uid=0)
> 10:53:30.162 srv1 XRDP-sesman[14799] err: (14799)(139898864416704)[ERROR]
> another Xserver might already be active on display 10 - see log
> 10:53:30.162 srv1 XRDP-sesman[14799] debug: (14799)(139898864416704)[DEBUG]
> aborting connection...
> 10:53:30.162 srv1 XRDP-sesman[14292] info: pam_unix(xrdp-sesman:session):
> session closed for user usr1
> 10:53:30.164 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] ++
> terminated session:  username usr1, display :10.0, session_pid 14290, ip
> 192.xx.xx.xx:52861 - socket: 8
> 10:53:30.660 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:31.160 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
>
>
> i then looked into the process list and didn't see any X11rdp process so i
> tried to start one by hand. it didn't start with the following errors.
> after some time the command worked, the X11rdp session started. I stopped it
> on the command line and tried via win7 rdp client and it worked again.
>
> [root@srv1 ~]# X11rdp :10 -geometry 1024x768 -depth 24 -bs -ac -nolisten tcp
> -uds
> InitOutput:
>
> X11rdp, an X server for xrdp
> Version 0.7.0
> Copyright (C) 2005-2012 Jay Sorg
> See http://xrdp.sf.net for information on xrdp.
> Underlying X server release 10903000, The X.Org Foundation
> Screen width 1024 height 768 depth 24 bpp 32
> dpix 100 dpiy 100
> buffer size 3145728
> rdpup_init: g_tcp_local_bind failed
> rdpScreenInit: rdpup_init failed
> pRRScrPriv 0x244f820
> rdpScreenInit: ret 0
>
> Fatal server error:
> Couldn't add screen
>
> ddxGiveUp:
>
>
> Can anyone give me a hint where i have to look for those X11rdp startup
> errors?
>
>
> BR,
> Lionel
>
>
> ---------- Forwarded message ----------
> From: Lionel Rocket <[hidden email]>
> Date: Tue, Dec 16, 2014 at 3:58 PM
> Subject: Re: reconnection to X11rdp occasionally fails
> To: [hidden email]
>
>
> Hello,
>
> Another occurrence now shows failing connects:
>
> 2014-12-16T15:33:42.274+01:00 srv1 XRDP-sesman[8213] info:
> (8213)(140565769365440)[INFO ] A connection received from: 127.0.0.1 port
> 43983
> 2014-12-16T15:33:42.274+01:00 srv1 XRDP[7005] debug:
> (7005)(140019385399232)[DEBUG] returnvalue from xrdp_mm_connect 0
> 2014-12-16T15:33:42.274+01:00 srv1 XRDP-sesman[8213] info:
> (8213)(140565769365440)[INFO ] scp thread on sck 8 started successfully
> 2014-12-16T15:33:42.276+01:00 srv1 XRDP-sesman[8213] notice:
> pam_unix(xrdp-sesman:auth): authentication failure; logname= uid=0 euid=0
> tty= ruser= rhost=  user=usr1
> 2014-12-16T15:33:42.284+01:00 srv1 XRDP-sesman[8213] info:
> (8213)(140565769144064)[INFO ] ++ reconnected session: username usr1,
> display :12.0, session_pid 15489, ip 172.xx.xx.xx:56097 - socket: 8
> 2014-12-16T15:33:42.285+01:00 srv1 XRDP-sesman[8213] info:
> (8213)(140565769144064)[INFO ] An established connection closed to endpoint:
> 127.0.0.1:43983 - socket: 8
> 2014-12-16T15:33:42.286+01:00 srv1 XRDP[7005] info:
> (7005)(140019385399232)[INFO ] lib_mod_log_peer: xrdp_pid=7005 connected to
> X11rdp_pid=15491 X11rdp_uid=20991 X11rdp_gid=2991 client_ip=172.xx.xx.xx
> client_port=56097
> 2014-12-16T15:33:43.286+01:00 srv1 XRDP[7005] err:
> (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: connect failed
> trying again...
> 2014-12-16T15:33:43.286+01:00 srv1 XRDP[7005] info:
> (7005)(140019385399232)[INFO ] An established connection closed to endpoint:
> NULL:NULL - socket: 13
> 2014-12-16T15:33:44.287+01:00 srv1 XRDP[7005] err:
> (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: connect failed
> trying again...
> 2014-12-16T15:33:44.287+01:00 srv1 XRDP[7005] info:
> (7005)(140019385399232)[INFO ] An established connection closed to endpoint:
> NULL:NULL - socket: 13
> 2014-12-16T15:33:45.287+01:00 srv1 XRDP[7005] err:
> (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: connect failed
> trying again...
> 2014-12-16T15:33:45.287+01:00 srv1 XRDP[7005] info:
> (7005)(140019385399232)[INFO ] An established connection closed to endpoint:
> NULL:NULL - socket: 13
> 2014-12-16T15:33:46.288+01:00 srv1 XRDP[7005] err:
> (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: connect failed
> trying again...
> 2014-12-16T15:33:46.288+01:00 srv1 XRDP[7005] err:
> (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: error
> intrans_connect chan
> 2014-12-16T15:33:46.288+01:00 srv1 XRDP[7005] info:
> (7005)(140019385399232)[INFO ] An established connection closed to endpoint:
> 127.0.0.1:3350 - socket: 11
>
> any ideas that i can try?
>
>
> BR,
> Lionel
>
>
> On Mon, Dec 15, 2014 at 3:28 PM, Lionel Rocket <[hidden email]>
> wrote:
>>
>> Hello,
>>
>> I'm having problems reconnecting to X11rdp sessions. I can't reproduce
>> this but its occurring quite often.
>>
>> Log output shows only the following lines, it finds the correct X11rdp
>> session on display 11 but after that it immediately closes the connection
>> and the Microsoft RDP client freezes.
>>
>> 2014-12-15T12:42:33.759+01:00 srv1 XRDP-sesman[8213] info:
>> (8213)(140565769365440)[INFO ] A connection received from: 127.0.0.1 port
>> 46705
>> 2014-12-15T12:42:33.759+01:00 srv1 XRDP[25753] debug:
>> (25753)(140019385399232)[DEBUG] returnvalue from xrdp_mm_connect 0
>> 2014-12-15T12:42:33.759+01:00 srv1 XRDP-sesman[8213] info:
>> (8213)(140565769365440)[INFO ] scp thread on sck 8 started successfully
>> 2014-12-15T12:42:33.760+01:00 srv1 XRDP-sesman[8213] notice:
>> pam_unix(xrdp-sesman:auth): authentication failure; logname= uid=0 euid=0
>> tty= ruser= rhost=  user=usr1
>> 2014-12-15T12:42:33.769+01:00 srv1 XRDP-sesman[8213] info:
>> (8213)(140565769144064)[INFO ] ++ reconnected session: username usr1,
>> display :11.0, session_pid 3526, ip 172.16.51.68:50662 - socket: 8
>> 2014-12-15T12:42:33.770+01:00 srv1 XRDP-sesman[8213] info:
>> (8213)(140565769144064)[INFO ] An established connection closed to endpoint:
>> 127.0.0.1:46705 - socket: 8
>>
>> The process tree looks like this:
>>
>>     1  8209  8194  1670 ?           -1 S       0:00 /usr/sbin/xrdp
>>  8209  3500  8194  1670 ?           -1 S       0:30  \_ /usr/sbin/xrdp
>>  8209 13964  8194  1670 ?           -1 S       0:00  \_ /usr/sbin/xrdp
>>     1  8213  8194  1670 ?           -1 S       0:00 /usr/sbin/xrdp-sesman
>>  8213  3526  8194  1670 ?           -1 S       0:00  \_
>> /usr/sbin/xrdp-sessvc 3528 3527
>>  3526  3527  8194  1670 ?           -1 S       0:00      \_
>> /usr/sbin/xrdp-sesman
>>  3527  3531  8194  1670 ?           -1 S       0:00      |   \_
>> /usr/bin/ck-xinit-session /usr/bin/ssh-agent /etc/X11/xinit/Xclients
>>  3531  3579  8194  1670 ?           -1 Sl      0:00      |       \_
>> /usr/bin/gnome-session
>>  3579  3580  3580  3580 ?           -1 Ss      0:00      |           \_
>> /usr/bin/ssh-agent /etc/X11/xinit/Xclients
>>  3579  3607  8194  1670 ?           -1 S       0:00      |           \_
>> metacity
>>  3579  3612  8194  1670 ?           -1 S       0:02      |           \_
>> gnome-panel
>>  3579  3622  8194  1670 ?           -1 S       0:15      |           \_
>> nautilus
>>  3579  3628  8194  1670 ?           -1 S       0:00      |           \_
>> /usr/libexec/polkit-gnome-authentication-agent-1
>>  3526  3528  8194  1670 ?           -1 S       0:44      \_ X11rdp :11
>> -geometry 1600x900 -depth 24 -bs -ac -nolisten tcp -uds
>>  3526  3532  8194  1670 ?           -1 Sl      0:00      \_ xrdp-chansrv
>>
>>
>> xrdp.ini content looks like this
>>
>> [globals]
>> # xrdp.ini file version number
>> ini_version=1
>>
>> bitmap_cache=yes
>> bitmap_compression=yes
>> port=3389
>> crypt_level=high
>> allow_channels=true
>> max_bpp=24
>> fork=yes
>>
>> # regulate if the listening socket use socket option tcp_nodelay
>> # no buffering will be performed in the TCP stack
>> tcp_nodelay=yes
>>
>> # regulate if the listening socket use socket option keepalive
>> # if the network connection disappear without close messages the
>> connection will be closed
>> tcp_keepalive=yes
>>
>> #tcp_send_buffer_bytes=32768
>> #tcp_recv_buffer_bytes=32768
>>
>> # when true, userid/password *must* be passed on cmd line
>> # require_credentials=yes
>>
>> bulk_compression=yes
>>
>> # You can set the PAM error text in a gateway setup (MAX 256 chars)
>> #pamerrortxt=change your password according to policy at http://url
>> #new_cursors=no
>> #nego_sec_layer=0
>> allow_multimon=true
>>
>> #
>> # configure login screen
>> #
>>
>> # top level window background color in RGB format
>> ls_top_window_bg_color=003399
>>
>> # width and height of login screen
>> ls_width=350
>> ls_height=430
>>
>> # login screen background color in RGB format
>> ls_bg_color=ffffff
>>
>> # logo
>> ls_logo_filename=/usr/share/logo.bmp
>> ls_logo_x_pos=35
>> ls_logo_y_pos=55
>>
>> # for positioning labels such as username, password etc
>> ls_label_x_pos=30
>> ls_label_width=60
>>
>> # for positioning text and combo boxes next to above labels
>> ls_input_x_pos=110
>> ls_input_width=210
>>
>> # y pos for first label and combo box
>> ls_input_y_pos=220
>>
>> # OK button
>> ls_btn_ok_x_pos=142
>> ls_btn_ok_y_pos=370
>> ls_btn_ok_width=85
>> ls_btn_ok_height=30
>>
>> # Cancel button
>> ls_btn_cancel_x_pos=237
>> ls_btn_cancel_y_pos=370
>> ls_btn_cancel_width=85
>> ls_btn_cancel_height=30
>>
>> [Logging]
>> EnableSyslog=1
>> SyslogLevel=DEBUG
>>
>> [channels]
>> # Channel names not listed here will be blocked by XRDP.
>> # You can block any channel by setting its value to false.
>> # IMPORTANT! All channels are not supported in all use
>> # cases even if you set all values to true.
>> # You can override these settings on each session type
>> # These settings are only used if allow_channels=true
>> rdpdr=true
>> rdpsnd=true
>> drdynvc=true
>> cliprdr=true
>> rail=true
>> xrdpvr=true
>>
>> # for debugging xrdp, in section xrdp1, change port=-1 to this:
>> # port=/tmp/.xrdp/xrdp_display_10
>>
>> # for debugging xrdp, add following line to section xrdp1
>> # chansrvport=/tmp/.xrdp/xrdp_chansrv_socket_7210
>>
>> [xrdp1]
>> name=sesman-X11rdp
>> lib=libxup.so
>> username=ask
>> password=ask
>> ip=127.0.0.1
>> port=-1
>> xserverbpp=24
>> code=10
>>
>> # You can override the common channel settings for each session type
>> #channel.rdpdr=true
>> #channel.rdpsnd=true
>> #channel.drdynvc=true
>> #channel.cliprdr=true
>> #channel.rail=true
>> #channel.xrdpvr=true
>>
>>
>> Content of sesman.ini:
>>
>> [Globals]
>> ListenAddress=127.0.0.1
>> ListenPort=3350
>> EnableUserWindowManager=1
>> UserWindowManager=startwm.sh
>> DefaultWindowManager=startwm.sh
>>
>> [Security]
>> AllowRootLogin=1
>> MaxLoginRetry=4
>> TerminalServerUsers=tsusers
>> TerminalServerAdmins=tsadmins
>> # When AlwaysGroupCheck = false access will be permitted
>> # if the group TerminalServerUsers is not defined.
>> AlwaysGroupCheck = false
>>
>> [Sessions]
>> X11DisplayOffset=10
>> MaxSessions=50
>> # if 1, true, or yes, kill session after 60 seconds
>> KillDisconnected=0
>> # if not zero, the seconds without mouse or keyboard input before
>> disconnect
>> # not complete yet
>> IdleTimeLimit=0
>> # if not zero, the seconds before a disconnected session is killed
>> # min 60 seconds
>> DisconnectedTimeLimit=0
>>
>> [Logging]
>> EnableSyslog=1
>> SyslogLevel=DEBUG
>>
>> [X11rdp]
>> param1=-bs
>> param2=-ac
>> param3=-nolisten
>> param4=tcp
>> param5=-uds
>>
>> [Xvnc]
>> param1=-bs
>> param2=-ac
>> param3=-nolisten
>> param4=tcp
>> param5=-localhost
>> param6=-dpi
>> param7=96
>>
>> [Chansrv]
>> # drive redirection, defaults to xrdp_client if not set
>> FuseMountName=thinclient_drives
>>
>>
>> I have to kill the X11rdp thats making trouble and a new Session is
>> created. It is not possible to reconnect to this session any more.
>> Is there any info i can provide to make debugging easier?
>>
>> Used software is xrdp 0.8.0 running on rhel6.3. Connected via Windows 7
>> RDP client.
>>
>>
>> BR,
>> Lionel
>
>
>
> ------------------------------------------------------------------------------
> Dive into the World of Parallel Programming. The Go Parallel Website,
> sponsored by Intel and developed in partnership with Slashdot Media, is your
> hub for all things parallel software development, from weekly thought
> leadership blogs to news, videos, case studies, tutorials and more. Take a
> look and join the conversation now. http://goparallel.sourceforge.net/
> _______________________________________________
> xrdp-devel mailing list
> [hidden email]
> https://lists.sourceforge.net/lists/listinfo/xrdp-devel
>

------------------------------------------------------------------------------
Dive into the World of Parallel Programming. The Go Parallel Website,
sponsored by Intel and developed in partnership with Slashdot Media, is your
hub for all things parallel software development, from weekly thought
leadership blogs to news, videos, case studies, tutorials and more. Take a
look and join the conversation now. http://goparallel.sourceforge.net/
_______________________________________________
xrdp-devel mailing list
[hidden email]
https://lists.sourceforge.net/lists/listinfo/xrdp-devel
Reply | Threaded
Open this post in threaded view
|  
Report Content as Inappropriate

Re: [Xrdp-devel] Fwd: reconnection to X11rdp occasionally fails

Lionel Rocket
Hi,

looks like you are right the following files are in /tmp/.xrdp/

[root@srv1 ~]# ls /tmp/.xrdp/
xrdp-3I503l  xrdpapi_13           xrdp-chansrv-MwJjdp       xrdp-chansrv-tFj5gm         xrdp_disconnect_display_14  xrdp-fZpkha  xrdp-Oq4v5d         xrdp-sesman-ap9vEz  xrdp-sesman-faPtHh  xrdp-sesman-UUMRqs  xrdp-sesman-YjE8nj  xrdp-VfGzgv
xrdp-4FgAtA  xrdpapi_14           xrdp-chansrv-rI3lis       xrdp-chansrv-wtlD0q         xrdp_display_10             xrdp-j8lcVc  xrdp-P2DhJe         xrdp-sesman-B7Yh6W  xrdp-sesman-gu8zPN  xrdp-sesman-W3TOcP  xrdp-sesman-zxeNxy  xrdp-VsXGrc
xrdp-6oInTS  xrdp-chansrv-15EmpY  xrdp_chansrv_socket_7210  xrdp-CPMN2l                 xrdp_display_11             xrdp-LgHWtB  xrdp-PogNdL         xrdp-sesman-CHOLuD  xrdp-sesman-j3ocjU  xrdp-sesman-w7FDPv  xrdp-sessvc-hXettK  xrdp-XRi2Ki
xrdp-9NAf4B  xrdp-chansrv-bcOgkX  xrdp_chansrv_socket_7213  xrdp_disconnect_display_10  xrdp_display_13             xrdp-n3M8Cu  xrdp-QesY6e         xrdp-sesman-d7TE8v  xrdp-sesman-mx1U3Q  xrdp-sesman-wDzxzG  xrdp-sessvc-YsglGp
xrdpapi_10   xrdp-chansrv-dck7ia  xrdp_chansrv_socket_7214  xrdp_disconnect_display_11  xrdp_display_14             xrdp-NXfoH9  xrdp-sesman-5Q9oV9  xrdp-sesman-DsCFgv  xrdp-sesman-pC2TeM  xrdp-sesman-Xoai6u  xrdp-sREy8z
xrdpapi_11   xrdp-chansrv-IvKMrq  xrdp-chansrv-T0LbxN       xrdp_disconnect_display_13  xrdp-EdXICZ                 xrdp-NZEyKf  xrdp-sesman-7KVBoM  xrdp-sesman-eHCueT  xrdp-sesman-suigzj  xrdp-sesman-Y6cSaI  xrdp-tb7RBA

and the following sessions are running:

[root@srv1 ~]# ps aux |grep X11rdp
usr1    2656  0.0  1.5 129904 58904 ?        S    Feb04   3:20 X11rdp :11 -geometry 1024x768 -depth 24 -bs -ac -nolisten tcp -uds
usr2   27772  0.0  0.3  90820 12300 ?        S    Feb04   1:11 X11rdp :10 -geometry 1024x768 -depth 24 -bs -ac -nolisten tcp -uds


so there was a xrdp_display_13 file but no corresponding session. i logged in 2 more users. a session on :12 was created which worked fine, and the next session on :13 threw the X11rdp timeout error again.
when i looked again at the /tmp/.xrdp/, xrdp_display_13 was gone and i was able to login again.

now im wondering how this directory is "cleaned up", because sometimes i can't reconnect to such a faulty session for a longer time.
how can this happen that those files stay in the directory? any ideas for a workaround to clean those files up before reconnecting?


thanks a lot so far!
BR,
Lionel


On Fri, Feb 6, 2015 at 9:16 PM, Jay Sorg <[hidden email]> wrote:
Oh, it looks like a file /tmp/.xrdp/xrdp_display_10 already exists or
is owned by someone else.
sesman should be looking for that file and use a different display if it exists.

Can you check whats in /tmp/.xrdp/ ?

Jay


On Fri, Feb 6, 2015 at 2:16 AM, Lionel Rocket <[hidden email]> wrote:
> Hi everyone!
>
> i think i got a little bit farther by disabling channels in the xrdp.ini
> file.
> but now starting the X11rdp session occasionaly times out. im having a hard
> time investigating here because i can not reproduce the issue and after some
> time it starts working again. so now i found something that might be an
> indicator why the X11rdp session times out.
>
> so first, connecting to sesman, channels are disabled:
>
> 10:52:45.205 srv1 XRDP[932] info: (932)(140270395066304)[INFO ] A connection
> received from: 192.xx.xx.xx port 52860
> 10:52:45.206 srv1 XRDP[932] info: (932)(140270395066304)[INFO ] An
> established connection closed to endpoint: 192.xx.xx.xx:52860 - socket: 8
> 10:52:45.206 srv1 XRDP[13257] info: (13257)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 7
> 10:52:45.207 srv1 XRDP[13257] debug: (13257)(140270395066304)[DEBUG] Info -
> All channels are disabled
> 10:52:45.240 srv1 XRDP[13257] info: (13257)(140270395066304)[INFO ] An
> established connection closed to endpoint: 192.xx.xx.xx:52860 - socket: 8
> 10:52:45.355 srv1 XRDP[932] info: (932)(140270395066304)[INFO ] A connection
> received from: 192.xx.xx.xx port 52861
> 10:52:45.355 srv1 XRDP[932] info: (932)(140270395066304)[INFO ] An
> established connection closed to endpoint: 192.xx.xx.xx:52861 - socket: 8
> 10:52:45.356 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 7
> 10:52:45.356 srv1 XRDP[13258] debug: (13258)(140270395066304)[DEBUG] Info -
> All channels are disabled
> 10:52:45.800 srv1 XRDP[13258] debug: (13258)(140270395066304)[DEBUG]
> xrdp_000033ca_wm_login_mode_event_00000001
> 10:52:45.805 srv1 XRDP[13258] warning: (13258)(140270395066304)[WARN ] local
> keymap file for 0x0409 found and dosen't match built in keymap, using local
> keymap file
>
>
> then logging in with ldap user, some connection at socket 12 is tried to be
> closed some times
>
> 10:53:20.142 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] A
> connection received from: 127.0.0.1 port 60721
> 10:53:20.142 srv1 XRDP[13258] debug: (13258)(140270395066304)[DEBUG]
> returnvalue from xrdp_mm_connect 0
> 10:53:20.142 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] scp
> thread on sck 8 started successfully
> 10:53:20.144 srv1 XRDP-sesman[936] notice: pam_unix(xrdp-sesman:auth):
> authentication failure; logname= uid=0 euid=0 tty= ruser= rhost=  user=usr1
> 10:53:20.152 srv1 XRDP-sesman[936] info: (936)(139898864195328)[INFO ] ++
> created session (access granted): username usr1, ip 192.xx.xx.xx:52861 -
> socket: 8
> 10:53:20.152 srv1 XRDP-sesman[936] info: (936)(139898864195328)[INFO ]
> starting X11rdp session...
> 10:53:20.152 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 14
> 10:53:20.152 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 14
> 10:53:20.153 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 14
> 10:53:20.153 srv1 XRDP-sesman[936] info: (936)(139898864195328)[INFO ] An
> established connection closed to endpoint: 127.0.0.1:60721 - socket: 8
> 10:53:20.153 srv1 XRDP-sesman[14290] info: (14290)(139898864416704)[INFO ]
> An established connection closed to endpoint: NULL:NULL - socket: 7
> 10:53:20.154 srv1 XRDP-sesman[14290] info: (14290)(139898864416704)[INFO ]
> An established connection closed to endpoint: 127.0.0.1:60721 - socket: 8
> 10:53:20.154 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:20.155 srv1 XRDP-sesman[14293] info: (14293)(139898864416704)[INFO ]
> X11rdp start:X11rdp :10 -geometry 1024x768 -depth 24 -bs -ac -nolisten tcp
> -uds
> 10:53:20.654 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:21.154 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
>
>
> then the X11rdp session timeout is logged and connection at socket 12 ist
> tried to be closed some more
>
> 10:53:29.159 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:29.659 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:29.918 srv1 XRDP-sesman[14290] err: (14290)(139898864416704)[ERROR] X
> server for display 10 startup timeout
> 10:53:29.918 srv1 XRDP-sesman[14290] info: (14290)(139898864416704)[INFO ]
> starting xrdp-sessvc - xpid=14293 - wmpid=14292
> 10:53:30.159 srv1 XRDP-sesman[14292] err: (14292)(139898864416704)[ERROR] X
> server for display 10 startup timeout
> 10:53:30.159 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:30.160 srv1 XRDP-sesman[14292] info: pam_unix(xrdp-sesman:session):
> session opened for user usr1 by (uid=0)
> 10:53:30.162 srv1 XRDP-sesman[14799] err: (14799)(139898864416704)[ERROR]
> another Xserver might already be active on display 10 - see log
> 10:53:30.162 srv1 XRDP-sesman[14799] debug: (14799)(139898864416704)[DEBUG]
> aborting connection...
> 10:53:30.162 srv1 XRDP-sesman[14292] info: pam_unix(xrdp-sesman:session):
> session closed for user usr1
> 10:53:30.164 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] ++
> terminated session:  username usr1, display :10.0, session_pid 14290, ip
> 192.xx.xx.xx:52861 - socket: 8
> 10:53:30.660 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:31.160 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
>
>
> and finally, it gives up
>
> 10:53:29.159 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:29.659 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:29.918 srv1 XRDP-sesman[14290] err: (14290)(139898864416704)[ERROR] X
> server for display 10 startup timeout
> 10:53:29.918 srv1 XRDP-sesman[14290] info: (14290)(139898864416704)[INFO ]
> starting xrdp-sessvc - xpid=14293 - wmpid=14292
> 10:53:30.159 srv1 XRDP-sesman[14292] err: (14292)(139898864416704)[ERROR] X
> server for display 10 startup timeout
> 10:53:30.159 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:30.160 srv1 XRDP-sesman[14292] info: pam_unix(xrdp-sesman:session):
> session opened for user usr1 by (uid=0)
> 10:53:30.162 srv1 XRDP-sesman[14799] err: (14799)(139898864416704)[ERROR]
> another Xserver might already be active on display 10 - see log
> 10:53:30.162 srv1 XRDP-sesman[14799] debug: (14799)(139898864416704)[DEBUG]
> aborting connection...
> 10:53:30.162 srv1 XRDP-sesman[14292] info: pam_unix(xrdp-sesman:session):
> session closed for user usr1
> 10:53:30.164 srv1 XRDP-sesman[936] info: (936)(139898864416704)[INFO ] ++
> terminated session:  username usr1, display :10.0, session_pid 14290, ip
> 192.xx.xx.xx:52861 - socket: 8
> 10:53:30.660 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
> 10:53:31.160 srv1 XRDP[13258] info: (13258)(140270395066304)[INFO ] An
> established connection closed to endpoint: NULL:NULL - socket: 12
>
>
> i then looked into the process list and didn't see any X11rdp process so i
> tried to start one by hand. it didn't start with the following errors.
> after some time the command worked, the X11rdp session started. I stopped it
> on the command line and tried via win7 rdp client and it worked again.
>
> [root@srv1 ~]# X11rdp :10 -geometry 1024x768 -depth 24 -bs -ac -nolisten tcp
> -uds
> InitOutput:
>
> X11rdp, an X server for xrdp
> Version 0.7.0
> Copyright (C) 2005-2012 Jay Sorg
> See http://xrdp.sf.net for information on xrdp.
> Underlying X server release 10903000, The X.Org Foundation
> Screen width 1024 height 768 depth 24 bpp 32
> dpix 100 dpiy 100
> buffer size 3145728
> rdpup_init: g_tcp_local_bind failed
> rdpScreenInit: rdpup_init failed
> pRRScrPriv 0x244f820
> rdpScreenInit: ret 0
>
> Fatal server error:
> Couldn't add screen
>
> ddxGiveUp:
>
>
> Can anyone give me a hint where i have to look for those X11rdp startup
> errors?
>
>
> BR,
> Lionel
>
>
> ---------- Forwarded message ----------
> From: Lionel Rocket <[hidden email]>
> Date: Tue, Dec 16, 2014 at 3:58 PM
> Subject: Re: reconnection to X11rdp occasionally fails
> To: [hidden email]
>
>
> Hello,
>
> Another occurrence now shows failing connects:
>
> 2014-12-16T15:33:42.274+01:00 srv1 XRDP-sesman[8213] info:
> (8213)(140565769365440)[INFO ] A connection received from: 127.0.0.1 port
> 43983
> 2014-12-16T15:33:42.274+01:00 srv1 XRDP[7005] debug:
> (7005)(140019385399232)[DEBUG] returnvalue from xrdp_mm_connect 0
> 2014-12-16T15:33:42.274+01:00 srv1 XRDP-sesman[8213] info:
> (8213)(140565769365440)[INFO ] scp thread on sck 8 started successfully
> 2014-12-16T15:33:42.276+01:00 srv1 XRDP-sesman[8213] notice:
> pam_unix(xrdp-sesman:auth): authentication failure; logname= uid=0 euid=0
> tty= ruser= rhost=  user=usr1
> 2014-12-16T15:33:42.284+01:00 srv1 XRDP-sesman[8213] info:
> (8213)(140565769144064)[INFO ] ++ reconnected session: username usr1,
> display :12.0, session_pid 15489, ip 172.xx.xx.xx:56097 - socket: 8
> 2014-12-16T15:33:42.285+01:00 srv1 XRDP-sesman[8213] info:
> (8213)(140565769144064)[INFO ] An established connection closed to endpoint:
> 127.0.0.1:43983 - socket: 8
> 2014-12-16T15:33:42.286+01:00 srv1 XRDP[7005] info:
> (7005)(140019385399232)[INFO ] lib_mod_log_peer: xrdp_pid=7005 connected to
> X11rdp_pid=15491 X11rdp_uid=20991 X11rdp_gid=2991 client_ip=172.xx.xx.xx
> client_port=56097
> 2014-12-16T15:33:43.286+01:00 srv1 XRDP[7005] err:
> (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: connect failed
> trying again...
> 2014-12-16T15:33:43.286+01:00 srv1 XRDP[7005] info:
> (7005)(140019385399232)[INFO ] An established connection closed to endpoint:
> NULL:NULL - socket: 13
> 2014-12-16T15:33:44.287+01:00 srv1 XRDP[7005] err:
> (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: connect failed
> trying again...
> 2014-12-16T15:33:44.287+01:00 srv1 XRDP[7005] info:
> (7005)(140019385399232)[INFO ] An established connection closed to endpoint:
> NULL:NULL - socket: 13
> 2014-12-16T15:33:45.287+01:00 srv1 XRDP[7005] err:
> (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: connect failed
> trying again...
> 2014-12-16T15:33:45.287+01:00 srv1 XRDP[7005] info:
> (7005)(140019385399232)[INFO ] An established connection closed to endpoint:
> NULL:NULL - socket: 13
> 2014-12-16T15:33:46.288+01:00 srv1 XRDP[7005] err:
> (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: connect failed
> trying again...
> 2014-12-16T15:33:46.288+01:00 srv1 XRDP[7005] err:
> (7005)(140019385399232)[ERROR] xrdp_mm_connect_chansrv: error
> intrans_connect chan
> 2014-12-16T15:33:46.288+01:00 srv1 XRDP[7005] info:
> (7005)(140019385399232)[INFO ] An established connection closed to endpoint:
> 127.0.0.1:3350 - socket: 11
>
> any ideas that i can try?
>
>
> BR,
> Lionel
>
>
> On Mon, Dec 15, 2014 at 3:28 PM, Lionel Rocket <[hidden email]>
> wrote:
>>
>> Hello,
>>
>> I'm having problems reconnecting to X11rdp sessions. I can't reproduce
>> this but its occurring quite often.
>>
>> Log output shows only the following lines, it finds the correct X11rdp
>> session on display 11 but after that it immediately closes the connection
>> and the Microsoft RDP client freezes.
>>
>> 2014-12-15T12:42:33.759+01:00 srv1 XRDP-sesman[8213] info:
>> (8213)(140565769365440)[INFO ] A connection received from: 127.0.0.1 port
>> 46705
>> 2014-12-15T12:42:33.759+01:00 srv1 XRDP[25753] debug:
>> (25753)(140019385399232)[DEBUG] returnvalue from xrdp_mm_connect 0
>> 2014-12-15T12:42:33.759+01:00 srv1 XRDP-sesman[8213] info:
>> (8213)(140565769365440)[INFO ] scp thread on sck 8 started successfully
>> 2014-12-15T12:42:33.760+01:00 srv1 XRDP-sesman[8213] notice:
>> pam_unix(xrdp-sesman:auth): authentication failure; logname= uid=0 euid=0
>> tty= ruser= rhost=  user=usr1
>> 2014-12-15T12:42:33.769+01:00 srv1 XRDP-sesman[8213] info:
>> (8213)(140565769144064)[INFO ] ++ reconnected session: username usr1,
>> display :11.0, session_pid 3526, ip 172.16.51.68:50662 - socket: 8
>> 2014-12-15T12:42:33.770+01:00 srv1 XRDP-sesman[8213] info:
>> (8213)(140565769144064)[INFO ] An established connection closed to endpoint:
>> 127.0.0.1:46705 - socket: 8
>>
>> The process tree looks like this:
>>
>>     1  8209  8194  1670 ?           -1 S       0:00 /usr/sbin/xrdp
>>  8209  3500  8194  1670 ?           -1 S       0:30  \_ /usr/sbin/xrdp
>>  8209 13964  8194  1670 ?           -1 S       0:00  \_ /usr/sbin/xrdp
>>     1  8213  8194  1670 ?           -1 S       0:00 /usr/sbin/xrdp-sesman
>>  8213  3526  8194  1670 ?           -1 S       0:00  \_
>> /usr/sbin/xrdp-sessvc 3528 3527
>>  3526  3527  8194  1670 ?           -1 S       0:00      \_
>> /usr/sbin/xrdp-sesman
>>  3527  3531  8194  1670 ?           -1 S       0:00      |   \_
>> /usr/bin/ck-xinit-session /usr/bin/ssh-agent /etc/X11/xinit/Xclients
>>  3531  3579  8194  1670 ?           -1 Sl      0:00      |       \_
>> /usr/bin/gnome-session
>>  3579  3580  3580  3580 ?           -1 Ss      0:00      |           \_
>> /usr/bin/ssh-agent /etc/X11/xinit/Xclients
>>  3579  3607  8194  1670 ?           -1 S       0:00      |           \_
>> metacity
>>  3579  3612  8194  1670 ?           -1 S       0:02      |           \_
>> gnome-panel
>>  3579  3622  8194  1670 ?           -1 S       0:15      |           \_
>> nautilus
>>  3579  3628  8194  1670 ?           -1 S       0:00      |           \_
>> /usr/libexec/polkit-gnome-authentication-agent-1
>>  3526  3528  8194  1670 ?           -1 S       0:44      \_ X11rdp :11
>> -geometry 1600x900 -depth 24 -bs -ac -nolisten tcp -uds
>>  3526  3532  8194  1670 ?           -1 Sl      0:00      \_ xrdp-chansrv
>>
>>
>> xrdp.ini content looks like this
>>
>> [globals]
>> # xrdp.ini file version number
>> ini_version=1
>>
>> bitmap_cache=yes
>> bitmap_compression=yes
>> port=3389
>> crypt_level=high
>> allow_channels=true
>> max_bpp=24
>> fork=yes
>>
>> # regulate if the listening socket use socket option tcp_nodelay
>> # no buffering will be performed in the TCP stack
>> tcp_nodelay=yes
>>
>> # regulate if the listening socket use socket option keepalive
>> # if the network connection disappear without close messages the
>> connection will be closed
>> tcp_keepalive=yes
>>
>> #tcp_send_buffer_bytes=32768
>> #tcp_recv_buffer_bytes=32768
>>
>> # when true, userid/password *must* be passed on cmd line
>> # require_credentials=yes
>>
>> bulk_compression=yes
>>
>> # You can set the PAM error text in a gateway setup (MAX 256 chars)
>> #pamerrortxt=change your password according to policy at http://url
>> #new_cursors=no
>> #nego_sec_layer=0
>> allow_multimon=true
>>
>> #
>> # configure login screen
>> #
>>
>> # top level window background color in RGB format
>> ls_top_window_bg_color=003399
>>
>> # width and height of login screen
>> ls_width=350
>> ls_height=430
>>
>> # login screen background color in RGB format
>> ls_bg_color=ffffff
>>
>> # logo
>> ls_logo_filename=/usr/share/logo.bmp
>> ls_logo_x_pos=35
>> ls_logo_y_pos=55
>>
>> # for positioning labels such as username, password etc
>> ls_label_x_pos=30
>> ls_label_width=60
>>
>> # for positioning text and combo boxes next to above labels
>> ls_input_x_pos=110
>> ls_input_width=210
>>
>> # y pos for first label and combo box
>> ls_input_y_pos=220
>>
>> # OK button
>> ls_btn_ok_x_pos=142
>> ls_btn_ok_y_pos=370
>> ls_btn_ok_width=85
>> ls_btn_ok_height=30
>>
>> # Cancel button
>> ls_btn_cancel_x_pos=237
>> ls_btn_cancel_y_pos=370
>> ls_btn_cancel_width=85
>> ls_btn_cancel_height=30
>>
>> [Logging]
>> EnableSyslog=1
>> SyslogLevel=DEBUG
>>
>> [channels]
>> # Channel names not listed here will be blocked by XRDP.
>> # You can block any channel by setting its value to false.
>> # IMPORTANT! All channels are not supported in all use
>> # cases even if you set all values to true.
>> # You can override these settings on each session type
>> # These settings are only used if allow_channels=true
>> rdpdr=true
>> rdpsnd=true
>> drdynvc=true
>> cliprdr=true
>> rail=true
>> xrdpvr=true
>>
>> # for debugging xrdp, in section xrdp1, change port=-1 to this:
>> # port=/tmp/.xrdp/xrdp_display_10
>>
>> # for debugging xrdp, add following line to section xrdp1
>> # chansrvport=/tmp/.xrdp/xrdp_chansrv_socket_7210
>>
>> [xrdp1]
>> name=sesman-X11rdp
>> lib=libxup.so
>> username=ask
>> password=ask
>> ip=127.0.0.1
>> port=-1
>> xserverbpp=24
>> code=10
>>
>> # You can override the common channel settings for each session type
>> #channel.rdpdr=true
>> #channel.rdpsnd=true
>> #channel.drdynvc=true
>> #channel.cliprdr=true
>> #channel.rail=true
>> #channel.xrdpvr=true
>>
>>
>> Content of sesman.ini:
>>
>> [Globals]
>> ListenAddress=127.0.0.1
>> ListenPort=3350
>> EnableUserWindowManager=1
>> UserWindowManager=startwm.sh
>> DefaultWindowManager=startwm.sh
>>
>> [Security]
>> AllowRootLogin=1
>> MaxLoginRetry=4
>> TerminalServerUsers=tsusers
>> TerminalServerAdmins=tsadmins
>> # When AlwaysGroupCheck = false access will be permitted
>> # if the group TerminalServerUsers is not defined.
>> AlwaysGroupCheck = false
>>
>> [Sessions]
>> X11DisplayOffset=10
>> MaxSessions=50
>> # if 1, true, or yes, kill session after 60 seconds
>> KillDisconnected=0
>> # if not zero, the seconds without mouse or keyboard input before
>> disconnect
>> # not complete yet
>> IdleTimeLimit=0
>> # if not zero, the seconds before a disconnected session is killed
>> # min 60 seconds
>> DisconnectedTimeLimit=0
>>
>> [Logging]
>> EnableSyslog=1
>> SyslogLevel=DEBUG
>>
>> [X11rdp]
>> param1=-bs
>> param2=-ac
>> param3=-nolisten
>> param4=tcp
>> param5=-uds
>>
>> [Xvnc]
>> param1=-bs
>> param2=-ac
>> param3=-nolisten
>> param4=tcp
>> param5=-localhost
>> param6=-dpi
>> param7=96
>>
>> [Chansrv]
>> # drive redirection, defaults to xrdp_client if not set
>> FuseMountName=thinclient_drives
>>
>>
>> I have to kill the X11rdp thats making trouble and a new Session is
>> created. It is not possible to reconnect to this session any more.
>> Is there any info i can provide to make debugging easier?
>>
>> Used software is xrdp 0.8.0 running on rhel6.3. Connected via Windows 7
>> RDP client.
>>
>>
>> BR,
>> Lionel
>
>
>
> ------------------------------------------------------------------------------
> Dive into the World of Parallel Programming. The Go Parallel Website,
> sponsored by Intel and developed in partnership with Slashdot Media, is your
> hub for all things parallel software development, from weekly thought
> leadership blogs to news, videos, case studies, tutorials and more. Take a
> look and join the conversation now. http://goparallel.sourceforge.net/
> _______________________________________________
> xrdp-devel mailing list
> [hidden email]
> https://lists.sourceforge.net/lists/listinfo/xrdp-devel
>


------------------------------------------------------------------------------
Dive into the World of Parallel Programming. The Go Parallel Website,
sponsored by Intel and developed in partnership with Slashdot Media, is your
hub for all things parallel software development, from weekly thought
leadership blogs to news, videos, case studies, tutorials and more. Take a
look and join the conversation now. http://goparallel.sourceforge.net/
_______________________________________________
xrdp-devel mailing list
[hidden email]
https://lists.sourceforge.net/lists/listinfo/xrdp-devel
Loading...