You are viewing a plain text version of this content. The canonical link for it is here.
Posted to user@guacamole.apache.org by "Wiegman, Steve" <st...@thyssenkrupp.com> on 2022/09/07 06:56:13 UTC

Guacamole RDP to W7 issues

Hi all,

We recently upgraded our Guacamole server from version 0.9.14 to 1.4.0. We did a fresh install and didn't migrate any old data.

Everything seems to be working fine except for the Remote Desktop connections to Windows 7 machines. It instantly disconnects whenever we try to connect to a server. Windows 10 however is working just fine.


  *   The Windows 7 client and Guacamole server can both ping each-other.
  *   Port 3389 on the Windows 7 client is open. (I checked using telnet)
  *   Using other clients I can create a RDP connection to the Windows 7 client without any problems. It's just the RDP connection from Guacamole tot he client.

I can't really figure out what's wrong, maybe you guys see what I'm missing.

My Guacamole RDP settings:

[cid:image001.png@01D8C296.C9D6A540]
[Afbeelding met tekst  Automatisch gegenereerde beschrijving]

Catalina.out log (last 50 lines DEBUG):

[2022-09-07 06:51:27] [info] 06:51:27.637 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Returned connection 1360630681 to pool.
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.t.jdbc.JdbcTransaction - Opening JDBC Connection
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Checked out connection 131714390 from pool.
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Testing connection 131714390 ...
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Connection 131714390 is GOOD!
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.t.jdbc.JdbcTransaction - Setting autocommit to false on JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@7d9cd56]
[2022-09-07 06:51:27] [info] 06:51:27.639 [http-nio-80-exec-10] DEBUG o.a.g.a.j.p.S.selectOne - ==>  Preparing: SELECT DISTINCT ? AS entity_id, permission FROM guacamole_system_permission WHERE ( entity_id = ? OR entity_id IN ( SELECT guacamole_entity.entity_id FROM guacamole_entity JOIN guacamole_user_group ON guacamole_user_group.entity_id = guacamole_entity.entity_id WHERE type = 'USER_GROUP' AND name IN ( ? ) AND disabled = false ) ) AND permission = ?
[2022-09-07 06:51:27] [info] 06:51:27.639 [http-nio-80-exec-10] DEBUG o.a.g.a.j.p.S.selectOne - ==> Parameters: 3(Integer), 3(Integer), SBA(String), ADMINISTER(String)
[2022-09-07 06:51:27] [info] 06:51:27.640 [http-nio-80-exec-10] DEBUG o.a.g.a.j.p.S.selectOne - <==      Total: 1
[2022-09-07 06:51:27] [info] 06:51:27.640 [http-nio-80-exec-10] DEBUG o.a.i.t.jdbc.JdbcTransaction - Resetting autocommit to true on JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@7d9cd56]
[2022-09-07 06:51:27] [info] 06:51:27.640 [http-nio-80-exec-10] DEBUG o.a.i.t.jdbc.JdbcTransaction - Closing JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@7d9cd56]
[2022-09-07 06:51:27] [info] 06:51:27.640 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Testing connection 131714390 ...
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Connection 131714390 is GOOD!
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Returned connection 131714390 to pool.
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.m.g.t.TransactionalMethodInterceptor - [Intercepted method: public java.util.Collection<org.apache.guacamole.net.auth.SharingProfile> org.apache.guacamole.auth.jdbc.sharingprofile.SharingProfileDirectory.getAll(java.util.Collection<java.lang.String>) throws org.apache.guacamole.GuacamoleException] - SqlSession not set for thread: 26, creating a new one
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.m.g.t.TransactionalMethodInterceptor - [Intercepted method: public java.util.Collection<org.apache.guacamole.net.auth.SharingProfile> org.apache.guacamole.auth.jdbc.sharingprofile.SharingProfileDirectory.getAll(java.util.Collection<java.lang.String>) throws org.apache.guacamole.GuacamoleException] - SqlSession of thread: 26 committing
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.m.g.t.TransactionalMethodInterceptor - [Intercepted method: public java.util.Collection<org.apache.guacamole.net.auth.SharingProfile> org.apache.guacamole.auth.jdbc.sharingprofile.SharingProfileDirectory.getAll(java.util.Collection<java.lang.String>) throws org.apache.guacamole.GuacamoleException] - SqlSession of thread: 26 terminated its life-cycle, closing it
[2022-09-07 06:51:27] [info] 06:51:27.902 [http-nio-80-exec-6] INFO  o.a.g.tunnel.TunnelRequestService - User "*****" disconnected from connection "176". Duration: 342 milliseconds
[2022-09-07 06:51:27] [info] 06:51:27.902 [http-nio-80-exec-6] DEBUG o.a.g.net.InetGuacamoleSocket - Closing socket to guacd.
[2022-09-07 06:51:27] [info] 06:51:27.903 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Opening JDBC Connection
[2022-09-07 06:51:27] [info] 06:51:27.903 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Checked out connection 152105523 from pool.
[2022-09-07 06:51:27] [info] 06:51:27.903 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Testing connection 152105523 ...
[2022-09-07 06:51:27] [info] 06:51:27.903 [Thread-401] DEBUG o.a.g.w.GuacamoleWebSocketTunnelEndpoint - Connection to guacd closed.
[2022-09-07 06:51:27] [info] org.apache.guacamole.GuacamoleConnectionClosedException: Connection to guacd is closed.
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.io.ReaderGuacamoleReader.read(ReaderGuacamoleReader.java:183)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.io.ReaderGuacamoleReader.readInstruction(ReaderGuacamoleReader.java:195)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.protocol.FilteredGuacamoleReader.readInstruction(FilteredGuacamoleReader.java:81)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.protocol.FilteredGuacamoleReader.readInstruction(FilteredGuacamoleReader.java:81)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.protocol.FilteredGuacamoleReader.read(FilteredGuacamoleReader.java:64)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.websocket.GuacamoleWebSocketTunnelEndpoint$2.run(GuacamoleWebSocketTunnelEndpoint.java:246)
[2022-09-07 06:51:27] [info] Caused by: java.net.SocketException: Socket closed
[2022-09-07 06:51:27] [info] #011at java.base/java.net.SocketInputStream.read(SocketInputStream.java:183)
[2022-09-07 06:51:27] [info] #011at java.base/java.net.SocketInputStream.read(SocketInputStream.java:140)
[2022-09-07 06:51:27] [info] #011at java.base/sun.nio.cs.StreamDecoder.readBytes(StreamDecoder.java:284)
[2022-09-07 06:51:27] [info] #011at java.base/sun.nio.cs.StreamDecoder.implRead(StreamDecoder.java:326)
[2022-09-07 06:51:27] [info] #011at java.base/sun.nio.cs.StreamDecoder.read(StreamDecoder.java:178)
[2022-09-07 06:51:27] [info] #011at java.base/java.io.InputStreamReader.read(InputStreamReader.java:181)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.io.ReaderGuacamoleReader.read(ReaderGuacamoleReader.java:169)
[2022-09-07 06:51:27] [info] #011... 5 common frames omitted
[2022-09-07 06:51:27] [info] 06:51:27.904 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Connection 152105523 is GOOD!
[2022-09-07 06:51:27] [info] 06:51:27.904 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Setting autocommit to false on JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@910f233]
[2022-09-07 06:51:27] [info] 06:51:27.904 [http-nio-80-exec-6] DEBUG o.a.g.a.j.c.C.insert - ==>  Preparing: INSERT INTO guacamole_connection_history ( connection_id, connection_name, remote_host, sharing_profile_id, sharing_profile_name, user_id, username, start_date, end_date ) VALUES ( ?, ?, ?, ?, ?, (SELECT user_id FROM guacamole_user JOIN guacamole_entity ON guacamole_user.entity_id = guacamole_entity.entity_id WHERE guacamole_entity.name = ? AND guacamole_entity.type = 'USER'), ?, ?, ? )
[2022-09-07 06:51:27] [info] 06:51:27.904 [http-nio-80-exec-6] DEBUG o.a.g.a.j.c.C.insert - ==> Parameters: 176(String), ***** (RDP)(String), 10.53.102.50(String), null, null, *****(String), *****(String), 2022-09-07 06:51:27.542(Timestamp), 2022-09-07 06:51:27.903(Timestamp)
[2022-09-07 06:51:27] [info] 06:51:27.905 [http-nio-80-exec-6] DEBUG o.a.g.a.j.c.C.insert - <==    Updates: 1
[2022-09-07 06:51:27] [info] 06:51:27.905 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Committing JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@910f233]
[2022-09-07 06:51:27] [info] 06:51:27.946 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Resetting autocommit to true on JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@910f233]
[2022-09-07 06:51:27] [info] 06:51:27.946 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Closing JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@910f233]
[2022-09-07 06:51:27] [info] 06:51:27.946 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Testing connection 152105523 ...
[2022-09-07 06:51:27] [info] 06:51:27.947 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Connection 152105523 is GOOD!
[2022-09-07 06:51:27] [info] 06:51:27.947 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Returned connection 152105523 to pool.
kvmadmin@kvm02srv:/var/lib/tomcat9/logs$


RE: Guacamole RDP to W7 issues

Posted by "Wiegman, Steve" <st...@thyssenkrupp.com>.
I managed to fix the problem already. Apparently I had to choose "RDP Encryption" over "Any".

I was pretty sure I tried that out already, but it's working now.

Van: Wiegman, Steve <st...@thyssenkrupp.com>
Verzonden: woensdag 7 september 2022 11:09
Aan: user@guacamole.apache.org
Onderwerp: RE: Guacamole RDP to W7 issues

Sorry I didn't thought about the language difference.

Security mode is currently on "Any" (Ieder), but I tried all the different options already and none of them seem to work.
NLA is disabled on the Windows 7 client by default using a group policy. (See attachment)

Is there a guacd log? As far as I know, by default, Guacamole logs all messages to the console which Tomcat redirects to Catalina.out


Van: MAURIZI Lorenzo <l....@comune.jesi.an.it>>
Verzonden: woensdag 7 september 2022 09:05
Aan: user@guacamole.apache.org<ma...@guacamole.apache.org>
Onderwerp: R: Guacamole RDP to W7 issues

It could be the Security mode (Beveiligins modus ?). It should be something different from NLA, I think Windows 7 does not support it. Leder means automatic?

In any case, to track down the issue, it could be useful a part of the guacd log instead of the catalina.out of guacamole.

Regards
Lorenzo


Da: Wiegman, Steve <st...@thyssenkrupp.com>>
Inviato: mercoledì 7 settembre 2022 08:56
A: user@guacamole.apache.org<ma...@guacamole.apache.org>
Oggetto: Guacamole RDP to W7 issues

Hi all,

We recently upgraded our Guacamole server from version 0.9.14 to 1.4.0. We did a fresh install and didn't migrate any old data.

Everything seems to be working fine except for the Remote Desktop connections to Windows 7 machines. It instantly disconnects whenever we try to connect to a server. Windows 10 however is working just fine.


  *   The Windows 7 client and Guacamole server can both ping each-other.
  *   Port 3389 on the Windows 7 client is open. (I checked using telnet)
  *   Using other clients I can create a RDP connection to the Windows 7 client without any problems. It's just the RDP connection from Guacamole tot he client.

I can't really figure out what's wrong, maybe you guys see what I'm missing.

My Guacamole RDP settings:

[cid:image001.jpg@01D8C2AD.CC161680]
[Afbeelding met tekst  Automatisch gegenereerde beschrijving]

Catalina.out log (last 50 lines DEBUG):

[2022-09-07 06:51:27] [info] 06:51:27.637 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Returned connection 1360630681 to pool.
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.t.jdbc.JdbcTransaction - Opening JDBC Connection
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Checked out connection 131714390 from pool.
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Testing connection 131714390 ...
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Connection 131714390 is GOOD!
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.t.jdbc.JdbcTransaction - Setting autocommit to false on JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@7d9cd56]
[2022-09-07 06:51:27] [info] 06:51:27.639 [http-nio-80-exec-10] DEBUG o.a.g.a.j.p.S.selectOne - ==>  Preparing: SELECT DISTINCT ? AS entity_id, permission FROM guacamole_system_permission WHERE ( entity_id = ? OR entity_id IN ( SELECT guacamole_entity.entity_id FROM guacamole_entity JOIN guacamole_user_group ON guacamole_user_group.entity_id = guacamole_entity.entity_id WHERE type = 'USER_GROUP' AND name IN ( ? ) AND disabled = false ) ) AND permission = ?
[2022-09-07 06:51:27] [info] 06:51:27.639 [http-nio-80-exec-10] DEBUG o.a.g.a.j.p.S.selectOne - ==> Parameters: 3(Integer), 3(Integer), SBA(String), ADMINISTER(String)
[2022-09-07 06:51:27] [info] 06:51:27.640 [http-nio-80-exec-10] DEBUG o.a.g.a.j.p.S.selectOne - <==      Total: 1
[2022-09-07 06:51:27] [info] 06:51:27.640 [http-nio-80-exec-10] DEBUG o.a.i.t.jdbc.JdbcTransaction - Resetting autocommit to true on JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@7d9cd56]
[2022-09-07 06:51:27] [info] 06:51:27.640 [http-nio-80-exec-10] DEBUG o.a.i.t.jdbc.JdbcTransaction - Closing JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@7d9cd56]
[2022-09-07 06:51:27] [info] 06:51:27.640 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Testing connection 131714390 ...
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Connection 131714390 is GOOD!
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Returned connection 131714390 to pool.
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.m.g.t.TransactionalMethodInterceptor - [Intercepted method: public java.util.Collection<org.apache.guacamole.net.auth.SharingProfile> org.apache.guacamole.auth.jdbc.sharingprofile.SharingProfileDirectory.getAll(java.util.Collection<java.lang.String>) throws org.apache.guacamole.GuacamoleException] - SqlSession not set for thread: 26, creating a new one
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.m.g.t.TransactionalMethodInterceptor - [Intercepted method: public java.util.Collection<org.apache.guacamole.net.auth.SharingProfile> org.apache.guacamole.auth.jdbc.sharingprofile.SharingProfileDirectory.getAll(java.util.Collection<java.lang.String>) throws org.apache.guacamole.GuacamoleException] - SqlSession of thread: 26 committing
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.m.g.t.TransactionalMethodInterceptor - [Intercepted method: public java.util.Collection<org.apache.guacamole.net.auth.SharingProfile> org.apache.guacamole.auth.jdbc.sharingprofile.SharingProfileDirectory.getAll(java.util.Collection<java.lang.String>) throws org.apache.guacamole.GuacamoleException] - SqlSession of thread: 26 terminated its life-cycle, closing it
[2022-09-07 06:51:27] [info] 06:51:27.902 [http-nio-80-exec-6] INFO  o.a.g.tunnel.TunnelRequestService - User "*****" disconnected from connection "176". Duration: 342 milliseconds
[2022-09-07 06:51:27] [info] 06:51:27.902 [http-nio-80-exec-6] DEBUG o.a.g.net.InetGuacamoleSocket - Closing socket to guacd.
[2022-09-07 06:51:27] [info] 06:51:27.903 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Opening JDBC Connection
[2022-09-07 06:51:27] [info] 06:51:27.903 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Checked out connection 152105523 from pool.
[2022-09-07 06:51:27] [info] 06:51:27.903 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Testing connection 152105523 ...
[2022-09-07 06:51:27] [info] 06:51:27.903 [Thread-401] DEBUG o.a.g.w.GuacamoleWebSocketTunnelEndpoint - Connection to guacd closed.
[2022-09-07 06:51:27] [info] org.apache.guacamole.GuacamoleConnectionClosedException: Connection to guacd is closed.
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.io.ReaderGuacamoleReader.read(ReaderGuacamoleReader.java:183)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.io.ReaderGuacamoleReader.readInstruction(ReaderGuacamoleReader.java:195)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.protocol.FilteredGuacamoleReader.readInstruction(FilteredGuacamoleReader.java:81)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.protocol.FilteredGuacamoleReader.readInstruction(FilteredGuacamoleReader.java:81)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.protocol.FilteredGuacamoleReader.read(FilteredGuacamoleReader.java:64)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.websocket.GuacamoleWebSocketTunnelEndpoint$2.run(GuacamoleWebSocketTunnelEndpoint.java:246)
[2022-09-07 06:51:27] [info] Caused by: java.net.SocketException: Socket closed
[2022-09-07 06:51:27] [info] #011at java.base/java.net.SocketInputStream.read(SocketInputStream.java:183)
[2022-09-07 06:51:27] [info] #011at java.base/java.net.SocketInputStream.read(SocketInputStream.java:140)
[2022-09-07 06:51:27] [info] #011at java.base/sun.nio.cs.StreamDecoder.readBytes(StreamDecoder.java:284)
[2022-09-07 06:51:27] [info] #011at java.base/sun.nio.cs.StreamDecoder.implRead(StreamDecoder.java:326)
[2022-09-07 06:51:27] [info] #011at java.base/sun.nio.cs.StreamDecoder.read(StreamDecoder.java:178)
[2022-09-07 06:51:27] [info] #011at java.base/java.io.InputStreamReader.read(InputStreamReader.java:181)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.io.ReaderGuacamoleReader.read(ReaderGuacamoleReader.java:169)
[2022-09-07 06:51:27] [info] #011... 5 common frames omitted
[2022-09-07 06:51:27] [info] 06:51:27.904 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Connection 152105523 is GOOD!
[2022-09-07 06:51:27] [info] 06:51:27.904 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Setting autocommit to false on JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@910f233]
[2022-09-07 06:51:27] [info] 06:51:27.904 [http-nio-80-exec-6] DEBUG o.a.g.a.j.c.C.insert - ==>  Preparing: INSERT INTO guacamole_connection_history ( connection_id, connection_name, remote_host, sharing_profile_id, sharing_profile_name, user_id, username, start_date, end_date ) VALUES ( ?, ?, ?, ?, ?, (SELECT user_id FROM guacamole_user JOIN guacamole_entity ON guacamole_user.entity_id = guacamole_entity.entity_id WHERE guacamole_entity.name = ? AND guacamole_entity.type = 'USER'), ?, ?, ? )
[2022-09-07 06:51:27] [info] 06:51:27.904 [http-nio-80-exec-6] DEBUG o.a.g.a.j.c.C.insert - ==> Parameters: 176(String), ***** (RDP)(String), 10.53.102.50(String), null, null, *****(String), *****(String), 2022-09-07 06:51:27.542(Timestamp), 2022-09-07 06:51:27.903(Timestamp)
[2022-09-07 06:51:27] [info] 06:51:27.905 [http-nio-80-exec-6] DEBUG o.a.g.a.j.c.C.insert - <==    Updates: 1
[2022-09-07 06:51:27] [info] 06:51:27.905 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Committing JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@910f233]
[2022-09-07 06:51:27] [info] 06:51:27.946 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Resetting autocommit to true on JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@910f233]
[2022-09-07 06:51:27] [info] 06:51:27.946 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Closing JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@910f233]
[2022-09-07 06:51:27] [info] 06:51:27.946 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Testing connection 152105523 ...
[2022-09-07 06:51:27] [info] 06:51:27.947 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Connection 152105523 is GOOD!
[2022-09-07 06:51:27] [info] 06:51:27.947 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Returned connection 152105523 to pool.
kvmadmin@kvm02srv:/var/lib/tomcat9/logs$


RE: Guacamole RDP to W7 issues

Posted by "Wiegman, Steve" <st...@thyssenkrupp.com>.
Sorry I didn't thought about the language difference.

Security mode is currently on "Any" (Ieder), but I tried all the different options already and none of them seem to work.
NLA is disabled on the Windows 7 client by default using a group policy. (See attachment)

Is there a guacd log? As far as I know, by default, Guacamole logs all messages to the console which Tomcat redirects to Catalina.out


Van: MAURIZI Lorenzo <l....@comune.jesi.an.it>
Verzonden: woensdag 7 september 2022 09:05
Aan: user@guacamole.apache.org
Onderwerp: R: Guacamole RDP to W7 issues

It could be the Security mode (Beveiligins modus ?). It should be something different from NLA, I think Windows 7 does not support it. Leder means automatic?

In any case, to track down the issue, it could be useful a part of the guacd log instead of the catalina.out of guacamole.

Regards
Lorenzo


Da: Wiegman, Steve <st...@thyssenkrupp.com>>
Inviato: mercoledì 7 settembre 2022 08:56
A: user@guacamole.apache.org<ma...@guacamole.apache.org>
Oggetto: Guacamole RDP to W7 issues

Hi all,

We recently upgraded our Guacamole server from version 0.9.14 to 1.4.0. We did a fresh install and didn't migrate any old data.

Everything seems to be working fine except for the Remote Desktop connections to Windows 7 machines. It instantly disconnects whenever we try to connect to a server. Windows 10 however is working just fine.


  *   The Windows 7 client and Guacamole server can both ping each-other.
  *   Port 3389 on the Windows 7 client is open. (I checked using telnet)
  *   Using other clients I can create a RDP connection to the Windows 7 client without any problems. It's just the RDP connection from Guacamole tot he client.

I can't really figure out what's wrong, maybe you guys see what I'm missing.

My Guacamole RDP settings:

[cid:image001.jpg@01D8C2AA.25C22920]
[Afbeelding met tekst  Automatisch gegenereerde beschrijving]

Catalina.out log (last 50 lines DEBUG):

[2022-09-07 06:51:27] [info] 06:51:27.637 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Returned connection 1360630681 to pool.
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.t.jdbc.JdbcTransaction - Opening JDBC Connection
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Checked out connection 131714390 from pool.
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Testing connection 131714390 ...
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Connection 131714390 is GOOD!
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.t.jdbc.JdbcTransaction - Setting autocommit to false on JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@7d9cd56]
[2022-09-07 06:51:27] [info] 06:51:27.639 [http-nio-80-exec-10] DEBUG o.a.g.a.j.p.S.selectOne - ==>  Preparing: SELECT DISTINCT ? AS entity_id, permission FROM guacamole_system_permission WHERE ( entity_id = ? OR entity_id IN ( SELECT guacamole_entity.entity_id FROM guacamole_entity JOIN guacamole_user_group ON guacamole_user_group.entity_id = guacamole_entity.entity_id WHERE type = 'USER_GROUP' AND name IN ( ? ) AND disabled = false ) ) AND permission = ?
[2022-09-07 06:51:27] [info] 06:51:27.639 [http-nio-80-exec-10] DEBUG o.a.g.a.j.p.S.selectOne - ==> Parameters: 3(Integer), 3(Integer), SBA(String), ADMINISTER(String)
[2022-09-07 06:51:27] [info] 06:51:27.640 [http-nio-80-exec-10] DEBUG o.a.g.a.j.p.S.selectOne - <==      Total: 1
[2022-09-07 06:51:27] [info] 06:51:27.640 [http-nio-80-exec-10] DEBUG o.a.i.t.jdbc.JdbcTransaction - Resetting autocommit to true on JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@7d9cd56]
[2022-09-07 06:51:27] [info] 06:51:27.640 [http-nio-80-exec-10] DEBUG o.a.i.t.jdbc.JdbcTransaction - Closing JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@7d9cd56]
[2022-09-07 06:51:27] [info] 06:51:27.640 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Testing connection 131714390 ...
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Connection 131714390 is GOOD!
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Returned connection 131714390 to pool.
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.m.g.t.TransactionalMethodInterceptor - [Intercepted method: public java.util.Collection<org.apache.guacamole.net.auth.SharingProfile> org.apache.guacamole.auth.jdbc.sharingprofile.SharingProfileDirectory.getAll(java.util.Collection<java.lang.String>) throws org.apache.guacamole.GuacamoleException] - SqlSession not set for thread: 26, creating a new one
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.m.g.t.TransactionalMethodInterceptor - [Intercepted method: public java.util.Collection<org.apache.guacamole.net.auth.SharingProfile> org.apache.guacamole.auth.jdbc.sharingprofile.SharingProfileDirectory.getAll(java.util.Collection<java.lang.String>) throws org.apache.guacamole.GuacamoleException] - SqlSession of thread: 26 committing
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.m.g.t.TransactionalMethodInterceptor - [Intercepted method: public java.util.Collection<org.apache.guacamole.net.auth.SharingProfile> org.apache.guacamole.auth.jdbc.sharingprofile.SharingProfileDirectory.getAll(java.util.Collection<java.lang.String>) throws org.apache.guacamole.GuacamoleException] - SqlSession of thread: 26 terminated its life-cycle, closing it
[2022-09-07 06:51:27] [info] 06:51:27.902 [http-nio-80-exec-6] INFO  o.a.g.tunnel.TunnelRequestService - User "*****" disconnected from connection "176". Duration: 342 milliseconds
[2022-09-07 06:51:27] [info] 06:51:27.902 [http-nio-80-exec-6] DEBUG o.a.g.net.InetGuacamoleSocket - Closing socket to guacd.
[2022-09-07 06:51:27] [info] 06:51:27.903 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Opening JDBC Connection
[2022-09-07 06:51:27] [info] 06:51:27.903 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Checked out connection 152105523 from pool.
[2022-09-07 06:51:27] [info] 06:51:27.903 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Testing connection 152105523 ...
[2022-09-07 06:51:27] [info] 06:51:27.903 [Thread-401] DEBUG o.a.g.w.GuacamoleWebSocketTunnelEndpoint - Connection to guacd closed.
[2022-09-07 06:51:27] [info] org.apache.guacamole.GuacamoleConnectionClosedException: Connection to guacd is closed.
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.io.ReaderGuacamoleReader.read(ReaderGuacamoleReader.java:183)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.io.ReaderGuacamoleReader.readInstruction(ReaderGuacamoleReader.java:195)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.protocol.FilteredGuacamoleReader.readInstruction(FilteredGuacamoleReader.java:81)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.protocol.FilteredGuacamoleReader.readInstruction(FilteredGuacamoleReader.java:81)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.protocol.FilteredGuacamoleReader.read(FilteredGuacamoleReader.java:64)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.websocket.GuacamoleWebSocketTunnelEndpoint$2.run(GuacamoleWebSocketTunnelEndpoint.java:246)
[2022-09-07 06:51:27] [info] Caused by: java.net.SocketException: Socket closed
[2022-09-07 06:51:27] [info] #011at java.base/java.net.SocketInputStream.read(SocketInputStream.java:183)
[2022-09-07 06:51:27] [info] #011at java.base/java.net.SocketInputStream.read(SocketInputStream.java:140)
[2022-09-07 06:51:27] [info] #011at java.base/sun.nio.cs.StreamDecoder.readBytes(StreamDecoder.java:284)
[2022-09-07 06:51:27] [info] #011at java.base/sun.nio.cs.StreamDecoder.implRead(StreamDecoder.java:326)
[2022-09-07 06:51:27] [info] #011at java.base/sun.nio.cs.StreamDecoder.read(StreamDecoder.java:178)
[2022-09-07 06:51:27] [info] #011at java.base/java.io.InputStreamReader.read(InputStreamReader.java:181)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.io.ReaderGuacamoleReader.read(ReaderGuacamoleReader.java:169)
[2022-09-07 06:51:27] [info] #011... 5 common frames omitted
[2022-09-07 06:51:27] [info] 06:51:27.904 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Connection 152105523 is GOOD!
[2022-09-07 06:51:27] [info] 06:51:27.904 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Setting autocommit to false on JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@910f233]
[2022-09-07 06:51:27] [info] 06:51:27.904 [http-nio-80-exec-6] DEBUG o.a.g.a.j.c.C.insert - ==>  Preparing: INSERT INTO guacamole_connection_history ( connection_id, connection_name, remote_host, sharing_profile_id, sharing_profile_name, user_id, username, start_date, end_date ) VALUES ( ?, ?, ?, ?, ?, (SELECT user_id FROM guacamole_user JOIN guacamole_entity ON guacamole_user.entity_id = guacamole_entity.entity_id WHERE guacamole_entity.name = ? AND guacamole_entity.type = 'USER'), ?, ?, ? )
[2022-09-07 06:51:27] [info] 06:51:27.904 [http-nio-80-exec-6] DEBUG o.a.g.a.j.c.C.insert - ==> Parameters: 176(String), ***** (RDP)(String), 10.53.102.50(String), null, null, *****(String), *****(String), 2022-09-07 06:51:27.542(Timestamp), 2022-09-07 06:51:27.903(Timestamp)
[2022-09-07 06:51:27] [info] 06:51:27.905 [http-nio-80-exec-6] DEBUG o.a.g.a.j.c.C.insert - <==    Updates: 1
[2022-09-07 06:51:27] [info] 06:51:27.905 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Committing JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@910f233]
[2022-09-07 06:51:27] [info] 06:51:27.946 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Resetting autocommit to true on JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@910f233]
[2022-09-07 06:51:27] [info] 06:51:27.946 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Closing JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@910f233]
[2022-09-07 06:51:27] [info] 06:51:27.946 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Testing connection 152105523 ...
[2022-09-07 06:51:27] [info] 06:51:27.947 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Connection 152105523 is GOOD!
[2022-09-07 06:51:27] [info] 06:51:27.947 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Returned connection 152105523 to pool.
kvmadmin@kvm02srv:/var/lib/tomcat9/logs$


R: Guacamole RDP to W7 issues

Posted by MAURIZI Lorenzo <l....@comune.jesi.an.it>.
It could be the Security mode (Beveiligins modus ?). It should be something different from NLA, I think Windows 7 does not support it. Leder means automatic?

In any case, to track down the issue, it could be useful a part of the guacd log instead of the catalina.out of guacamole.

Regards
Lorenzo


Da: Wiegman, Steve <st...@thyssenkrupp.com>
Inviato: mercoledì 7 settembre 2022 08:56
A: user@guacamole.apache.org
Oggetto: Guacamole RDP to W7 issues

Hi all,

We recently upgraded our Guacamole server from version 0.9.14 to 1.4.0. We did a fresh install and didn't migrate any old data.

Everything seems to be working fine except for the Remote Desktop connections to Windows 7 machines. It instantly disconnects whenever we try to connect to a server. Windows 10 however is working just fine.


  *   The Windows 7 client and Guacamole server can both ping each-other.
  *   Port 3389 on the Windows 7 client is open. (I checked using telnet)
  *   Using other clients I can create a RDP connection to the Windows 7 client without any problems. It's just the RDP connection from Guacamole tot he client.

I can't really figure out what's wrong, maybe you guys see what I'm missing.

My Guacamole RDP settings:

[cid:image003.jpg@01D8C298.F10FED40]
[Afbeelding met tekst  Automatisch gegenereerde beschrijving]

Catalina.out log (last 50 lines DEBUG):

[2022-09-07 06:51:27] [info] 06:51:27.637 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Returned connection 1360630681 to pool.
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.t.jdbc.JdbcTransaction - Opening JDBC Connection
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Checked out connection 131714390 from pool.
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Testing connection 131714390 ...
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Connection 131714390 is GOOD!
[2022-09-07 06:51:27] [info] 06:51:27.638 [http-nio-80-exec-10] DEBUG o.a.i.t.jdbc.JdbcTransaction - Setting autocommit to false on JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@7d9cd56]
[2022-09-07 06:51:27] [info] 06:51:27.639 [http-nio-80-exec-10] DEBUG o.a.g.a.j.p.S.selectOne - ==>  Preparing: SELECT DISTINCT ? AS entity_id, permission FROM guacamole_system_permission WHERE ( entity_id = ? OR entity_id IN ( SELECT guacamole_entity.entity_id FROM guacamole_entity JOIN guacamole_user_group ON guacamole_user_group.entity_id = guacamole_entity.entity_id WHERE type = 'USER_GROUP' AND name IN ( ? ) AND disabled = false ) ) AND permission = ?
[2022-09-07 06:51:27] [info] 06:51:27.639 [http-nio-80-exec-10] DEBUG o.a.g.a.j.p.S.selectOne - ==> Parameters: 3(Integer), 3(Integer), SBA(String), ADMINISTER(String)
[2022-09-07 06:51:27] [info] 06:51:27.640 [http-nio-80-exec-10] DEBUG o.a.g.a.j.p.S.selectOne - <==      Total: 1
[2022-09-07 06:51:27] [info] 06:51:27.640 [http-nio-80-exec-10] DEBUG o.a.i.t.jdbc.JdbcTransaction - Resetting autocommit to true on JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@7d9cd56]
[2022-09-07 06:51:27] [info] 06:51:27.640 [http-nio-80-exec-10] DEBUG o.a.i.t.jdbc.JdbcTransaction - Closing JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@7d9cd56]
[2022-09-07 06:51:27] [info] 06:51:27.640 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Testing connection 131714390 ...
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Connection 131714390 is GOOD!
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.a.i.d.pooled.PooledDataSource - Returned connection 131714390 to pool.
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.m.g.t.TransactionalMethodInterceptor - [Intercepted method: public java.util.Collection<org.apache.guacamole.net.auth.SharingProfile> org.apache.guacamole.auth.jdbc.sharingprofile.SharingProfileDirectory.getAll(java.util.Collection<java.lang.String>) throws org.apache.guacamole.GuacamoleException] - SqlSession not set for thread: 26, creating a new one
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.m.g.t.TransactionalMethodInterceptor - [Intercepted method: public java.util.Collection<org.apache.guacamole.net.auth.SharingProfile> org.apache.guacamole.auth.jdbc.sharingprofile.SharingProfileDirectory.getAll(java.util.Collection<java.lang.String>) throws org.apache.guacamole.GuacamoleException] - SqlSession of thread: 26 committing
[2022-09-07 06:51:27] [info] 06:51:27.641 [http-nio-80-exec-10] DEBUG o.m.g.t.TransactionalMethodInterceptor - [Intercepted method: public java.util.Collection<org.apache.guacamole.net.auth.SharingProfile> org.apache.guacamole.auth.jdbc.sharingprofile.SharingProfileDirectory.getAll(java.util.Collection<java.lang.String>) throws org.apache.guacamole.GuacamoleException] - SqlSession of thread: 26 terminated its life-cycle, closing it
[2022-09-07 06:51:27] [info] 06:51:27.902 [http-nio-80-exec-6] INFO  o.a.g.tunnel.TunnelRequestService - User "*****" disconnected from connection "176". Duration: 342 milliseconds
[2022-09-07 06:51:27] [info] 06:51:27.902 [http-nio-80-exec-6] DEBUG o.a.g.net.InetGuacamoleSocket - Closing socket to guacd.
[2022-09-07 06:51:27] [info] 06:51:27.903 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Opening JDBC Connection
[2022-09-07 06:51:27] [info] 06:51:27.903 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Checked out connection 152105523 from pool.
[2022-09-07 06:51:27] [info] 06:51:27.903 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Testing connection 152105523 ...
[2022-09-07 06:51:27] [info] 06:51:27.903 [Thread-401] DEBUG o.a.g.w.GuacamoleWebSocketTunnelEndpoint - Connection to guacd closed.
[2022-09-07 06:51:27] [info] org.apache.guacamole.GuacamoleConnectionClosedException: Connection to guacd is closed.
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.io.ReaderGuacamoleReader.read(ReaderGuacamoleReader.java:183)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.io.ReaderGuacamoleReader.readInstruction(ReaderGuacamoleReader.java:195)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.protocol.FilteredGuacamoleReader.readInstruction(FilteredGuacamoleReader.java:81)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.protocol.FilteredGuacamoleReader.readInstruction(FilteredGuacamoleReader.java:81)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.protocol.FilteredGuacamoleReader.read(FilteredGuacamoleReader.java:64)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.websocket.GuacamoleWebSocketTunnelEndpoint$2.run(GuacamoleWebSocketTunnelEndpoint.java:246)
[2022-09-07 06:51:27] [info] Caused by: java.net.SocketException: Socket closed
[2022-09-07 06:51:27] [info] #011at java.base/java.net.SocketInputStream.read(SocketInputStream.java:183)
[2022-09-07 06:51:27] [info] #011at java.base/java.net.SocketInputStream.read(SocketInputStream.java:140)
[2022-09-07 06:51:27] [info] #011at java.base/sun.nio.cs.StreamDecoder.readBytes(StreamDecoder.java:284)
[2022-09-07 06:51:27] [info] #011at java.base/sun.nio.cs.StreamDecoder.implRead(StreamDecoder.java:326)
[2022-09-07 06:51:27] [info] #011at java.base/sun.nio.cs.StreamDecoder.read(StreamDecoder.java:178)
[2022-09-07 06:51:27] [info] #011at java.base/java.io.InputStreamReader.read(InputStreamReader.java:181)
[2022-09-07 06:51:27] [info] #011at org.apache.guacamole.io.ReaderGuacamoleReader.read(ReaderGuacamoleReader.java:169)
[2022-09-07 06:51:27] [info] #011... 5 common frames omitted
[2022-09-07 06:51:27] [info] 06:51:27.904 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Connection 152105523 is GOOD!
[2022-09-07 06:51:27] [info] 06:51:27.904 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Setting autocommit to false on JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@910f233]
[2022-09-07 06:51:27] [info] 06:51:27.904 [http-nio-80-exec-6] DEBUG o.a.g.a.j.c.C.insert - ==>  Preparing: INSERT INTO guacamole_connection_history ( connection_id, connection_name, remote_host, sharing_profile_id, sharing_profile_name, user_id, username, start_date, end_date ) VALUES ( ?, ?, ?, ?, ?, (SELECT user_id FROM guacamole_user JOIN guacamole_entity ON guacamole_user.entity_id = guacamole_entity.entity_id WHERE guacamole_entity.name = ? AND guacamole_entity.type = 'USER'), ?, ?, ? )
[2022-09-07 06:51:27] [info] 06:51:27.904 [http-nio-80-exec-6] DEBUG o.a.g.a.j.c.C.insert - ==> Parameters: 176(String), ***** (RDP)(String), 10.53.102.50(String), null, null, *****(String), *****(String), 2022-09-07 06:51:27.542(Timestamp), 2022-09-07 06:51:27.903(Timestamp)
[2022-09-07 06:51:27] [info] 06:51:27.905 [http-nio-80-exec-6] DEBUG o.a.g.a.j.c.C.insert - <==    Updates: 1
[2022-09-07 06:51:27] [info] 06:51:27.905 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Committing JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@910f233]
[2022-09-07 06:51:27] [info] 06:51:27.946 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Resetting autocommit to true on JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@910f233]
[2022-09-07 06:51:27] [info] 06:51:27.946 [http-nio-80-exec-6] DEBUG o.a.i.t.jdbc.JdbcTransaction - Closing JDBC Connection [com.mysql.cj.jdbc.ConnectionImpl@910f233]
[2022-09-07 06:51:27] [info] 06:51:27.946 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Testing connection 152105523 ...
[2022-09-07 06:51:27] [info] 06:51:27.947 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Connection 152105523 is GOOD!
[2022-09-07 06:51:27] [info] 06:51:27.947 [http-nio-80-exec-6] DEBUG o.a.i.d.pooled.PooledDataSource - Returned connection 152105523 to pool.
kvmadmin@kvm02srv:/var/lib/tomcat9/logs$