Tomás Esteban Losada created GUACAMOLE-1326:
-----------------------------------------------
Summary: Guacamole v1.30 cannot establish RDP sessions after
upgrading from v1.2.0
Key: GUACAMOLE-1326
URL: https://issues.apache.org/jira/browse/GUACAMOLE-1326
Project: Guacamole
Issue Type: Bug
Components: guacamole-client, guacd
Affects Versions: 1.3.0
Environment: Debian 10 Buster
guacd v1.3.0
freerdp2-dev v2.0.0~git20190204.1.2693389a+dfsg1-1+deb10u2
Reporter: Tomás Esteban Losada
Attachments: image-2021-04-12-12-36-25-174.png
I've been worikig with Guacamole *v1.2.0* without any issues using RDP in my
Debian 10 Buster until now. I have upgraded to version *v1.3.0* building
*guacamole-server* and *guacamole-client* source code directly from Repo and I
cannot connect to my servers using RDP anymore. This is the error I get:
!image-2021-04-12-12-36-40-827.png!
*guacd* daemon is running:
~root@guacamole2:/opt/tomcat/logs# systemctl status guacd~
~● guacd.service - LSB: Guacamole proxy daemon~
~Loaded: loaded (/etc/init.d/guacd; generated)~
~Active: active (running) since Mon 2021-04-12 11:18:11 -03; 1h 19min ago~
~Docs: man:systemd-sysv-generator(8)~
~Process: 18457 ExecStart=/etc/init.d/guacd start (code=exited,
status=0/SUCCESS)~
~Tasks: 1 (limit: 2277)~
~Memory: 10.4M~
~CGroup: /system.slice/guacd.service~
~└─18461 /usr/local/sbin/guacd -p /var/run/guacd.pid~
~Apr 12 11:18:11 guacamole2 systemd[1]: Starting LSB: Guacamole proxy daemon...~
~Apr 12 11:18:11 guacamole2 guacd[18459]: Guacamole proxy daemon (guacd)
version 1.3.0 started~
~Apr 12 11:18:11 guacamole2 guacd[18457]: Starting guacd: guacd[18459]: INFO:
Guacamole proxy daemon (guacd) version 1.3.0 s~
~Apr 12 11:18:11 guacamole2 guacd[18457]: SUCCESS~
~Apr 12 11:18:11 guacamole2 systemd[1]: Started LSB: Guacamole proxy daemon.~
~Apr 12 11:18:11 guacamole2 guacd[18461]: Listening on host ::1, port 4822~
~lines 1-16/16 (END)~
And is listening at *localhost:4822* :
~root@guacamole2:/etc/guacamole# cat guacamole.properties~
~# Hostname and Guacamole server port~
~guacd-hostname: localhost~
~guacd-port: 4822~
~root@guacamole2:/etc/guacamole# telnet localhost 4822~
~Trying ::1...~
~Connected to localhost.~
~Escape character is '^]'.~
There seems to be no problems in */var/log/syslog*:
~Apr 12 11:18:03 guacamole2 systemd[1]: Starting Apache Tomcat Web Application
Container...~
~Apr 12 11:18:03 guacamole2 startup.sh[18412]: Tomcat started.~
~Apr 12 11:18:03 guacamole2 systemd[1]: Started Apache Tomcat Web Application
Container.~
~Apr 12 11:18:11 guacamole2 systemd[1]: Starting LSB: Guacamole proxy daemon...~
~Apr 12 11:18:11 guacamole2 guacd[18459]: Guacamole proxy daemon (guacd)
version 1.3.0 started~
~Apr 12 11:18:11 guacamole2 guacd[18457]: Starting guacd: guacd[18459]:
INFO:#011Guacamole proxy daemon (guacd) version 1.3.0 started~
~Apr 12 11:18:11 guacamole2 guacd[18457]: SUCCESS~
~Apr 12 11:18:11 guacamole2 systemd[1]: Started LSB: Guacamole proxy daemon.~
~Apr 12 11:18:11 guacamole2 guacd[18461]: Listening on host ::1, port 4822~
This is what I get in */opt/tomcat/logs/localhost_access_log.**:
~127.0.0.1 - - [12/Apr/2021:12:51:00 -0300] "POST /guacamole/api/tokens
HTTP/1.1" 200 187~
~0:0:0:0:0:0:0:1 - - [12/Apr/2021:12:51:00 -0300] "GET
/guacamole/app/element/templates/blank.html HTTP/1.1" 200 173~
~127.0.0.1 - - [12/Apr/2021:12:51:01 -0300] "GET
/guacamole/websocket-tunnel?token=F01049CFF44F51D6480CBDA56F795AA4130BB19383CBE430A0DDAA9789EFFD12&GUAC_DATA_SOURCE=mysql&GUAC_ID=4&GUAC_TYPE=c&GUAC_WIDTH=1360&GUAC_HEIGHT=625&GUAC_DPI=96&GUAC_TIMEZONE=America%2FBuenos_Aires&GUAC_AUDIO=audio%2FL8&GUAC_AUDIO=audio%2FL16&GUAC_IMAGE=image%2Fjpeg&GUAC_IMAGE=image%2Fpng&GUAC_IMAGE=image%2Fwebp
HTTP/1.1" 101 -~
~0:0:0:0:0:0:0:1 - - [12/Apr/2021:12:51:01 -0300] "POST
/guacamole/tunnel?connect HTTP/1.1" 500 676~
~127.0.0.1 - - [12/Apr/2021:12:51:01 -0300] "POST /guacamole/api/tokens
HTTP/1.1" 200 187~
~This in */opt/tomcat/logs/localhost.**:~
~12-Apr-2021 08:16:03.006 INFO [main]
org.apache.catalina.core.ApplicationContext.log SessionListener:
contextDestroyed()~
~12-Apr-2021 08:16:03.006 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
contextDestroyed()~
~12-Apr-2021 08:33:37.912 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
contextInitialized()~
~12-Apr-2021 08:33:37.913 INFO [main]
org.apache.catalina.core.ApplicationContext.log SessionListener:
contextInitialized()~
~12-Apr-2021 08:33:37.914 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
attributeAdded('StockTicker', 'async.Stockticker@6c758c74')~
~12-Apr-2021 08:34:25.924 INFO [main]
org.apache.catalina.core.ApplicationContext.log SessionListener:
contextDestroyed()~
~12-Apr-2021 08:34:25.924 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
contextDestroyed()~
~12-Apr-2021 08:34:44.032 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
contextInitialized()~
~12-Apr-2021 08:34:44.033 INFO [main]
org.apache.catalina.core.ApplicationContext.log SessionListener:
contextInitialized()~
~12-Apr-2021 08:34:44.035 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
attributeAdded('StockTicker', 'async.Stockticker@55a4a0ab')~
~12-Apr-2021 08:38:01.000 INFO [main]
org.apache.catalina.core.ApplicationContext.log SessionListener:
contextDestroyed()~
~12-Apr-2021 08:38:01.000 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
contextDestroyed()~
~12-Apr-2021 08:47:10.578 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
contextInitialized()~
~12-Apr-2021 08:47:10.578 INFO [main]
org.apache.catalina.core.ApplicationContext.log SessionListener:
contextInitialized()~
~12-Apr-2021 08:47:10.581 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
attributeAdded('StockTicker', 'async.Stockticker@1f94e1')~
~12-Apr-2021 09:06:14.160 INFO [main]
org.apache.catalina.core.ApplicationContext.log SessionListener:
contextDestroyed()~
~12-Apr-2021 09:06:14.160 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
contextDestroyed()~
~12-Apr-2021 09:26:49.382 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
contextInitialized()~
~12-Apr-2021 09:26:49.384 INFO [main]
org.apache.catalina.core.ApplicationContext.log SessionListener:
contextInitialized()~
~12-Apr-2021 09:26:49.385 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
attributeAdded('StockTicker', 'async.Stockticker@7194f5b')~
~12-Apr-2021 09:47:59.700 INFO [main]
org.apache.catalina.core.ApplicationContext.log SessionListener:
contextDestroyed()~
~12-Apr-2021 09:47:59.700 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
contextDestroyed()~
~12-Apr-2021 09:48:28.334 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
contextInitialized()~
~12-Apr-2021 09:48:28.335 INFO [main]
org.apache.catalina.core.ApplicationContext.log SessionListener:
contextInitialized()~
~12-Apr-2021 09:48:28.336 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
attributeAdded('StockTicker', 'async.Stockticker@4af32714')~
~12-Apr-2021 10:36:59.848 INFO [main]
org.apache.catalina.core.ApplicationContext.log SessionListener:
contextDestroyed()~
~12-Apr-2021 10:36:59.848 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
contextDestroyed()~
~12-Apr-2021 10:37:21.985 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
contextInitialized()~
~12-Apr-2021 10:37:21.985 INFO [main]
org.apache.catalina.core.ApplicationContext.log SessionListener:
contextInitialized()~
~12-Apr-2021 10:37:21.987 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
attributeAdded('StockTicker', 'async.Stockticker@417c9b17')~
~12-Apr-2021 10:42:38.044 INFO [main]
org.apache.catalina.core.ApplicationContext.log SessionListener:
contextDestroyed()~
~12-Apr-2021 10:42:38.044 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
contextDestroyed()~
~12-Apr-2021 10:43:09.830 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
contextInitialized()~
~12-Apr-2021 10:43:09.830 INFO [main]
org.apache.catalina.core.ApplicationContext.log SessionListener:
contextInitialized()~
~12-Apr-2021 10:43:09.832 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
attributeAdded('StockTicker', 'async.Stockticker@1f94e1')~
~12-Apr-2021 11:16:59.485 INFO [main]
org.apache.catalina.core.ApplicationContext.log SessionListener:
contextDestroyed()~
~12-Apr-2021 11:16:59.485 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
contextDestroyed()~
~12-Apr-2021 11:18:11.313 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
contextInitialized()~
~12-Apr-2021 11:18:11.314 INFO [main]
org.apache.catalina.core.ApplicationContext.log SessionListener:
contextInitialized()~
~12-Apr-2021 11:18:11.316 INFO [main]
org.apache.catalina.core.ApplicationContext.log ContextListener:
attributeAdded('StockTicker', 'async.Stockticker@31e5d408')~
And this in */opt/tomcat/logs/catalina.out*:
~12:56:56.442 [http-nio-8080-exec-8] ERROR
o.a.g.w.GuacamoleWebSocketTunnelEndpoint - Creation of WebSocket tunnel to
guacd failed: java.net.ConnectException: Connection refused (Connection
refused)~
~12:56:56.467 [http-nio-8080-exec-5] ERROR o.a.g.s.GuacamoleHTTPTunnelServlet -
HTTP tunnel request failed: java.net.ConnectException: Connection refused
(Connection refused)~
How you can see, this last log shows that *guacamole-client* cannot establish a
connection with *guacd*.
I also tried to run guacamole-client and server downloading them from
[https://guacamole.apache.org/releases/1.3.0/|[https://guacamole.apache.org/releases/1.3.0/],]
however I had [this other
issue|https://issues.apache.org/jira/browse/GUACAMOLE-1324/].
Could you please help me with this?
--
This message was sent by Atlassian Jira
(v8.3.4#803005)
