You are viewing a plain text version of this content. The canonical link for it is here.
Posted to user@guacamole.apache.org by rramalho <rr...@gmail.com> on 2020/08/25 15:06:04 UTC
RDP disconnects after a few seconds
Hi all,
I'm having a strange thing happening to my guacamole installation, since
I've upgraded to guacamole 1.1.0.
Clients to RDP servers disconnect after a few seconds. I've set guacd to
debug and got this. I'm running Guacamole on Ubuntu Server 20.04.1.
Aug 25 15:25:19 molerat guacd[3090]: Internal RDP client disconnected
Aug 25 15:25:19 molerat guacd[3090]: User
"@493c7148-b53e-49f1-85cd-ac3e3ff0b7b8" disconnected (0 users remain)
Aug 25 15:25:19 molerat guacd[3090]: Last user of connection
"$9e67fe50-37d9-4677-be10-ca83885fb515" disconnected
Aug 25 15:25:19 molerat guacd[3090]: Requesting termination of client...
Aug 25 15:25:19 molerat guacd[3090]: Client terminated successfully.
Aug 25 15:25:19 molerat guacd[3076]: Connection
"$9e67fe50-37d9-4677-be10-ca83885fb515" removed.
Aug 25 15:36:30 molerat guacd[12627]: Stopping guacd: SUCCESS
Aug 25 15:36:30 molerat systemd[1]: guacd.service: Succeeded.
Aug 25 15:37:40 molerat guacd[14185]: Guacamole proxy daemon (guacd) version
1.1.0 started
Aug 25 15:37:40 molerat guacd[14183]: Starting guacd:
Aug 25 15:37:40 molerat guacd[14185]: guacd[14185]: INFO:#011Guacamole proxy
daemon (guacd) version 1.1.0 started
Aug 25 15:37:40 molerat guacd[14185]: guacd[14185]: DEBUG:#011Unable to bind
socket to host ::1, port 4822: Address family not supported by protocol
Aug 25 15:37:40 molerat guacd[14185]: guacd[14185]: DEBUG:#011Successfully
bound socket to host 127.0.0.1, port 4822
Aug 25 15:37:40 molerat guacd[14185]: Unable to bind socket to host ::1,
port 4822: Address family not supported by protocol
Aug 25 15:37:40 molerat guacd[14185]: guacd[14185]: DEBUG:#011Exiting and
passing control to PID 14186
Aug 25 15:37:40 molerat guacd[14185]: Successfully bound socket to host
127.0.0.1, port 4822
Aug 25 15:37:40 molerat guacd[14183]: SUCCESS
Aug 25 15:37:40 molerat guacd[14185]: Exiting and passing control to PID
14186
Aug 25 15:37:40 molerat guacd[14186]: guacd[14186]: DEBUG:#011Exiting and
passing control to PID 14187
Aug 25 15:37:40 molerat guacd[14186]: Exiting and passing control to PID
14187
Aug 25 15:37:40 molerat guacd[14187]: Listening on host 127.0.0.1, port 4822
Aug 25 15:39:16 molerat guacd[14187]: Creating new client for protocol "rdp"
Aug 25 15:39:16 molerat guacd[14187]: Connection ID is
"$f4711187-83f6-4684-b5ce-a08b79a38390"
Aug 25 15:39:16 molerat guacd[14194]: "HOME" environment variable was unset
and has been automatically set to "/root"
Aug 25 15:39:16 molerat guacd[14194]: Processing instruction: size
Aug 25 15:39:16 molerat guacd[14194]: Processing instruction: audio
Aug 25 15:39:16 molerat guacd[14194]: Processing instruction: video
Aug 25 15:39:16 molerat guacd[14194]: Processing instruction: image
Aug 25 15:39:16 molerat guacd[14194]: Processing instruction: timezone
Aug 25 15:39:16 molerat guacd[14194]: Parameter "console" omitted. Using
default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "console-audio" omitted.
Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "disable-auth" omitted.
Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: No security mode specified. Defaulting
to security mode negotiation with server.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "port" omitted. Using
default value of 3389.
Aug 25 15:39:16 molerat guacd[14194]: User resolution is 1582x828 at 96 DPI
Aug 25 15:39:16 molerat guacd[14194]: Parameter "dpi" omitted. Using default
value of 96.
Aug 25 15:39:16 molerat guacd[14194]: Using resolution of 1580x828 at 96 DPI
Aug 25 15:39:16 molerat guacd[14194]: Parameter "read-only" omitted. Using
default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "client-name" omitted. Using
default value of "Guacamole RDP".
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-wallpaper" omitted.
Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-theming" omitted.
Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-font-smoothing"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-full-window-drag"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-desktop-composition"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-menu-animations"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "disable-bitmap-caching"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "disable-offscreen-caching"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "disable-glyph-caching"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "color-depth" omitted. Using
default value of 16.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-printing" omitted.
Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "printer-name" omitted.
Using default value of "Guacamole Printer".
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-drive" omitted.
Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "drive-name" omitted. Using
default value of "Guacamole Filesystem".
Aug 25 15:39:16 molerat guacd[14194]: Parameter "drive-path" omitted. Using
default value of "".
Aug 25 15:39:16 molerat guacd[14194]: Parameter "create-drive-path" omitted.
Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "timezone" omitted. Using
default value of "Europe/Lisbon".
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-sftp" omitted. Using
default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "sftp-passphrase" omitted.
Using default value of "".
Aug 25 15:39:16 molerat guacd[14194]: Parameter "sftp-server-alive-interval"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "recording-name" omitted.
Using default value of "recording".
Aug 25 15:39:16 molerat guacd[14194]: Parameter "recording-exclude-output"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "recording-exclude-mouse"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "recording-include-keys"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "create-recording-path"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Resize method: none
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-audio-input"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "gateway-port" omitted.
Using default value of 443.
Aug 25 15:39:16 molerat guacd[14194]: User
"@f78e84cb-0ea8-4caa-afcb-40433d29e103" joined connection
"$f4711187-83f6-4684-b5ce-a08b79a38390" (1 users now present)
Aug 25 15:39:16 molerat guacd[14194]: Client is using protocol version
"VERSION_1_1_0"
Aug 25 15:39:16 molerat guacd[14194]: Loading keymap "base"
Aug 25 15:39:16 molerat guacd[14194]: Loading keymap "en-us-qwerty"
Aug 25 15:39:16 molerat guacd[14194]:
freerdp_connect:freerdp_set_last_error_ex resetting error state
Aug 25 15:39:16 molerat guacd[14194]: Support for CLIPRDR (clipboard
redirection) registered. Awaiting channel connection.
Aug 25 15:39:16 molerat guacd[14194]: Local framebuffer format
PIXEL_FORMAT_BGRX32
Aug 25 15:39:16 molerat guacd[14194]: Remote framebuffer format
PIXEL_FORMAT_RGB16
Aug 25 15:39:17 molerat guacd[14194]: primitives autodetect, using optimized
Aug 25 15:39:17 molerat guacd[14194]:
freerdp_tcp_is_hostname_resolvable:freerdp_set_last_error_ex resetting error
state
Aug 25 15:39:17 molerat guacd[14194]:
freerdp_tcp_connect:freerdp_set_last_error_ex resetting error state
Aug 25 15:39:17 molerat guacd[14194]: CLIPRDR (clipboard redirection)
channel connected.
Aug 25 15:39:18 molerat guacd[14194]: Clipboard data received. Reporting
availability of clipboard data to RDP server.
Aug 25 15:39:18 molerat guacd[14194]: [cliprdr_packet_format_list_new]
called with invalid type 00000000
Aug 25 15:39:18 molerat guacd[14194]: Clipboard data received. Reporting
availability of clipboard data to RDP server.
Aug 25 15:39:18 molerat guacd[14194]: [cliprdr_packet_format_list_new]
called with invalid type 00000000
Aug 25 15:39:24 molerat guacd[14194]:
rdp_set_error_info:freerdp_set_last_error_ex resetting error state
Aug 25 15:39:24 molerat guacd[14194]: invalid bitmap bpp 0
Aug 25 15:39:24 molerat guacd[14194]: SECONDARY ORDER [0x00] Cache Bitmap
failed
Aug 25 15:39:24 molerat guacd[14194]: SECONDARY_ORDER [0x00] Cache Bitmap:
read 18446744073709551096bytes too much
Aug 25 15:39:24 molerat guacd[14194]: order flags 03 failed
Aug 25 15:39:24 molerat guacd[14194]: Fastpath update Orders [0] failed,
status 0
Aug 25 15:39:24 molerat guacd[14194]: fastpath_recv_update() - -1
Aug 25 15:39:24 molerat guacd[14194]: fastpath_recv_update_data() fail
Aug 25 15:39:24 molerat guacd[14194]: transport_check_fds:
transport->ReceiveCallback() - -3
Aug 25 15:39:24 molerat guacd[14194]: freerdp_check_fds() failed - 0
Aug 25 15:39:24 molerat guacd[14194]: Connection closed.
Aug 25 15:39:24 molerat guacd[14194]: Internal RDP client disconnected
Aug 25 15:39:24 molerat guacd[14194]: User
"@f78e84cb-0ea8-4caa-afcb-40433d29e103" disconnected (0 users remain)
Aug 25 15:39:24 molerat guacd[14194]: Last user of connection
"$f4711187-83f6-4684-b5ce-a08b79a38390" disconnected
Aug 25 15:39:24 molerat guacd[14194]: Requesting termination of client...
Aug 25 15:39:24 molerat guacd[14194]: Client terminated successfully.
Aug 25 15:39:24 molerat guacd[14187]: Connection
"$f4711187-83f6-4684-b5ce-a08b79a38390" removed.
I really don't know what's happening.
This happens with Windows Server 2008 R2 or Windows 7. With Windows 10, it
connects and works.
Thank you for any help!
--
Ricardo Ramalho
--
Sent from: http://apache-guacamole-general-user-mailing-list.2363388.n4.nabble.com/
---------------------------------------------------------------------
To unsubscribe, e-mail: user-unsubscribe@guacamole.apache.org
For additional commands, e-mail: user-help@guacamole.apache.org
RE: RDP disconnects after a few seconds
Posted by Tushar Jain <tu...@hitachi.mgrmnet.com>.
Did you try guacamole 1.2.0 instead of 1.1.0?
From: Nick Couchman [mailto:vnick@apache.org]
Sent: 25 August 2020 11:09 PM
To: user@guacamole.apache.org
Subject: Re: RDP disconnects after a few seconds
On Tue, Aug 25, 2020 at 11:06 AM rramalho <rramalho@gmail.com <ma...@gmail.com> > wrote:
Hi all,
I'm having a strange thing happening to my guacamole installation, since
I've upgraded to guacamole 1.1.0.
Clients to RDP servers disconnect after a few seconds. I've set guacd to
debug and got this. I'm running Guacamole on Ubuntu Server 20.04.1.
Aug 25 15:25:19 molerat guacd[3090]: Internal RDP client disconnected
Aug 25 15:25:19 molerat guacd[3090]: User
"@493c7148-b53e-49f1-85cd-ac3e3ff0b7b8" disconnected (0 users remain)
Aug 25 15:25:19 molerat guacd[3090]: Last user of connection
"$9e67fe50-37d9-4677-be10-ca83885fb515" disconnected
Aug 25 15:25:19 molerat guacd[3090]: Requesting termination of client...
Aug 25 15:25:19 molerat guacd[3090]: Client terminated successfully.
Aug 25 15:25:19 molerat guacd[3076]: Connection
"$9e67fe50-37d9-4677-be10-ca83885fb515" removed.
Aug 25 15:36:30 molerat guacd[12627]: Stopping guacd: SUCCESS
Aug 25 15:36:30 molerat systemd[1]: guacd.service: Succeeded.
Aug 25 15:37:40 molerat guacd[14185]: Guacamole proxy daemon (guacd) version
1.1.0 started
Aug 25 15:37:40 molerat guacd[14183]: Starting guacd:
Aug 25 15:37:40 molerat guacd[14185]: guacd[14185]: INFO:#011Guacamole proxy
daemon (guacd) version 1.1.0 started
Aug 25 15:37:40 molerat guacd[14185]: guacd[14185]: DEBUG:#011Unable to bind
socket to host ::1, port 4822: Address family not supported by protocol
Aug 25 15:37:40 molerat guacd[14185]: guacd[14185]: DEBUG:#011Successfully
bound socket to host 127.0.0.1, port 4822
Aug 25 15:37:40 molerat guacd[14185]: Unable to bind socket to host ::1,
port 4822: Address family not supported by protocol
Aug 25 15:37:40 molerat guacd[14185]: guacd[14185]: DEBUG:#011Exiting and
passing control to PID 14186
Aug 25 15:37:40 molerat guacd[14185]: Successfully bound socket to host
127.0.0.1, port 4822
Aug 25 15:37:40 molerat guacd[14183]: SUCCESS
Aug 25 15:37:40 molerat guacd[14185]: Exiting and passing control to PID
14186
Aug 25 15:37:40 molerat guacd[14186]: guacd[14186]: DEBUG:#011Exiting and
passing control to PID 14187
Aug 25 15:37:40 molerat guacd[14186]: Exiting and passing control to PID
14187
Aug 25 15:37:40 molerat guacd[14187]: Listening on host 127.0.0.1, port 4822
Aug 25 15:39:16 molerat guacd[14187]: Creating new client for protocol "rdp"
Aug 25 15:39:16 molerat guacd[14187]: Connection ID is
"$f4711187-83f6-4684-b5ce-a08b79a38390"
Aug 25 15:39:16 molerat guacd[14194]: "HOME" environment variable was unset
and has been automatically set to "/root"
Aug 25 15:39:16 molerat guacd[14194]: Processing instruction: size
Aug 25 15:39:16 molerat guacd[14194]: Processing instruction: audio
Aug 25 15:39:16 molerat guacd[14194]: Processing instruction: video
Aug 25 15:39:16 molerat guacd[14194]: Processing instruction: image
Aug 25 15:39:16 molerat guacd[14194]: Processing instruction: timezone
Aug 25 15:39:16 molerat guacd[14194]: Parameter "console" omitted. Using
default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "console-audio" omitted.
Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "disable-auth" omitted.
Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: No security mode specified. Defaulting
to security mode negotiation with server.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "port" omitted. Using
default value of 3389.
Aug 25 15:39:16 molerat guacd[14194]: User resolution is 1582x828 at 96 DPI
Aug 25 15:39:16 molerat guacd[14194]: Parameter "dpi" omitted. Using default
value of 96.
Aug 25 15:39:16 molerat guacd[14194]: Using resolution of 1580x828 at 96 DPI
Aug 25 15:39:16 molerat guacd[14194]: Parameter "read-only" omitted. Using
default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "client-name" omitted. Using
default value of "Guacamole RDP".
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-wallpaper" omitted.
Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-theming" omitted.
Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-font-smoothing"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-full-window-drag"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-desktop-composition"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-menu-animations"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "disable-bitmap-caching"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "disable-offscreen-caching"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "disable-glyph-caching"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "color-depth" omitted. Using
default value of 16.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-printing" omitted.
Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "printer-name" omitted.
Using default value of "Guacamole Printer".
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-drive" omitted.
Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "drive-name" omitted. Using
default value of "Guacamole Filesystem".
Aug 25 15:39:16 molerat guacd[14194]: Parameter "drive-path" omitted. Using
default value of "".
Aug 25 15:39:16 molerat guacd[14194]: Parameter "create-drive-path" omitted.
Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "timezone" omitted. Using
default value of "Europe/Lisbon".
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-sftp" omitted. Using
default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "sftp-passphrase" omitted.
Using default value of "".
Aug 25 15:39:16 molerat guacd[14194]: Parameter "sftp-server-alive-interval"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "recording-name" omitted.
Using default value of "recording".
Aug 25 15:39:16 molerat guacd[14194]: Parameter "recording-exclude-output"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "recording-exclude-mouse"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "recording-include-keys"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "create-recording-path"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Resize method: none
Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-audio-input"
omitted. Using default value of 0.
Aug 25 15:39:16 molerat guacd[14194]: Parameter "gateway-port" omitted.
Using default value of 443.
Aug 25 15:39:16 molerat guacd[14194]: User
"@f78e84cb-0ea8-4caa-afcb-40433d29e103" joined connection
"$f4711187-83f6-4684-b5ce-a08b79a38390" (1 users now present)
Aug 25 15:39:16 molerat guacd[14194]: Client is using protocol version
"VERSION_1_1_0"
Aug 25 15:39:16 molerat guacd[14194]: Loading keymap "base"
Aug 25 15:39:16 molerat guacd[14194]: Loading keymap "en-us-qwerty"
Aug 25 15:39:16 molerat guacd[14194]:
freerdp_connect:freerdp_set_last_error_ex resetting error state
Aug 25 15:39:16 molerat guacd[14194]: Support for CLIPRDR (clipboard
redirection) registered. Awaiting channel connection.
Aug 25 15:39:16 molerat guacd[14194]: Local framebuffer format
PIXEL_FORMAT_BGRX32
Aug 25 15:39:16 molerat guacd[14194]: Remote framebuffer format
PIXEL_FORMAT_RGB16
Aug 25 15:39:17 molerat guacd[14194]: primitives autodetect, using optimized
Aug 25 15:39:17 molerat guacd[14194]:
freerdp_tcp_is_hostname_resolvable:freerdp_set_last_error_ex resetting error
state
Aug 25 15:39:17 molerat guacd[14194]:
freerdp_tcp_connect:freerdp_set_last_error_ex resetting error state
Aug 25 15:39:17 molerat guacd[14194]: CLIPRDR (clipboard redirection)
channel connected.
Aug 25 15:39:18 molerat guacd[14194]: Clipboard data received. Reporting
availability of clipboard data to RDP server.
Aug 25 15:39:18 molerat guacd[14194]: [cliprdr_packet_format_list_new]
called with invalid type 00000000
Aug 25 15:39:18 molerat guacd[14194]: Clipboard data received. Reporting
availability of clipboard data to RDP server.
Aug 25 15:39:18 molerat guacd[14194]: [cliprdr_packet_format_list_new]
called with invalid type 00000000
Aug 25 15:39:24 molerat guacd[14194]:
rdp_set_error_info:freerdp_set_last_error_ex resetting error state
Aug 25 15:39:24 molerat guacd[14194]: invalid bitmap bpp 0
Aug 25 15:39:24 molerat guacd[14194]: SECONDARY ORDER [0x00] Cache Bitmap
failed
Aug 25 15:39:24 molerat guacd[14194]: SECONDARY_ORDER [0x00] Cache Bitmap:
read 18446744073709551096bytes too much
Aug 25 15:39:24 molerat guacd[14194]: order flags 03 failed
Aug 25 15:39:24 molerat guacd[14194]: Fastpath update Orders [0] failed,
status 0
Aug 25 15:39:24 molerat guacd[14194]: fastpath_recv_update() - -1
Aug 25 15:39:24 molerat guacd[14194]: fastpath_recv_update_data() fail
Aug 25 15:39:24 molerat guacd[14194]: transport_check_fds:
transport->ReceiveCallback() - -3
Aug 25 15:39:24 molerat guacd[14194]: freerdp_check_fds() failed - 0
Aug 25 15:39:24 molerat guacd[14194]: Connection closed.
Aug 25 15:39:24 molerat guacd[14194]: Internal RDP client disconnected
Aug 25 15:39:24 molerat guacd[14194]: User
"@f78e84cb-0ea8-4caa-afcb-40433d29e103" disconnected (0 users remain)
Aug 25 15:39:24 molerat guacd[14194]: Last user of connection
"$f4711187-83f6-4684-b5ce-a08b79a38390" disconnected
Aug 25 15:39:24 molerat guacd[14194]: Requesting termination of client...
Aug 25 15:39:24 molerat guacd[14194]: Client terminated successfully.
Aug 25 15:39:24 molerat guacd[14187]: Connection
"$f4711187-83f6-4684-b5ce-a08b79a38390" removed.
I really don't know what's happening.
This happens with Windows Server 2008 R2 or Windows 7. With Windows 10, it
connects and works.
I believe there are some known issues with certain versions of the FreeRDP libraries, specifically in Ubuntu, that cause this. I can't locate a JIRA issue for it at the moment, but it seems like it has been brought to either the mailing list or the JIRA tracker before, and relates to a specific update to FreeRDP that has caused issues.
-Nick
--
**Disclaimer:* This message and any attachment may contain confidential,
proprietary information and is intended only for the individual named. If
you are not the original intended recipient and have erroneously received
this message, you should not disseminate, distribute or copy this e-mail.
Please notify the sender immediately by e-mail if you have received this
e-mail by mistake and delete this e-mail from your system. Hitachi MGRM Net
E-mail transmission cannot be guaranteed to be secure or error-free as
information could be intercepted, corrupted, lost, destroyed, arrive late
or incomplete, or contain viruses. Hitachi MGRM Net therefore does not
accept liability for any errors or omissions in the contents of this
message, which arise as a result of e-mail transmission. If verification is
required, please request a hard-copy version. Hitachi MGRM Net Ltd, C -
6/5, Safdarjung Development Area, New Delhi - 110016, India*
*
*
*'Please
consider the environment before printing this e-mail'.*
Re: RDP disconnects after a few seconds
Posted by Nick Couchman <vn...@apache.org>.
On Tue, Aug 25, 2020 at 11:06 AM rramalho <rr...@gmail.com> wrote:
> Hi all,
>
> I'm having a strange thing happening to my guacamole installation, since
> I've upgraded to guacamole 1.1.0.
> Clients to RDP servers disconnect after a few seconds. I've set guacd to
> debug and got this. I'm running Guacamole on Ubuntu Server 20.04.1.
>
> Aug 25 15:25:19 molerat guacd[3090]: Internal RDP client disconnected
> Aug 25 15:25:19 molerat guacd[3090]: User
> "@493c7148-b53e-49f1-85cd-ac3e3ff0b7b8" disconnected (0 users remain)
> Aug 25 15:25:19 molerat guacd[3090]: Last user of connection
> "$9e67fe50-37d9-4677-be10-ca83885fb515" disconnected
> Aug 25 15:25:19 molerat guacd[3090]: Requesting termination of client...
> Aug 25 15:25:19 molerat guacd[3090]: Client terminated successfully.
> Aug 25 15:25:19 molerat guacd[3076]: Connection
> "$9e67fe50-37d9-4677-be10-ca83885fb515" removed.
> Aug 25 15:36:30 molerat guacd[12627]: Stopping guacd: SUCCESS
> Aug 25 15:36:30 molerat systemd[1]: guacd.service: Succeeded.
> Aug 25 15:37:40 molerat guacd[14185]: Guacamole proxy daemon (guacd)
> version
> 1.1.0 started
> Aug 25 15:37:40 molerat guacd[14183]: Starting guacd:
> Aug 25 15:37:40 molerat guacd[14185]: guacd[14185]: INFO:#011Guacamole
> proxy
> daemon (guacd) version 1.1.0 started
> Aug 25 15:37:40 molerat guacd[14185]: guacd[14185]: DEBUG:#011Unable to
> bind
> socket to host ::1, port 4822: Address family not supported by protocol
> Aug 25 15:37:40 molerat guacd[14185]: guacd[14185]: DEBUG:#011Successfully
> bound socket to host 127.0.0.1, port 4822
> Aug 25 15:37:40 molerat guacd[14185]: Unable to bind socket to host ::1,
> port 4822: Address family not supported by protocol
> Aug 25 15:37:40 molerat guacd[14185]: guacd[14185]: DEBUG:#011Exiting and
> passing control to PID 14186
> Aug 25 15:37:40 molerat guacd[14185]: Successfully bound socket to host
> 127.0.0.1, port 4822
> Aug 25 15:37:40 molerat guacd[14183]: SUCCESS
> Aug 25 15:37:40 molerat guacd[14185]: Exiting and passing control to PID
> 14186
> Aug 25 15:37:40 molerat guacd[14186]: guacd[14186]: DEBUG:#011Exiting and
> passing control to PID 14187
> Aug 25 15:37:40 molerat guacd[14186]: Exiting and passing control to PID
> 14187
> Aug 25 15:37:40 molerat guacd[14187]: Listening on host 127.0.0.1, port
> 4822
> Aug 25 15:39:16 molerat guacd[14187]: Creating new client for protocol
> "rdp"
> Aug 25 15:39:16 molerat guacd[14187]: Connection ID is
> "$f4711187-83f6-4684-b5ce-a08b79a38390"
> Aug 25 15:39:16 molerat guacd[14194]: "HOME" environment variable was unset
> and has been automatically set to "/root"
> Aug 25 15:39:16 molerat guacd[14194]: Processing instruction: size
> Aug 25 15:39:16 molerat guacd[14194]: Processing instruction: audio
> Aug 25 15:39:16 molerat guacd[14194]: Processing instruction: video
> Aug 25 15:39:16 molerat guacd[14194]: Processing instruction: image
> Aug 25 15:39:16 molerat guacd[14194]: Processing instruction: timezone
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "console" omitted. Using
> default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "console-audio" omitted.
> Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "disable-auth" omitted.
> Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: No security mode specified.
> Defaulting
> to security mode negotiation with server.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "port" omitted. Using
> default value of 3389.
> Aug 25 15:39:16 molerat guacd[14194]: User resolution is 1582x828 at 96 DPI
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "dpi" omitted. Using
> default
> value of 96.
> Aug 25 15:39:16 molerat guacd[14194]: Using resolution of 1580x828 at 96
> DPI
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "read-only" omitted. Using
> default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "client-name" omitted.
> Using
> default value of "Guacamole RDP".
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-wallpaper" omitted.
> Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-theming" omitted.
> Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-font-smoothing"
> omitted. Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-full-window-drag"
> omitted. Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter
> "enable-desktop-composition"
> omitted. Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-menu-animations"
> omitted. Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "disable-bitmap-caching"
> omitted. Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "disable-offscreen-caching"
> omitted. Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "disable-glyph-caching"
> omitted. Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "color-depth" omitted.
> Using
> default value of 16.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-printing" omitted.
> Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "printer-name" omitted.
> Using default value of "Guacamole Printer".
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-drive" omitted.
> Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "drive-name" omitted. Using
> default value of "Guacamole Filesystem".
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "drive-path" omitted. Using
> default value of "".
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "create-drive-path"
> omitted.
> Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "timezone" omitted. Using
> default value of "Europe/Lisbon".
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-sftp" omitted.
> Using
> default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "sftp-passphrase" omitted.
> Using default value of "".
> Aug 25 15:39:16 molerat guacd[14194]: Parameter
> "sftp-server-alive-interval"
> omitted. Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "recording-name" omitted.
> Using default value of "recording".
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "recording-exclude-output"
> omitted. Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "recording-exclude-mouse"
> omitted. Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "recording-include-keys"
> omitted. Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "create-recording-path"
> omitted. Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Resize method: none
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "enable-audio-input"
> omitted. Using default value of 0.
> Aug 25 15:39:16 molerat guacd[14194]: Parameter "gateway-port" omitted.
> Using default value of 443.
> Aug 25 15:39:16 molerat guacd[14194]: User
> "@f78e84cb-0ea8-4caa-afcb-40433d29e103" joined connection
> "$f4711187-83f6-4684-b5ce-a08b79a38390" (1 users now present)
> Aug 25 15:39:16 molerat guacd[14194]: Client is using protocol version
> "VERSION_1_1_0"
> Aug 25 15:39:16 molerat guacd[14194]: Loading keymap "base"
> Aug 25 15:39:16 molerat guacd[14194]: Loading keymap "en-us-qwerty"
> Aug 25 15:39:16 molerat guacd[14194]:
> freerdp_connect:freerdp_set_last_error_ex resetting error state
> Aug 25 15:39:16 molerat guacd[14194]: Support for CLIPRDR (clipboard
> redirection) registered. Awaiting channel connection.
> Aug 25 15:39:16 molerat guacd[14194]: Local framebuffer format
> PIXEL_FORMAT_BGRX32
> Aug 25 15:39:16 molerat guacd[14194]: Remote framebuffer format
> PIXEL_FORMAT_RGB16
> Aug 25 15:39:17 molerat guacd[14194]: primitives autodetect, using
> optimized
> Aug 25 15:39:17 molerat guacd[14194]:
> freerdp_tcp_is_hostname_resolvable:freerdp_set_last_error_ex resetting
> error
> state
> Aug 25 15:39:17 molerat guacd[14194]:
> freerdp_tcp_connect:freerdp_set_last_error_ex resetting error state
> Aug 25 15:39:17 molerat guacd[14194]: CLIPRDR (clipboard redirection)
> channel connected.
> Aug 25 15:39:18 molerat guacd[14194]: Clipboard data received. Reporting
> availability of clipboard data to RDP server.
> Aug 25 15:39:18 molerat guacd[14194]: [cliprdr_packet_format_list_new]
> called with invalid type 00000000
> Aug 25 15:39:18 molerat guacd[14194]: Clipboard data received. Reporting
> availability of clipboard data to RDP server.
> Aug 25 15:39:18 molerat guacd[14194]: [cliprdr_packet_format_list_new]
> called with invalid type 00000000
> Aug 25 15:39:24 molerat guacd[14194]:
> rdp_set_error_info:freerdp_set_last_error_ex resetting error state
> Aug 25 15:39:24 molerat guacd[14194]: invalid bitmap bpp 0
> Aug 25 15:39:24 molerat guacd[14194]: SECONDARY ORDER [0x00] Cache Bitmap
> failed
> Aug 25 15:39:24 molerat guacd[14194]: SECONDARY_ORDER [0x00] Cache Bitmap:
> read 18446744073709551096bytes too much
> Aug 25 15:39:24 molerat guacd[14194]: order flags 03 failed
> Aug 25 15:39:24 molerat guacd[14194]: Fastpath update Orders [0] failed,
> status 0
> Aug 25 15:39:24 molerat guacd[14194]: fastpath_recv_update() - -1
> Aug 25 15:39:24 molerat guacd[14194]: fastpath_recv_update_data() fail
> Aug 25 15:39:24 molerat guacd[14194]: transport_check_fds:
> transport->ReceiveCallback() - -3
> Aug 25 15:39:24 molerat guacd[14194]: freerdp_check_fds() failed - 0
> Aug 25 15:39:24 molerat guacd[14194]: Connection closed.
> Aug 25 15:39:24 molerat guacd[14194]: Internal RDP client disconnected
> Aug 25 15:39:24 molerat guacd[14194]: User
> "@f78e84cb-0ea8-4caa-afcb-40433d29e103" disconnected (0 users remain)
> Aug 25 15:39:24 molerat guacd[14194]: Last user of connection
> "$f4711187-83f6-4684-b5ce-a08b79a38390" disconnected
> Aug 25 15:39:24 molerat guacd[14194]: Requesting termination of client...
> Aug 25 15:39:24 molerat guacd[14194]: Client terminated successfully.
> Aug 25 15:39:24 molerat guacd[14187]: Connection
> "$f4711187-83f6-4684-b5ce-a08b79a38390" removed.
>
> I really don't know what's happening.
>
> This happens with Windows Server 2008 R2 or Windows 7. With Windows 10, it
> connects and works.
>
>
I believe there are some known issues with certain versions of the FreeRDP
libraries, specifically in Ubuntu, that cause this. I can't locate a JIRA
issue for it at the moment, but it seems like it has been brought to either
the mailing list or the JIRA tracker before, and relates to a specific
update to FreeRDP that has caused issues.
-Nick