RDP is not able to connect , 2023.1.7.1
It ist possible to connect to a running session (scaling is not working correctly -> with horizontal and vertical small bar ) but not to create a new session. I see the MS Session Manager is trying to create the session but without luck. Windows Terminalserver 2019. RDM worked fine the last years so it looks like an update (RDM or on MS) has raised this issue. Can someone support?
All Comments (25)
Hello
Sorry to hear about the trouble connecting. I'll try to reproduce this on my side, but in the meantime it would help if you can generate a diagnostic log. You need to enable session logging as described here. Then, try to connect to your server - creating a new session, which we expect not to work - and afterwards, send the log file to us. You can either send it to me direct in a PM or to support@devolutions.net (mentioning this forum thread).
Please let me know if something isn't clear or if you have further questions or comments.
Thanks and kind regards,
Richard Markievicz
Hello again
I did just try this on my side (establish a new RDP session to a Win2k19 server) and it worked well on my side. As well as the diagnostic information I asked in my previous post, can you share some information about your setup? What version of RDM are you using (Remote Desktop Manager > About...)? Are you connecting directly to the server, or are you using an RD Gateway?
Please let me know if something isn't clear
Thanks and kind regards,
Richard Markievicz
Thanks for the fast reply. RDM 2023.1.7.1 and i am not using a RD Gateway on my Mac (macOS 13 Ventura)
I will post the logs when i am back in the office today
Hello
Thank you for the update. Since this scenario seems quite straightforward, and I'm unable to reproduce locally, the session log will be important to understand what's going wrong.
Please don't hesitate to post back if something isn't clear or if you have further questions.
Kind regards,
Richard Markievicz
[19:07:08:947] [15807:70b9b000] [WARN][com.freerdp.core.autodetect] - [autodetect_recv_request_packet]: Received a [MS-RDPBCGR] 2.2.14.1.1 RTT Measure Request (RDP_RTT_REQUEST) [RDP_RTT_REQUEST_TYPE_CONTINUOUS] message but support was not enabled
[19:07:08:951] [15807:70b9b000] [WARN][com.freerdp.core.autodetect] - [autodetect_recv_request_packet]: Received a [MS-RDPBCGR] 2.2.14.1.1 RTT Measure Request (RDP_RTT_REQUEST) [RDP_RTT_REQUEST_TYPE_CONTINUOUS] message but support was not enabled
[19:07:08:960] [15807:70b9b000] [WARN][com.freerdp.core.autodetect] - [autodetect_recv_request_packet]: Received a [MS-RDPBCGR] 2.2.14.1.1 RTT Measure Request (RDP_RTT_REQUEST) [RDP_RTT_REQUEST_TYPE_CONTINUOUS] message but support was not enabled
[19:07:08:969] [15807:70b9b000] [WARN][com.freerdp.core.autodetect] - [autodetect_recv_request_packet]: Received a [MS-RDPBCGR] 2.2.14.1.1 RTT Measure Request (RDP_RTT_REQUEST) [RDP_RTT_REQUEST_TYPE_CONTINUOUS] message but support was not enabled
[19:07:08:971] [15807:70b9b000] [WARN][com.freerdp.core.autodetect] - [autodetect_recv_request_packet]: Received a [MS-RDPBCGR] 2.2.14.1.1 RTT Measure Request (RDP_RTT_REQUEST) [RDP_RTT_REQUEST_TYPE_CONTINUOUS] message but support was not enabled
[19:07:08:977] [15807:70b9b000] [WARN][com.freerdp.core.autodetect] - [autodetect_recv_request_packet]: Received a [MS-RDPBCGR] 2.2.14.1.1 RTT Measure Request (RDP_RTT_REQUEST) [RDP_RTT_REQUEST_TYPE_CONTINUOUS] message but support was not enabled
[19:07:08:994] [15807:70b9b000] [WARN][com.freerdp.core.autodetect] - [autodetect_recv_request_packet]: Received a [MS-RDPBCGR] 2.2.14.1.1 RTT Measure Request (RDP_RTT_REQUEST) [RDP_RTT_REQUEST_TYPE_CONTINUOUS] message but support was not enabled
[19:07:08:999] [15807:70b9b000] [WARN][com.freerdp.core.autodetect] - [autodetect_recv_request_packet]: Received a [MS-RDPBCGR] 2.2.14.1.1 RTT Measure Request (RDP_RTT_REQUEST) [RDP_RTT_REQUEST_TYPE_CONTINUOUS] message but support was not enabled
[19:07:08:002] [15807:70b9b000] [WARN][com.freerdp.core.autodetect] - [autodetect_recv_request_packet]: Received a [MS-RDPBCGR] 2.2.14.1.1 RTT Measure Request (RDP_RTT_REQUEST) [RDP_RTT_REQUEST_TYPE_CONTINUOUS] message but support was not enabled
[19:07:08:008] [15807:70b9b000] [WARN][com.freerdp.core.autodetect] - [autodetect_recv_request_packet]: Received a [MS-RDPBCGR] 2.2.14.1.1 RTT Measure Request (RDP_RTT_REQUEST) [RDP_RTT_REQUEST_TYPE_CONTINUOUS] message but support was not enabled
[19:07:08:024] [15807:70b9b000] [WARN][com.freerdp.core.autodetect] - [autodetect_recv_request_packet]: Received a [MS-RDPBCGR] 2.2.14.1.1 RTT Measure Request (RDP_RTT_REQUEST) [RDP_RTT_REQUEST_TYPE_CONTINUOUS] message but support was not enabled
[19:07:08:027] [15807:70b9b000] [WARN][com.freerdp.core.autodetect] - [autodetect_recv_request_packet]: Received a [MS-RDPBCGR] 2.2.14.1.1 RTT Measure Request (RDP_RTT_REQUEST) [RDP_RTT_REQUEST_TYPE_CONTINUOUS] message but support was not enabled
[19:07:09:292] [15807:70b9b000] [DEBUG][com.freerdp.core.heartbeat] - [rdp_recv_heartbeat_packet]: received Heartbeat PDU -> period=1, count1=8, count2=8
[19:07:09:292] [15807:70b9b000] [WARN][com.freerdp.core.autodetect] - [autodetect_recv_request_packet]: Received a [MS-RDPBCGR] 2.2.14.1.1 RTT Measure Request (RDP_RTT_REQUEST) [RDP_RTT_REQUEST_TYPE_CONTINUOUS] message but support was not enabled
[19:07:09:338] [15807:70b9b000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Save Session Info Data PDU (0x26), length: 624
[19:07:09:338] [15807:70b9b000] [DEBUG][com.freerdp.core.info] - [rdp_recv_logon_info_v2]: LogonInfoV2: SessionId: 0x0000009A UserName: [user] Domain: [ad]
[19:07:09:338] [15807:70b9b000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Save Session Info Data PDU (0x26), length: 630
[19:07:09:338] [15807:70b9b000] [DEBUG][com.freerdp.core.info] - [rdp_recv_logon_info_extended]: LogonInfoExtended: fieldsPresent: 0x00000001
[19:07:09:338] [15807:70b9b000] [DEBUG][com.freerdp.core.info] - [rdp_read_server_auto_reconnect_cookie]: ServerAutoReconnectCookie: Version: 1 LogonId: 154 SecurityVerifier: 010C6A7CEF789020747D914E58E8D290
[19:07:09:346] [15807:70553000] [INFO][com.freerdp.channels.rdpdr.client] - [device_announce]: registered [0000drive] device #1: ppk (type=8 id=1)
[19:07:09:422] [15807:70b9b000] [WARN][com.freerdp.core.autodetect] - [autodetect_recv_request_packet]: Received a [MS-RDPBCGR] 2.2.14.1.1 RTT Measure Request (RDP_RTT_REQUEST) [RDP_RTT_REQUEST_TYPE_CONTINUOUS] message but support was not enabled
[19:07:09:792] [15807:70b9b000] [WARN][com.freerdp.core.autodetect] - [autodetect_recv_request_packet]: Received a [MS-RDPBCGR] 2.2.14.1.1 RTT Measure Request (RDP_RTT_REQUEST) [RDP_RTT_REQUEST_TYPE_CONTINUOUS] message but support was not enabled
[19:07:10:306] [15807:70b9b000] [DEBUG][com.freerdp.core.heartbeat] - [rdp_recv_heartbeat_packet]: received Heartbeat PDU -> period=1, count1=8, count2=8
Hello
Thanks for the update. Sorry for the trouble, but is the log file complete? In the list of session logs, you should be able to right-click and "Reveal in Finder" and attach the complete file to the forum or an email.
Please let me know if something isn't clear
Thanks and kind regards,
Richard Markievicz
[19:20:42:921] [15954:6dd7b000] [INFO][Devolutions.Rdp.Credentials] - [Parse]: parsing "a********", "a*" (Mstsc) => "Username: "a********" Domain: "a*""
[19:20:42:923] [15954:6dd7b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpdr
[19:20:42:923] [15954:6dd7b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpsnd
[19:20:42:923] [15954:6dd7b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMJump
[19:20:42:923] [15954:6dd7b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMCmd
[19:20:42:923] [15954:6dd7b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMLog
[19:20:42:923] [15954:6dd7b000] [DEBUG][com.freerdp.channels.channels.cliprdr.client] - [cliprdr_VirtualChannelEntryEx]: VirtualChannelEntryEx
[19:20:42:923] [15954:6dd7b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx cliprdr
[19:20:42:923] [15954:6dd7b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_VirtualChannelEntryEx]: VirtualChannelEntryEx
[19:20:42:923] [15954:6dd7b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx drdynvc
[19:20:42:923] [15954:6dd7b000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:42:923] [15954:6dd7b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpdr
[19:20:42:923] [15954:6dd7b000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:42:923] [15954:6dd7b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpsnd
[19:20:42:923] [15954:6dd7b000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:42:923] [15954:6dd7b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMJump
[19:20:42:923] [15954:6dd7b000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:42:923] [15954:6dd7b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMCmd
[19:20:42:923] [15954:6dd7b000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:42:924] [15954:6dd7b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMLog
[19:20:42:924] [15954:6dd7b000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:42:924] [15954:6dd7b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx cliprdr
[19:20:42:924] [15954:6dd7b000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:42:924] [15954:6dd7b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx drdynvc
[19:20:42:924] [15954:6dd7b000] [ERROR][com.freerdp.channels.virtual.channel] - [virtchan_virtual_channel_init_event_ex]: Unhandled event type 0
[19:20:42:924] [15954:6dd7b000] [ERROR][com.freerdp.channels.virtual.channel] - [virtchan_virtual_channel_init_event_ex]: Unhandled event type 0
[19:20:42:924] [15954:6dd7b000] [ERROR][com.freerdp.channels.virtual.channel] - [virtchan_virtual_channel_init_event_ex]: Unhandled event type 0
[19:20:42:125] [15954:6dd7b000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: primitives benchmark result:
[19:20:43:278] [15954:6dd7b000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: * generic= 96
[19:20:43:428] [15954:6dd7b000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: * optimized= 475
[19:20:43:428] [15954:6dd7b000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: primitives autodetect, using optimized
[19:20:43:430] [15954:6dd7b000] [DEBUG][com.freerdp.core.nego] - [nego_set_negotiation_enabled]: Enabling security layer negotiation: TRUE
[19:20:43:430] [15954:6dd7b000] [DEBUG][com.freerdp.core.nego] - [nego_set_restricted_admin_mode_required]: Enabling restricted admin mode: FALSE
[19:20:43:430] [15954:6dd7b000] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdp]: Enabling RDP security: TRUE
[19:20:43:430] [15954:6dd7b000] [DEBUG][com.freerdp.core.nego] - [nego_enable_tls]: Enabling TLS security: TRUE
[19:20:43:430] [15954:6dd7b000] [DEBUG][com.freerdp.core.nego] - [nego_enable_nla]: Enabling NLA security: TRUE
[19:20:43:430] [15954:6dd7b000] [DEBUG][com.freerdp.core.nego] - [nego_enable_ext]: Enabling NLA extended security: FALSE
[19:20:43:430] [15954:6dd7b000] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdstls]: Enabling RDSTLS security: FALSE
[19:20:43:430] [15954:6dd7b000] [DEBUG][com.freerdp.core.nego] - [nego_enable_aad]: Enabling RDS AAD security: FALSE
[19:20:43:430] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_INITIAL --> CONNECTION_STATE_NEGO
[19:20:43:430] [15954:6dd7b000] [DEBUG][com.freerdp.core.nego] - [nego_connect]: state: NEGO_STATE_NLA
[19:20:43:430] [15954:6dd7b000] [DEBUG][com.freerdp.core.nego] - [nego_attempt_nla]: Attempting NLA security
[19:20:43:432] [15954:6dd7b000] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: connecting to peer 192.168.10.38
[19:20:43:443] [15954:6dd7b000] [DEBUG][com.freerdp.core.nego] - [nego_send_negotiation_request]: RequestedProtocols: 3
[19:20:43:459] [15954:6dd7b000] [DEBUG][com.freerdp.core.nego] - [nego_process_negotiation_response]: RDP_NEG_RSP::flags = { [0x1f] |EXTENDED_CLIENT_DATA_SUPPORTED|DYNVC_GFX_PROTOCOL_SUPPORTED|RDP_NEGRSP_RESERVED|RESTRICTED_ADMIN_MODE_SUPPORTED|REDIRECTED_AUTHENTICATION_MODE_SUPPORTED }
[19:20:43:459] [15954:6dd7b000] [DEBUG][com.freerdp.core.nego] - [nego_recv]: selected_protocol: 2
[19:20:43:459] [15954:6dd7b000] [DEBUG][com.freerdp.core.nego] - [nego_attempt_nla]: state: NEGO_STATE_FINAL
[19:20:43:459] [15954:6dd7b000] [DEBUG][com.freerdp.core.nego] - [nego_connect]: Negotiated NLA security
[19:20:43:459] [15954:6dd7b000] [DEBUG][com.freerdp.core.nego] - [nego_try_connect]: nego_security_connect with PROTOCOL_HYBRID
[19:20:43:488] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_INITIAL --> NLA_STATE_INITIAL
[19:20:43:488] [15954:6dd7b000] [DEBUG][com.winpr.sspi] - [InitSecurityInterfaceExA]: InitSecurityInterfaceExA
[19:20:43:488] [15954:6dd7b000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_init]: Using package: Negotiate (cbMaxToken: 12256 bytes)
[19:20:43:488] [15954:6dd7b000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_setup_client]: Acquired client credentials
[19:20:43:488] [15954:6dd7b000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_INITIAL to NTLM_STATE_INITIAL
[19:20:43:488] [15954:6dd7b000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_INITIAL to NTLM_STATE_NEGOTIATE
[19:20:43:488] [15954:6dd7b000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_write_negotiate_flags]: Write flags [0xe20882b7] NTLMSSP_NEGOTIATE_UNICODE|NTLMSSP_NEGOTIATE_OEM|NTLMSSP_REQUEST_TARGET|NTLMSSP_NEGOTIATE_SIGN|NTLMSSP_NEGOTIATE_SEAL|NTLMSSP_NEGOTIATE_LM_KEY|NTLMSSP_NEGOTIATE_NTLM|NTLMSSP_NEGOTIATE_ALWAYS_SIGN|NTLMSSP_NEGOTIATE_EXTENDED_SESSION_SECURITY|NTLMSSP_NEGOTIATE_VERSION|NTLMSSP_NEGOTIATE_128|NTLMSSP_NEGOTIATE_KEY_EXCH
[19:20:43:488] [15954:6dd7b000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_NEGOTIATE to NTLM_STATE_CHALLENGE
[19:20:43:488] [15954:6dd7b000] [DEBUG][com.winpr.negotiate] - [negotiate_InitializeSecurityContextW]: Available mechanism: NTLM (1.3.6.1.4.1.311.2.2.10)
[19:20:43:488] [15954:6dd7b000] [DEBUG][com.winpr.negotiate] - [negotiate_InitializeSecurityContextW]: Using direct NTLM
[19:20:43:488] [15954:6dd7b000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_authenticate]: Authentication in progress... (output token size: 40)
[19:20:43:488] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> sending...
[19:20:43:488] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> protocol version 6
[19:20:43:488] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> negoToken
[19:20:43:488] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> client nonce
[19:20:43:488] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_send]: [93 bytes]
[19:20:43:489] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_INITIAL --> NLA_STATE_NEGO_TOKEN
[19:20:43:489] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_NEGO --> CONNECTION_STATE_NLA
[19:20:43:500] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- receiving...
[19:20:43:500] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- protocol version 6
[19:20:43:500] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- nego token
[19:20:43:500] [15954:6dd7b000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_read_negotiate_flags]: Read flags [0xe2898235] NTLMSSP_NEGOTIATE_UNICODE|NTLMSSP_REQUEST_TARGET|NTLMSSP_NEGOTIATE_SIGN|NTLMSSP_NEGOTIATE_SEAL|NTLMSSP_NEGOTIATE_NTLM|NTLMSSP_NEGOTIATE_ALWAYS_SIGN|NTLMSSP_TARGET_TYPE_DOMAIN|NTLMSSP_NEGOTIATE_EXTENDED_SESSION_SECURITY|NTLMSSP_NEGOTIATE_TARGET_INFO|NTLMSSP_NEGOTIATE_VERSION|NTLMSSP_NEGOTIATE_128|NTLMSSP_NEGOTIATE_KEY_EXCH
[19:20:43:501] [15954:6dd7b000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_CHALLENGE to NTLM_STATE_AUTHENTICATE
[19:20:43:501] [15954:6dd7b000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_write_negotiate_flags]: Write flags [0xe288b235] NTLMSSP_NEGOTIATE_UNICODE|NTLMSSP_REQUEST_TARGET|NTLMSSP_NEGOTIATE_SIGN|NTLMSSP_NEGOTIATE_SEAL|NTLMSSP_NEGOTIATE_NTLM|NTLMSSP_NEGOTIATE_DOMAIN_SUPPLIED|NTLMSSP_NEGOTIATE_WORKSTATION_SUPPLIED|NTLMSSP_NEGOTIATE_ALWAYS_SIGN|NTLMSSP_NEGOTIATE_EXTENDED_SESSION_SECURITY|NTLMSSP_NEGOTIATE_TARGET_INFO|NTLMSSP_NEGOTIATE_VERSION|NTLMSSP_NEGOTIATE_128|NTLMSSP_NEGOTIATE_KEY_EXCH
[19:20:43:501] [15954:6dd7b000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_AUTHENTICATE to NTLM_STATE_FINAL
[19:20:43:501] [15954:6dd7b000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_authenticate]: Authentication complete (output token size: 532 bytes)
[19:20:43:501] [15954:6dd7b000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_authenticate]: Context sizes: cbMaxSignature=16, cbSecurityTrailer=16
[19:20:43:501] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> sending...
[19:20:43:501] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> protocol version 6
[19:20:43:501] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> negoToken
[19:20:43:501] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> public key auth
[19:20:43:501] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> client nonce
[19:20:43:501] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_send]: [649 bytes]
[19:20:43:501] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_NEGO_TOKEN --> NLA_STATE_PUB_KEY_AUTH
[19:20:43:515] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- receiving...
[19:20:43:515] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- protocol version 6
[19:20:43:515] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- public key auth
[19:20:43:515] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> sending...
[19:20:43:515] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> protocol version 6
[19:20:43:515] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> auth info
[19:20:43:515] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> client nonce
[19:20:43:515] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_send]: [135 bytes]
[19:20:43:515] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_PUB_KEY_AUTH --> NLA_STATE_AUTH_INFO
[19:20:43:515] [15954:6dd7b000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_AUTH_INFO --> NLA_STATE_FINAL
[19:20:43:515] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_NLA --> CONNECTION_STATE_MCS_CREATE_REQUEST
[19:20:43:515] [15954:6dd7b000] [DEBUG][com.freerdp.core.gcc] - [gcc_write_client_core_data]: Sending highColorDepth=0x0018, supportedColorDepths=0x000f, earlyCapabilityFlags=RNS_UD_CS_WANT_32BPP_SESSION|RNS_UD_CS_VALID_CONNECTION_TYPE|RNS_UD_CS_SUPPORT_DYNVC_GFX_PROTOCOL|RNS_UD_CS_SUPPORT_HEARTBEAT_PDU|RNS_UD_CS_SUPPORT_SKIP_CHANNELJOIN|[0x00000d22]
[19:20:43:515] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CREATE_REQUEST --> CONNECTION_STATE_MCS_CREATE_RESPONSE
[19:20:43:530] [15954:6dd7b000] [DEBUG][com.freerdp.core.gcc] - [gcc_read_server_core_data]: Received EarlyCapabilityFlags=RNS_UD_CS_SUPPORT_STATUSINFO_PDU|[0x00000004]
[19:20:43:530] [15954:6dd7b000] [DEBUG][com.freerdp.core.gcc] - [gcc_read_server_security_data]: Server rdp encryption method: NONE
[19:20:43:530] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CREATE_RESPONSE --> CONNECTION_STATE_MCS_ERECT_DOMAIN
[19:20:43:530] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_ERECT_DOMAIN --> CONNECTION_STATE_MCS_ATTACH_USER
[19:20:43:530] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_ATTACH_USER --> CONNECTION_STATE_MCS_ATTACH_USER_CONFIRM
[19:20:43:542] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_ATTACH_USER_CONFIRM --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:43:542] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:43:553] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:43:553] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:43:564] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:43:564] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:43:575] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:43:575] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:43:586] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:43:586] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:43:597] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:43:597] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:43:608] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:43:608] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:43:620] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:43:620] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:43:631] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:43:631] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:43:642] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:43:642] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:43:653] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_SECURE_SETTINGS_EXCHANGE
[19:20:43:653] [15954:6dd7b000] [DEBUG][com.freerdp.core.info] - [rdp_write_info_packet]: Client Info Packet Flags = INFO_MOUSE|INFO_DISABLECTRLALTDEL|INFO_AUTOLOGON|INFO_UNICODE|INFO_MAXIMIZESHELL|INFO_LOGONNOTIFY|INFO_COMPRESSION|INFO_ENABLEWINDOWSKEY|INFO_FORCE_ENCRYPTED_CS_PDU|INFO_LOGONERRORS|INFO_MOUSE_HAS_WHEEL|INFO_AUDIOCAPTURE
[19:20:43:654] [15954:6dd7b000] [DEBUG][com.winpr.timezone] - [winpr_get_timezone_from_link]: tzid: Europe/Berlin
[19:20:43:654] [15954:6dd7b000] [INFO][com.winpr.timezone] - [winpr_detect_windows_time_zone]: tzid: Europe/Berlin
[19:20:43:654] [15954:6dd7b000] [DEBUG][com.winpr.timezone] - [GetTimeZoneInformation]: tz: Bias=-60 sn='W. Europe Standard Time' dln='W. Europe Daylight Time'
[19:20:43:654] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_SECURE_SETTINGS_EXCHANGE --> CONNECTION_STATE_CONNECT_TIME_AUTO_DETECT_REQUEST
[19:20:43:667] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_CONNECT_TIME_AUTO_DETECT_REQUEST --> CONNECTION_STATE_LICENSING
[19:20:43:667] [15954:6dd7b000] [WARN][com.freerdp.core.license] - [license_read_binary_blob_data]: license binary blob::type BB_ERROR_BLOB, length=0, skipping.
[19:20:43:667] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_LICENSING --> CONNECTION_STATE_MULTITRANSPORT_BOOTSTRAPPING_REQUEST
[19:20:43:736] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MULTITRANSPORT_BOOTSTRAPPING_REQUEST --> CONNECTION_STATE_CAPABILITIES_EXCHANGE_DEMAND_ACTIVE
[19:20:43:737] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_CAPABILITIES_EXCHANGE_DEMAND_ACTIVE --> CONNECTION_STATE_CAPABILITIES_EXCHANGE_CONFIRM_ACTIVE
[19:20:43:737] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_CAPABILITIES_EXCHANGE_CONFIRM_ACTIVE --> CONNECTION_STATE_FINALIZATION_SYNC
[19:20:43:737] [15954:6dd7b000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_SYNC] reset finalize_sc_pdus
[19:20:43:737] [15954:6dd7b000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x1f size=37 channelId=1012)
[19:20:43:737] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_SYNC --> CONNECTION_STATE_FINALIZATION_COOPERATE
[19:20:43:737] [15954:6dd7b000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_COOPERATE] reset finalize_sc_pdus
[19:20:43:737] [15954:6dd7b000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x14 size=41 channelId=1012)
[19:20:43:737] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_COOPERATE --> CONNECTION_STATE_FINALIZATION_REQUEST_CONTROL
[19:20:43:737] [15954:6dd7b000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_REQUEST_CONTROL] reset finalize_sc_pdus
[19:20:43:737] [15954:6dd7b000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x14 size=41 channelId=1012)
[19:20:43:737] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_REQUEST_CONTROL --> CONNECTION_STATE_FINALIZATION_FONT_LIST
[19:20:43:737] [15954:6dd7b000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_FONT_LIST] reset finalize_sc_pdus
[19:20:43:737] [15954:6dd7b000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x27 size=41 channelId=1012)
[19:20:43:737] [15954:6dd7b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_FONT_LIST --> CONNECTION_STATE_FINALIZATION_CLIENT_SYNC
[19:20:43:737] [15954:6dd7b000] [INFO][com.freerdp.gdi] - [gdi_init_ex]: Local framebuffer format PIXEL_FORMAT_BGRX32
[19:20:43:738] [15954:6dd7b000] [INFO][com.freerdp.gdi] - [gdi_init_ex]: Remote framebuffer format PIXEL_FORMAT_BGRA32
[19:20:43:738] [15954:6e7df000] [INFO][com.freerdp.channels.rdpdr.client] - [devman_load_device_service]: Loading device service drive [ppk] (static)
[19:20:43:740] [15954:6dd7b000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (rdpdr)
[19:20:43:756] [15954:6dd7b000] [INFO][com.freerdp.channels.rdpsnd.client] - [rdpsnd_load_device_plugin]: [static] Loaded mac backend for rdpsnd
[19:20:43:756] [15954:6dd7b000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (rdpsnd)
[19:20:43:756] [15954:6dd7b000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (RDMJump)
[19:20:43:756] [15954:6dd7b000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (RDMCmd)
[19:20:43:756] [15954:6dd7b000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (RDMLog)
[19:20:43:756] [15954:6dd7b000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (cliprdr)
[19:20:43:769] [15954:6dd7b000] [DEBUG][com.winpr.clipboard] - [ClipboardInitLocalFileSubsystem]: initialized synthetic local file subsystem
[19:20:43:772] [15954:6dd7b000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel audin
[19:20:43:772] [15954:6dd7b000] [DEBUG][com.freerdp.channels.audin.client] - [audin_register_device_plugin]: device registered.
[19:20:43:794] [15954:6dd7b000] [INFO][com.freerdp.channels.audin.client] - [audin_load_device_plugin]: Loaded mac backend for audin
[19:20:43:794] [15954:6dd7b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 1
[19:20:43:794] [15954:6dd7b000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel ainput
[19:20:43:794] [15954:6dd7b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 2
[19:20:43:794] [15954:6dd7b000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel rdpsnd
[19:20:43:794] [15954:6dd7b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 3
[19:20:43:794] [15954:6dd7b000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel rdpgfx
[19:20:43:795] [15954:6dd7b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 4
[19:20:43:795] [15954:6dd7b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 1.AUDIO_INPUT.
[19:20:43:795] [15954:6dd7b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 2.FreeRDP::Advanced::Input.
[19:20:43:795] [15954:6dd7b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 3.AUDIO_PLAYBACK_DVC.
[19:20:43:795] [15954:6dd7b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 4.Microsoft::Windows::RDS::Graphics.
[19:20:43:795] [15954:6dd7b000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (drdynvc)
[19:20:43:802] [15954:6ee27000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Synchronize Data PDU (0x1F), length: 22
[19:20:43:802] [15954:6ee27000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_SYNC] received flag FINALIZE_SC_SYNCHRONIZE_PDU [0x00000001]
[19:20:43:802] [15954:6ee27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_SYNC --> CONNECTION_STATE_FINALIZATION_CLIENT_COOPERATE
[19:20:43:802] [15954:6ee27000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Control Data PDU (0x14), length: 26
[19:20:43:802] [15954:6ee27000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_COOPERATE] received flag FINALIZE_SC_CONTROL_COOPERATE_PDU [0x00000002]
[19:20:43:802] [15954:6ee27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_COOPERATE --> CONNECTION_STATE_FINALIZATION_CLIENT_GRANTED_CONTROL
[19:20:43:802] [15954:6ee27000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Control Data PDU (0x14), length: 26
[19:20:43:802] [15954:6ee27000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_GRANTED_CONTROL] received flag FINALIZE_SC_CONTROL_GRANTED_PDU [0x00000004]
[19:20:43:802] [15954:6ee27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_GRANTED_CONTROL --> CONNECTION_STATE_FINALIZATION_CLIENT_FONT_MAP
[19:20:43:802] [15954:6ee27000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Font Map Data PDU (0x28), length: 26
[19:20:43:802] [15954:6ee27000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_FONT_MAP] received flag FINALIZE_SC_FONT_MAP_PDU [0x00000008]
[19:20:43:802] [15954:6ee27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_FONT_MAP --> CONNECTION_STATE_ACTIVE
[19:20:43:802] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=3 ChannelName=Microsoft::Windows::RDS::Telemetry
[19:20:43:802] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Telemetry'
[19:20:43:803] [15954:6ee27000] [DEBUG][com.freerdp.core.heartbeat] - [rdp_recv_heartbeat_packet]: received Heartbeat PDU -> period=1, count1=8, count2=8
[19:20:43:803] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=7 ChannelName=Microsoft::Windows::RDS::Graphics
[19:20:43:803] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_channel]: listener Microsoft::Windows::RDS::Graphics created new channel 7
[19:20:43:803] [15954:6ec1b000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (Microsoft::Windows::RDS::Graphics)
[19:20:43:806] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: channel created
[19:20:43:806] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_open_channel]: open_channel: ChannelId 7
[19:20:43:817] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=9 ChannelName=Microsoft::Windows::RDS::Video::Control::v08.01
[19:20:43:817] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Video::Control::v08.01'
[19:20:43:817] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=10 ChannelName=Microsoft::Windows::RDS::Video::Data::v08.01
[19:20:43:817] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Video::Data::v08.01'
[19:20:43:818] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=11 ChannelName=Microsoft::Windows::RDS::Geometry::v08.01
[19:20:43:818] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Geometry::v08.01'
[19:20:43:181] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=18 ChannelName=AUDIO_PLAYBACK_DVC
[19:20:43:181] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_channel]: listener AUDIO_PLAYBACK_DVC created new channel 18
[19:20:43:181] [15954:6ec1b000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (AUDIO_PLAYBACK_DVC)
[19:20:43:181] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: channel created
[19:20:43:181] [15954:6ec1b000] [INFO][com.freerdp.channels.rdpsnd.client] - [rdpsnd_load_device_plugin]: [dynamic] Loaded mac backend for rdpsnd
[19:20:43:181] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_open_channel]: open_channel: ChannelId 18
[19:20:43:193] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=19 ChannelName=AUDIO_PLAYBACK_LOSSY_DVC
[19:20:43:193] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'AUDIO_PLAYBACK_LOSSY_DVC'
[19:20:43:206] [15954:6e7df000] [DEBUG][com.freerdp.channels.rdpdr.client] - [rdpdr_process_server_announce_request]: [rdpdr] server announces version 1.13, client uses 1.13
[19:20:43:207] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=19 ChannelName=RDCamera_Device_Enumerator
[19:20:43:207] [15954:6ec1b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'RDCamera_Device_Enumerator'
[19:20:44:305] [15954:6e7df000] [WARN][com.freerdp.channels.rdpdr.client] - [devman_get_device_by_id]: could not find device ID 0xffffffff
[19:20:44:305] [15954:6e7df000] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_process_irp]: irp_new failed with 87!
[19:20:44:305] [15954:6e7df000] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_process_receive]: rdpdr_process_irp failed with error 87
[19:20:44:305] [15954:6e7df000] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_virtual_channel_client_thread]: rdpdr_process_receive failed with error 87!
[19:20:44:305] [15954:6ee27000] [ERROR][com.freerdp.core] - [checkChannelErrorEvent]: rdpdr_virtual_channel_client_thread reported an error. Error was 87
[19:20:44:305] [15954:6ee27000] [ERROR][com.freerdp.core] - [freerdp_check_event_handles]: checkChannelErrorEvent() failed - 0
[19:20:44:308] [15954:6ee27000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_ACTIVE] reset finalize_sc_pdus
[19:20:44:308] [15954:6ee27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_ACTIVE --> CONNECTION_STATE_INITIAL
[19:20:44:310] [15954:6ec1b000] [DEBUG][Devolutions.Rdp] - [_OnChannelDisconnected]: OnChannelDisconnected (Microsoft::Windows::RDS::Graphics)
[19:20:44:312] [15954:6ec1b000] [DEBUG][Devolutions.Rdp] - [_OnChannelDisconnected]: OnChannelDisconnected (AUDIO_PLAYBACK_DVC)
[19:20:44:056] [15955:6c34b000] [INFO][Devolutions.Rdp.Credentials] - [Parse]: parsing "a********", "a*" (Mstsc) => "Username: "a********" Domain: "a*""
[19:20:44:058] [15955:6c34b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpdr
[19:20:44:058] [15955:6c34b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpsnd
[19:20:44:058] [15955:6c34b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMJump
[19:20:44:058] [15955:6c34b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMCmd
[19:20:44:058] [15955:6c34b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMLog
[19:20:44:058] [15955:6c34b000] [DEBUG][com.freerdp.channels.channels.cliprdr.client] - [cliprdr_VirtualChannelEntryEx]: VirtualChannelEntryEx
[19:20:44:058] [15955:6c34b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx cliprdr
[19:20:44:058] [15955:6c34b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_VirtualChannelEntryEx]: VirtualChannelEntryEx
[19:20:44:058] [15955:6c34b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx drdynvc
[19:20:44:058] [15955:6c34b000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:44:058] [15955:6c34b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpdr
[19:20:44:058] [15955:6c34b000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:44:058] [15955:6c34b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpsnd
[19:20:44:059] [15955:6c34b000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:44:059] [15955:6c34b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMJump
[19:20:44:059] [15955:6c34b000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:44:059] [15955:6c34b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMCmd
[19:20:44:059] [15955:6c34b000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:44:059] [15955:6c34b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMLog
[19:20:44:059] [15955:6c34b000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:44:059] [15955:6c34b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx cliprdr
[19:20:44:059] [15955:6c34b000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:44:059] [15955:6c34b000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx drdynvc
[19:20:44:059] [15955:6c34b000] [ERROR][com.freerdp.channels.virtual.channel] - [virtchan_virtual_channel_init_event_ex]: Unhandled event type 0
[19:20:44:059] [15955:6c34b000] [ERROR][com.freerdp.channels.virtual.channel] - [virtchan_virtual_channel_init_event_ex]: Unhandled event type 0
[19:20:44:059] [15955:6c34b000] [ERROR][com.freerdp.channels.virtual.channel] - [virtchan_virtual_channel_init_event_ex]: Unhandled event type 0
[19:20:44:259] [15955:6c34b000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: primitives benchmark result:
[19:20:45:410] [15955:6c34b000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: * generic= 96
[19:20:45:561] [15955:6c34b000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: * optimized= 477
[19:20:45:561] [15955:6c34b000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: primitives autodetect, using optimized
[19:20:45:563] [15955:6c34b000] [DEBUG][com.freerdp.core.nego] - [nego_set_negotiation_enabled]: Enabling security layer negotiation: TRUE
[19:20:45:563] [15955:6c34b000] [DEBUG][com.freerdp.core.nego] - [nego_set_restricted_admin_mode_required]: Enabling restricted admin mode: FALSE
[19:20:45:563] [15955:6c34b000] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdp]: Enabling RDP security: TRUE
[19:20:45:563] [15955:6c34b000] [DEBUG][com.freerdp.core.nego] - [nego_enable_tls]: Enabling TLS security: TRUE
[19:20:45:563] [15955:6c34b000] [DEBUG][com.freerdp.core.nego] - [nego_enable_nla]: Enabling NLA security: TRUE
[19:20:45:563] [15955:6c34b000] [DEBUG][com.freerdp.core.nego] - [nego_enable_ext]: Enabling NLA extended security: FALSE
[19:20:45:563] [15955:6c34b000] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdstls]: Enabling RDSTLS security: FALSE
[19:20:45:563] [15955:6c34b000] [DEBUG][com.freerdp.core.nego] - [nego_enable_aad]: Enabling RDS AAD security: FALSE
[19:20:45:563] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_INITIAL --> CONNECTION_STATE_NEGO
[19:20:45:563] [15955:6c34b000] [DEBUG][com.freerdp.core.nego] - [nego_connect]: state: NEGO_STATE_NLA
[19:20:45:563] [15955:6c34b000] [DEBUG][com.freerdp.core.nego] - [nego_attempt_nla]: Attempting NLA security
[19:20:45:565] [15955:6c34b000] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: connecting to peer 192.168.10.38
[19:20:45:577] [15955:6c34b000] [DEBUG][com.freerdp.core.nego] - [nego_send_negotiation_request]: RequestedProtocols: 3
[19:20:45:592] [15955:6c34b000] [DEBUG][com.freerdp.core.nego] - [nego_process_negotiation_response]: RDP_NEG_RSP::flags = { [0x1f] |EXTENDED_CLIENT_DATA_SUPPORTED|DYNVC_GFX_PROTOCOL_SUPPORTED|RDP_NEGRSP_RESERVED|RESTRICTED_ADMIN_MODE_SUPPORTED|REDIRECTED_AUTHENTICATION_MODE_SUPPORTED }
[19:20:45:592] [15955:6c34b000] [DEBUG][com.freerdp.core.nego] - [nego_recv]: selected_protocol: 2
[19:20:45:592] [15955:6c34b000] [DEBUG][com.freerdp.core.nego] - [nego_attempt_nla]: state: NEGO_STATE_FINAL
[19:20:45:592] [15955:6c34b000] [DEBUG][com.freerdp.core.nego] - [nego_connect]: Negotiated NLA security
[19:20:45:592] [15955:6c34b000] [DEBUG][com.freerdp.core.nego] - [nego_try_connect]: nego_security_connect with PROTOCOL_HYBRID
[19:20:45:623] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_INITIAL --> NLA_STATE_INITIAL
[19:20:45:623] [15955:6c34b000] [DEBUG][com.winpr.sspi] - [InitSecurityInterfaceExA]: InitSecurityInterfaceExA
[19:20:45:623] [15955:6c34b000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_init]: Using package: Negotiate (cbMaxToken: 12256 bytes)
[19:20:45:623] [15955:6c34b000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_setup_client]: Acquired client credentials
[19:20:45:623] [15955:6c34b000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_INITIAL to NTLM_STATE_INITIAL
[19:20:45:623] [15955:6c34b000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_INITIAL to NTLM_STATE_NEGOTIATE
[19:20:45:623] [15955:6c34b000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_write_negotiate_flags]: Write flags [0xe20882b7] NTLMSSP_NEGOTIATE_UNICODE|NTLMSSP_NEGOTIATE_OEM|NTLMSSP_REQUEST_TARGET|NTLMSSP_NEGOTIATE_SIGN|NTLMSSP_NEGOTIATE_SEAL|NTLMSSP_NEGOTIATE_LM_KEY|NTLMSSP_NEGOTIATE_NTLM|NTLMSSP_NEGOTIATE_ALWAYS_SIGN|NTLMSSP_NEGOTIATE_EXTENDED_SESSION_SECURITY|NTLMSSP_NEGOTIATE_VERSION|NTLMSSP_NEGOTIATE_128|NTLMSSP_NEGOTIATE_KEY_EXCH
[19:20:45:623] [15955:6c34b000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_NEGOTIATE to NTLM_STATE_CHALLENGE
[19:20:45:623] [15955:6c34b000] [DEBUG][com.winpr.negotiate] - [negotiate_InitializeSecurityContextW]: Available mechanism: NTLM (1.3.6.1.4.1.311.2.2.10)
[19:20:45:623] [15955:6c34b000] [DEBUG][com.winpr.negotiate] - [negotiate_InitializeSecurityContextW]: Using direct NTLM
[19:20:45:623] [15955:6c34b000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_authenticate]: Authentication in progress... (output token size: 40)
[19:20:45:623] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> sending...
[19:20:45:623] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> protocol version 6
[19:20:45:623] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> negoToken
[19:20:45:623] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> client nonce
[19:20:45:623] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_send]: [93 bytes]
[19:20:45:623] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_INITIAL --> NLA_STATE_NEGO_TOKEN
[19:20:45:623] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_NEGO --> CONNECTION_STATE_NLA
[19:20:45:635] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- receiving...
[19:20:45:635] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- protocol version 6
[19:20:45:635] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- nego token
[19:20:45:635] [15955:6c34b000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_read_negotiate_flags]: Read flags [0xe2898235] NTLMSSP_NEGOTIATE_UNICODE|NTLMSSP_REQUEST_TARGET|NTLMSSP_NEGOTIATE_SIGN|NTLMSSP_NEGOTIATE_SEAL|NTLMSSP_NEGOTIATE_NTLM|NTLMSSP_NEGOTIATE_ALWAYS_SIGN|NTLMSSP_TARGET_TYPE_DOMAIN|NTLMSSP_NEGOTIATE_EXTENDED_SESSION_SECURITY|NTLMSSP_NEGOTIATE_TARGET_INFO|NTLMSSP_NEGOTIATE_VERSION|NTLMSSP_NEGOTIATE_128|NTLMSSP_NEGOTIATE_KEY_EXCH
[19:20:45:635] [15955:6c34b000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_CHALLENGE to NTLM_STATE_AUTHENTICATE
[19:20:45:635] [15955:6c34b000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_write_negotiate_flags]: Write flags [0xe288b235] NTLMSSP_NEGOTIATE_UNICODE|NTLMSSP_REQUEST_TARGET|NTLMSSP_NEGOTIATE_SIGN|NTLMSSP_NEGOTIATE_SEAL|NTLMSSP_NEGOTIATE_NTLM|NTLMSSP_NEGOTIATE_DOMAIN_SUPPLIED|NTLMSSP_NEGOTIATE_WORKSTATION_SUPPLIED|NTLMSSP_NEGOTIATE_ALWAYS_SIGN|NTLMSSP_NEGOTIATE_EXTENDED_SESSION_SECURITY|NTLMSSP_NEGOTIATE_TARGET_INFO|NTLMSSP_NEGOTIATE_VERSION|NTLMSSP_NEGOTIATE_128|NTLMSSP_NEGOTIATE_KEY_EXCH
[19:20:45:635] [15955:6c34b000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_AUTHENTICATE to NTLM_STATE_FINAL
[19:20:45:635] [15955:6c34b000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_authenticate]: Authentication complete (output token size: 532 bytes)
[19:20:45:635] [15955:6c34b000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_authenticate]: Context sizes: cbMaxSignature=16, cbSecurityTrailer=16
[19:20:45:635] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> sending...
[19:20:45:635] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> protocol version 6
[19:20:45:635] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> negoToken
[19:20:45:635] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> public key auth
[19:20:45:635] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> client nonce
[19:20:45:635] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_send]: [649 bytes]
[19:20:45:635] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_NEGO_TOKEN --> NLA_STATE_PUB_KEY_AUTH
[19:20:45:649] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- receiving...
[19:20:45:649] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- protocol version 6
[19:20:45:649] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- public key auth
[19:20:45:649] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> sending...
[19:20:45:649] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> protocol version 6
[19:20:45:649] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> auth info
[19:20:45:649] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> client nonce
[19:20:45:649] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_send]: [135 bytes]
[19:20:45:649] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_PUB_KEY_AUTH --> NLA_STATE_AUTH_INFO
[19:20:45:649] [15955:6c34b000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_AUTH_INFO --> NLA_STATE_FINAL
[19:20:45:649] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_NLA --> CONNECTION_STATE_MCS_CREATE_REQUEST
[19:20:45:649] [15955:6c34b000] [DEBUG][com.freerdp.core.gcc] - [gcc_write_client_core_data]: Sending highColorDepth=0x0018, supportedColorDepths=0x000f, earlyCapabilityFlags=RNS_UD_CS_WANT_32BPP_SESSION|RNS_UD_CS_VALID_CONNECTION_TYPE|RNS_UD_CS_SUPPORT_DYNVC_GFX_PROTOCOL|RNS_UD_CS_SUPPORT_HEARTBEAT_PDU|RNS_UD_CS_SUPPORT_SKIP_CHANNELJOIN|[0x00000d22]
[19:20:45:649] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CREATE_REQUEST --> CONNECTION_STATE_MCS_CREATE_RESPONSE
[19:20:45:663] [15955:6c34b000] [DEBUG][com.freerdp.core.gcc] - [gcc_read_server_core_data]: Received EarlyCapabilityFlags=RNS_UD_CS_SUPPORT_STATUSINFO_PDU|[0x00000004]
[19:20:45:663] [15955:6c34b000] [DEBUG][com.freerdp.core.gcc] - [gcc_read_server_security_data]: Server rdp encryption method: NONE
[19:20:45:663] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CREATE_RESPONSE --> CONNECTION_STATE_MCS_ERECT_DOMAIN
[19:20:45:663] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_ERECT_DOMAIN --> CONNECTION_STATE_MCS_ATTACH_USER
[19:20:45:663] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_ATTACH_USER --> CONNECTION_STATE_MCS_ATTACH_USER_CONFIRM
[19:20:45:674] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_ATTACH_USER_CONFIRM --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:45:674] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:45:685] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:45:685] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:45:705] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:45:705] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:45:718] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:45:718] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:45:730] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:45:730] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:45:741] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:45:741] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:45:752] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:45:752] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:45:763] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:45:763] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:45:774] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:45:774] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:45:785] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:45:785] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:45:796] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_SECURE_SETTINGS_EXCHANGE
[19:20:45:797] [15955:6c34b000] [DEBUG][com.freerdp.core.info] - [rdp_write_info_packet]: Client Info Packet Flags = INFO_MOUSE|INFO_DISABLECTRLALTDEL|INFO_AUTOLOGON|INFO_UNICODE|INFO_MAXIMIZESHELL|INFO_LOGONNOTIFY|INFO_COMPRESSION|INFO_ENABLEWINDOWSKEY|INFO_FORCE_ENCRYPTED_CS_PDU|INFO_LOGONERRORS|INFO_MOUSE_HAS_WHEEL|INFO_AUDIOCAPTURE
[19:20:45:797] [15955:6c34b000] [DEBUG][com.winpr.timezone] - [winpr_get_timezone_from_link]: tzid: Europe/Berlin
[19:20:45:797] [15955:6c34b000] [INFO][com.winpr.timezone] - [winpr_detect_windows_time_zone]: tzid: Europe/Berlin
[19:20:45:797] [15955:6c34b000] [DEBUG][com.winpr.timezone] - [GetTimeZoneInformation]: tz: Bias=-60 sn='W. Europe Standard Time' dln='W. Europe Daylight Time'
[19:20:45:797] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_SECURE_SETTINGS_EXCHANGE --> CONNECTION_STATE_CONNECT_TIME_AUTO_DETECT_REQUEST
[19:20:45:810] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_CONNECT_TIME_AUTO_DETECT_REQUEST --> CONNECTION_STATE_LICENSING
[19:20:45:810] [15955:6c34b000] [WARN][com.freerdp.core.license] - [license_read_binary_blob_data]: license binary blob::type BB_ERROR_BLOB, length=0, skipping.
[19:20:45:810] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_LICENSING --> CONNECTION_STATE_MULTITRANSPORT_BOOTSTRAPPING_REQUEST
[19:20:45:875] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MULTITRANSPORT_BOOTSTRAPPING_REQUEST --> CONNECTION_STATE_CAPABILITIES_EXCHANGE_DEMAND_ACTIVE
[19:20:45:875] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_CAPABILITIES_EXCHANGE_DEMAND_ACTIVE --> CONNECTION_STATE_CAPABILITIES_EXCHANGE_CONFIRM_ACTIVE
[19:20:45:875] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_CAPABILITIES_EXCHANGE_CONFIRM_ACTIVE --> CONNECTION_STATE_FINALIZATION_SYNC
[19:20:45:875] [15955:6c34b000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_SYNC] reset finalize_sc_pdus
[19:20:45:875] [15955:6c34b000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x1f size=37 channelId=1012)
[19:20:45:875] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_SYNC --> CONNECTION_STATE_FINALIZATION_COOPERATE
[19:20:45:875] [15955:6c34b000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_COOPERATE] reset finalize_sc_pdus
[19:20:45:875] [15955:6c34b000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x14 size=41 channelId=1012)
[19:20:45:875] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_COOPERATE --> CONNECTION_STATE_FINALIZATION_REQUEST_CONTROL
[19:20:45:875] [15955:6c34b000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_REQUEST_CONTROL] reset finalize_sc_pdus
[19:20:45:875] [15955:6c34b000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x14 size=41 channelId=1012)
[19:20:45:875] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_REQUEST_CONTROL --> CONNECTION_STATE_FINALIZATION_FONT_LIST
[19:20:45:875] [15955:6c34b000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_FONT_LIST] reset finalize_sc_pdus
[19:20:45:875] [15955:6c34b000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x27 size=41 channelId=1012)
[19:20:45:876] [15955:6c34b000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_FONT_LIST --> CONNECTION_STATE_FINALIZATION_CLIENT_SYNC
[19:20:45:876] [15955:6c34b000] [INFO][com.freerdp.gdi] - [gdi_init_ex]: Local framebuffer format PIXEL_FORMAT_BGRX32
[19:20:45:876] [15955:6c34b000] [INFO][com.freerdp.gdi] - [gdi_init_ex]: Remote framebuffer format PIXEL_FORMAT_BGRA32
[19:20:45:876] [15955:6cdaf000] [INFO][com.freerdp.channels.rdpdr.client] - [devman_load_device_service]: Loading device service drive [ppk] (static)
[19:20:45:878] [15955:6c34b000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (rdpdr)
[19:20:45:887] [15955:6c34b000] [INFO][com.freerdp.channels.rdpsnd.client] - [rdpsnd_load_device_plugin]: [static] Loaded mac backend for rdpsnd
[19:20:45:887] [15955:6c34b000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (rdpsnd)
[19:20:45:887] [15955:6c34b000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (RDMJump)
[19:20:45:887] [15955:6c34b000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (RDMCmd)
[19:20:45:887] [15955:6c34b000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (RDMLog)
[19:20:45:888] [15955:6c34b000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (cliprdr)
[19:20:45:893] [15955:6c34b000] [DEBUG][com.winpr.clipboard] - [ClipboardInitLocalFileSubsystem]: initialized synthetic local file subsystem
[19:20:45:895] [15955:6c34b000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel audin
[19:20:45:895] [15955:6c34b000] [DEBUG][com.freerdp.channels.audin.client] - [audin_register_device_plugin]: device registered.
[19:20:45:908] [15955:6c34b000] [INFO][com.freerdp.channels.audin.client] - [audin_load_device_plugin]: Loaded mac backend for audin
[19:20:45:908] [15955:6c34b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 1
[19:20:45:908] [15955:6c34b000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel ainput
[19:20:45:908] [15955:6c34b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 2
[19:20:45:908] [15955:6c34b000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel rdpsnd
[19:20:45:908] [15955:6c34b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 3
[19:20:45:908] [15955:6c34b000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel rdpgfx
[19:20:45:908] [15955:6c34b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 4
[19:20:45:908] [15955:6c34b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 1.AUDIO_INPUT.
[19:20:45:908] [15955:6c34b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 2.FreeRDP::Advanced::Input.
[19:20:45:908] [15955:6c34b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 3.AUDIO_PLAYBACK_DVC.
[19:20:45:908] [15955:6c34b000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 4.Microsoft::Windows::RDS::Graphics.
[19:20:45:908] [15955:6c34b000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (drdynvc)
[19:20:45:913] [15955:6d3f7000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Synchronize Data PDU (0x1F), length: 22
[19:20:45:913] [15955:6d3f7000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_SYNC] received flag FINALIZE_SC_SYNCHRONIZE_PDU [0x00000001]
[19:20:45:913] [15955:6d3f7000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_SYNC --> CONNECTION_STATE_FINALIZATION_CLIENT_COOPERATE
[19:20:45:913] [15955:6d3f7000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Control Data PDU (0x14), length: 26
[19:20:45:913] [15955:6d3f7000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_COOPERATE] received flag FINALIZE_SC_CONTROL_COOPERATE_PDU [0x00000002]
[19:20:45:913] [15955:6d3f7000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_COOPERATE --> CONNECTION_STATE_FINALIZATION_CLIENT_GRANTED_CONTROL
[19:20:45:913] [15955:6d3f7000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Control Data PDU (0x14), length: 26
[19:20:45:913] [15955:6d3f7000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_GRANTED_CONTROL] received flag FINALIZE_SC_CONTROL_GRANTED_PDU [0x00000004]
[19:20:45:913] [15955:6d3f7000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_GRANTED_CONTROL --> CONNECTION_STATE_FINALIZATION_CLIENT_FONT_MAP
[19:20:45:914] [15955:6d3f7000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Font Map Data PDU (0x28), length: 26
[19:20:45:914] [15955:6d3f7000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_FONT_MAP] received flag FINALIZE_SC_FONT_MAP_PDU [0x00000008]
[19:20:45:914] [15955:6d3f7000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_FONT_MAP --> CONNECTION_STATE_ACTIVE
[19:20:45:914] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=3 ChannelName=Microsoft::Windows::RDS::Telemetry
[19:20:45:914] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Telemetry'
[19:20:45:914] [15955:6d3f7000] [DEBUG][com.freerdp.core.heartbeat] - [rdp_recv_heartbeat_packet]: received Heartbeat PDU -> period=1, count1=8, count2=8
[19:20:45:914] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=7 ChannelName=Microsoft::Windows::RDS::Graphics
[19:20:45:914] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_channel]: listener Microsoft::Windows::RDS::Graphics created new channel 7
[19:20:45:914] [15955:6d1eb000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (Microsoft::Windows::RDS::Graphics)
[19:20:45:916] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: channel created
[19:20:45:916] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_open_channel]: open_channel: ChannelId 7
[19:20:45:928] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=9 ChannelName=Microsoft::Windows::RDS::Video::Control::v08.01
[19:20:45:928] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Video::Control::v08.01'
[19:20:45:928] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=10 ChannelName=Microsoft::Windows::RDS::Video::Data::v08.01
[19:20:45:928] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Video::Data::v08.01'
[19:20:45:928] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=11 ChannelName=Microsoft::Windows::RDS::Geometry::v08.01
[19:20:45:928] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Geometry::v08.01'
[19:20:46:289] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=18 ChannelName=AUDIO_PLAYBACK_DVC
[19:20:46:289] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_channel]: listener AUDIO_PLAYBACK_DVC created new channel 18
[19:20:46:289] [15955:6d1eb000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (AUDIO_PLAYBACK_DVC)
[19:20:46:289] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: channel created
[19:20:46:289] [15955:6d1eb000] [INFO][com.freerdp.channels.rdpsnd.client] - [rdpsnd_load_device_plugin]: [dynamic] Loaded mac backend for rdpsnd
[19:20:46:289] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_open_channel]: open_channel: ChannelId 18
[19:20:46:301] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=19 ChannelName=AUDIO_PLAYBACK_LOSSY_DVC
[19:20:46:301] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'AUDIO_PLAYBACK_LOSSY_DVC'
[19:20:46:313] [15955:6cdaf000] [DEBUG][com.freerdp.channels.rdpdr.client] - [rdpdr_process_server_announce_request]: [rdpdr] server announces version 1.13, client uses 1.13
[19:20:46:314] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=19 ChannelName=RDCamera_Device_Enumerator
[19:20:46:314] [15955:6d1eb000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'RDCamera_Device_Enumerator'
[19:20:46:382] [15955:6cdaf000] [WARN][com.freerdp.channels.rdpdr.client] - [devman_get_device_by_id]: could not find device ID 0xffffffff
[19:20:46:382] [15955:6cdaf000] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_process_irp]: irp_new failed with 87!
[19:20:46:382] [15955:6cdaf000] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_process_receive]: rdpdr_process_irp failed with error 87
[19:20:46:382] [15955:6cdaf000] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_virtual_channel_client_thread]: rdpdr_process_receive failed with error 87!
[19:20:46:382] [15955:6d3f7000] [ERROR][com.freerdp.core] - [checkChannelErrorEvent]: rdpdr_virtual_channel_client_thread reported an error. Error was 87
[19:20:46:382] [15955:6d3f7000] [ERROR][com.freerdp.core] - [freerdp_check_event_handles]: checkChannelErrorEvent() failed - 0
[19:20:46:383] [15955:6d3f7000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_ACTIVE] reset finalize_sc_pdus
[19:20:46:383] [15955:6d3f7000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_ACTIVE --> CONNECTION_STATE_INITIAL
[19:20:46:384] [15955:6d1eb000] [DEBUG][Devolutions.Rdp] - [_OnChannelDisconnected]: OnChannelDisconnected (Microsoft::Windows::RDS::Graphics)
[19:20:46:385] [15955:6d1eb000] [DEBUG][Devolutions.Rdp] - [_OnChannelDisconnected]: OnChannelDisconnected (AUDIO_PLAYBACK_DVC)
[19:20:46:127] [15956:6db27000] [INFO][Devolutions.Rdp.Credentials] - [Parse]: parsing "a********", "a*" (Mstsc) => "Username: "a********" Domain: "a*""
[19:20:46:129] [15956:6db27000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpdr
[19:20:46:129] [15956:6db27000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpsnd
[19:20:46:129] [15956:6db27000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMJump
[19:20:46:129] [15956:6db27000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMCmd
[19:20:46:129] [15956:6db27000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMLog
[19:20:46:129] [15956:6db27000] [DEBUG][com.freerdp.channels.channels.cliprdr.client] - [cliprdr_VirtualChannelEntryEx]: VirtualChannelEntryEx
[19:20:46:129] [15956:6db27000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx cliprdr
[19:20:46:129] [15956:6db27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_VirtualChannelEntryEx]: VirtualChannelEntryEx
[19:20:46:129] [15956:6db27000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx drdynvc
[19:20:46:129] [15956:6db27000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:46:129] [15956:6db27000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpdr
[19:20:46:129] [15956:6db27000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:46:129] [15956:6db27000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpsnd
[19:20:46:129] [15956:6db27000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:46:129] [15956:6db27000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMJump
[19:20:46:129] [15956:6db27000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:46:129] [15956:6db27000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMCmd
[19:20:46:129] [15956:6db27000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:46:129] [15956:6db27000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMLog
[19:20:46:129] [15956:6db27000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:46:129] [15956:6db27000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx cliprdr
[19:20:46:129] [15956:6db27000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:46:129] [15956:6db27000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx drdynvc
[19:20:46:129] [15956:6db27000] [ERROR][com.freerdp.channels.virtual.channel] - [virtchan_virtual_channel_init_event_ex]: Unhandled event type 0
[19:20:46:129] [15956:6db27000] [ERROR][com.freerdp.channels.virtual.channel] - [virtchan_virtual_channel_init_event_ex]: Unhandled event type 0
[19:20:46:129] [15956:6db27000] [ERROR][com.freerdp.channels.virtual.channel] - [virtchan_virtual_channel_init_event_ex]: Unhandled event type 0
[19:20:47:330] [15956:6db27000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: primitives benchmark result:
[19:20:47:482] [15956:6db27000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: * generic= 96
[19:20:47:632] [15956:6db27000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: * optimized= 505
[19:20:47:632] [15956:6db27000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: primitives autodetect, using optimized
[19:20:47:633] [15956:6db27000] [DEBUG][com.freerdp.core.nego] - [nego_set_negotiation_enabled]: Enabling security layer negotiation: TRUE
[19:20:47:633] [15956:6db27000] [DEBUG][com.freerdp.core.nego] - [nego_set_restricted_admin_mode_required]: Enabling restricted admin mode: FALSE
[19:20:47:633] [15956:6db27000] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdp]: Enabling RDP security: TRUE
[19:20:47:633] [15956:6db27000] [DEBUG][com.freerdp.core.nego] - [nego_enable_tls]: Enabling TLS security: TRUE
[19:20:47:633] [15956:6db27000] [DEBUG][com.freerdp.core.nego] - [nego_enable_nla]: Enabling NLA security: TRUE
[19:20:47:633] [15956:6db27000] [DEBUG][com.freerdp.core.nego] - [nego_enable_ext]: Enabling NLA extended security: FALSE
[19:20:47:633] [15956:6db27000] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdstls]: Enabling RDSTLS security: FALSE
[19:20:47:633] [15956:6db27000] [DEBUG][com.freerdp.core.nego] - [nego_enable_aad]: Enabling RDS AAD security: FALSE
[19:20:47:633] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_INITIAL --> CONNECTION_STATE_NEGO
[19:20:47:633] [15956:6db27000] [DEBUG][com.freerdp.core.nego] - [nego_connect]: state: NEGO_STATE_NLA
[19:20:47:633] [15956:6db27000] [DEBUG][com.freerdp.core.nego] - [nego_attempt_nla]: Attempting NLA security
[19:20:47:635] [15956:6db27000] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: connecting to peer 192.168.10.38
[19:20:47:647] [15956:6db27000] [DEBUG][com.freerdp.core.nego] - [nego_send_negotiation_request]: RequestedProtocols: 3
[19:20:47:664] [15956:6db27000] [DEBUG][com.freerdp.core.nego] - [nego_process_negotiation_response]: RDP_NEG_RSP::flags = { [0x1f] |EXTENDED_CLIENT_DATA_SUPPORTED|DYNVC_GFX_PROTOCOL_SUPPORTED|RDP_NEGRSP_RESERVED|RESTRICTED_ADMIN_MODE_SUPPORTED|REDIRECTED_AUTHENTICATION_MODE_SUPPORTED }
[19:20:47:664] [15956:6db27000] [DEBUG][com.freerdp.core.nego] - [nego_recv]: selected_protocol: 2
[19:20:47:664] [15956:6db27000] [DEBUG][com.freerdp.core.nego] - [nego_attempt_nla]: state: NEGO_STATE_FINAL
[19:20:47:664] [15956:6db27000] [DEBUG][com.freerdp.core.nego] - [nego_connect]: Negotiated NLA security
[19:20:47:664] [15956:6db27000] [DEBUG][com.freerdp.core.nego] - [nego_try_connect]: nego_security_connect with PROTOCOL_HYBRID
[19:20:47:694] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_INITIAL --> NLA_STATE_INITIAL
[19:20:47:694] [15956:6db27000] [DEBUG][com.winpr.sspi] - [InitSecurityInterfaceExA]: InitSecurityInterfaceExA
[19:20:47:694] [15956:6db27000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_init]: Using package: Negotiate (cbMaxToken: 12256 bytes)
[19:20:47:694] [15956:6db27000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_setup_client]: Acquired client credentials
[19:20:47:695] [15956:6db27000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_INITIAL to NTLM_STATE_INITIAL
[19:20:47:695] [15956:6db27000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_INITIAL to NTLM_STATE_NEGOTIATE
[19:20:47:695] [15956:6db27000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_write_negotiate_flags]: Write flags [0xe20882b7] NTLMSSP_NEGOTIATE_UNICODE|NTLMSSP_NEGOTIATE_OEM|NTLMSSP_REQUEST_TARGET|NTLMSSP_NEGOTIATE_SIGN|NTLMSSP_NEGOTIATE_SEAL|NTLMSSP_NEGOTIATE_LM_KEY|NTLMSSP_NEGOTIATE_NTLM|NTLMSSP_NEGOTIATE_ALWAYS_SIGN|NTLMSSP_NEGOTIATE_EXTENDED_SESSION_SECURITY|NTLMSSP_NEGOTIATE_VERSION|NTLMSSP_NEGOTIATE_128|NTLMSSP_NEGOTIATE_KEY_EXCH
[19:20:47:695] [15956:6db27000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_NEGOTIATE to NTLM_STATE_CHALLENGE
[19:20:47:695] [15956:6db27000] [DEBUG][com.winpr.negotiate] - [negotiate_InitializeSecurityContextW]: Available mechanism: NTLM (1.3.6.1.4.1.311.2.2.10)
[19:20:47:695] [15956:6db27000] [DEBUG][com.winpr.negotiate] - [negotiate_InitializeSecurityContextW]: Using direct NTLM
[19:20:47:695] [15956:6db27000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_authenticate]: Authentication in progress... (output token size: 40)
[19:20:47:695] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> sending...
[19:20:47:695] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> protocol version 6
[19:20:47:695] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> negoToken
[19:20:47:695] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> client nonce
[19:20:47:695] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_send]: [93 bytes]
[19:20:47:695] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_INITIAL --> NLA_STATE_NEGO_TOKEN
[19:20:47:695] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_NEGO --> CONNECTION_STATE_NLA
[19:20:47:707] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- receiving...
[19:20:47:707] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- protocol version 6
[19:20:47:707] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- nego token
[19:20:47:707] [15956:6db27000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_read_negotiate_flags]: Read flags [0xe2898235] NTLMSSP_NEGOTIATE_UNICODE|NTLMSSP_REQUEST_TARGET|NTLMSSP_NEGOTIATE_SIGN|NTLMSSP_NEGOTIATE_SEAL|NTLMSSP_NEGOTIATE_NTLM|NTLMSSP_NEGOTIATE_ALWAYS_SIGN|NTLMSSP_TARGET_TYPE_DOMAIN|NTLMSSP_NEGOTIATE_EXTENDED_SESSION_SECURITY|NTLMSSP_NEGOTIATE_TARGET_INFO|NTLMSSP_NEGOTIATE_VERSION|NTLMSSP_NEGOTIATE_128|NTLMSSP_NEGOTIATE_KEY_EXCH
[19:20:47:707] [15956:6db27000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_CHALLENGE to NTLM_STATE_AUTHENTICATE
[19:20:47:707] [15956:6db27000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_write_negotiate_flags]: Write flags [0xe288b235] NTLMSSP_NEGOTIATE_UNICODE|NTLMSSP_REQUEST_TARGET|NTLMSSP_NEGOTIATE_SIGN|NTLMSSP_NEGOTIATE_SEAL|NTLMSSP_NEGOTIATE_NTLM|NTLMSSP_NEGOTIATE_DOMAIN_SUPPLIED|NTLMSSP_NEGOTIATE_WORKSTATION_SUPPLIED|NTLMSSP_NEGOTIATE_ALWAYS_SIGN|NTLMSSP_NEGOTIATE_EXTENDED_SESSION_SECURITY|NTLMSSP_NEGOTIATE_TARGET_INFO|NTLMSSP_NEGOTIATE_VERSION|NTLMSSP_NEGOTIATE_128|NTLMSSP_NEGOTIATE_KEY_EXCH
[19:20:47:707] [15956:6db27000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_AUTHENTICATE to NTLM_STATE_FINAL
[19:20:47:707] [15956:6db27000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_authenticate]: Authentication complete (output token size: 532 bytes)
[19:20:47:707] [15956:6db27000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_authenticate]: Context sizes: cbMaxSignature=16, cbSecurityTrailer=16
[19:20:47:707] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> sending...
[19:20:47:707] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> protocol version 6
[19:20:47:707] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> negoToken
[19:20:47:707] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> public key auth
[19:20:47:707] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> client nonce
[19:20:47:707] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_send]: [649 bytes]
[19:20:47:707] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_NEGO_TOKEN --> NLA_STATE_PUB_KEY_AUTH
[19:20:47:720] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- receiving...
[19:20:47:720] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- protocol version 6
[19:20:47:720] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- public key auth
[19:20:47:721] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> sending...
[19:20:47:721] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> protocol version 6
[19:20:47:721] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> auth info
[19:20:47:721] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> client nonce
[19:20:47:721] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_send]: [135 bytes]
[19:20:47:721] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_PUB_KEY_AUTH --> NLA_STATE_AUTH_INFO
[19:20:47:721] [15956:6db27000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_AUTH_INFO --> NLA_STATE_FINAL
[19:20:47:721] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_NLA --> CONNECTION_STATE_MCS_CREATE_REQUEST
[19:20:47:721] [15956:6db27000] [DEBUG][com.freerdp.core.gcc] - [gcc_write_client_core_data]: Sending highColorDepth=0x0018, supportedColorDepths=0x000f, earlyCapabilityFlags=RNS_UD_CS_WANT_32BPP_SESSION|RNS_UD_CS_VALID_CONNECTION_TYPE|RNS_UD_CS_SUPPORT_DYNVC_GFX_PROTOCOL|RNS_UD_CS_SUPPORT_HEARTBEAT_PDU|RNS_UD_CS_SUPPORT_SKIP_CHANNELJOIN|[0x00000d22]
[19:20:47:721] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CREATE_REQUEST --> CONNECTION_STATE_MCS_CREATE_RESPONSE
[19:20:47:733] [15956:6db27000] [DEBUG][com.freerdp.core.gcc] - [gcc_read_server_core_data]: Received EarlyCapabilityFlags=RNS_UD_CS_SUPPORT_STATUSINFO_PDU|[0x00000004]
[19:20:47:733] [15956:6db27000] [DEBUG][com.freerdp.core.gcc] - [gcc_read_server_security_data]: Server rdp encryption method: NONE
[19:20:47:733] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CREATE_RESPONSE --> CONNECTION_STATE_MCS_ERECT_DOMAIN
[19:20:47:733] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_ERECT_DOMAIN --> CONNECTION_STATE_MCS_ATTACH_USER
[19:20:47:733] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_ATTACH_USER --> CONNECTION_STATE_MCS_ATTACH_USER_CONFIRM
[19:20:47:745] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_ATTACH_USER_CONFIRM --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:47:745] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:47:757] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:47:757] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:47:768] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:47:768] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:47:780] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:47:780] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:47:791] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:47:791] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:47:802] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:47:802] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:47:814] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:47:814] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:47:825] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:47:825] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:47:837] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:47:837] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:47:847] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:47:848] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:47:859] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_SECURE_SETTINGS_EXCHANGE
[19:20:47:859] [15956:6db27000] [DEBUG][com.freerdp.core.info] - [rdp_write_info_packet]: Client Info Packet Flags = INFO_MOUSE|INFO_DISABLECTRLALTDEL|INFO_AUTOLOGON|INFO_UNICODE|INFO_MAXIMIZESHELL|INFO_LOGONNOTIFY|INFO_COMPRESSION|INFO_ENABLEWINDOWSKEY|INFO_FORCE_ENCRYPTED_CS_PDU|INFO_LOGONERRORS|INFO_MOUSE_HAS_WHEEL|INFO_AUDIOCAPTURE
[19:20:47:860] [15956:6db27000] [DEBUG][com.winpr.timezone] - [winpr_get_timezone_from_link]: tzid: Europe/Berlin
[19:20:47:860] [15956:6db27000] [INFO][com.winpr.timezone] - [winpr_detect_windows_time_zone]: tzid: Europe/Berlin
[19:20:47:860] [15956:6db27000] [DEBUG][com.winpr.timezone] - [GetTimeZoneInformation]: tz: Bias=-60 sn='W. Europe Standard Time' dln='W. Europe Daylight Time'
[19:20:47:860] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_SECURE_SETTINGS_EXCHANGE --> CONNECTION_STATE_CONNECT_TIME_AUTO_DETECT_REQUEST
[19:20:47:873] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_CONNECT_TIME_AUTO_DETECT_REQUEST --> CONNECTION_STATE_LICENSING
[19:20:47:873] [15956:6db27000] [WARN][com.freerdp.core.license] - [license_read_binary_blob_data]: license binary blob::type BB_ERROR_BLOB, length=0, skipping.
[19:20:47:873] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_LICENSING --> CONNECTION_STATE_MULTITRANSPORT_BOOTSTRAPPING_REQUEST
[19:20:47:965] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MULTITRANSPORT_BOOTSTRAPPING_REQUEST --> CONNECTION_STATE_CAPABILITIES_EXCHANGE_DEMAND_ACTIVE
[19:20:47:965] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_CAPABILITIES_EXCHANGE_DEMAND_ACTIVE --> CONNECTION_STATE_CAPABILITIES_EXCHANGE_CONFIRM_ACTIVE
[19:20:47:965] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_CAPABILITIES_EXCHANGE_CONFIRM_ACTIVE --> CONNECTION_STATE_FINALIZATION_SYNC
[19:20:47:965] [15956:6db27000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_SYNC] reset finalize_sc_pdus
[19:20:47:965] [15956:6db27000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x1f size=37 channelId=1012)
[19:20:47:966] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_SYNC --> CONNECTION_STATE_FINALIZATION_COOPERATE
[19:20:47:966] [15956:6db27000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_COOPERATE] reset finalize_sc_pdus
[19:20:47:966] [15956:6db27000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x14 size=41 channelId=1012)
[19:20:47:966] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_COOPERATE --> CONNECTION_STATE_FINALIZATION_REQUEST_CONTROL
[19:20:47:966] [15956:6db27000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_REQUEST_CONTROL] reset finalize_sc_pdus
[19:20:47:966] [15956:6db27000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x14 size=41 channelId=1012)
[19:20:47:966] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_REQUEST_CONTROL --> CONNECTION_STATE_FINALIZATION_FONT_LIST
[19:20:47:966] [15956:6db27000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_FONT_LIST] reset finalize_sc_pdus
[19:20:47:966] [15956:6db27000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x27 size=41 channelId=1012)
[19:20:47:966] [15956:6db27000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_FONT_LIST --> CONNECTION_STATE_FINALIZATION_CLIENT_SYNC
[19:20:47:966] [15956:6db27000] [INFO][com.freerdp.gdi] - [gdi_init_ex]: Local framebuffer format PIXEL_FORMAT_BGRX32
[19:20:47:966] [15956:6db27000] [INFO][com.freerdp.gdi] - [gdi_init_ex]: Remote framebuffer format PIXEL_FORMAT_BGRA32
[19:20:47:966] [15956:6e58b000] [INFO][com.freerdp.channels.rdpdr.client] - [devman_load_device_service]: Loading device service drive [ppk] (static)
[19:20:47:968] [15956:6db27000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (rdpdr)
[19:20:47:981] [15956:6db27000] [INFO][com.freerdp.channels.rdpsnd.client] - [rdpsnd_load_device_plugin]: [static] Loaded mac backend for rdpsnd
[19:20:47:981] [15956:6db27000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (rdpsnd)
[19:20:47:981] [15956:6db27000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (RDMJump)
[19:20:47:981] [15956:6db27000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (RDMCmd)
[19:20:47:981] [15956:6db27000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (RDMLog)
[19:20:47:981] [15956:6db27000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (cliprdr)
[19:20:47:995] [15956:6db27000] [DEBUG][com.winpr.clipboard] - [ClipboardInitLocalFileSubsystem]: initialized synthetic local file subsystem
[19:20:47:997] [15956:6db27000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel audin
[19:20:47:997] [15956:6db27000] [DEBUG][com.freerdp.channels.audin.client] - [audin_register_device_plugin]: device registered.
[19:20:47:020] [15956:6db27000] [INFO][com.freerdp.channels.audin.client] - [audin_load_device_plugin]: Loaded mac backend for audin
[19:20:47:020] [15956:6db27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 1
[19:20:47:020] [15956:6db27000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel ainput
[19:20:47:020] [15956:6db27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 2
[19:20:47:020] [15956:6db27000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel rdpsnd
[19:20:47:020] [15956:6db27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 3
[19:20:47:020] [15956:6db27000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel rdpgfx
[19:20:47:020] [15956:6db27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 4
[19:20:47:020] [15956:6db27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 1.AUDIO_INPUT.
[19:20:47:020] [15956:6db27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 2.FreeRDP::Advanced::Input.
[19:20:47:020] [15956:6db27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 3.AUDIO_PLAYBACK_DVC.
[19:20:47:020] [15956:6db27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 4.Microsoft::Windows::RDS::Graphics.
[19:20:47:021] [15956:6db27000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (drdynvc)
[19:20:47:027] [15956:6ebd3000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Synchronize Data PDU (0x1F), length: 22
[19:20:47:027] [15956:6ebd3000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_SYNC] received flag FINALIZE_SC_SYNCHRONIZE_PDU [0x00000001]
[19:20:47:027] [15956:6ebd3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_SYNC --> CONNECTION_STATE_FINALIZATION_CLIENT_COOPERATE
[19:20:47:027] [15956:6ebd3000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Control Data PDU (0x14), length: 26
[19:20:47:027] [15956:6ebd3000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_COOPERATE] received flag FINALIZE_SC_CONTROL_COOPERATE_PDU [0x00000002]
[19:20:47:027] [15956:6ebd3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_COOPERATE --> CONNECTION_STATE_FINALIZATION_CLIENT_GRANTED_CONTROL
[19:20:47:027] [15956:6ebd3000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Control Data PDU (0x14), length: 26
[19:20:47:027] [15956:6ebd3000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_GRANTED_CONTROL] received flag FINALIZE_SC_CONTROL_GRANTED_PDU [0x00000004]
[19:20:47:027] [15956:6ebd3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_GRANTED_CONTROL --> CONNECTION_STATE_FINALIZATION_CLIENT_FONT_MAP
[19:20:47:027] [15956:6ebd3000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Font Map Data PDU (0x28), length: 26
[19:20:47:027] [15956:6ebd3000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_FONT_MAP] received flag FINALIZE_SC_FONT_MAP_PDU [0x00000008]
[19:20:47:027] [15956:6ebd3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_FONT_MAP --> CONNECTION_STATE_ACTIVE
[19:20:47:028] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=3 ChannelName=Microsoft::Windows::RDS::Telemetry
[19:20:47:028] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Telemetry'
[19:20:47:028] [15956:6ebd3000] [DEBUG][com.freerdp.core.heartbeat] - [rdp_recv_heartbeat_packet]: received Heartbeat PDU -> period=1, count1=8, count2=8
[19:20:47:028] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=7 ChannelName=Microsoft::Windows::RDS::Graphics
[19:20:47:028] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_channel]: listener Microsoft::Windows::RDS::Graphics created new channel 7
[19:20:47:028] [15956:6e9c7000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (Microsoft::Windows::RDS::Graphics)
[19:20:47:030] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: channel created
[19:20:47:031] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_open_channel]: open_channel: ChannelId 7
[19:20:47:042] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=9 ChannelName=Microsoft::Windows::RDS::Video::Control::v08.01
[19:20:47:042] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Video::Control::v08.01'
[19:20:47:042] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=10 ChannelName=Microsoft::Windows::RDS::Video::Data::v08.01
[19:20:47:042] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Video::Data::v08.01'
[19:20:47:043] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=11 ChannelName=Microsoft::Windows::RDS::Geometry::v08.01
[19:20:47:043] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Geometry::v08.01'
[19:20:48:486] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=18 ChannelName=AUDIO_PLAYBACK_DVC
[19:20:48:486] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_channel]: listener AUDIO_PLAYBACK_DVC created new channel 18
[19:20:48:486] [15956:6e9c7000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (AUDIO_PLAYBACK_DVC)
[19:20:48:486] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: channel created
[19:20:48:486] [15956:6e9c7000] [INFO][com.freerdp.channels.rdpsnd.client] - [rdpsnd_load_device_plugin]: [dynamic] Loaded mac backend for rdpsnd
[19:20:48:486] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_open_channel]: open_channel: ChannelId 18
[19:20:48:498] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=19 ChannelName=AUDIO_PLAYBACK_LOSSY_DVC
[19:20:48:498] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'AUDIO_PLAYBACK_LOSSY_DVC'
[19:20:48:510] [15956:6e58b000] [DEBUG][com.freerdp.channels.rdpdr.client] - [rdpdr_process_server_announce_request]: [rdpdr] server announces version 1.13, client uses 1.13
[19:20:48:511] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=19 ChannelName=RDCamera_Device_Enumerator
[19:20:48:511] [15956:6e9c7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'RDCamera_Device_Enumerator'
[19:20:48:530] [15956:6e58b000] [WARN][com.freerdp.channels.rdpdr.client] - [devman_get_device_by_id]: could not find device ID 0xffffffff
[19:20:48:530] [15956:6e58b000] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_process_irp]: irp_new failed with 87!
[19:20:48:530] [15956:6e58b000] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_process_receive]: rdpdr_process_irp failed with error 87
[19:20:48:530] [15956:6e58b000] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_virtual_channel_client_thread]: rdpdr_process_receive failed with error 87!
[19:20:48:531] [15956:6ebd3000] [ERROR][com.freerdp.core] - [checkChannelErrorEvent]: rdpdr_virtual_channel_client_thread reported an error. Error was 87
[19:20:48:531] [15956:6ebd3000] [ERROR][com.freerdp.core] - [freerdp_check_event_handles]: checkChannelErrorEvent() failed - 0
[19:20:48:533] [15956:6ebd3000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_ACTIVE] reset finalize_sc_pdus
[19:20:48:533] [15956:6ebd3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_ACTIVE --> CONNECTION_STATE_INITIAL
[19:20:48:533] [15956:6e9c7000] [DEBUG][Devolutions.Rdp] - [_OnChannelDisconnected]: OnChannelDisconnected (Microsoft::Windows::RDS::Graphics)
[19:20:48:535] [15956:6e9c7000] [DEBUG][Devolutions.Rdp] - [_OnChannelDisconnected]: OnChannelDisconnected (AUDIO_PLAYBACK_DVC)
[19:20:49:291] [15957:6bdb3000] [INFO][Devolutions.Rdp.Credentials] - [Parse]: parsing "a********", "a*" (Mstsc) => "Username: "a********" Domain: "a*""
[19:20:49:293] [15957:6bdb3000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpdr
[19:20:49:293] [15957:6bdb3000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpsnd
[19:20:49:293] [15957:6bdb3000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMJump
[19:20:49:293] [15957:6bdb3000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMCmd
[19:20:49:293] [15957:6bdb3000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMLog
[19:20:49:293] [15957:6bdb3000] [DEBUG][com.freerdp.channels.channels.cliprdr.client] - [cliprdr_VirtualChannelEntryEx]: VirtualChannelEntryEx
[19:20:49:293] [15957:6bdb3000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx cliprdr
[19:20:49:293] [15957:6bdb3000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_VirtualChannelEntryEx]: VirtualChannelEntryEx
[19:20:49:293] [15957:6bdb3000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx drdynvc
[19:20:49:294] [15957:6bdb3000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:49:294] [15957:6bdb3000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpdr
[19:20:49:294] [15957:6bdb3000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:49:294] [15957:6bdb3000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpsnd
[19:20:49:294] [15957:6bdb3000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:49:294] [15957:6bdb3000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMJump
[19:20:49:294] [15957:6bdb3000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:49:294] [15957:6bdb3000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMCmd
[19:20:49:294] [15957:6bdb3000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:49:294] [15957:6bdb3000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMLog
[19:20:49:294] [15957:6bdb3000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:49:294] [15957:6bdb3000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx cliprdr
[19:20:49:294] [15957:6bdb3000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:49:294] [15957:6bdb3000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx drdynvc
[19:20:49:294] [15957:6bdb3000] [ERROR][com.freerdp.channels.virtual.channel] - [virtchan_virtual_channel_init_event_ex]: Unhandled event type 0
[19:20:49:294] [15957:6bdb3000] [ERROR][com.freerdp.channels.virtual.channel] - [virtchan_virtual_channel_init_event_ex]: Unhandled event type 0
[19:20:49:294] [15957:6bdb3000] [ERROR][com.freerdp.channels.virtual.channel] - [virtchan_virtual_channel_init_event_ex]: Unhandled event type 0
[19:20:49:496] [15957:6bdb3000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: primitives benchmark result:
[19:20:49:648] [15957:6bdb3000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: * generic= 96
[19:20:49:798] [15957:6bdb3000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: * optimized= 479
[19:20:49:798] [15957:6bdb3000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: primitives autodetect, using optimized
[19:20:49:800] [15957:6bdb3000] [DEBUG][com.freerdp.core.nego] - [nego_set_negotiation_enabled]: Enabling security layer negotiation: TRUE
[19:20:49:800] [15957:6bdb3000] [DEBUG][com.freerdp.core.nego] - [nego_set_restricted_admin_mode_required]: Enabling restricted admin mode: FALSE
[19:20:49:800] [15957:6bdb3000] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdp]: Enabling RDP security: TRUE
[19:20:49:800] [15957:6bdb3000] [DEBUG][com.freerdp.core.nego] - [nego_enable_tls]: Enabling TLS security: TRUE
[19:20:49:800] [15957:6bdb3000] [DEBUG][com.freerdp.core.nego] - [nego_enable_nla]: Enabling NLA security: TRUE
[19:20:49:800] [15957:6bdb3000] [DEBUG][com.freerdp.core.nego] - [nego_enable_ext]: Enabling NLA extended security: FALSE
[19:20:49:800] [15957:6bdb3000] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdstls]: Enabling RDSTLS security: FALSE
[19:20:49:800] [15957:6bdb3000] [DEBUG][com.freerdp.core.nego] - [nego_enable_aad]: Enabling RDS AAD security: FALSE
[19:20:49:800] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_INITIAL --> CONNECTION_STATE_NEGO
[19:20:49:800] [15957:6bdb3000] [DEBUG][com.freerdp.core.nego] - [nego_connect]: state: NEGO_STATE_NLA
[19:20:49:800] [15957:6bdb3000] [DEBUG][com.freerdp.core.nego] - [nego_attempt_nla]: Attempting NLA security
[19:20:49:802] [15957:6bdb3000] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: connecting to peer 192.168.10.38
[19:20:49:815] [15957:6bdb3000] [DEBUG][com.freerdp.core.nego] - [nego_send_negotiation_request]: RequestedProtocols: 3
[19:20:49:830] [15957:6bdb3000] [DEBUG][com.freerdp.core.nego] - [nego_process_negotiation_response]: RDP_NEG_RSP::flags = { [0x1f] |EXTENDED_CLIENT_DATA_SUPPORTED|DYNVC_GFX_PROTOCOL_SUPPORTED|RDP_NEGRSP_RESERVED|RESTRICTED_ADMIN_MODE_SUPPORTED|REDIRECTED_AUTHENTICATION_MODE_SUPPORTED }
[19:20:49:830] [15957:6bdb3000] [DEBUG][com.freerdp.core.nego] - [nego_recv]: selected_protocol: 2
[19:20:49:830] [15957:6bdb3000] [DEBUG][com.freerdp.core.nego] - [nego_attempt_nla]: state: NEGO_STATE_FINAL
[19:20:49:830] [15957:6bdb3000] [DEBUG][com.freerdp.core.nego] - [nego_connect]: Negotiated NLA security
[19:20:49:830] [15957:6bdb3000] [DEBUG][com.freerdp.core.nego] - [nego_try_connect]: nego_security_connect with PROTOCOL_HYBRID
[19:20:49:861] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_INITIAL --> NLA_STATE_INITIAL
[19:20:49:861] [15957:6bdb3000] [DEBUG][com.winpr.sspi] - [InitSecurityInterfaceExA]: InitSecurityInterfaceExA
[19:20:49:861] [15957:6bdb3000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_init]: Using package: Negotiate (cbMaxToken: 12256 bytes)
[19:20:49:861] [15957:6bdb3000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_setup_client]: Acquired client credentials
[19:20:49:861] [15957:6bdb3000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_INITIAL to NTLM_STATE_INITIAL
[19:20:49:861] [15957:6bdb3000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_INITIAL to NTLM_STATE_NEGOTIATE
[19:20:49:861] [15957:6bdb3000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_write_negotiate_flags]: Write flags [0xe20882b7] NTLMSSP_NEGOTIATE_UNICODE|NTLMSSP_NEGOTIATE_OEM|NTLMSSP_REQUEST_TARGET|NTLMSSP_NEGOTIATE_SIGN|NTLMSSP_NEGOTIATE_SEAL|NTLMSSP_NEGOTIATE_LM_KEY|NTLMSSP_NEGOTIATE_NTLM|NTLMSSP_NEGOTIATE_ALWAYS_SIGN|NTLMSSP_NEGOTIATE_EXTENDED_SESSION_SECURITY|NTLMSSP_NEGOTIATE_VERSION|NTLMSSP_NEGOTIATE_128|NTLMSSP_NEGOTIATE_KEY_EXCH
[19:20:49:861] [15957:6bdb3000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_NEGOTIATE to NTLM_STATE_CHALLENGE
[19:20:49:861] [15957:6bdb3000] [DEBUG][com.winpr.negotiate] - [negotiate_InitializeSecurityContextW]: Available mechanism: NTLM (1.3.6.1.4.1.311.2.2.10)
[19:20:49:861] [15957:6bdb3000] [DEBUG][com.winpr.negotiate] - [negotiate_InitializeSecurityContextW]: Using direct NTLM
[19:20:49:861] [15957:6bdb3000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_authenticate]: Authentication in progress... (output token size: 40)
[19:20:49:861] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> sending...
[19:20:49:861] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> protocol version 6
[19:20:49:861] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> negoToken
[19:20:49:861] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> client nonce
[19:20:49:861] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_send]: [93 bytes]
[19:20:49:861] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_INITIAL --> NLA_STATE_NEGO_TOKEN
[19:20:49:861] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_NEGO --> CONNECTION_STATE_NLA
[19:20:49:877] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- receiving...
[19:20:49:877] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- protocol version 6
[19:20:49:877] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- nego token
[19:20:49:877] [15957:6bdb3000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_read_negotiate_flags]: Read flags [0xe2898235] NTLMSSP_NEGOTIATE_UNICODE|NTLMSSP_REQUEST_TARGET|NTLMSSP_NEGOTIATE_SIGN|NTLMSSP_NEGOTIATE_SEAL|NTLMSSP_NEGOTIATE_NTLM|NTLMSSP_NEGOTIATE_ALWAYS_SIGN|NTLMSSP_TARGET_TYPE_DOMAIN|NTLMSSP_NEGOTIATE_EXTENDED_SESSION_SECURITY|NTLMSSP_NEGOTIATE_TARGET_INFO|NTLMSSP_NEGOTIATE_VERSION|NTLMSSP_NEGOTIATE_128|NTLMSSP_NEGOTIATE_KEY_EXCH
[19:20:49:877] [15957:6bdb3000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_CHALLENGE to NTLM_STATE_AUTHENTICATE
[19:20:49:877] [15957:6bdb3000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_write_negotiate_flags]: Write flags [0xe288b235] NTLMSSP_NEGOTIATE_UNICODE|NTLMSSP_REQUEST_TARGET|NTLMSSP_NEGOTIATE_SIGN|NTLMSSP_NEGOTIATE_SEAL|NTLMSSP_NEGOTIATE_NTLM|NTLMSSP_NEGOTIATE_DOMAIN_SUPPLIED|NTLMSSP_NEGOTIATE_WORKSTATION_SUPPLIED|NTLMSSP_NEGOTIATE_ALWAYS_SIGN|NTLMSSP_NEGOTIATE_EXTENDED_SESSION_SECURITY|NTLMSSP_NEGOTIATE_TARGET_INFO|NTLMSSP_NEGOTIATE_VERSION|NTLMSSP_NEGOTIATE_128|NTLMSSP_NEGOTIATE_KEY_EXCH
[19:20:49:877] [15957:6bdb3000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_AUTHENTICATE to NTLM_STATE_FINAL
[19:20:49:877] [15957:6bdb3000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_authenticate]: Authentication complete (output token size: 532 bytes)
[19:20:49:877] [15957:6bdb3000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_authenticate]: Context sizes: cbMaxSignature=16, cbSecurityTrailer=16
[19:20:49:877] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> sending...
[19:20:49:877] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> protocol version 6
[19:20:49:877] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> negoToken
[19:20:49:877] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> public key auth
[19:20:49:877] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> client nonce
[19:20:49:877] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_send]: [649 bytes]
[19:20:49:877] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_NEGO_TOKEN --> NLA_STATE_PUB_KEY_AUTH
[19:20:49:892] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- receiving...
[19:20:49:892] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- protocol version 6
[19:20:49:892] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- public key auth
[19:20:49:892] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> sending...
[19:20:49:892] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> protocol version 6
[19:20:49:892] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> auth info
[19:20:49:892] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> client nonce
[19:20:49:892] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_send]: [135 bytes]
[19:20:49:892] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_PUB_KEY_AUTH --> NLA_STATE_AUTH_INFO
[19:20:49:892] [15957:6bdb3000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_AUTH_INFO --> NLA_STATE_FINAL
[19:20:49:892] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_NLA --> CONNECTION_STATE_MCS_CREATE_REQUEST
[19:20:49:892] [15957:6bdb3000] [DEBUG][com.freerdp.core.gcc] - [gcc_write_client_core_data]: Sending highColorDepth=0x0018, supportedColorDepths=0x000f, earlyCapabilityFlags=RNS_UD_CS_WANT_32BPP_SESSION|RNS_UD_CS_VALID_CONNECTION_TYPE|RNS_UD_CS_SUPPORT_DYNVC_GFX_PROTOCOL|RNS_UD_CS_SUPPORT_HEARTBEAT_PDU|RNS_UD_CS_SUPPORT_SKIP_CHANNELJOIN|[0x00000d22]
[19:20:49:892] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CREATE_REQUEST --> CONNECTION_STATE_MCS_CREATE_RESPONSE
[19:20:49:904] [15957:6bdb3000] [DEBUG][com.freerdp.core.gcc] - [gcc_read_server_core_data]: Received EarlyCapabilityFlags=RNS_UD_CS_SUPPORT_STATUSINFO_PDU|[0x00000004]
[19:20:49:904] [15957:6bdb3000] [DEBUG][com.freerdp.core.gcc] - [gcc_read_server_security_data]: Server rdp encryption method: NONE
[19:20:49:904] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CREATE_RESPONSE --> CONNECTION_STATE_MCS_ERECT_DOMAIN
[19:20:49:904] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_ERECT_DOMAIN --> CONNECTION_STATE_MCS_ATTACH_USER
[19:20:49:904] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_ATTACH_USER --> CONNECTION_STATE_MCS_ATTACH_USER_CONFIRM
[19:20:49:915] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_ATTACH_USER_CONFIRM --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:49:916] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:49:927] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:49:927] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:49:938] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:49:938] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:49:950] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:49:950] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:49:962] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:49:962] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:49:973] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:49:973] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:49:984] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:49:984] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:49:996] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:49:996] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:49:007] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:49:007] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:49:019] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:49:019] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:49:030] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_SECURE_SETTINGS_EXCHANGE
[19:20:49:030] [15957:6bdb3000] [DEBUG][com.freerdp.core.info] - [rdp_write_info_packet]: Client Info Packet Flags = INFO_MOUSE|INFO_DISABLECTRLALTDEL|INFO_AUTOLOGON|INFO_UNICODE|INFO_MAXIMIZESHELL|INFO_LOGONNOTIFY|INFO_COMPRESSION|INFO_ENABLEWINDOWSKEY|INFO_FORCE_ENCRYPTED_CS_PDU|INFO_LOGONERRORS|INFO_MOUSE_HAS_WHEEL|INFO_AUDIOCAPTURE
[19:20:49:030] [15957:6bdb3000] [DEBUG][com.winpr.timezone] - [winpr_get_timezone_from_link]: tzid: Europe/Berlin
[19:20:49:030] [15957:6bdb3000] [INFO][com.winpr.timezone] - [winpr_detect_windows_time_zone]: tzid: Europe/Berlin
[19:20:49:031] [15957:6bdb3000] [DEBUG][com.winpr.timezone] - [GetTimeZoneInformation]: tz: Bias=-60 sn='W. Europe Standard Time' dln='W. Europe Daylight Time'
[19:20:49:031] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_SECURE_SETTINGS_EXCHANGE --> CONNECTION_STATE_CONNECT_TIME_AUTO_DETECT_REQUEST
[19:20:49:044] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_CONNECT_TIME_AUTO_DETECT_REQUEST --> CONNECTION_STATE_LICENSING
[19:20:49:044] [15957:6bdb3000] [WARN][com.freerdp.core.license] - [license_read_binary_blob_data]: license binary blob::type BB_ERROR_BLOB, length=0, skipping.
[19:20:49:044] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_LICENSING --> CONNECTION_STATE_MULTITRANSPORT_BOOTSTRAPPING_REQUEST
[19:20:49:127] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MULTITRANSPORT_BOOTSTRAPPING_REQUEST --> CONNECTION_STATE_CAPABILITIES_EXCHANGE_DEMAND_ACTIVE
[19:20:49:127] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_CAPABILITIES_EXCHANGE_DEMAND_ACTIVE --> CONNECTION_STATE_CAPABILITIES_EXCHANGE_CONFIRM_ACTIVE
[19:20:49:127] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_CAPABILITIES_EXCHANGE_CONFIRM_ACTIVE --> CONNECTION_STATE_FINALIZATION_SYNC
[19:20:49:127] [15957:6bdb3000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_SYNC] reset finalize_sc_pdus
[19:20:49:127] [15957:6bdb3000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x1f size=37 channelId=1012)
[19:20:49:127] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_SYNC --> CONNECTION_STATE_FINALIZATION_COOPERATE
[19:20:49:128] [15957:6bdb3000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_COOPERATE] reset finalize_sc_pdus
[19:20:49:128] [15957:6bdb3000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x14 size=41 channelId=1012)
[19:20:49:128] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_COOPERATE --> CONNECTION_STATE_FINALIZATION_REQUEST_CONTROL
[19:20:49:128] [15957:6bdb3000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_REQUEST_CONTROL] reset finalize_sc_pdus
[19:20:49:128] [15957:6bdb3000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x14 size=41 channelId=1012)
[19:20:49:128] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_REQUEST_CONTROL --> CONNECTION_STATE_FINALIZATION_FONT_LIST
[19:20:49:128] [15957:6bdb3000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_FONT_LIST] reset finalize_sc_pdus
[19:20:49:128] [15957:6bdb3000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x27 size=41 channelId=1012)
[19:20:49:128] [15957:6bdb3000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_FONT_LIST --> CONNECTION_STATE_FINALIZATION_CLIENT_SYNC
[19:20:49:128] [15957:6bdb3000] [INFO][com.freerdp.gdi] - [gdi_init_ex]: Local framebuffer format PIXEL_FORMAT_BGRX32
[19:20:49:128] [15957:6bdb3000] [INFO][com.freerdp.gdi] - [gdi_init_ex]: Remote framebuffer format PIXEL_FORMAT_BGRA32
[19:20:49:129] [15957:6c817000] [INFO][com.freerdp.channels.rdpdr.client] - [devman_load_device_service]: Loading device service drive [ppk] (static)
[19:20:49:130] [15957:6bdb3000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (rdpdr)
[19:20:49:145] [15957:6bdb3000] [INFO][com.freerdp.channels.rdpsnd.client] - [rdpsnd_load_device_plugin]: [static] Loaded mac backend for rdpsnd
[19:20:49:145] [15957:6bdb3000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (rdpsnd)
[19:20:49:145] [15957:6bdb3000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (RDMJump)
[19:20:49:145] [15957:6bdb3000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (RDMCmd)
[19:20:49:145] [15957:6bdb3000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (RDMLog)
[19:20:49:145] [15957:6bdb3000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (cliprdr)
[19:20:49:159] [15957:6bdb3000] [DEBUG][com.winpr.clipboard] - [ClipboardInitLocalFileSubsystem]: initialized synthetic local file subsystem
[19:20:49:161] [15957:6bdb3000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel audin
[19:20:49:161] [15957:6bdb3000] [DEBUG][com.freerdp.channels.audin.client] - [audin_register_device_plugin]: device registered.
[19:20:49:185] [15957:6bdb3000] [INFO][com.freerdp.channels.audin.client] - [audin_load_device_plugin]: Loaded mac backend for audin
[19:20:49:185] [15957:6bdb3000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 1
[19:20:49:185] [15957:6bdb3000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel ainput
[19:20:49:185] [15957:6bdb3000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 2
[19:20:49:185] [15957:6bdb3000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel rdpsnd
[19:20:49:185] [15957:6bdb3000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 3
[19:20:49:185] [15957:6bdb3000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel rdpgfx
[19:20:49:186] [15957:6bdb3000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 4
[19:20:49:186] [15957:6bdb3000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 1.AUDIO_INPUT.
[19:20:49:186] [15957:6bdb3000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 2.FreeRDP::Advanced::Input.
[19:20:49:186] [15957:6bdb3000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 3.AUDIO_PLAYBACK_DVC.
[19:20:49:186] [15957:6bdb3000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 4.Microsoft::Windows::RDS::Graphics.
[19:20:49:186] [15957:6bdb3000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (drdynvc)
[19:20:49:193] [15957:6ce5f000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Synchronize Data PDU (0x1F), length: 22
[19:20:49:193] [15957:6ce5f000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_SYNC] received flag FINALIZE_SC_SYNCHRONIZE_PDU [0x00000001]
[19:20:49:193] [15957:6ce5f000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_SYNC --> CONNECTION_STATE_FINALIZATION_CLIENT_COOPERATE
[19:20:49:193] [15957:6ce5f000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Control Data PDU (0x14), length: 26
[19:20:49:193] [15957:6ce5f000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_COOPERATE] received flag FINALIZE_SC_CONTROL_COOPERATE_PDU [0x00000002]
[19:20:49:193] [15957:6ce5f000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_COOPERATE --> CONNECTION_STATE_FINALIZATION_CLIENT_GRANTED_CONTROL
[19:20:49:193] [15957:6ce5f000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Control Data PDU (0x14), length: 26
[19:20:49:193] [15957:6ce5f000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_GRANTED_CONTROL] received flag FINALIZE_SC_CONTROL_GRANTED_PDU [0x00000004]
[19:20:49:193] [15957:6ce5f000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_GRANTED_CONTROL --> CONNECTION_STATE_FINALIZATION_CLIENT_FONT_MAP
[19:20:49:193] [15957:6ce5f000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Font Map Data PDU (0x28), length: 26
[19:20:49:193] [15957:6ce5f000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_FONT_MAP] received flag FINALIZE_SC_FONT_MAP_PDU [0x00000008]
[19:20:49:193] [15957:6ce5f000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_FONT_MAP --> CONNECTION_STATE_ACTIVE
[19:20:49:193] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=3 ChannelName=Microsoft::Windows::RDS::Telemetry
[19:20:49:193] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Telemetry'
[19:20:49:194] [15957:6ce5f000] [DEBUG][com.freerdp.core.heartbeat] - [rdp_recv_heartbeat_packet]: received Heartbeat PDU -> period=1, count1=8, count2=8
[19:20:49:194] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=7 ChannelName=Microsoft::Windows::RDS::Graphics
[19:20:49:194] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_channel]: listener Microsoft::Windows::RDS::Graphics created new channel 7
[19:20:49:194] [15957:6cc53000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (Microsoft::Windows::RDS::Graphics)
[19:20:49:197] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: channel created
[19:20:49:197] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_open_channel]: open_channel: ChannelId 7
[19:20:49:209] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=9 ChannelName=Microsoft::Windows::RDS::Video::Control::v08.01
[19:20:49:209] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Video::Control::v08.01'
[19:20:49:209] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=10 ChannelName=Microsoft::Windows::RDS::Video::Data::v08.01
[19:20:49:209] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Video::Data::v08.01'
[19:20:49:209] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=11 ChannelName=Microsoft::Windows::RDS::Geometry::v08.01
[19:20:49:209] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Geometry::v08.01'
[19:20:50:589] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=18 ChannelName=AUDIO_PLAYBACK_DVC
[19:20:50:590] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_channel]: listener AUDIO_PLAYBACK_DVC created new channel 18
[19:20:50:590] [15957:6cc53000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (AUDIO_PLAYBACK_DVC)
[19:20:50:590] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: channel created
[19:20:50:590] [15957:6cc53000] [INFO][com.freerdp.channels.rdpsnd.client] - [rdpsnd_load_device_plugin]: [dynamic] Loaded mac backend for rdpsnd
[19:20:50:590] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_open_channel]: open_channel: ChannelId 18
[19:20:50:602] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=19 ChannelName=AUDIO_PLAYBACK_LOSSY_DVC
[19:20:50:602] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'AUDIO_PLAYBACK_LOSSY_DVC'
[19:20:50:615] [15957:6c817000] [DEBUG][com.freerdp.channels.rdpdr.client] - [rdpdr_process_server_announce_request]: [rdpdr] server announces version 1.13, client uses 1.13
[19:20:50:616] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=19 ChannelName=RDCamera_Device_Enumerator
[19:20:50:616] [15957:6cc53000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'RDCamera_Device_Enumerator'
[19:20:50:679] [15957:6c817000] [WARN][com.freerdp.channels.rdpdr.client] - [devman_get_device_by_id]: could not find device ID 0xffffffff
[19:20:50:679] [15957:6c817000] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_process_irp]: irp_new failed with 87!
[19:20:50:679] [15957:6c817000] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_process_receive]: rdpdr_process_irp failed with error 87
[19:20:50:679] [15957:6c817000] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_virtual_channel_client_thread]: rdpdr_process_receive failed with error 87!
[19:20:50:679] [15957:6ce5f000] [ERROR][com.freerdp.core] - [checkChannelErrorEvent]: rdpdr_virtual_channel_client_thread reported an error. Error was 87
[19:20:50:679] [15957:6ce5f000] [ERROR][com.freerdp.core] - [freerdp_check_event_handles]: checkChannelErrorEvent() failed - 0
[19:20:50:682] [15957:6ce5f000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_ACTIVE] reset finalize_sc_pdus
[19:20:50:682] [15957:6ce5f000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_ACTIVE --> CONNECTION_STATE_INITIAL
[19:20:50:685] [15957:6cc53000] [DEBUG][Devolutions.Rdp] - [_OnChannelDisconnected]: OnChannelDisconnected (Microsoft::Windows::RDS::Graphics)
[19:20:50:687] [15957:6cc53000] [DEBUG][Devolutions.Rdp] - [_OnChannelDisconnected]: OnChannelDisconnected (AUDIO_PLAYBACK_DVC)
[19:20:51:430] [15958:6ff87000] [INFO][Devolutions.Rdp.Credentials] - [Parse]: parsing "a********", "a*" (Mstsc) => "Username: "a********" Domain: "a*""
[19:20:51:432] [15958:6ff87000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpdr
[19:20:51:432] [15958:6ff87000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpsnd
[19:20:51:432] [15958:6ff87000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMJump
[19:20:51:432] [15958:6ff87000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMCmd
[19:20:51:432] [15958:6ff87000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMLog
[19:20:51:432] [15958:6ff87000] [DEBUG][com.freerdp.channels.channels.cliprdr.client] - [cliprdr_VirtualChannelEntryEx]: VirtualChannelEntryEx
[19:20:51:432] [15958:6ff87000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx cliprdr
[19:20:51:432] [15958:6ff87000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_VirtualChannelEntryEx]: VirtualChannelEntryEx
[19:20:51:432] [15958:6ff87000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx drdynvc
[19:20:51:432] [15958:6ff87000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:51:432] [15958:6ff87000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpdr
[19:20:51:432] [15958:6ff87000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:51:432] [15958:6ff87000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpsnd
[19:20:51:432] [15958:6ff87000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:51:432] [15958:6ff87000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMJump
[19:20:51:432] [15958:6ff87000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:51:432] [15958:6ff87000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMCmd
[19:20:51:432] [15958:6ff87000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:51:432] [15958:6ff87000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMLog
[19:20:51:432] [15958:6ff87000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:51:432] [15958:6ff87000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx cliprdr
[19:20:51:432] [15958:6ff87000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:51:432] [15958:6ff87000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx drdynvc
[19:20:51:432] [15958:6ff87000] [ERROR][com.freerdp.channels.virtual.channel] - [virtchan_virtual_channel_init_event_ex]: Unhandled event type 0
[19:20:51:432] [15958:6ff87000] [ERROR][com.freerdp.channels.virtual.channel] - [virtchan_virtual_channel_init_event_ex]: Unhandled event type 0
[19:20:51:432] [15958:6ff87000] [ERROR][com.freerdp.channels.virtual.channel] - [virtchan_virtual_channel_init_event_ex]: Unhandled event type 0
[19:20:51:632] [15958:6ff87000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: primitives benchmark result:
[19:20:51:784] [15958:6ff87000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: * generic= 96
[19:20:51:935] [15958:6ff87000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: * optimized= 493
[19:20:51:935] [15958:6ff87000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: primitives autodetect, using optimized
[19:20:51:937] [15958:6ff87000] [DEBUG][com.freerdp.core.nego] - [nego_set_negotiation_enabled]: Enabling security layer negotiation: TRUE
[19:20:51:937] [15958:6ff87000] [DEBUG][com.freerdp.core.nego] - [nego_set_restricted_admin_mode_required]: Enabling restricted admin mode: FALSE
[19:20:51:937] [15958:6ff87000] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdp]: Enabling RDP security: TRUE
[19:20:51:937] [15958:6ff87000] [DEBUG][com.freerdp.core.nego] - [nego_enable_tls]: Enabling TLS security: TRUE
[19:20:51:937] [15958:6ff87000] [DEBUG][com.freerdp.core.nego] - [nego_enable_nla]: Enabling NLA security: TRUE
[19:20:51:937] [15958:6ff87000] [DEBUG][com.freerdp.core.nego] - [nego_enable_ext]: Enabling NLA extended security: FALSE
[19:20:51:937] [15958:6ff87000] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdstls]: Enabling RDSTLS security: FALSE
[19:20:51:937] [15958:6ff87000] [DEBUG][com.freerdp.core.nego] - [nego_enable_aad]: Enabling RDS AAD security: FALSE
[19:20:51:937] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_INITIAL --> CONNECTION_STATE_NEGO
[19:20:51:937] [15958:6ff87000] [DEBUG][com.freerdp.core.nego] - [nego_connect]: state: NEGO_STATE_NLA
[19:20:51:937] [15958:6ff87000] [DEBUG][com.freerdp.core.nego] - [nego_attempt_nla]: Attempting NLA security
[19:20:51:939] [15958:6ff87000] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: connecting to peer 192.168.10.38
[19:20:51:951] [15958:6ff87000] [DEBUG][com.freerdp.core.nego] - [nego_send_negotiation_request]: RequestedProtocols: 3
[19:20:51:966] [15958:6ff87000] [DEBUG][com.freerdp.core.nego] - [nego_process_negotiation_response]: RDP_NEG_RSP::flags = { [0x1f] |EXTENDED_CLIENT_DATA_SUPPORTED|DYNVC_GFX_PROTOCOL_SUPPORTED|RDP_NEGRSP_RESERVED|RESTRICTED_ADMIN_MODE_SUPPORTED|REDIRECTED_AUTHENTICATION_MODE_SUPPORTED }
[19:20:51:966] [15958:6ff87000] [DEBUG][com.freerdp.core.nego] - [nego_recv]: selected_protocol: 2
[19:20:51:966] [15958:6ff87000] [DEBUG][com.freerdp.core.nego] - [nego_attempt_nla]: state: NEGO_STATE_FINAL
[19:20:51:966] [15958:6ff87000] [DEBUG][com.freerdp.core.nego] - [nego_connect]: Negotiated NLA security
[19:20:51:966] [15958:6ff87000] [DEBUG][com.freerdp.core.nego] - [nego_try_connect]: nego_security_connect with PROTOCOL_HYBRID
[19:20:51:996] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_INITIAL --> NLA_STATE_INITIAL
[19:20:51:996] [15958:6ff87000] [DEBUG][com.winpr.sspi] - [InitSecurityInterfaceExA]: InitSecurityInterfaceExA
[19:20:51:996] [15958:6ff87000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_init]: Using package: Negotiate (cbMaxToken: 12256 bytes)
[19:20:51:996] [15958:6ff87000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_setup_client]: Acquired client credentials
[19:20:51:996] [15958:6ff87000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_INITIAL to NTLM_STATE_INITIAL
[19:20:51:996] [15958:6ff87000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_INITIAL to NTLM_STATE_NEGOTIATE
[19:20:51:996] [15958:6ff87000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_write_negotiate_flags]: Write flags [0xe20882b7] NTLMSSP_NEGOTIATE_UNICODE|NTLMSSP_NEGOTIATE_OEM|NTLMSSP_REQUEST_TARGET|NTLMSSP_NEGOTIATE_SIGN|NTLMSSP_NEGOTIATE_SEAL|NTLMSSP_NEGOTIATE_LM_KEY|NTLMSSP_NEGOTIATE_NTLM|NTLMSSP_NEGOTIATE_ALWAYS_SIGN|NTLMSSP_NEGOTIATE_EXTENDED_SESSION_SECURITY|NTLMSSP_NEGOTIATE_VERSION|NTLMSSP_NEGOTIATE_128|NTLMSSP_NEGOTIATE_KEY_EXCH
[19:20:51:996] [15958:6ff87000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_NEGOTIATE to NTLM_STATE_CHALLENGE
[19:20:51:996] [15958:6ff87000] [DEBUG][com.winpr.negotiate] - [negotiate_InitializeSecurityContextW]: Available mechanism: NTLM (1.3.6.1.4.1.311.2.2.10)
[19:20:51:996] [15958:6ff87000] [DEBUG][com.winpr.negotiate] - [negotiate_InitializeSecurityContextW]: Using direct NTLM
[19:20:51:996] [15958:6ff87000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_authenticate]: Authentication in progress... (output token size: 40)
[19:20:51:996] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> sending...
[19:20:51:996] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> protocol version 6
[19:20:51:996] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> negoToken
[19:20:51:996] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> client nonce
[19:20:51:996] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_send]: [93 bytes]
[19:20:51:996] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_INITIAL --> NLA_STATE_NEGO_TOKEN
[19:20:51:996] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_NEGO --> CONNECTION_STATE_NLA
[19:20:51:008] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- receiving...
[19:20:51:008] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- protocol version 6
[19:20:51:008] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- nego token
[19:20:51:008] [15958:6ff87000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_read_negotiate_flags]: Read flags [0xe2898235] NTLMSSP_NEGOTIATE_UNICODE|NTLMSSP_REQUEST_TARGET|NTLMSSP_NEGOTIATE_SIGN|NTLMSSP_NEGOTIATE_SEAL|NTLMSSP_NEGOTIATE_NTLM|NTLMSSP_NEGOTIATE_ALWAYS_SIGN|NTLMSSP_TARGET_TYPE_DOMAIN|NTLMSSP_NEGOTIATE_EXTENDED_SESSION_SECURITY|NTLMSSP_NEGOTIATE_TARGET_INFO|NTLMSSP_NEGOTIATE_VERSION|NTLMSSP_NEGOTIATE_128|NTLMSSP_NEGOTIATE_KEY_EXCH
[19:20:51:009] [15958:6ff87000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_CHALLENGE to NTLM_STATE_AUTHENTICATE
[19:20:51:009] [15958:6ff87000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_write_negotiate_flags]: Write flags [0xe288b235] NTLMSSP_NEGOTIATE_UNICODE|NTLMSSP_REQUEST_TARGET|NTLMSSP_NEGOTIATE_SIGN|NTLMSSP_NEGOTIATE_SEAL|NTLMSSP_NEGOTIATE_NTLM|NTLMSSP_NEGOTIATE_DOMAIN_SUPPLIED|NTLMSSP_NEGOTIATE_WORKSTATION_SUPPLIED|NTLMSSP_NEGOTIATE_ALWAYS_SIGN|NTLMSSP_NEGOTIATE_EXTENDED_SESSION_SECURITY|NTLMSSP_NEGOTIATE_TARGET_INFO|NTLMSSP_NEGOTIATE_VERSION|NTLMSSP_NEGOTIATE_128|NTLMSSP_NEGOTIATE_KEY_EXCH
[19:20:51:009] [15958:6ff87000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_AUTHENTICATE to NTLM_STATE_FINAL
[19:20:51:009] [15958:6ff87000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_authenticate]: Authentication complete (output token size: 532 bytes)
[19:20:51:009] [15958:6ff87000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_authenticate]: Context sizes: cbMaxSignature=16, cbSecurityTrailer=16
[19:20:51:009] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> sending...
[19:20:51:009] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> protocol version 6
[19:20:51:009] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> negoToken
[19:20:51:009] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> public key auth
[19:20:51:009] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> client nonce
[19:20:51:009] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_send]: [649 bytes]
[19:20:51:009] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_NEGO_TOKEN --> NLA_STATE_PUB_KEY_AUTH
[19:20:51:022] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- receiving...
[19:20:51:022] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- protocol version 6
[19:20:51:022] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- public key auth
[19:20:51:022] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> sending...
[19:20:51:022] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> protocol version 6
[19:20:51:022] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> auth info
[19:20:51:022] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> client nonce
[19:20:51:022] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_send]: [135 bytes]
[19:20:51:022] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_PUB_KEY_AUTH --> NLA_STATE_AUTH_INFO
[19:20:51:022] [15958:6ff87000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_AUTH_INFO --> NLA_STATE_FINAL
[19:20:51:022] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_NLA --> CONNECTION_STATE_MCS_CREATE_REQUEST
[19:20:51:022] [15958:6ff87000] [DEBUG][com.freerdp.core.gcc] - [gcc_write_client_core_data]: Sending highColorDepth=0x0018, supportedColorDepths=0x000f, earlyCapabilityFlags=RNS_UD_CS_WANT_32BPP_SESSION|RNS_UD_CS_VALID_CONNECTION_TYPE|RNS_UD_CS_SUPPORT_DYNVC_GFX_PROTOCOL|RNS_UD_CS_SUPPORT_HEARTBEAT_PDU|RNS_UD_CS_SUPPORT_SKIP_CHANNELJOIN|[0x00000d22]
[19:20:51:022] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CREATE_REQUEST --> CONNECTION_STATE_MCS_CREATE_RESPONSE
[19:20:51:035] [15958:6ff87000] [DEBUG][com.freerdp.core.gcc] - [gcc_read_server_core_data]: Received EarlyCapabilityFlags=RNS_UD_CS_SUPPORT_STATUSINFO_PDU|[0x00000004]
[19:20:51:035] [15958:6ff87000] [DEBUG][com.freerdp.core.gcc] - [gcc_read_server_security_data]: Server rdp encryption method: NONE
[19:20:51:035] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CREATE_RESPONSE --> CONNECTION_STATE_MCS_ERECT_DOMAIN
[19:20:51:035] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_ERECT_DOMAIN --> CONNECTION_STATE_MCS_ATTACH_USER
[19:20:51:035] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_ATTACH_USER --> CONNECTION_STATE_MCS_ATTACH_USER_CONFIRM
[19:20:51:047] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_ATTACH_USER_CONFIRM --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:51:047] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:51:058] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:51:058] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:51:069] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:51:069] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:51:081] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:51:081] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:51:092] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:51:092] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:51:103] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:51:103] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:51:114] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:51:114] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:51:126] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:51:126] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:51:137] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:51:137] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:51:149] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:51:149] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:51:160] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_SECURE_SETTINGS_EXCHANGE
[19:20:51:160] [15958:6ff87000] [DEBUG][com.freerdp.core.info] - [rdp_write_info_packet]: Client Info Packet Flags = INFO_MOUSE|INFO_DISABLECTRLALTDEL|INFO_AUTOLOGON|INFO_UNICODE|INFO_MAXIMIZESHELL|INFO_LOGONNOTIFY|INFO_COMPRESSION|INFO_ENABLEWINDOWSKEY|INFO_FORCE_ENCRYPTED_CS_PDU|INFO_LOGONERRORS|INFO_MOUSE_HAS_WHEEL|INFO_AUDIOCAPTURE
[19:20:51:161] [15958:6ff87000] [DEBUG][com.winpr.timezone] - [winpr_get_timezone_from_link]: tzid: Europe/Berlin
[19:20:51:161] [15958:6ff87000] [INFO][com.winpr.timezone] - [winpr_detect_windows_time_zone]: tzid: Europe/Berlin
[19:20:51:161] [15958:6ff87000] [DEBUG][com.winpr.timezone] - [GetTimeZoneInformation]: tz: Bias=-60 sn='W. Europe Standard Time' dln='W. Europe Daylight Time'
[19:20:51:161] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_SECURE_SETTINGS_EXCHANGE --> CONNECTION_STATE_CONNECT_TIME_AUTO_DETECT_REQUEST
[19:20:51:174] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_CONNECT_TIME_AUTO_DETECT_REQUEST --> CONNECTION_STATE_LICENSING
[19:20:51:174] [15958:6ff87000] [WARN][com.freerdp.core.license] - [license_read_binary_blob_data]: license binary blob::type BB_ERROR_BLOB, length=0, skipping.
[19:20:51:174] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_LICENSING --> CONNECTION_STATE_MULTITRANSPORT_BOOTSTRAPPING_REQUEST
[19:20:51:260] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MULTITRANSPORT_BOOTSTRAPPING_REQUEST --> CONNECTION_STATE_CAPABILITIES_EXCHANGE_DEMAND_ACTIVE
[19:20:51:260] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_CAPABILITIES_EXCHANGE_DEMAND_ACTIVE --> CONNECTION_STATE_CAPABILITIES_EXCHANGE_CONFIRM_ACTIVE
[19:20:51:260] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_CAPABILITIES_EXCHANGE_CONFIRM_ACTIVE --> CONNECTION_STATE_FINALIZATION_SYNC
[19:20:51:260] [15958:6ff87000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_SYNC] reset finalize_sc_pdus
[19:20:51:260] [15958:6ff87000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x1f size=37 channelId=1012)
[19:20:51:260] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_SYNC --> CONNECTION_STATE_FINALIZATION_COOPERATE
[19:20:51:260] [15958:6ff87000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_COOPERATE] reset finalize_sc_pdus
[19:20:51:260] [15958:6ff87000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x14 size=41 channelId=1012)
[19:20:51:260] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_COOPERATE --> CONNECTION_STATE_FINALIZATION_REQUEST_CONTROL
[19:20:51:260] [15958:6ff87000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_REQUEST_CONTROL] reset finalize_sc_pdus
[19:20:51:261] [15958:6ff87000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x14 size=41 channelId=1012)
[19:20:51:261] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_REQUEST_CONTROL --> CONNECTION_STATE_FINALIZATION_FONT_LIST
[19:20:51:261] [15958:6ff87000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_FONT_LIST] reset finalize_sc_pdus
[19:20:51:261] [15958:6ff87000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x27 size=41 channelId=1012)
[19:20:51:261] [15958:6ff87000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_FONT_LIST --> CONNECTION_STATE_FINALIZATION_CLIENT_SYNC
[19:20:51:261] [15958:6ff87000] [INFO][com.freerdp.gdi] - [gdi_init_ex]: Local framebuffer format PIXEL_FORMAT_BGRX32
[19:20:51:261] [15958:6ff87000] [INFO][com.freerdp.gdi] - [gdi_init_ex]: Remote framebuffer format PIXEL_FORMAT_BGRA32
[19:20:51:261] [15958:709eb000] [INFO][com.freerdp.channels.rdpdr.client] - [devman_load_device_service]: Loading device service drive [ppk] (static)
[19:20:51:263] [15958:6ff87000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (rdpdr)
[19:20:52:279] [15958:6ff87000] [INFO][com.freerdp.channels.rdpsnd.client] - [rdpsnd_load_device_plugin]: [static] Loaded mac backend for rdpsnd
[19:20:52:279] [15958:6ff87000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (rdpsnd)
[19:20:52:279] [15958:6ff87000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (RDMJump)
[19:20:52:279] [15958:6ff87000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (RDMCmd)
[19:20:52:279] [15958:6ff87000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (RDMLog)
[19:20:52:279] [15958:6ff87000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (cliprdr)
[19:20:52:293] [15958:6ff87000] [DEBUG][com.winpr.clipboard] - [ClipboardInitLocalFileSubsystem]: initialized synthetic local file subsystem
[19:20:52:295] [15958:6ff87000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel audin
[19:20:52:295] [15958:6ff87000] [DEBUG][com.freerdp.channels.audin.client] - [audin_register_device_plugin]: device registered.
[19:20:52:318] [15958:6ff87000] [INFO][com.freerdp.channels.audin.client] - [audin_load_device_plugin]: Loaded mac backend for audin
[19:20:52:318] [15958:6ff87000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 1
[19:20:52:318] [15958:6ff87000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel ainput
[19:20:52:318] [15958:6ff87000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 2
[19:20:52:318] [15958:6ff87000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel rdpsnd
[19:20:52:318] [15958:6ff87000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 3
[19:20:52:318] [15958:6ff87000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel rdpgfx
[19:20:52:318] [15958:6ff87000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 4
[19:20:52:318] [15958:6ff87000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 1.AUDIO_INPUT.
[19:20:52:318] [15958:6ff87000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 2.FreeRDP::Advanced::Input.
[19:20:52:318] [15958:6ff87000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 3.AUDIO_PLAYBACK_DVC.
[19:20:52:318] [15958:6ff87000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 4.Microsoft::Windows::RDS::Graphics.
[19:20:52:318] [15958:6ff87000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (drdynvc)
[19:20:52:325] [15958:71033000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Synchronize Data PDU (0x1F), length: 22
[19:20:52:325] [15958:71033000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_SYNC] received flag FINALIZE_SC_SYNCHRONIZE_PDU [0x00000001]
[19:20:52:325] [15958:71033000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_SYNC --> CONNECTION_STATE_FINALIZATION_CLIENT_COOPERATE
[19:20:52:325] [15958:71033000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Control Data PDU (0x14), length: 26
[19:20:52:325] [15958:71033000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_COOPERATE] received flag FINALIZE_SC_CONTROL_COOPERATE_PDU [0x00000002]
[19:20:52:325] [15958:71033000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_COOPERATE --> CONNECTION_STATE_FINALIZATION_CLIENT_GRANTED_CONTROL
[19:20:52:325] [15958:71033000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Control Data PDU (0x14), length: 26
[19:20:52:325] [15958:71033000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_GRANTED_CONTROL] received flag FINALIZE_SC_CONTROL_GRANTED_PDU [0x00000004]
[19:20:52:325] [15958:71033000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_GRANTED_CONTROL --> CONNECTION_STATE_FINALIZATION_CLIENT_FONT_MAP
[19:20:52:325] [15958:71033000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Font Map Data PDU (0x28), length: 26
[19:20:52:325] [15958:71033000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_FONT_MAP] received flag FINALIZE_SC_FONT_MAP_PDU [0x00000008]
[19:20:52:325] [15958:71033000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_FONT_MAP --> CONNECTION_STATE_ACTIVE
[19:20:52:325] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=3 ChannelName=Microsoft::Windows::RDS::Telemetry
[19:20:52:325] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Telemetry'
[19:20:52:326] [15958:71033000] [DEBUG][com.freerdp.core.heartbeat] - [rdp_recv_heartbeat_packet]: received Heartbeat PDU -> period=1, count1=8, count2=8
[19:20:52:326] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=7 ChannelName=Microsoft::Windows::RDS::Graphics
[19:20:52:326] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_channel]: listener Microsoft::Windows::RDS::Graphics created new channel 7
[19:20:52:326] [15958:70e27000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (Microsoft::Windows::RDS::Graphics)
[19:20:52:328] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: channel created
[19:20:52:328] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_open_channel]: open_channel: ChannelId 7
[19:20:52:340] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=9 ChannelName=Microsoft::Windows::RDS::Video::Control::v08.01
[19:20:52:340] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Video::Control::v08.01'
[19:20:52:340] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=10 ChannelName=Microsoft::Windows::RDS::Video::Data::v08.01
[19:20:52:340] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Video::Data::v08.01'
[19:20:52:340] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=11 ChannelName=Microsoft::Windows::RDS::Geometry::v08.01
[19:20:52:340] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Geometry::v08.01'
[19:20:52:724] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=18 ChannelName=AUDIO_PLAYBACK_DVC
[19:20:52:724] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_channel]: listener AUDIO_PLAYBACK_DVC created new channel 18
[19:20:52:724] [15958:70e27000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (AUDIO_PLAYBACK_DVC)
[19:20:52:724] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: channel created
[19:20:52:724] [15958:70e27000] [INFO][com.freerdp.channels.rdpsnd.client] - [rdpsnd_load_device_plugin]: [dynamic] Loaded mac backend for rdpsnd
[19:20:52:724] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_open_channel]: open_channel: ChannelId 18
[19:20:52:736] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=19 ChannelName=AUDIO_PLAYBACK_LOSSY_DVC
[19:20:52:736] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'AUDIO_PLAYBACK_LOSSY_DVC'
[19:20:52:748] [15958:709eb000] [DEBUG][com.freerdp.channels.rdpdr.client] - [rdpdr_process_server_announce_request]: [rdpdr] server announces version 1.13, client uses 1.13
[19:20:52:749] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=19 ChannelName=RDCamera_Device_Enumerator
[19:20:52:749] [15958:70e27000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'RDCamera_Device_Enumerator'
[19:20:52:820] [15958:709eb000] [WARN][com.freerdp.channels.rdpdr.client] - [devman_get_device_by_id]: could not find device ID 0xffffffff
[19:20:52:820] [15958:709eb000] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_process_irp]: irp_new failed with 87!
[19:20:52:820] [15958:709eb000] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_process_receive]: rdpdr_process_irp failed with error 87
[19:20:52:820] [15958:709eb000] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_virtual_channel_client_thread]: rdpdr_process_receive failed with error 87!
[19:20:52:820] [15958:71033000] [ERROR][com.freerdp.core] - [checkChannelErrorEvent]: rdpdr_virtual_channel_client_thread reported an error. Error was 87
[19:20:52:820] [15958:71033000] [ERROR][com.freerdp.core] - [freerdp_check_event_handles]: checkChannelErrorEvent() failed - 0
[19:20:52:822] [15958:71033000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_ACTIVE] reset finalize_sc_pdus
[19:20:52:822] [15958:71033000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_ACTIVE --> CONNECTION_STATE_INITIAL
[19:20:52:823] [15958:70e27000] [DEBUG][Devolutions.Rdp] - [_OnChannelDisconnected]: OnChannelDisconnected (Microsoft::Windows::RDS::Graphics)
[19:20:52:824] [15958:70e27000] [DEBUG][Devolutions.Rdp] - [_OnChannelDisconnected]: OnChannelDisconnected (AUDIO_PLAYBACK_DVC)
[19:20:53:553] [15960:6f657000] [INFO][Devolutions.Rdp.Credentials] - [Parse]: parsing "a********", "a*" (Mstsc) => "Username: "a********" Domain: "a*""
[19:20:53:555] [15960:6f657000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpdr
[19:20:53:555] [15960:6f657000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpsnd
[19:20:53:555] [15960:6f657000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMJump
[19:20:53:555] [15960:6f657000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMCmd
[19:20:53:555] [15960:6f657000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMLog
[19:20:53:556] [15960:6f657000] [DEBUG][com.freerdp.channels.channels.cliprdr.client] - [cliprdr_VirtualChannelEntryEx]: VirtualChannelEntryEx
[19:20:53:556] [15960:6f657000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx cliprdr
[19:20:53:556] [15960:6f657000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_VirtualChannelEntryEx]: VirtualChannelEntryEx
[19:20:53:556] [15960:6f657000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx drdynvc
[19:20:53:556] [15960:6f657000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:53:556] [15960:6f657000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpdr
[19:20:53:556] [15960:6f657000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:53:556] [15960:6f657000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpsnd
[19:20:53:556] [15960:6f657000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:53:556] [15960:6f657000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMJump
[19:20:53:556] [15960:6f657000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:53:556] [15960:6f657000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMCmd
[19:20:53:556] [15960:6f657000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:53:556] [15960:6f657000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx RDMLog
[19:20:53:556] [15960:6f657000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:53:556] [15960:6f657000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx cliprdr
[19:20:53:556] [15960:6f657000] [WARN][com.freerdp.core.client] - [freerdp_channels_client_load_ex]: Skipping, channel already loaded
[19:20:53:556] [15960:6f657000] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx drdynvc
[19:20:53:556] [15960:6f657000] [ERROR][com.freerdp.channels.virtual.channel] - [virtchan_virtual_channel_init_event_ex]: Unhandled event type 0
[19:20:53:556] [15960:6f657000] [ERROR][com.freerdp.channels.virtual.channel] - [virtchan_virtual_channel_init_event_ex]: Unhandled event type 0
[19:20:53:556] [15960:6f657000] [ERROR][com.freerdp.channels.virtual.channel] - [virtchan_virtual_channel_init_event_ex]: Unhandled event type 0
[19:20:53:756] [15960:6f657000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: primitives benchmark result:
[19:20:53:908] [15960:6f657000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: * generic= 96
[19:20:53:059] [15960:6f657000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: * optimized= 470
[19:20:53:059] [15960:6f657000] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: primitives autodetect, using optimized
[19:20:53:061] [15960:6f657000] [DEBUG][com.freerdp.core.nego] - [nego_set_negotiation_enabled]: Enabling security layer negotiation: TRUE
[19:20:53:061] [15960:6f657000] [DEBUG][com.freerdp.core.nego] - [nego_set_restricted_admin_mode_required]: Enabling restricted admin mode: FALSE
[19:20:53:061] [15960:6f657000] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdp]: Enabling RDP security: TRUE
[19:20:53:061] [15960:6f657000] [DEBUG][com.freerdp.core.nego] - [nego_enable_tls]: Enabling TLS security: TRUE
[19:20:53:061] [15960:6f657000] [DEBUG][com.freerdp.core.nego] - [nego_enable_nla]: Enabling NLA security: TRUE
[19:20:53:061] [15960:6f657000] [DEBUG][com.freerdp.core.nego] - [nego_enable_ext]: Enabling NLA extended security: FALSE
[19:20:53:061] [15960:6f657000] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdstls]: Enabling RDSTLS security: FALSE
[19:20:53:061] [15960:6f657000] [DEBUG][com.freerdp.core.nego] - [nego_enable_aad]: Enabling RDS AAD security: FALSE
[19:20:53:061] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_INITIAL --> CONNECTION_STATE_NEGO
[19:20:53:061] [15960:6f657000] [DEBUG][com.freerdp.core.nego] - [nego_connect]: state: NEGO_STATE_NLA
[19:20:53:061] [15960:6f657000] [DEBUG][com.freerdp.core.nego] - [nego_attempt_nla]: Attempting NLA security
[19:20:53:063] [15960:6f657000] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: connecting to peer 192.168.10.38
[19:20:53:075] [15960:6f657000] [DEBUG][com.freerdp.core.nego] - [nego_send_negotiation_request]: RequestedProtocols: 3
[19:20:53:089] [15960:6f657000] [DEBUG][com.freerdp.core.nego] - [nego_process_negotiation_response]: RDP_NEG_RSP::flags = { [0x1f] |EXTENDED_CLIENT_DATA_SUPPORTED|DYNVC_GFX_PROTOCOL_SUPPORTED|RDP_NEGRSP_RESERVED|RESTRICTED_ADMIN_MODE_SUPPORTED|REDIRECTED_AUTHENTICATION_MODE_SUPPORTED }
[19:20:53:089] [15960:6f657000] [DEBUG][com.freerdp.core.nego] - [nego_recv]: selected_protocol: 2
[19:20:53:089] [15960:6f657000] [DEBUG][com.freerdp.core.nego] - [nego_attempt_nla]: state: NEGO_STATE_FINAL
[19:20:53:089] [15960:6f657000] [DEBUG][com.freerdp.core.nego] - [nego_connect]: Negotiated NLA security
[19:20:53:089] [15960:6f657000] [DEBUG][com.freerdp.core.nego] - [nego_try_connect]: nego_security_connect with PROTOCOL_HYBRID
[19:20:53:119] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_INITIAL --> NLA_STATE_INITIAL
[19:20:53:119] [15960:6f657000] [DEBUG][com.winpr.sspi] - [InitSecurityInterfaceExA]: InitSecurityInterfaceExA
[19:20:53:119] [15960:6f657000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_init]: Using package: Negotiate (cbMaxToken: 12256 bytes)
[19:20:53:119] [15960:6f657000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_setup_client]: Acquired client credentials
[19:20:53:119] [15960:6f657000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_INITIAL to NTLM_STATE_INITIAL
[19:20:53:119] [15960:6f657000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_INITIAL to NTLM_STATE_NEGOTIATE
[19:20:53:119] [15960:6f657000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_write_negotiate_flags]: Write flags [0xe20882b7] NTLMSSP_NEGOTIATE_UNICODE|NTLMSSP_NEGOTIATE_OEM|NTLMSSP_REQUEST_TARGET|NTLMSSP_NEGOTIATE_SIGN|NTLMSSP_NEGOTIATE_SEAL|NTLMSSP_NEGOTIATE_LM_KEY|NTLMSSP_NEGOTIATE_NTLM|NTLMSSP_NEGOTIATE_ALWAYS_SIGN|NTLMSSP_NEGOTIATE_EXTENDED_SESSION_SECURITY|NTLMSSP_NEGOTIATE_VERSION|NTLMSSP_NEGOTIATE_128|NTLMSSP_NEGOTIATE_KEY_EXCH
[19:20:53:119] [15960:6f657000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_NEGOTIATE to NTLM_STATE_CHALLENGE
[19:20:53:119] [15960:6f657000] [DEBUG][com.winpr.negotiate] - [negotiate_InitializeSecurityContextW]: Available mechanism: NTLM (1.3.6.1.4.1.311.2.2.10)
[19:20:53:119] [15960:6f657000] [DEBUG][com.winpr.negotiate] - [negotiate_InitializeSecurityContextW]: Using direct NTLM
[19:20:53:119] [15960:6f657000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_authenticate]: Authentication in progress... (output token size: 40)
[19:20:53:119] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> sending...
[19:20:53:119] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> protocol version 6
[19:20:53:119] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> negoToken
[19:20:53:119] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> client nonce
[19:20:53:119] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_send]: [93 bytes]
[19:20:53:119] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_INITIAL --> NLA_STATE_NEGO_TOKEN
[19:20:53:119] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_NEGO --> CONNECTION_STATE_NLA
[19:20:53:131] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- receiving...
[19:20:53:131] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- protocol version 6
[19:20:53:131] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- nego token
[19:20:53:131] [15960:6f657000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_read_negotiate_flags]: Read flags [0xe2898235] NTLMSSP_NEGOTIATE_UNICODE|NTLMSSP_REQUEST_TARGET|NTLMSSP_NEGOTIATE_SIGN|NTLMSSP_NEGOTIATE_SEAL|NTLMSSP_NEGOTIATE_NTLM|NTLMSSP_NEGOTIATE_ALWAYS_SIGN|NTLMSSP_TARGET_TYPE_DOMAIN|NTLMSSP_NEGOTIATE_EXTENDED_SESSION_SECURITY|NTLMSSP_NEGOTIATE_TARGET_INFO|NTLMSSP_NEGOTIATE_VERSION|NTLMSSP_NEGOTIATE_128|NTLMSSP_NEGOTIATE_KEY_EXCH
[19:20:53:131] [15960:6f657000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_CHALLENGE to NTLM_STATE_AUTHENTICATE
[19:20:53:131] [15960:6f657000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_write_negotiate_flags]: Write flags [0xe288b235] NTLMSSP_NEGOTIATE_UNICODE|NTLMSSP_REQUEST_TARGET|NTLMSSP_NEGOTIATE_SIGN|NTLMSSP_NEGOTIATE_SEAL|NTLMSSP_NEGOTIATE_NTLM|NTLMSSP_NEGOTIATE_DOMAIN_SUPPLIED|NTLMSSP_NEGOTIATE_WORKSTATION_SUPPLIED|NTLMSSP_NEGOTIATE_ALWAYS_SIGN|NTLMSSP_NEGOTIATE_EXTENDED_SESSION_SECURITY|NTLMSSP_NEGOTIATE_TARGET_INFO|NTLMSSP_NEGOTIATE_VERSION|NTLMSSP_NEGOTIATE_128|NTLMSSP_NEGOTIATE_KEY_EXCH
[19:20:53:131] [15960:6f657000] [DEBUG][com.winpr.sspi.NTLM] - [ntlm_change_state]: change state from NTLM_STATE_AUTHENTICATE to NTLM_STATE_FINAL
[19:20:53:131] [15960:6f657000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_authenticate]: Authentication complete (output token size: 532 bytes)
[19:20:53:131] [15960:6f657000] [DEBUG][com.freerdp.core.auth] - [credssp_auth_authenticate]: Context sizes: cbMaxSignature=16, cbSecurityTrailer=16
[19:20:53:131] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> sending...
[19:20:53:131] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> protocol version 6
[19:20:53:131] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> negoToken
[19:20:53:132] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> public key auth
[19:20:53:132] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> client nonce
[19:20:53:132] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_send]: [649 bytes]
[19:20:53:132] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_NEGO_TOKEN --> NLA_STATE_PUB_KEY_AUTH
[19:20:53:146] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- receiving...
[19:20:53:146] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- protocol version 6
[19:20:53:146] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_decode_ts_request]: <<----- public key auth
[19:20:53:146] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> sending...
[19:20:53:146] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_send]: ----->> protocol version 6
[19:20:53:146] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> auth info
[19:20:53:146] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_write_octet_string]: ----->> client nonce
[19:20:53:146] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_send]: [135 bytes]
[19:20:53:146] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_PUB_KEY_AUTH --> NLA_STATE_AUTH_INFO
[19:20:53:146] [15960:6f657000] [DEBUG][com.freerdp.core.nla] - [nla_set_state]: -- NLA_STATE_AUTH_INFO --> NLA_STATE_FINAL
[19:20:53:146] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_NLA --> CONNECTION_STATE_MCS_CREATE_REQUEST
[19:20:53:146] [15960:6f657000] [DEBUG][com.freerdp.core.gcc] - [gcc_write_client_core_data]: Sending highColorDepth=0x0018, supportedColorDepths=0x000f, earlyCapabilityFlags=RNS_UD_CS_WANT_32BPP_SESSION|RNS_UD_CS_VALID_CONNECTION_TYPE|RNS_UD_CS_SUPPORT_DYNVC_GFX_PROTOCOL|RNS_UD_CS_SUPPORT_HEARTBEAT_PDU|RNS_UD_CS_SUPPORT_SKIP_CHANNELJOIN|[0x00000d22]
[19:20:53:146] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CREATE_REQUEST --> CONNECTION_STATE_MCS_CREATE_RESPONSE
[19:20:53:158] [15960:6f657000] [DEBUG][com.freerdp.core.gcc] - [gcc_read_server_core_data]: Received EarlyCapabilityFlags=RNS_UD_CS_SUPPORT_STATUSINFO_PDU|[0x00000004]
[19:20:53:158] [15960:6f657000] [DEBUG][com.freerdp.core.gcc] - [gcc_read_server_security_data]: Server rdp encryption method: NONE
[19:20:53:158] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CREATE_RESPONSE --> CONNECTION_STATE_MCS_ERECT_DOMAIN
[19:20:53:158] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_ERECT_DOMAIN --> CONNECTION_STATE_MCS_ATTACH_USER
[19:20:53:158] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_ATTACH_USER --> CONNECTION_STATE_MCS_ATTACH_USER_CONFIRM
[19:20:53:169] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_ATTACH_USER_CONFIRM --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:53:169] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:53:181] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:53:181] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:53:192] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:53:192] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:53:203] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:53:203] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:53:215] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:53:215] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:53:227] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:53:227] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:53:239] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:53:239] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:53:250] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:53:250] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:53:262] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:53:262] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:54:273] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST
[19:20:54:273] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_REQUEST --> CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE
[19:20:54:285] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MCS_CHANNEL_JOIN_RESPONSE --> CONNECTION_STATE_SECURE_SETTINGS_EXCHANGE
[19:20:54:285] [15960:6f657000] [DEBUG][com.freerdp.core.info] - [rdp_write_info_packet]: Client Info Packet Flags = INFO_MOUSE|INFO_DISABLECTRLALTDEL|INFO_AUTOLOGON|INFO_UNICODE|INFO_MAXIMIZESHELL|INFO_LOGONNOTIFY|INFO_COMPRESSION|INFO_ENABLEWINDOWSKEY|INFO_FORCE_ENCRYPTED_CS_PDU|INFO_LOGONERRORS|INFO_MOUSE_HAS_WHEEL|INFO_AUDIOCAPTURE
[19:20:54:286] [15960:6f657000] [DEBUG][com.winpr.timezone] - [winpr_get_timezone_from_link]: tzid: Europe/Berlin
[19:20:54:286] [15960:6f657000] [INFO][com.winpr.timezone] - [winpr_detect_windows_time_zone]: tzid: Europe/Berlin
[19:20:54:286] [15960:6f657000] [DEBUG][com.winpr.timezone] - [GetTimeZoneInformation]: tz: Bias=-60 sn='W. Europe Standard Time' dln='W. Europe Daylight Time'
[19:20:54:286] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_SECURE_SETTINGS_EXCHANGE --> CONNECTION_STATE_CONNECT_TIME_AUTO_DETECT_REQUEST
[19:20:54:299] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_CONNECT_TIME_AUTO_DETECT_REQUEST --> CONNECTION_STATE_LICENSING
[19:20:54:299] [15960:6f657000] [WARN][com.freerdp.core.license] - [license_read_binary_blob_data]: license binary blob::type BB_ERROR_BLOB, length=0, skipping.
[19:20:54:299] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_LICENSING --> CONNECTION_STATE_MULTITRANSPORT_BOOTSTRAPPING_REQUEST
[19:20:54:375] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_MULTITRANSPORT_BOOTSTRAPPING_REQUEST --> CONNECTION_STATE_CAPABILITIES_EXCHANGE_DEMAND_ACTIVE
[19:20:54:375] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_CAPABILITIES_EXCHANGE_DEMAND_ACTIVE --> CONNECTION_STATE_CAPABILITIES_EXCHANGE_CONFIRM_ACTIVE
[19:20:54:376] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_CAPABILITIES_EXCHANGE_CONFIRM_ACTIVE --> CONNECTION_STATE_FINALIZATION_SYNC
[19:20:54:376] [15960:6f657000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_SYNC] reset finalize_sc_pdus
[19:20:54:376] [15960:6f657000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x1f size=37 channelId=1012)
[19:20:54:376] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_SYNC --> CONNECTION_STATE_FINALIZATION_COOPERATE
[19:20:54:376] [15960:6f657000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_COOPERATE] reset finalize_sc_pdus
[19:20:54:376] [15960:6f657000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x14 size=41 channelId=1012)
[19:20:54:376] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_COOPERATE --> CONNECTION_STATE_FINALIZATION_REQUEST_CONTROL
[19:20:54:376] [15960:6f657000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_REQUEST_CONTROL] reset finalize_sc_pdus
[19:20:54:376] [15960:6f657000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x14 size=41 channelId=1012)
[19:20:54:376] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_REQUEST_CONTROL --> CONNECTION_STATE_FINALIZATION_FONT_LIST
[19:20:54:376] [15960:6f657000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_FINALIZATION_FONT_LIST] reset finalize_sc_pdus
[19:20:54:376] [15960:6f657000] [DEBUG][com.freerdp.core.rdp] - [rdp_send_data_pdu]: sending data (type=0x27 size=41 channelId=1012)
[19:20:54:376] [15960:6f657000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_FONT_LIST --> CONNECTION_STATE_FINALIZATION_CLIENT_SYNC
[19:20:54:376] [15960:6f657000] [INFO][com.freerdp.gdi] - [gdi_init_ex]: Local framebuffer format PIXEL_FORMAT_BGRX32
[19:20:54:376] [15960:6f657000] [INFO][com.freerdp.gdi] - [gdi_init_ex]: Remote framebuffer format PIXEL_FORMAT_BGRA32
[19:20:54:376] [15960:700bb000] [INFO][com.freerdp.channels.rdpdr.client] - [devman_load_device_service]: Loading device service drive [ppk] (static)
[19:20:54:378] [15960:6f657000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (rdpdr)
[19:20:54:394] [15960:6f657000] [INFO][com.freerdp.channels.rdpsnd.client] - [rdpsnd_load_device_plugin]: [static] Loaded mac backend for rdpsnd
[19:20:54:394] [15960:6f657000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (rdpsnd)
[19:20:54:394] [15960:6f657000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (RDMJump)
[19:20:54:394] [15960:6f657000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (RDMCmd)
[19:20:54:394] [15960:6f657000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (RDMLog)
[19:20:54:394] [15960:6f657000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (cliprdr)
[19:20:54:408] [15960:6f657000] [DEBUG][com.winpr.clipboard] - [ClipboardInitLocalFileSubsystem]: initialized synthetic local file subsystem
[19:20:54:410] [15960:6f657000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel audin
[19:20:54:410] [15960:6f657000] [DEBUG][com.freerdp.channels.audin.client] - [audin_register_device_plugin]: device registered.
[19:20:54:432] [15960:6f657000] [INFO][com.freerdp.channels.audin.client] - [audin_load_device_plugin]: Loaded mac backend for audin
[19:20:54:432] [15960:6f657000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 1
[19:20:54:432] [15960:6f657000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel ainput
[19:20:54:432] [15960:6f657000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 2
[19:20:54:432] [15960:6f657000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel rdpsnd
[19:20:54:432] [15960:6f657000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 3
[19:20:54:432] [15960:6f657000] [INFO][com.freerdp.channels.drdynvc.client] - [dvcman_load_addin]: Loading Dynamic Virtual Channel rdpgfx
[19:20:54:433] [15960:6f657000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_register_plugin]: register_plugin: num_plugins 4
[19:20:54:433] [15960:6f657000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 1.AUDIO_INPUT.
[19:20:54:433] [15960:6f657000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 2.FreeRDP::Advanced::Input.
[19:20:54:433] [15960:6f657000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 3.AUDIO_PLAYBACK_DVC.
[19:20:54:433] [15960:6f657000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_listener]: create_listener: 4.Microsoft::Windows::RDS::Graphics.
[19:20:54:433] [15960:6f657000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (drdynvc)
[19:20:54:440] [15960:70703000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Synchronize Data PDU (0x1F), length: 22
[19:20:54:440] [15960:70703000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_SYNC] received flag FINALIZE_SC_SYNCHRONIZE_PDU [0x00000001]
[19:20:54:440] [15960:70703000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_SYNC --> CONNECTION_STATE_FINALIZATION_CLIENT_COOPERATE
[19:20:54:440] [15960:70703000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Control Data PDU (0x14), length: 26
[19:20:54:440] [15960:70703000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_COOPERATE] received flag FINALIZE_SC_CONTROL_COOPERATE_PDU [0x00000002]
[19:20:54:440] [15960:70703000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_COOPERATE --> CONNECTION_STATE_FINALIZATION_CLIENT_GRANTED_CONTROL
[19:20:54:440] [15960:70703000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Control Data PDU (0x14), length: 26
[19:20:54:440] [15960:70703000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_GRANTED_CONTROL] received flag FINALIZE_SC_CONTROL_GRANTED_PDU [0x00000004]
[19:20:54:440] [15960:70703000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_GRANTED_CONTROL --> CONNECTION_STATE_FINALIZATION_CLIENT_FONT_MAP
[19:20:54:440] [15960:70703000] [DEBUG][com.freerdp.core.rdp] - [rdp_recv_data_pdu]: recv Font Map Data PDU (0x28), length: 26
[19:20:54:440] [15960:70703000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_set_flag]: [CONNECTION_STATE_FINALIZATION_CLIENT_FONT_MAP] received flag FINALIZE_SC_FONT_MAP_PDU [0x00000008]
[19:20:54:440] [15960:70703000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_FINALIZATION_CLIENT_FONT_MAP --> CONNECTION_STATE_ACTIVE
[19:20:54:440] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=3 ChannelName=Microsoft::Windows::RDS::Telemetry
[19:20:54:441] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Telemetry'
[19:20:54:441] [15960:70703000] [DEBUG][com.freerdp.core.heartbeat] - [rdp_recv_heartbeat_packet]: received Heartbeat PDU -> period=1, count1=8, count2=8
[19:20:54:441] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=7 ChannelName=Microsoft::Windows::RDS::Graphics
[19:20:54:441] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_channel]: listener Microsoft::Windows::RDS::Graphics created new channel 7
[19:20:54:441] [15960:704f7000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (Microsoft::Windows::RDS::Graphics)
[19:20:54:444] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: channel created
[19:20:54:444] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_open_channel]: open_channel: ChannelId 7
[19:20:54:456] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=9 ChannelName=Microsoft::Windows::RDS::Video::Control::v08.01
[19:20:54:456] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Video::Control::v08.01'
[19:20:54:456] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=10 ChannelName=Microsoft::Windows::RDS::Video::Data::v08.01
[19:20:54:456] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Video::Data::v08.01'
[19:20:54:456] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=11 ChannelName=Microsoft::Windows::RDS::Geometry::v08.01
[19:20:54:456] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'Microsoft::Windows::RDS::Geometry::v08.01'
[19:20:54:811] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=18 ChannelName=AUDIO_PLAYBACK_DVC
[19:20:54:811] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_create_channel]: listener AUDIO_PLAYBACK_DVC created new channel 18
[19:20:54:811] [15960:704f7000] [DEBUG][Devolutions.Rdp] - [_OnChannelConnected]: OnChannelConnected (AUDIO_PLAYBACK_DVC)
[19:20:54:811] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: channel created
[19:20:54:811] [15960:704f7000] [INFO][com.freerdp.channels.rdpsnd.client] - [rdpsnd_load_device_plugin]: [dynamic] Loaded mac backend for rdpsnd
[19:20:54:811] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [dvcman_open_channel]: open_channel: ChannelId 18
[19:20:54:823] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=19 ChannelName=AUDIO_PLAYBACK_LOSSY_DVC
[19:20:54:823] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'AUDIO_PLAYBACK_LOSSY_DVC'
[19:20:54:835] [15960:700bb000] [DEBUG][com.freerdp.channels.rdpdr.client] - [rdpdr_process_server_announce_request]: [rdpdr] server announces version 1.13, client uses 1.13
[19:20:54:836] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: process_create_request: ChannelId=19 ChannelName=RDCamera_Device_Enumerator
[19:20:54:836] [15960:704f7000] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_process_create_request]: no listener for 'RDCamera_Device_Enumerator'
[19:20:54:952] [15960:700bb000] [WARN][com.freerdp.channels.rdpdr.client] - [devman_get_device_by_id]: could not find device ID 0xffffffff
[19:20:54:952] [15960:700bb000] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_process_irp]: irp_new failed with 87!
[19:20:54:952] [15960:700bb000] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_process_receive]: rdpdr_process_irp failed with error 87
[19:20:54:952] [15960:700bb000] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_virtual_channel_client_thread]: rdpdr_process_receive failed with error 87!
[19:20:54:952] [15960:70703000] [ERROR][com.freerdp.core] - [checkChannelErrorEvent]: rdpdr_virtual_channel_client_thread reported an error. Error was 87
[19:20:54:952] [15960:70703000] [ERROR][com.freerdp.core] - [freerdp_check_event_handles]: checkChannelErrorEvent() failed - 0
[19:20:54:954] [15960:70703000] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags]: [CONNECTION_STATE_ACTIVE] reset finalize_sc_pdus
[19:20:54:954] [15960:70703000] [DEBUG][com.freerdp.core.connection] - [rdp_client_transition_to_state]: CONNECTION_STATE_ACTIVE --> CONNECTION_STATE_INITIAL
[19:20:54:958] [15960:704f7000] [DEBUG][Devolutions.Rdp] - [_OnChannelDisconnected]: OnChannelDisconnected (Microsoft::Windows::RDS::Graphics)
[19:20:54:960] [15960:704f7000] [DEBUG][Devolutions.Rdp] - [_OnChannelDisconnected]: OnChannelDisconnected (AUDIO_PLAYBACK_DVC)
Sorry, this is the complete one
Hello
Thank you for the information.
On first glance, it seems that there might be a problem redirecting resources to the remote machine. What options do you have selected in RDP > Local Resources > Local Devices and Resources?
You might try next unchecking everything in that section and see if the connection works. This will be a good point to start troubleshooting.
Let me know if something isn't clear.
Thanks and kind regards,
Richard Markievicz
After i have unchecked everything the issue is the same
Hello
Thanks for the update. By any chance, can you provide an updated session log with all those options unchecked?
I'm still working to reproduce the problem on my side.
Thanks and kind regards,
Richard Markievicz
Hello again
I've done some more digging here; the RDP server is sending an I/O request for a device on your client that isn't properly registered. Previously, this wasn't handled as an error but an update to one of our dependencies has transformed this condition to an error that prevents the connection from proceeding. So I've identified why you can't connect (and to reiterate - it is a regression on our side) but the reason this condition exists is not clear to me.
It appears to me from the earlier log that you are forwarding one drive or directory to the remote machine ("ppk"?). Just to double-check: can you confirm that if you disable "Local Devices and Resources > Hard Drives" and all sub options ("Redirect all disk drives", etc), the connection still does not work?
In that case, an updated session log with those options disabled will be really important to understand what's happening here.
Please let me know if something isn't clear or you have further questions
Kind regards,
Richard Markievicz
Anything is deactivated
4bb6ffbe-5466-4324-9bb9-41b3a9934925.png
Here the session log
eb79894d-e20f-4735-9e99-3fdd9951720c.log
I am able to reconnect to existing sessions but not to create a new one
Hello
Thank you for all the extra information.
I cannot tell why this is happening - I believe it must be something specific to your server environment or configuration. The server is trying to send an IO request to a local device, although you clearly have none forwarded.
I've opened a ticket to make our RDP implementation less strict here (and restore the prior behaviour). I hope to have that fix available in the next release. I'll post back in this thread once that fix is available.
I apologize for the regression and inconvenience, and thank you for your patience.
In the meantime, if you have further questions or problems, please don't hesitate to post back.
Kind regards,
Richard Markievicz
Thanks for your support!
Hi joerg1,
RDM Mac 2023.1.11.0 is now available with a fix for your issue. Please, do tell us if you're still facing issues after the update.
Best regards,
Xavier Fortin
Every thing is working fine since the update. So the issue is fixed in my opinion. Thanks for your brilliant fast support. My Rating : A++
Hi Xavier Fortin, hi Richard Markievicz, hi everyone,
I stumbled upon this topic when debugging an RDP connection issue using XFreeRDP on Linux. I know this is not the correct place to discuss this but I hope you are so kind to ignore this is not about RDM in particular. From the log output posted above I guess RDM might use the same library in the background as well.
I am most interested in the change that was made to fix this in RDM to hopefully be able to implement that myself as well.
What I see is the following log output:
[15:26:53:900] [2487:000009ca] [WARN][com.freerdp.channels.rdpdr.client] - [devman_get_device_by_id]: could not find device ID 0xffffffff [15:26:53:900] [2487:000009ca] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_process_irp]: irp_new failed with 55! [15:26:53:900] [2487:000009ca] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_process_receive]: rdpdr_process_irp failed with error 55 [15:26:53:900] [2487:000009ca] [ERROR][com.freerdp.channels.rdpdr.client] - [rdpdr_virtual_channel_client_thread]: rdpdr_process_receive failed with error 55! [15:26:53:900] [2487:000009b8] [ERROR][com.freerdp.core] - [checkChannelErrorEvent]: rdpdr_virtual_channel_client_thread reported an error. Error was 55 [15:26:53:900] [2487:000009b8] [ERROR][com.freerdp.core] - [freerdp_check_event_handles]: checkChannelErrorEvent() failed - 0 [15:26:53:900] [2487:000009b8] [INFO][com.freerdp.client.common] - [client_auto_reconnect_ex]: Network disconnect!
Although the return code is different (55 in our case while this topic is about 87) I guess the root cause might be the same.
We don't have resources forwarded - actually using xfreerdp from the command line to test without resource options set and non is activated by default as far as I see in the manual.
One very interesting finding a colleague made is that this error only starts to arise when the system we try connect to is joined to a AD domain. I suspect this has something to do with kerberos tokens but so far I was not able to find a clear answer to why this happens and how to solve it. As well this only happens with the recent version 3.x but not with the 2.x versions of XFreeRDP.
FInd a diff between logs before and after joining an AD domain here: https://www.diffchecker.com/lD26xB6L/
Looking forward to hear from you. Whatever input you are willing to share I will be grateful to hear. Thanks in advance!
Sebastian
Hello
You are correct that our RDP implementation is built on FreeRDP, the same as xfreerdp.
Indeed this error looks similar, if not the exact same. You can see here my upstream pull request where I added a setting to work around the problem. However, this setting isn't available on the command-line (that's not relevant for our needs). If you can build and maintain your own implementation, that would be easy enough to fix; if not, you'll need to talk to the maintainers. They might not want to expose that option on the command line. If you check the PR, you'll see someone else in the comments reports the same issue and requests to make this the default behaviour, but the response was:
> no, definitely not.
> if you have any issue please provide some details, that is a bug!
So I suggest you raise an issue, they are usually very responsive.
This isn't related to kerberos but there were a lot of changes on that side between FreeRDP 2.x and 3.x. Is kerberos enforced in your environment? I don't think so, and if you've noticed a significant increase in connection times after updating to 3.x, I'd suggest forcing NTLM on the command line because as far as I can tell (without seeing the complete log with timestamps), you might be seeing a delay as the kerberos implementation tries to make a DNS lookup for the default realm.
Please, let me know if something isn't clear or you have further questions
Kind regards,
Richard Markievicz
Hello Richard Markievicz,
thank you very much for your quick response and the pointer to the upstream topic!
Sebastian
Hello
I did take a look at the code to see why device redirection is being enabled even though you don't forward any resources at the command line.
There are other features (most of them are RDP 8.1 features) that depend on and will enable device redirection:
- heartbeat
- network auto detect
- multitransport
- audio out redirection
I don't think audio out is enabled by default, but the others are in FreeRDP 3. I'm not sure the syntax to disable heartbeat and multi transport from the command line (maybe `-heartbeat -multitransport`) and the FreeRDP wiki isn't loading for me right now. For network, you need to explicitly choose an option other than "auto" - something like /network:lan.
You could give that a try as a workaround
Thanks and kind regards,
Richard Markievicz
Hello Richard Markievicz,
thanks heaps for digging into this again!!
I checked out the mentioned command line options in the man page and tried all three by themselves and in combination. Did not make any difference. Still getting the same errors ("could not find device ID 0xffffffff" and "irp_new failed with 55!"). As well I have tried different options for audio the other day and had no success either.
On Github I also got an reply and will need to open a new bug report there. Will do in a minute.
On the other hand I started compiling FreeRDP myself to add more debugging output and try to figure out what device (ID) that might be.
Thanks,
Sebastian
Hello
Yes, you're right, and after checking in the debugger, it's not so simple to disable device redirection with any combination of CLI options.
If you're building yourself, the first thing you should try is forcing the option I added in my PR (`FreeRDP_IgnoreInvalidDevices`) to `TRUE` and verify that it works around your issue.
I expect you'll have trouble figuring out what this "phantom" device is, the server is sending the IRP for a device that's not registered on the client. We have a lot of users and we literally only saw this with one or two cases, and without any real explanation.
Good luck!
Richard Markievicz