You are viewing a plain text version of this content. The canonical link for it is here.
Posted to user@guacamole.apache.org by Igor Kattar <ig...@gmail.com> on 2020/02/19 17:36:36 UTC
Unstable server after 1.0.0 upgrade to 1.1.0
After an upgrade of guacamole-server and client to 1.1.0 any connection
made is quite slow and the message "The network connection to guacamole
server appears unstable" keeps poping up frequently, even on SSH or TELNET
connections (more often in VNC and RDP).
In the previous version (1.0.0) there was no such problem at all.
The daemon (GUACD), conteiner (JETTY) and auth database (PostgreSQL) are on
the same machine (FreeBSD).
Below are some configuration files and logs that I think could help anyone
help me return to the previous behaviour.
P.s.: I noticed that, at least on FreeBSD ports, there are no SQL script to
update the authentication database (PostgreSQL) to the new version (1.0.0
-> 1.1.0) is that right?
This is the log of GUACD when I start a session with a Windows machine,
operate briefly then disconnect.
# guacd -L debug -f
guacd[26504]: INFO: Guacamole proxy daemon (guacd) version 1.1.0 started
guacd[26504]: DEBUG: Unable to bind socket to host ::1, port 4822: Invalid
argument
guacd[26504]: DEBUG: Successfully bound socket to host 127.0.0.1, port 4822
guacd[26504]: INFO: Listening on host 127.0.0.1, port 4822
guacd[26504]: INFO: Creating new client for protocol "rdp"
guacd[26504]: INFO: Connection ID is "$f130e90b-3c66-49f0-932a-ef9824e26d4c"
guacd[26508]: DEBUG: Processing instruction: size
guacd[26508]: DEBUG: Processing instruction: audio
guacd[26508]: DEBUG: Processing instruction: video
guacd[26508]: DEBUG: Processing instruction: image
guacd[26508]: DEBUG: Processing instruction: timezone
guacd[26508]: DEBUG: Parameter "console" omitted. Using default value of 0.
guacd[26508]: DEBUG: Parameter "console-audio" omitted. Using default value
of 0.
guacd[26508]: DEBUG: Parameter "disable-auth" omitted. Using default value
of 0.
guacd[26508]: INFO: No security mode specified. Defaulting to security mode
negotiation with server.
guacd[26508]: DEBUG: Parameter "port" omitted. Using default value of 3389.
guacd[26508]: DEBUG: User resolution is 1920x992 at 96 DPI
guacd[26508]: DEBUG: Parameter "dpi" omitted. Using default value of 96.
guacd[26508]: DEBUG: Using resolution of 1920x992 at 96 DPI
guacd[26508]: DEBUG: Parameter "read-only" omitted. Using default value of
0.
guacd[26508]: DEBUG: Parameter "client-name" omitted. Using default value
of "Guacamole RDP".
guacd[26508]: DEBUG: Parameter "enable-wallpaper" omitted. Using default
value of 0.
guacd[26508]: DEBUG: Parameter "enable-theming" omitted. Using default
value of 0.
guacd[26508]: DEBUG: Parameter "enable-font-smoothing" omitted. Using
default value of 0.
guacd[26508]: DEBUG: Parameter "enable-full-window-drag" omitted. Using
default value of 0.
guacd[26508]: DEBUG: Parameter "enable-desktop-composition" omitted. Using
default value of 0.
guacd[26508]: DEBUG: Parameter "enable-menu-animations" omitted. Using
default value of 0.
guacd[26508]: DEBUG: Parameter "disable-bitmap-caching" omitted. Using
default value of 0.
guacd[26508]: DEBUG: Parameter "disable-offscreen-caching" omitted. Using
default value of 0.
guacd[26508]: DEBUG: Parameter "disable-glyph-caching" omitted. Using
default value of 0.
guacd[26508]: DEBUG: Parameter "enable-printing" omitted. Using default
value of 0.
guacd[26508]: DEBUG: Parameter "printer-name" omitted. Using default value
of "Guacamole Printer".
guacd[26508]: DEBUG: Parameter "drive-name" omitted. Using default value of
"Guacamole Filesystem".
guacd[26508]: DEBUG: Parameter "timezone" omitted. Using default value of
"America/Recife".
guacd[26508]: DEBUG: Parameter "enable-sftp" omitted. Using default value
of 0.
guacd[26508]: DEBUG: Parameter "sftp-hostname" omitted. Using default value
of "172.17.0.63".
guacd[26508]: DEBUG: Parameter "sftp-port" omitted. Using default value of
"22".
guacd[26508]: DEBUG: Parameter "sftp-username" omitted. Using default value
of "ifsc".
guacd[26508]: DEBUG: Parameter "sftp-password" omitted. Using default value
of "".
guacd[26508]: DEBUG: Parameter "sftp-passphrase" omitted. Using default
value of "".
guacd[26508]: DEBUG: Parameter "sftp-root-directory" omitted. Using default
value of "/".
guacd[26508]: DEBUG: Parameter "sftp-server-alive-interval" omitted. Using
default value of 0.
guacd[26508]: DEBUG: Parameter "recording-name" omitted. Using default
value of "recording".
guacd[26508]: DEBUG: Parameter "recording-exclude-output" omitted. Using
default value of 0.
guacd[26508]: DEBUG: Parameter "recording-exclude-mouse" omitted. Using
default value of 0.
guacd[26508]: DEBUG: Parameter "recording-include-keys" omitted. Using
default value of 0.
guacd[26508]: DEBUG: Parameter "create-recording-path" omitted. Using
default value of 0.
guacd[26508]: INFO: Resize method: none
guacd[26508]: DEBUG: Parameter "enable-audio-input" omitted. Using default
value of 0.
guacd[26508]: DEBUG: Parameter "gateway-port" omitted. Using default value
of 443.
guacd[26508]: DEBUG: guac_rdp_fs_alloc: Creating directory "/tmp/sambaqui"
if necessary.
guacd[26508]: INFO: User "@f8402d10-28f1-4a3b-b3dd-b6b30832f382" joined
connection "$f130e90b-3c66-49f0-932a-ef9824e26d4c" (1 users now present)
guacd[26508]: DEBUG: Client is using protocol version "VERSION_1_1_0"
guacd[26508]: INFO: Loading keymap "base"
guacd[26508]: INFO: Loading keymap "pt-br-qwerty"
guacd[26508]: DEBUG: Support for CLIPRDR (clipboard redirection)
registered. Awaiting channel connection.
guacd[26508]: DEBUG: Support for static channel "rdpdr" loaded.
guacd[26508]: DEBUG: Support for static channel "rdpsnd" loaded.
guacd[26508]: DEBUG: Local framebuffer format PIXEL_FORMAT_BGRX32
guacd[26508]: DEBUG: Remote framebuffer format PIXEL_FORMAT_RGB16
guacd[26508]: DEBUG: guac_rdp_fs_open: path="/", access=0x80000000,
file_attributes=0x0, create_disposition=0x1, create_options=0x0
guacd[26508]: DEBUG: guac_rdp_fs_open: Normalized path "/" to "\".
guacd[26508]: DEBUG: guac_rdp_fs_open: Translated path "\" to
"/tmp/sambaqui/".
guacd[26508]: DEBUG: guac_rdp_fs_open: native open:
real_path="/tmp/sambaqui/", flags=0x0
guacd[26508]: DEBUG: guac_rdp_fs_open: Opened "\" as file_id=0
guacd[26508]: DEBUG: guac_rdp_fs_close: Closed "\" (file_id=0)
guacd[26508]: DEBUG: CLIPRDR (clipboard redirection) channel connected.
guacd[26508]: DEBUG: SVC "rdpdr" connected.
guacd[26508]: DEBUG: SVC "rdpsnd" connected.
guacd[26508]: DEBUG: Clipboard data received. Reporting availability of
clipboard data to RDP server.
guacd[26508]: INFO: Connected to RDPDR 1.12 as client 0x0004
guacd[26508]: DEBUG: Ignoring server capability set type=0x0001, length=44
guacd[26508]: DEBUG: Ignoring server capability set type=0x0002, length=8
guacd[26508]: DEBUG: Ignoring server capability set type=0x0003, length=8
guacd[26508]: DEBUG: Ignoring server capability set type=0x0004, length=8
guacd[26508]: DEBUG: Ignoring server capability set type=0x0005, length=8
guacd[26508]: DEBUG: Sending capabilities...
guacd[26508]: DEBUG: Capabilities sent.
guacd[26508]: DEBUG: Client ID confirmed
guacd[26508]: INFO: Connected to RDPDR 1.12 as client 0x0002
guacd[26508]: DEBUG: Ignoring server capability set type=0x0001, length=44
guacd[26508]: DEBUG: Ignoring server capability set type=0x0002, length=8
guacd[26508]: DEBUG: Ignoring server capability set type=0x0003, length=8
guacd[26508]: DEBUG: Ignoring server capability set type=0x0004, length=8
guacd[26508]: DEBUG: Ignoring server capability set type=0x0005, length=8
guacd[26508]: DEBUG: Sending capabilities...
guacd[26508]: DEBUG: Capabilities sent.
guacd[26508]: DEBUG: Client ID confirmed
guacd[26508]: INFO: RDPDR user logged on
guacd[26508]: DEBUG: Registered device 0 (Guacamole Filesystem)
guacd[26508]: DEBUG: All supported devices sent.
guacd[26508]: DEBUG: Device 0 (Guacamole Filesystem) connected successfully
guacd[26508]: DEBUG: guac_rdp_fs_open: path="", access=0x80,
file_attributes=0x0, create_disposition=0x1, create_options=0x1
guacd[26508]: DEBUG: guac_rdp_fs_open: Normalized path "\" to "\".
guacd[26508]: DEBUG: guac_rdp_fs_open: Translated path "\" to
"/tmp/sambaqui/".
guacd[26508]: DEBUG: guac_rdp_fs_open: native open:
real_path="/tmp/sambaqui/", flags=0x0
guacd[26508]: DEBUG: guac_rdp_fs_open: Opened "\" as file_id=0
guacd[26508]: DEBUG: guac_rdpdr_fs_process_create: [file_id=0]
desired_access=0x80, file_attributes=0x0, create_disposition=0x1,
create_options=0x1, path=""
guacd[26508]: DEBUG: guac_rdp_fs_open: path="\Download", access=0x80000000,
file_attributes=0x0, create_disposition=0x3, create_options=0x1
guacd[26508]: DEBUG: guac_rdp_fs_open: Normalized path "\Download" to
"\Download".
guacd[26508]: DEBUG: guac_rdp_fs_open: Translated path "\Download" to
"/tmp/sambaqui/Download".
guacd[26508]: DEBUG: guac_rdp_fs_open: native open:
real_path="/tmp/sambaqui/Download", flags=0x0
guacd[26508]: DEBUG: guac_rdp_fs_open: Opened "\Download" as file_id=1
guacd[26508]: DEBUG: guac_rdp_fs_close: Closed "\Download" (file_id=1)
guacd[26508]: DEBUG: guac_rdpdr_fs_process_query_standard_info: [file_id=0]
guacd[26508]: DEBUG: guac_rdpdr_fs_process_query_basic_info: [file_id=0]
guacd[26508]: DEBUG: guac_rdpdr_fs_process_close: [file_id=0]
guacd[26508]: DEBUG: guac_rdp_fs_close: Closed "\" (file_id=0)
guacd[26508]: DEBUG: ERRINFO_RPC_INITIATED_DISCONNECT_BY_USER
(0x0000000B):The disconnection was initiated by an administrative tool on
the server running in the user's session.
guacd[26508]: DEBUG: rdp_recv_tpkt_pdu: rdp_recv_deactivate_all() fail
guacd[26508]: DEBUG: transport_check_fds: transport->ReceiveCallback() - -1
guacd[26508]: INFO: RDP server closed connection: Manually disconnected.
guacd[26508]: DEBUG: Disconnect reason code: 0xB.
guacd[26508]: DEBUG: Unloading device 0 (Guacamole Filesystem)
guacd[26508]: DEBUG: SVC "rdpdr" disconnected.
guacd[26508]: DEBUG: SVC "rdpsnd" disconnected.
guacd[26508]: INFO: Internal RDP client disconnected
guacd[26508]: INFO: User "@f8402d10-28f1-4a3b-b3dd-b6b30832f382"
disconnected (0 users remain)
guacd[26508]: INFO: Last user of connection
"$f130e90b-3c66-49f0-932a-ef9824e26d4c" disconnected
guacd[26508]: DEBUG: Requesting termination of client...
guacd[26508]: DEBUG: Client terminated successfully.
guacd[26504]: INFO: Connection "$f130e90b-3c66-49f0-932a-ef9824e26d4c"
removed.
guacd[26504]: ERROR: Unable to shutdown internal socket for connection
$f130e90b-3c66-49f0-932a-ef9824e26d4c. Corresponding process may remain
running but inactive.
2020-02-19 11:58:44.535:WARN:oejwcec.CompressExtension:qtp665576141-13:
java.nio.channels.ClosedChannelException
at
org.eclipse.jetty.websocket.common.io.FrameFlusher.enqueue(FrameFlusher.java:109)
at
org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.outgoingFrame(AbstractWebSocketConnection.java:582)
at
org.eclipse.jetty.websocket.common.extensions.AbstractExtension.nextOutgoingFrame(AbstractExtension.java:155)
at
org.eclipse.jetty.websocket.common.extensions.compress.PerMessageDeflateExtension.nextOutgoingFrame(PerMessageDeflateExtension.java:123)
at
org.eclipse.jetty.websocket.common.extensions.compress.CompressExtension.access$1100(CompressExtension.java:44)
at
org.eclipse.jetty.websocket.common.extensions.compress.CompressExtension$Flusher.compress(CompressExtension.java:591)
at
org.eclipse.jetty.websocket.common.extensions.compress.CompressExtension$Flusher.deflate(CompressExtension.java:488)
at
org.eclipse.jetty.websocket.common.extensions.compress.CompressExtension$Flusher.process(CompressExtension.java:468)
at
org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:241)
at
org.eclipse.jetty.util.IteratingCallback.iterate(IteratingCallback.java:223)
at
org.eclipse.jetty.websocket.common.extensions.compress.CompressExtension.outgoingFrame(CompressExtension.java:244)
at
org.eclipse.jetty.websocket.common.extensions.ExtensionStack$Flusher.process(ExtensionStack.java:400)
at
org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:241)
at
org.eclipse.jetty.util.IteratingCallback.iterate(IteratingCallback.java:223)
at
org.eclipse.jetty.websocket.common.extensions.ExtensionStack.outgoingFrame(ExtensionStack.java:277)
at
org.eclipse.jetty.websocket.common.WebSocketSession.outgoingFrame(WebSocketSession.java:355)
at
org.eclipse.jetty.websocket.common.WebSocketRemoteEndpoint.uncheckedSendFrame(WebSocketRemoteEndpoint.java:306)
at
org.eclipse.jetty.websocket.common.WebSocketRemoteEndpoint.blockingWrite(WebSocketRemoteEndpoint.java:106)
at
org.eclipse.jetty.websocket.common.WebSocketRemoteEndpoint.sendString(WebSocketRemoteEndpoint.java:384)
at
org.eclipse.jetty.websocket.jsr356.JsrBasicRemote.sendText(JsrBasicRemote.java:107)
at
org.apache.guacamole.websocket.GuacamoleWebSocketTunnelEndpoint.sendInstruction(GuacamoleWebSocketTunnelEndpoint.java:152)
at
org.apache.guacamole.websocket.GuacamoleWebSocketTunnelEndpoint.sendInstruction(GuacamoleWebSocketTunnelEndpoint.java:172)
at
org.apache.guacamole.websocket.GuacamoleWebSocketTunnelEndpoint.access$100(GuacamoleWebSocketTunnelEndpoint.java:53)
at
org.apache.guacamole.websocket.GuacamoleWebSocketTunnelEndpoint$3.filter(GuacamoleWebSocketTunnelEndpoint.java:321)
at
org.apache.guacamole.protocol.FilteredGuacamoleWriter.writeInstruction(FilteredGuacamoleWriter.java:96)
at
org.apache.guacamole.protocol.FilteredGuacamoleWriter.write(FilteredGuacamoleWriter.java:81)
at
org.apache.guacamole.protocol.FilteredGuacamoleWriter.write(FilteredGuacamoleWriter.java:89)
at
org.apache.guacamole.websocket.GuacamoleWebSocketTunnelEndpoint.onMessage(GuacamoleWebSocketTunnelEndpoint.java:345)
at
org.apache.guacamole.websocket.GuacamoleWebSocketTunnelEndpoint$1.onMessage(GuacamoleWebSocketTunnelEndpoint.java:220)
at
org.apache.guacamole.websocket.GuacamoleWebSocketTunnelEndpoint$1.onMessage(GuacamoleWebSocketTunnelEndpoint.java:216)
at
org.eclipse.jetty.websocket.jsr356.messages.TextWholeMessage.messageComplete(TextWholeMessage.java:59)
at
org.eclipse.jetty.websocket.jsr356.endpoints.JsrEndpointEventDriver.onTextFrame(JsrEndpointEventDriver.java:217)
at
org.eclipse.jetty.websocket.common.events.AbstractEventDriver.incomingFrame(AbstractEventDriver.java:150)
at
org.eclipse.jetty.websocket.common.WebSocketSession.incomingFrame(WebSocketSession.java:322)
at
org.eclipse.jetty.websocket.common.extensions.AbstractExtension.nextIncomingFrame(AbstractExtension.java:147)
at
org.eclipse.jetty.websocket.common.extensions.compress.PerMessageDeflateExtension.nextIncomingFrame(PerMessageDeflateExtension.java:112)
at
org.eclipse.jetty.websocket.common.extensions.compress.CompressExtension.forwardIncoming(CompressExtension.java:168)
at
org.eclipse.jetty.websocket.common.extensions.compress.PerMessageDeflateExtension.incomingFrame(PerMessageDeflateExtension.java:92)
at
org.eclipse.jetty.websocket.common.extensions.ExtensionStack.incomingFrame(ExtensionStack.java:202)
at org.eclipse.jetty.websocket.common.Parser.notifyFrame(Parser.java:225)
at
org.eclipse.jetty.websocket.common.Parser.parseSingleFrame(Parser.java:259)
at
org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.onFillable(AbstractWebSocketConnection.java:460)
at
org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.onFillable(AbstractWebSocketConnection.java:441)
at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
at
org.eclipse.jetty.io.ssl.SslConnection$DecryptedEndPoint.onFillable(SslConnection.java:543)
at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:398)
at
org.eclipse.jetty.io.ssl.SslConnection$2.succeeded(SslConnection.java:161)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117)
at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:336)
at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:313)
at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
at
org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:129)
at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:388)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938)
at java.lang.Thread.run(Thread.java:748)
This is the log when I start JETTY
# /usr/local/etc/rc.d/jetty start
Starting jetty.
Starting Jetty: 2020-02-19 12:22:33.868:INFO::main: Logging initialized
@1052ms to org.eclipse.jetty.util.log.StdErrLog
2020-02-19 12:22:34.377:INFO:oejs.Server:main: jetty-9.4.26.v20200117;
built: 2020-01-17T12:35:33.676Z; git:
7b38981d25d14afb4a12ff1f2596756144edf695; jvm 1.8.0_242-b07
2020-02-19 12:22:34.410:INFO:oejdp.ScanningAppProvider:main: Deployment
monitor [file:///usr/local/www/jetty/guacamole/webapps/] at interval 10
2020-02-19 12:22:35.551:WARN:oeja.AnnotationParser:qtp665576141-17:
org.apache.guacamole.net.auth.Connectable scanned from multiple locations:
file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/classes/org/apache/guacamole/net/auth/Connectable.class,
jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/guacamole-ext-1.1.0.jar!/org/apache/guacamole/net/auth/Connectable.class
2020-02-19 12:22:36.029:INFO:oeja.AnnotationConfiguration:main: Scanning
elapsed time=716ms
2020-02-19 12:22:36.631:INFO:oejs.session:main: DefaultSessionIdManager
workerName=node0
2020-02-19 12:22:36.632:INFO:oejs.session:main: No SessionScavenger set,
using defaults
2020-02-19 12:22:36.633:INFO:oejs.session:main: node0 Scavenging every
600000ms
OK Wed Feb 19 12:22:36 -03 2020
# Feb 19, 2020 12:22:39 PM
com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
INFO: Registering org.apache.guacamole.rest.RESTExceptionMapper as a
provider class
Feb 19, 2020 12:22:39 PM
com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
INFO: Registering org.apache.guacamole.rest.extension.ExtensionRESTService
as a root resource class
Feb 19, 2020 12:22:39 PM
com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
INFO: Registering org.apache.guacamole.rest.language.LanguageRESTService as
a root resource class
Feb 19, 2020 12:22:39 PM
com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
INFO: Registering org.apache.guacamole.rest.patch.PatchRESTService as a
root resource class
Feb 19, 2020 12:22:39 PM
com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
INFO: Registering org.apache.guacamole.rest.auth.TokenRESTService as a root
resource class
Feb 19, 2020 12:22:39 PM
com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
INFO: Registering org.apache.guacamole.rest.session.SessionRESTService as a
root resource class
Feb 19, 2020 12:22:39 PM
com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
INFO: Registering org.codehaus.jackson.jaxrs.JacksonJsonProvider as a
provider class
Feb 19, 2020 12:22:39 PM
com.sun.jersey.server.impl.application.WebApplicationImpl _initiate
INFO: Initiating Jersey application, version 'Jersey: 1.17.1 02/28/2013
12:47 PM'
Feb 19, 2020 12:22:39 PM
com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory
getComponentProvider
INFO: Binding org.apache.guacamole.rest.RESTExceptionMapper to
GuiceManagedComponentProvider with the scope "Singleton"
Feb 19, 2020 12:22:39 PM
com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory
getComponentProvider
INFO: Binding org.codehaus.jackson.jaxrs.JacksonJsonProvider to
GuiceManagedComponentProvider with the scope "Singleton"
Feb 19, 2020 12:22:40 PM
com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory
getComponentProvider
INFO: Binding org.apache.guacamole.rest.extension.ExtensionRESTService to
GuiceManagedComponentProvider with the scope "PerRequest"
Feb 19, 2020 12:22:40 PM
com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory
getComponentProvider
INFO: Binding org.apache.guacamole.rest.language.LanguageRESTService to
GuiceManagedComponentProvider with the scope "PerRequest"
Feb 19, 2020 12:22:40 PM
com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory
getComponentProvider
INFO: Binding org.apache.guacamole.rest.patch.PatchRESTService to
GuiceManagedComponentProvider with the scope "PerRequest"
Feb 19, 2020 12:22:40 PM
com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory
getComponentProvider
INFO: Binding org.apache.guacamole.rest.auth.TokenRESTService to
GuiceManagedComponentProvider with the scope "PerRequest"
Feb 19, 2020 12:22:40 PM
com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory
getComponentProvider
INFO: Binding org.apache.guacamole.rest.session.SessionRESTService to
GuiceManagedComponentProvider with the scope "PerRequest"
Feb 19, 2020 12:22:40 PM org.webjars.servlet.WebjarsServlet init
INFO: WebjarsServlet initialization completed
2020-02-19 12:22:40.696:INFO:oejsh.ContextHandler:main: Started
o.e.j.w.WebAppContext@4493d195{root,/,[file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/,
jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/blob-polyfill-1.0.20150320.jar!/META-INF/resources,
jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/datalist-polyfill-1.14.0.jar!/META-INF/resources,
jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/jstz-1.0.10.jar!/META-INF/resources,
jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/angular-module-shim-0.0.4.jar!/META-INF/resources,
jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/angular-touch-1.6.9.jar!/META-INF/resources,
jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/angular-translate-loader-static-files-2.16.0.jar!/META-INF/resources,
jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/filesaver-1.3.3.jar!/META-INF/resources,
jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/lodash-4.17.10.jar!/META-INF/resources,
jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/angular-1.6.9.jar!/META-INF/resources,
jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/angular-route-1.6.9.jar!/META-INF/resources,
jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/angular-translate-2.16.0.jar!/META-INF/resources,
jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/jquery-3.3.1.jar!/META-INF/resources,
jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/messageformat-1.0.2.jar!/META-INF/resources,
jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/angular-translate-interpolation-messageformat-2.16.0.jar!/META-INF/resources],AVAILABLE}{/usr/local/www/jetty/guacamole/webapps/root.war}
2020-02-19 12:22:40.719:INFO:oejs.AbstractConnector:main: Started
ServerConnector@5b18223f{HTTP/1.1,[http/1.1]}{0.0.0.0:8080}
2020-02-19 12:22:40.728:INFO:oejus.SslContextFactory:main:
x509=X509@48528634(jetty,h=[],w=[]) for Server@48d293ee
[provider=null,keyStore=file:///usr/local/www/jetty/guacamole/etc/keystore,trustStore=file:///usr/local/www/jetty/guacamole/etc/keystore]
2020-02-19 12:22:40.826:INFO:oejs.AbstractConnector:main: Started
ServerConnector@2c66a4f2{SSL,[ssl, http/1.1]}{0.0.0.0:8443}
2020-02-19 12:22:40.828:INFO:oejs.Server:main: Started @8013ms
The guacamole.properties file
# cat /usr/local/www/jetty/guacamole/.guacamole/guacamole.properties
available-languages: en
postgresql-port: 5432
postgresql-database: guacamole_db
postgresql-username: guacamole_user
postgresql-password: ********
The pg_hba.conf file
# cat /var/db/postgres/data10/pg_hba.conf
local all all trust
host all all 127.0.0.1/32 trust
host all all ::1/128 trust
local replication all trust
host replication all 127.0.0.1/32 trust
host replication all ::1/128 trust
The postgresql.conf file
# cat /var/db/postgres/data10/postgresql.conf
log_destination = 'syslog'
update_process_title = off
datestyle = 'iso, mdy'
default_text_search_config = 'pg_catalog.english'
The start.ini file
# cat /usr/local/www/jetty/guacamole/start.ini
--module=ext
--module=server
--module=ssl
--module=https
--module=jsp
--module=resources
--module=deploy
--module=jstl
--module=websocket
--module=http
jetty.httpConfig.sendServerVersion=false
jetty.sslContext.keyStorePath=etc/keystore
jetty.sslContext.trustStorePath=etc/keystore
jetty.sslContext.keyStorePassword=********
jetty.sslContext.keyManagerPassword=********
jetty.sslContext.trustStorePassword=********
The jetty file
# cat /usr/local/etc/jetty/jetty
JAVA_OPTIONS="-Xms128m -Xmx768m"
JETTY_HOME=/usr/local/jetty
JETTY_BASE=/usr/local/www/jetty/guacamole
JETTY_PID=/usr/local/www/jetty/guacamole/jetty.pid
The rc.conf file
# cat /etc/rc.conf
clear_tmp_enable="YES"
syslogd_flags="-ss"
sendmail_enable="NONE"
hostname="guaca.DOMAIN_HERE"
keymap="br275.iso.acc.kbd"
ifconfig_vmx0="inet 192.168.17.6 netmask 0xffffff00"
defaultrouter="192.168.17.254"
ipv6_activate_all_interfaces="YES"
ifconfig_vmx0_ipv6="inet6 VALID_IP6_HERE prefixlen 64"
ipv6_defaultrouter="VALID_IP6_HERE"
sshd_enable="YES"
ntpd_enable="NO"
dumpdev="NO"
postgresql_enable="YES"
guacd_enable="YES"
jetty_enable="YES"
zabbix_agentd_enable="YES"
firewall_enable="YES"
firewall_quiet="YES"
firewall_type="workstation"
firewall_myservices="80 443 8080 8443"
firewall_allowservices="any"
firewall_logdeny="NO"
Thank you for your time people!
Re: Unstable server after 1.0.0 upgrade to 1.1.0
Posted by Igor Kattar <ig...@gmail.com>.
Turns out it was the network interface fault.
After upgrading my FreeBSD VM to 12.1 I had to turn off the TCP
segmentation offloading (Both TSO4 and TSO6) on it.
These lines in /etc/rc.conf did the job (abstract the IPs) :
ifconfig_vmx0="inet A.B.C.D netmask 0xffffff00 -tso4"
ifconfig_vmx0_ipv6="inet6 A:B:C:D::E prefixlen 64 -tso6"
Em qua., 19 de fev. de 2020 às 14:36, Igor Kattar <ig...@gmail.com>
escreveu:
> After an upgrade of guacamole-server and client to 1.1.0 any connection
> made is quite slow and the message "The network connection to guacamole
> server appears unstable" keeps poping up frequently, even on SSH or TELNET
> connections (more often in VNC and RDP).
>
> In the previous version (1.0.0) there was no such problem at all.
>
> The daemon (GUACD), conteiner (JETTY) and auth database (PostgreSQL) are
> on the same machine (FreeBSD).
>
> Below are some configuration files and logs that I think could help anyone
> help me return to the previous behaviour.
>
> P.s.: I noticed that, at least on FreeBSD ports, there are no SQL script
> to update the authentication database (PostgreSQL) to the new version
> (1.0.0 -> 1.1.0) is that right?
>
> This is the log of GUACD when I start a session with a Windows machine,
> operate briefly then disconnect.
> # guacd -L debug -f
> guacd[26504]: INFO: Guacamole proxy daemon (guacd) version 1.1.0 started
> guacd[26504]: DEBUG: Unable to bind socket to host ::1, port 4822: Invalid
> argument
> guacd[26504]: DEBUG: Successfully bound socket to host 127.0.0.1, port 4822
> guacd[26504]: INFO: Listening on host 127.0.0.1, port 4822
> guacd[26504]: INFO: Creating new client for protocol "rdp"
> guacd[26504]: INFO: Connection ID is
> "$f130e90b-3c66-49f0-932a-ef9824e26d4c"
> guacd[26508]: DEBUG: Processing instruction: size
> guacd[26508]: DEBUG: Processing instruction: audio
> guacd[26508]: DEBUG: Processing instruction: video
> guacd[26508]: DEBUG: Processing instruction: image
> guacd[26508]: DEBUG: Processing instruction: timezone
> guacd[26508]: DEBUG: Parameter "console" omitted. Using default value of 0.
> guacd[26508]: DEBUG: Parameter "console-audio" omitted. Using default
> value of 0.
> guacd[26508]: DEBUG: Parameter "disable-auth" omitted. Using default value
> of 0.
> guacd[26508]: INFO: No security mode specified. Defaulting to security
> mode negotiation with server.
> guacd[26508]: DEBUG: Parameter "port" omitted. Using default value of 3389.
> guacd[26508]: DEBUG: User resolution is 1920x992 at 96 DPI
> guacd[26508]: DEBUG: Parameter "dpi" omitted. Using default value of 96.
> guacd[26508]: DEBUG: Using resolution of 1920x992 at 96 DPI
> guacd[26508]: DEBUG: Parameter "read-only" omitted. Using default value of
> 0.
> guacd[26508]: DEBUG: Parameter "client-name" omitted. Using default value
> of "Guacamole RDP".
> guacd[26508]: DEBUG: Parameter "enable-wallpaper" omitted. Using default
> value of 0.
> guacd[26508]: DEBUG: Parameter "enable-theming" omitted. Using default
> value of 0.
> guacd[26508]: DEBUG: Parameter "enable-font-smoothing" omitted. Using
> default value of 0.
> guacd[26508]: DEBUG: Parameter "enable-full-window-drag" omitted. Using
> default value of 0.
> guacd[26508]: DEBUG: Parameter "enable-desktop-composition" omitted. Using
> default value of 0.
> guacd[26508]: DEBUG: Parameter "enable-menu-animations" omitted. Using
> default value of 0.
> guacd[26508]: DEBUG: Parameter "disable-bitmap-caching" omitted. Using
> default value of 0.
> guacd[26508]: DEBUG: Parameter "disable-offscreen-caching" omitted. Using
> default value of 0.
> guacd[26508]: DEBUG: Parameter "disable-glyph-caching" omitted. Using
> default value of 0.
> guacd[26508]: DEBUG: Parameter "enable-printing" omitted. Using default
> value of 0.
> guacd[26508]: DEBUG: Parameter "printer-name" omitted. Using default value
> of "Guacamole Printer".
> guacd[26508]: DEBUG: Parameter "drive-name" omitted. Using default value
> of "Guacamole Filesystem".
> guacd[26508]: DEBUG: Parameter "timezone" omitted. Using default value of
> "America/Recife".
> guacd[26508]: DEBUG: Parameter "enable-sftp" omitted. Using default value
> of 0.
> guacd[26508]: DEBUG: Parameter "sftp-hostname" omitted. Using default
> value of "172.17.0.63".
> guacd[26508]: DEBUG: Parameter "sftp-port" omitted. Using default value of
> "22".
> guacd[26508]: DEBUG: Parameter "sftp-username" omitted. Using default
> value of "ifsc".
> guacd[26508]: DEBUG: Parameter "sftp-password" omitted. Using default
> value of "".
> guacd[26508]: DEBUG: Parameter "sftp-passphrase" omitted. Using default
> value of "".
> guacd[26508]: DEBUG: Parameter "sftp-root-directory" omitted. Using
> default value of "/".
> guacd[26508]: DEBUG: Parameter "sftp-server-alive-interval" omitted. Using
> default value of 0.
> guacd[26508]: DEBUG: Parameter "recording-name" omitted. Using default
> value of "recording".
> guacd[26508]: DEBUG: Parameter "recording-exclude-output" omitted. Using
> default value of 0.
> guacd[26508]: DEBUG: Parameter "recording-exclude-mouse" omitted. Using
> default value of 0.
> guacd[26508]: DEBUG: Parameter "recording-include-keys" omitted. Using
> default value of 0.
> guacd[26508]: DEBUG: Parameter "create-recording-path" omitted. Using
> default value of 0.
> guacd[26508]: INFO: Resize method: none
> guacd[26508]: DEBUG: Parameter "enable-audio-input" omitted. Using default
> value of 0.
> guacd[26508]: DEBUG: Parameter "gateway-port" omitted. Using default value
> of 443.
> guacd[26508]: DEBUG: guac_rdp_fs_alloc: Creating directory "/tmp/sambaqui"
> if necessary.
> guacd[26508]: INFO: User "@f8402d10-28f1-4a3b-b3dd-b6b30832f382" joined
> connection "$f130e90b-3c66-49f0-932a-ef9824e26d4c" (1 users now present)
> guacd[26508]: DEBUG: Client is using protocol version "VERSION_1_1_0"
> guacd[26508]: INFO: Loading keymap "base"
> guacd[26508]: INFO: Loading keymap "pt-br-qwerty"
> guacd[26508]: DEBUG: Support for CLIPRDR (clipboard redirection)
> registered. Awaiting channel connection.
> guacd[26508]: DEBUG: Support for static channel "rdpdr" loaded.
> guacd[26508]: DEBUG: Support for static channel "rdpsnd" loaded.
> guacd[26508]: DEBUG: Local framebuffer format PIXEL_FORMAT_BGRX32
> guacd[26508]: DEBUG: Remote framebuffer format PIXEL_FORMAT_RGB16
> guacd[26508]: DEBUG: guac_rdp_fs_open: path="/", access=0x80000000,
> file_attributes=0x0, create_disposition=0x1, create_options=0x0
> guacd[26508]: DEBUG: guac_rdp_fs_open: Normalized path "/" to "\".
> guacd[26508]: DEBUG: guac_rdp_fs_open: Translated path "\" to
> "/tmp/sambaqui/".
> guacd[26508]: DEBUG: guac_rdp_fs_open: native open:
> real_path="/tmp/sambaqui/", flags=0x0
> guacd[26508]: DEBUG: guac_rdp_fs_open: Opened "\" as file_id=0
> guacd[26508]: DEBUG: guac_rdp_fs_close: Closed "\" (file_id=0)
> guacd[26508]: DEBUG: CLIPRDR (clipboard redirection) channel connected.
> guacd[26508]: DEBUG: SVC "rdpdr" connected.
> guacd[26508]: DEBUG: SVC "rdpsnd" connected.
> guacd[26508]: DEBUG: Clipboard data received. Reporting availability of
> clipboard data to RDP server.
> guacd[26508]: INFO: Connected to RDPDR 1.12 as client 0x0004
> guacd[26508]: DEBUG: Ignoring server capability set type=0x0001, length=44
> guacd[26508]: DEBUG: Ignoring server capability set type=0x0002, length=8
> guacd[26508]: DEBUG: Ignoring server capability set type=0x0003, length=8
> guacd[26508]: DEBUG: Ignoring server capability set type=0x0004, length=8
> guacd[26508]: DEBUG: Ignoring server capability set type=0x0005, length=8
> guacd[26508]: DEBUG: Sending capabilities...
> guacd[26508]: DEBUG: Capabilities sent.
> guacd[26508]: DEBUG: Client ID confirmed
> guacd[26508]: INFO: Connected to RDPDR 1.12 as client 0x0002
> guacd[26508]: DEBUG: Ignoring server capability set type=0x0001, length=44
> guacd[26508]: DEBUG: Ignoring server capability set type=0x0002, length=8
> guacd[26508]: DEBUG: Ignoring server capability set type=0x0003, length=8
> guacd[26508]: DEBUG: Ignoring server capability set type=0x0004, length=8
> guacd[26508]: DEBUG: Ignoring server capability set type=0x0005, length=8
> guacd[26508]: DEBUG: Sending capabilities...
> guacd[26508]: DEBUG: Capabilities sent.
> guacd[26508]: DEBUG: Client ID confirmed
> guacd[26508]: INFO: RDPDR user logged on
> guacd[26508]: DEBUG: Registered device 0 (Guacamole Filesystem)
> guacd[26508]: DEBUG: All supported devices sent.
> guacd[26508]: DEBUG: Device 0 (Guacamole Filesystem) connected successfully
> guacd[26508]: DEBUG: guac_rdp_fs_open: path="", access=0x80,
> file_attributes=0x0, create_disposition=0x1, create_options=0x1
> guacd[26508]: DEBUG: guac_rdp_fs_open: Normalized path "\" to "\".
> guacd[26508]: DEBUG: guac_rdp_fs_open: Translated path "\" to
> "/tmp/sambaqui/".
> guacd[26508]: DEBUG: guac_rdp_fs_open: native open:
> real_path="/tmp/sambaqui/", flags=0x0
> guacd[26508]: DEBUG: guac_rdp_fs_open: Opened "\" as file_id=0
> guacd[26508]: DEBUG: guac_rdpdr_fs_process_create: [file_id=0]
> desired_access=0x80, file_attributes=0x0, create_disposition=0x1,
> create_options=0x1, path=""
> guacd[26508]: DEBUG: guac_rdp_fs_open: path="\Download",
> access=0x80000000, file_attributes=0x0, create_disposition=0x3,
> create_options=0x1
> guacd[26508]: DEBUG: guac_rdp_fs_open: Normalized path "\Download" to
> "\Download".
> guacd[26508]: DEBUG: guac_rdp_fs_open: Translated path "\Download" to
> "/tmp/sambaqui/Download".
> guacd[26508]: DEBUG: guac_rdp_fs_open: native open:
> real_path="/tmp/sambaqui/Download", flags=0x0
> guacd[26508]: DEBUG: guac_rdp_fs_open: Opened "\Download" as file_id=1
> guacd[26508]: DEBUG: guac_rdp_fs_close: Closed "\Download" (file_id=1)
> guacd[26508]: DEBUG: guac_rdpdr_fs_process_query_standard_info: [file_id=0]
> guacd[26508]: DEBUG: guac_rdpdr_fs_process_query_basic_info: [file_id=0]
> guacd[26508]: DEBUG: guac_rdpdr_fs_process_close: [file_id=0]
> guacd[26508]: DEBUG: guac_rdp_fs_close: Closed "\" (file_id=0)
> guacd[26508]: DEBUG: ERRINFO_RPC_INITIATED_DISCONNECT_BY_USER
> (0x0000000B):The disconnection was initiated by an administrative tool on
> the server running in the user's session.
> guacd[26508]: DEBUG: rdp_recv_tpkt_pdu: rdp_recv_deactivate_all() fail
> guacd[26508]: DEBUG: transport_check_fds: transport->ReceiveCallback() - -1
> guacd[26508]: INFO: RDP server closed connection: Manually disconnected.
> guacd[26508]: DEBUG: Disconnect reason code: 0xB.
> guacd[26508]: DEBUG: Unloading device 0 (Guacamole Filesystem)
> guacd[26508]: DEBUG: SVC "rdpdr" disconnected.
> guacd[26508]: DEBUG: SVC "rdpsnd" disconnected.
> guacd[26508]: INFO: Internal RDP client disconnected
> guacd[26508]: INFO: User "@f8402d10-28f1-4a3b-b3dd-b6b30832f382"
> disconnected (0 users remain)
> guacd[26508]: INFO: Last user of connection
> "$f130e90b-3c66-49f0-932a-ef9824e26d4c" disconnected
> guacd[26508]: DEBUG: Requesting termination of client...
> guacd[26508]: DEBUG: Client terminated successfully.
> guacd[26504]: INFO: Connection "$f130e90b-3c66-49f0-932a-ef9824e26d4c"
> removed.
> guacd[26504]: ERROR: Unable to shutdown internal socket for connection
> $f130e90b-3c66-49f0-932a-ef9824e26d4c. Corresponding process may remain
> running but inactive.
> 2020-02-19 11:58:44.535:WARN:oejwcec.CompressExtension:qtp665576141-13:
> java.nio.channels.ClosedChannelException
> at
> org.eclipse.jetty.websocket.common.io.FrameFlusher.enqueue(FrameFlusher.java:109)
> at
> org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.outgoingFrame(AbstractWebSocketConnection.java:582)
> at
> org.eclipse.jetty.websocket.common.extensions.AbstractExtension.nextOutgoingFrame(AbstractExtension.java:155)
> at
> org.eclipse.jetty.websocket.common.extensions.compress.PerMessageDeflateExtension.nextOutgoingFrame(PerMessageDeflateExtension.java:123)
> at
> org.eclipse.jetty.websocket.common.extensions.compress.CompressExtension.access$1100(CompressExtension.java:44)
> at
> org.eclipse.jetty.websocket.common.extensions.compress.CompressExtension$Flusher.compress(CompressExtension.java:591)
> at
> org.eclipse.jetty.websocket.common.extensions.compress.CompressExtension$Flusher.deflate(CompressExtension.java:488)
> at
> org.eclipse.jetty.websocket.common.extensions.compress.CompressExtension$Flusher.process(CompressExtension.java:468)
> at
> org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:241)
> at
> org.eclipse.jetty.util.IteratingCallback.iterate(IteratingCallback.java:223)
> at
> org.eclipse.jetty.websocket.common.extensions.compress.CompressExtension.outgoingFrame(CompressExtension.java:244)
> at
> org.eclipse.jetty.websocket.common.extensions.ExtensionStack$Flusher.process(ExtensionStack.java:400)
> at
> org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:241)
> at
> org.eclipse.jetty.util.IteratingCallback.iterate(IteratingCallback.java:223)
> at
> org.eclipse.jetty.websocket.common.extensions.ExtensionStack.outgoingFrame(ExtensionStack.java:277)
> at
> org.eclipse.jetty.websocket.common.WebSocketSession.outgoingFrame(WebSocketSession.java:355)
> at
> org.eclipse.jetty.websocket.common.WebSocketRemoteEndpoint.uncheckedSendFrame(WebSocketRemoteEndpoint.java:306)
> at
> org.eclipse.jetty.websocket.common.WebSocketRemoteEndpoint.blockingWrite(WebSocketRemoteEndpoint.java:106)
> at
> org.eclipse.jetty.websocket.common.WebSocketRemoteEndpoint.sendString(WebSocketRemoteEndpoint.java:384)
> at
> org.eclipse.jetty.websocket.jsr356.JsrBasicRemote.sendText(JsrBasicRemote.java:107)
> at
> org.apache.guacamole.websocket.GuacamoleWebSocketTunnelEndpoint.sendInstruction(GuacamoleWebSocketTunnelEndpoint.java:152)
> at
> org.apache.guacamole.websocket.GuacamoleWebSocketTunnelEndpoint.sendInstruction(GuacamoleWebSocketTunnelEndpoint.java:172)
> at
> org.apache.guacamole.websocket.GuacamoleWebSocketTunnelEndpoint.access$100(GuacamoleWebSocketTunnelEndpoint.java:53)
> at
> org.apache.guacamole.websocket.GuacamoleWebSocketTunnelEndpoint$3.filter(GuacamoleWebSocketTunnelEndpoint.java:321)
> at
> org.apache.guacamole.protocol.FilteredGuacamoleWriter.writeInstruction(FilteredGuacamoleWriter.java:96)
> at
> org.apache.guacamole.protocol.FilteredGuacamoleWriter.write(FilteredGuacamoleWriter.java:81)
> at
> org.apache.guacamole.protocol.FilteredGuacamoleWriter.write(FilteredGuacamoleWriter.java:89)
> at
> org.apache.guacamole.websocket.GuacamoleWebSocketTunnelEndpoint.onMessage(GuacamoleWebSocketTunnelEndpoint.java:345)
> at
> org.apache.guacamole.websocket.GuacamoleWebSocketTunnelEndpoint$1.onMessage(GuacamoleWebSocketTunnelEndpoint.java:220)
> at
> org.apache.guacamole.websocket.GuacamoleWebSocketTunnelEndpoint$1.onMessage(GuacamoleWebSocketTunnelEndpoint.java:216)
> at
> org.eclipse.jetty.websocket.jsr356.messages.TextWholeMessage.messageComplete(TextWholeMessage.java:59)
> at
> org.eclipse.jetty.websocket.jsr356.endpoints.JsrEndpointEventDriver.onTextFrame(JsrEndpointEventDriver.java:217)
> at
> org.eclipse.jetty.websocket.common.events.AbstractEventDriver.incomingFrame(AbstractEventDriver.java:150)
> at
> org.eclipse.jetty.websocket.common.WebSocketSession.incomingFrame(WebSocketSession.java:322)
> at
> org.eclipse.jetty.websocket.common.extensions.AbstractExtension.nextIncomingFrame(AbstractExtension.java:147)
> at
> org.eclipse.jetty.websocket.common.extensions.compress.PerMessageDeflateExtension.nextIncomingFrame(PerMessageDeflateExtension.java:112)
> at
> org.eclipse.jetty.websocket.common.extensions.compress.CompressExtension.forwardIncoming(CompressExtension.java:168)
> at
> org.eclipse.jetty.websocket.common.extensions.compress.PerMessageDeflateExtension.incomingFrame(PerMessageDeflateExtension.java:92)
> at
> org.eclipse.jetty.websocket.common.extensions.ExtensionStack.incomingFrame(ExtensionStack.java:202)
> at org.eclipse.jetty.websocket.common.Parser.notifyFrame(Parser.java:225)
> at
> org.eclipse.jetty.websocket.common.Parser.parseSingleFrame(Parser.java:259)
> at
> org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.onFillable(AbstractWebSocketConnection.java:460)
> at
> org.eclipse.jetty.websocket.common.io.AbstractWebSocketConnection.onFillable(AbstractWebSocketConnection.java:441)
> at
> org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:311)
> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
> at
> org.eclipse.jetty.io.ssl.SslConnection$DecryptedEndPoint.onFillable(SslConnection.java:543)
> at
> org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:398)
> at
> org.eclipse.jetty.io.ssl.SslConnection$2.succeeded(SslConnection.java:161)
> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:103)
> at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:117)
> at
> org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.runTask(EatWhatYouKill.java:336)
> at
> org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:313)
> at
> org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.tryProduce(EatWhatYouKill.java:171)
> at
> org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:129)
> at
> org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:388)
> at
> org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:806)
> at
> org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:938)
> at java.lang.Thread.run(Thread.java:748)
>
> This is the log when I start JETTY
> # /usr/local/etc/rc.d/jetty start
> Starting jetty.
> Starting Jetty: 2020-02-19 12:22:33.868:INFO::main: Logging initialized
> @1052ms to org.eclipse.jetty.util.log.StdErrLog
> 2020-02-19 12:22:34.377:INFO:oejs.Server:main: jetty-9.4.26.v20200117;
> built: 2020-01-17T12:35:33.676Z; git:
> 7b38981d25d14afb4a12ff1f2596756144edf695; jvm 1.8.0_242-b07
> 2020-02-19 12:22:34.410:INFO:oejdp.ScanningAppProvider:main: Deployment
> monitor [file:///usr/local/www/jetty/guacamole/webapps/] at interval 10
> 2020-02-19 12:22:35.551:WARN:oeja.AnnotationParser:qtp665576141-17:
> org.apache.guacamole.net.auth.Connectable scanned from multiple locations:
> file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/classes/org/apache/guacamole/net/auth/Connectable.class,
> jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/guacamole-ext-1.1.0.jar!/org/apache/guacamole/net/auth/Connectable.class
> 2020-02-19 12:22:36.029:INFO:oeja.AnnotationConfiguration:main: Scanning
> elapsed time=716ms
> 2020-02-19 12:22:36.631:INFO:oejs.session:main: DefaultSessionIdManager
> workerName=node0
> 2020-02-19 12:22:36.632:INFO:oejs.session:main: No SessionScavenger set,
> using defaults
> 2020-02-19 12:22:36.633:INFO:oejs.session:main: node0 Scavenging every
> 600000ms
> OK Wed Feb 19 12:22:36 -03 2020
> # Feb 19, 2020 12:22:39 PM
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.guacamole.rest.RESTExceptionMapper as a
> provider class
> Feb 19, 2020 12:22:39 PM
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.guacamole.rest.extension.ExtensionRESTService
> as a root resource class
> Feb 19, 2020 12:22:39 PM
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.guacamole.rest.language.LanguageRESTService
> as a root resource class
> Feb 19, 2020 12:22:39 PM
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.guacamole.rest.patch.PatchRESTService as a
> root resource class
> Feb 19, 2020 12:22:39 PM
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.guacamole.rest.auth.TokenRESTService as a
> root resource class
> Feb 19, 2020 12:22:39 PM
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.guacamole.rest.session.SessionRESTService as
> a root resource class
> Feb 19, 2020 12:22:39 PM
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.codehaus.jackson.jaxrs.JacksonJsonProvider as a
> provider class
> Feb 19, 2020 12:22:39 PM
> com.sun.jersey.server.impl.application.WebApplicationImpl _initiate
> INFO: Initiating Jersey application, version 'Jersey: 1.17.1 02/28/2013
> 12:47 PM'
> Feb 19, 2020 12:22:39 PM
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory
> getComponentProvider
> INFO: Binding org.apache.guacamole.rest.RESTExceptionMapper to
> GuiceManagedComponentProvider with the scope "Singleton"
> Feb 19, 2020 12:22:39 PM
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory
> getComponentProvider
> INFO: Binding org.codehaus.jackson.jaxrs.JacksonJsonProvider to
> GuiceManagedComponentProvider with the scope "Singleton"
> Feb 19, 2020 12:22:40 PM
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory
> getComponentProvider
> INFO: Binding org.apache.guacamole.rest.extension.ExtensionRESTService to
> GuiceManagedComponentProvider with the scope "PerRequest"
> Feb 19, 2020 12:22:40 PM
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory
> getComponentProvider
> INFO: Binding org.apache.guacamole.rest.language.LanguageRESTService to
> GuiceManagedComponentProvider with the scope "PerRequest"
> Feb 19, 2020 12:22:40 PM
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory
> getComponentProvider
> INFO: Binding org.apache.guacamole.rest.patch.PatchRESTService to
> GuiceManagedComponentProvider with the scope "PerRequest"
> Feb 19, 2020 12:22:40 PM
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory
> getComponentProvider
> INFO: Binding org.apache.guacamole.rest.auth.TokenRESTService to
> GuiceManagedComponentProvider with the scope "PerRequest"
> Feb 19, 2020 12:22:40 PM
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory
> getComponentProvider
> INFO: Binding org.apache.guacamole.rest.session.SessionRESTService to
> GuiceManagedComponentProvider with the scope "PerRequest"
> Feb 19, 2020 12:22:40 PM org.webjars.servlet.WebjarsServlet init
> INFO: WebjarsServlet initialization completed
> 2020-02-19 12:22:40.696:INFO:oejsh.ContextHandler:main: Started
> o.e.j.w.WebAppContext@4493d195{root,/,[file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/,
> jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/blob-polyfill-1.0.20150320.jar!/META-INF/resources,
> jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/datalist-polyfill-1.14.0.jar!/META-INF/resources,
> jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/jstz-1.0.10.jar!/META-INF/resources,
> jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/angular-module-shim-0.0.4.jar!/META-INF/resources,
> jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/angular-touch-1.6.9.jar!/META-INF/resources,
> jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/angular-translate-loader-static-files-2.16.0.jar!/META-INF/resources,
> jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/filesaver-1.3.3.jar!/META-INF/resources,
> jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/lodash-4.17.10.jar!/META-INF/resources,
> jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/angular-1.6.9.jar!/META-INF/resources,
> jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/angular-route-1.6.9.jar!/META-INF/resources,
> jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/angular-translate-2.16.0.jar!/META-INF/resources,
> jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/jquery-3.3.1.jar!/META-INF/resources,
> jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/messageformat-1.0.2.jar!/META-INF/resources,
> jar:file:///tmp/jetty-0_0_0_0-8080-root_war-_-any-6969824213125444526.dir/webapp/WEB-INF/lib/angular-translate-interpolation-messageformat-2.16.0.jar!/META-INF/resources],AVAILABLE}{/usr/local/www/jetty/guacamole/webapps/root.war}
> 2020-02-19 12:22:40.719:INFO:oejs.AbstractConnector:main: Started
> ServerConnector@5b18223f{HTTP/1.1,[http/1.1]}{0.0.0.0:8080}
> 2020-02-19 12:22:40.728:INFO:oejus.SslContextFactory:main:
> x509=X509@48528634(jetty,h=[],w=[]) for Server@48d293ee
> [provider=null,keyStore=file:///usr/local/www/jetty/guacamole/etc/keystore,trustStore=file:///usr/local/www/jetty/guacamole/etc/keystore]
> 2020-02-19 12:22:40.826:INFO:oejs.AbstractConnector:main: Started
> ServerConnector@2c66a4f2{SSL,[ssl, http/1.1]}{0.0.0.0:8443}
> 2020-02-19 12:22:40.828:INFO:oejs.Server:main: Started @8013ms
>
> The guacamole.properties file
> # cat /usr/local/www/jetty/guacamole/.guacamole/guacamole.properties
> available-languages: en
> postgresql-port: 5432
> postgresql-database: guacamole_db
> postgresql-username: guacamole_user
> postgresql-password: ********
>
> The pg_hba.conf file
> # cat /var/db/postgres/data10/pg_hba.conf
> local all all trust
> host all all 127.0.0.1/32 trust
> host all all ::1/128 trust
> local replication all trust
> host replication all 127.0.0.1/32 trust
> host replication all ::1/128 trust
>
> The postgresql.conf file
> # cat /var/db/postgres/data10/postgresql.conf
> log_destination = 'syslog'
> update_process_title = off
> datestyle = 'iso, mdy'
> default_text_search_config = 'pg_catalog.english'
>
> The start.ini file
> # cat /usr/local/www/jetty/guacamole/start.ini
> --module=ext
> --module=server
> --module=ssl
> --module=https
> --module=jsp
> --module=resources
> --module=deploy
> --module=jstl
> --module=websocket
> --module=http
> jetty.httpConfig.sendServerVersion=false
> jetty.sslContext.keyStorePath=etc/keystore
> jetty.sslContext.trustStorePath=etc/keystore
> jetty.sslContext.keyStorePassword=********
> jetty.sslContext.keyManagerPassword=********
> jetty.sslContext.trustStorePassword=********
>
> The jetty file
> # cat /usr/local/etc/jetty/jetty
> JAVA_OPTIONS="-Xms128m -Xmx768m"
> JETTY_HOME=/usr/local/jetty
> JETTY_BASE=/usr/local/www/jetty/guacamole
> JETTY_PID=/usr/local/www/jetty/guacamole/jetty.pid
>
> The rc.conf file
> # cat /etc/rc.conf
> clear_tmp_enable="YES"
> syslogd_flags="-ss"
> sendmail_enable="NONE"
> hostname="guaca.DOMAIN_HERE"
> keymap="br275.iso.acc.kbd"
> ifconfig_vmx0="inet 192.168.17.6 netmask 0xffffff00"
> defaultrouter="192.168.17.254"
> ipv6_activate_all_interfaces="YES"
> ifconfig_vmx0_ipv6="inet6 VALID_IP6_HERE prefixlen 64"
> ipv6_defaultrouter="VALID_IP6_HERE"
> sshd_enable="YES"
> ntpd_enable="NO"
> dumpdev="NO"
> postgresql_enable="YES"
> guacd_enable="YES"
> jetty_enable="YES"
> zabbix_agentd_enable="YES"
> firewall_enable="YES"
> firewall_quiet="YES"
> firewall_type="workstation"
> firewall_myservices="80 443 8080 8443"
> firewall_allowservices="any"
> firewall_logdeny="NO"
>
> Thank you for your time people!
>