Coder Social home page Coder Social logo

Comments (23)

akallabeth avatar akallabeth commented on September 23, 2024 1

@progxaker the ring buffer stuff is a red herring.
better deactivate that debug option, it is quite useless.

interesting part is that it retries rdstls authentication after accepting the cert.

from freerdp.

progxaker avatar progxaker commented on September 23, 2024 1

@akallabeth okay, I've tested with an AVD disabled and instantly clicking the "Permanent" button. Everything works as we expect it to.
So, the problem only occurs if a user waits for more than 1 minute (that's what we tested, but a shorter delay is possible) and then clicks the button.
freerdp.log

from freerdp.

akallabeth avatar akallabeth commented on September 23, 2024 1

@progxaker thank you.
fyi: better disable the thread debug logs (and be careful which ones to activate) as they might leak sensitive information, make the whole thing unstable and other things.

from freerdp.

akallabeth avatar akallabeth commented on September 23, 2024 1

maybe some timeout reached (server side, did you configure something there?) and the connection was already dropped due to being idle?

Perhaps, but as far as I understand, at this point (when the certification check failed) we have already initialized the session, all that is left is to wait for Permanent/Temporary signals from a user to continue the connection (at this point, as you could saw in the screenshots in my previous comment, the reconnect window has returned when the websocket viewer window normally appears) or Cancel/Close signals to abort the initialization. If we don't get any ideas, I might try looking at network traffic.

not quite correct.

yes, the target is running at that point in time, but it only initializes a TLS connection (that is the certificate warning you see) and only after that proceeds with RDSTLS authentication on the target.

so now the authentication fails if you proceed after a certain amount of time, so it would be interesting to know the lifetime of these tokens that are exchanged.
since the connection is running from a FreeRDP point of view something server side terminates and does not initialize the real RDP session after the RDSTLS step and does not inform the client about that.

I have to correct my previous statement, I now see where it hangs:

  1. The client sends the auth request in RDSTLS_STATE_AUTH_REQ state
  2. The client never receives a RDSTLS_STATE_AUTH_RSP state message (e.g. success/failure)
  3. the RDSTLS transport tunnel (TLS connection) is not terminating and still valid
  4. the client waits indefinitely for a response

so what we can do here is properly apply connection timeouts in case the server just does not reply and terminate. That would trigger a new connection attempt that might / might not work

from freerdp.

akallabeth avatar akallabeth commented on September 23, 2024 1

so basically we´re hitting http_response_recv here - it does not check for a timeout

from freerdp.

akallabeth avatar akallabeth commented on September 23, 2024
  1. thank you for the report, but the backtrace should use thread apply all bt to be usable.
  2. to reproduce you can just remove the accepted certificate from .config/freerdp/servers/somename.pem

from freerdp.

progxaker avatar progxaker commented on September 23, 2024

Thank you, I'm newbie with gdb :)
P.S. I didn't close the process, so gdb is still connected to it.

thread apply all bt
(gdb) thread apply all bt

Thread 18 (Thread 0x789a4d772640 (LWP 70997) "sdl-free:gdrv0"):
#0  __futex_abstimed_wait_common64 (private=0, cancel=true, abstime=0x0, op=393, expected=0, futex_word=0x789a43ea5db8) at ./nptl/futex-internal.c:57
#1  __futex_abstimed_wait_common (cancel=true, private=0, abstime=0x0, clockid=0, expected=0, futex_word=0x789a43ea5db8) at ./nptl/futex-internal.c:87
#2  __GI___futex_abstimed_wait_cancelable64 (futex_word=futex_word@entry=0x789a43ea5db8, expected=expected@entry=0, clockid=clockid@entry=0, abstime=abstime@entry=0x0, private=private@entry=0) at ./nptl/futex-internal.c:139
#3  0x0000789a66c93a41 in __pthread_cond_wait_common (abstime=0x0, clockid=0, mutex=0x789a43ea5d68, cond=0x789a43ea5d90) at ./nptl/pthread_cond_wait.c:503
#4  ___pthread_cond_wait (cond=0x789a43ea5d90, mutex=0x789a43ea5d68) at ./nptl/pthread_cond_wait.c:627
#5  0x0000789a5691952d in  () at /usr/lib/x86_64-linux-gnu/dri/crocus_dri.so
#6  0x0000789a568c98bb in  () at /usr/lib/x86_64-linux-gnu/dri/crocus_dri.so
#7  0x0000789a5691945b in  () at /usr/lib/x86_64-linux-gnu/dri/crocus_dri.so
#8  0x0000789a66c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#9  0x0000789a66d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 17 (Thread 0x789a46fc3640 (LWP 70671) "sdl-freerdp"):
#0  0x0000789a66d18bcf in __GI___poll (fds=0x789a46fc2038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x0000789a66d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x0000789a675257db in poll (__timeout=<optimized out>, __nfds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, __fds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x0000789a67529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, bWaitAll=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>, bAlertable=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/wait.c:425
#5  0x0000789a6759c65b in thread_pool_work_func (arg=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x0000789a6759e8de in thread_launcher (arg=<optimized out>) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x0000789a66c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x0000789a66d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 16 (Thread 0x789a47804640 (LWP 70670) "sdl-freerdp"):
#0  0x0000789a66d18bcf in __GI___poll (fds=0x789a47803038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x0000789a66d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x0000789a675257db in poll (__timeout=<optimized out>, __nfds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, __fds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x0000789a67529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, bWaitAll=<error read--Type <RET> for more, q to quit, c to continue without paging--c
ing variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>, bAlertable=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/wait.c:425
#5  0x0000789a6759c65b in thread_pool_work_func (arg=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x0000789a6759e8de in thread_launcher (arg=<optimized out>) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x0000789a66c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x0000789a66d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 15 (Thread 0x789a4801b640 (LWP 70669) "sdl-freerdp"):
#0  0x0000789a66d18bcf in __GI___poll (fds=0x789a4801a038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x0000789a66d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x0000789a675257db in poll (__timeout=<optimized out>, __nfds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, __fds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x0000789a67529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, bWaitAll=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>, bAlertable=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/wait.c:425
#5  0x0000789a6759c65b in thread_pool_work_func (arg=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x0000789a6759e8de in thread_launcher (arg=<optimized out>) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x0000789a66c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x0000789a66d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 14 (Thread 0x789a4885c640 (LWP 70668) "sdl-freerdp"):
#0  0x0000789a66d18bcf in __GI___poll (fds=0x789a4885b038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x0000789a66d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x0000789a675257db in poll (__timeout=<optimized out>, __nfds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, __fds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x0000789a67529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, bWaitAll=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>, bAlertable=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/wait.c:425
#5  0x0000789a6759c65b in thread_pool_work_func (arg=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x0000789a6759e8de in thread_launcher (arg=<optimized out>) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x0000789a66c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x0000789a66d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 13 (Thread 0x789a49217640 (LWP 70667) "sdl-freerdp"):
#0  0x0000789a66d18bcf in __GI___poll (fds=0x789a49216038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x0000789a66d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x0000789a675257db in poll (__timeout=<optimized out>, __nfds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, __fds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x0000789a67529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, bWaitAll=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>, bAlertable=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/wait.c:425
#5  0x0000789a6759c65b in thread_pool_work_func (arg=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x0000789a6759e8de in thread_launcher (arg=<optimized out>) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x0000789a66c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x0000789a66d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 12 (Thread 0x789a49a2e640 (LWP 70666) "sdl-freerdp"):
#0  0x0000789a66d18bcf in __GI___poll (fds=0x789a49a2d038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x0000789a66d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x0000789a675257db in poll (__timeout=<optimized out>, __nfds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, __fds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x0000789a67529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, bWaitAll=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>, bAlertable=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/wait.c:425
#5  0x0000789a6759c65b in thread_pool_work_func (arg=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x0000789a6759e8de in thread_launcher (arg=<optimized out>) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x0000789a66c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x0000789a66d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 11 (Thread 0x789a4a245640 (LWP 70665) "sdl-freerdp"):
#0  0x0000789a66d18bcf in __GI___poll (fds=0x789a4a244038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x0000789a66d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x0000789a675257db in poll (__timeout=<optimized out>, __nfds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, __fds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x0000789a67529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, bWaitAll=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>, bAlertable=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/wait.c:425
#5  0x0000789a6759c65b in thread_pool_work_func (arg=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x0000789a6759e8de in thread_launcher (arg=<optimized out>) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x0000789a66c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x0000789a66d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 10 (Thread 0x789a4aa5c640 (LWP 70664) "sdl-freerdp"):
#0  0x0000789a66d18bcf in __GI___poll (fds=0x789a4aa5b038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x0000789a66d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x0000789a675257db in poll (__timeout=<optimized out>, __nfds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, __fds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x0000789a67529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, bWaitAll=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>, bAlertable=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/wait.c:425
#5  0x0000789a6759c65b in thread_pool_work_func (arg=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x0000789a6759e8de in thread_launcher (arg=<optimized out>) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x0000789a66c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x0000789a66d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 9 (Thread 0x789a4b587640 (LWP 70663) "sdl-freerdp"):
#0  0x0000789a66d18bcf in __GI___poll (fds=0x789a4b586038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x0000789a66d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x0000789a675257db in poll (__timeout=<optimized out>, __nfds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, __fds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x0000789a67529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, bWaitAll=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>, bAlertable=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/wait.c:425
#5  0x0000789a6759c65b in thread_pool_work_func (arg=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x0000789a6759e8de in thread_launcher (arg=<optimized out>) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x0000789a66c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x0000789a66d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 8 (Thread 0x789a4bdc8640 (LWP 70662) "sdl-freerdp"):
#0  0x0000789a66d18bcf in __GI___poll (fds=0x789a4bdc7038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x0000789a66d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x0000789a675257db in poll (__timeout=<optimized out>, __nfds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, __fds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x0000789a67529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, bWaitAll=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>, bAlertable=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/wait.c:425
#5  0x0000789a6759c65b in thread_pool_work_func (arg=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x0000789a6759e8de in thread_launcher (arg=<optimized out>) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x0000789a66c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x0000789a66d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 7 (Thread 0x789a4c5df640 (LWP 70661) "sdl-freerdp"):
#0  0x0000789a66d18bcf in __GI___poll (fds=0x789a4c5de038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x0000789a66d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x0000789a675257db in poll (__timeout=<optimized out>, __nfds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, __fds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x0000789a67529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, bWaitAll=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>, bAlertable=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/wait.c:425
#5  0x0000789a6759c65b in thread_pool_work_func (arg=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x0000789a6759e8de in thread_launcher (arg=<optimized out>) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x0000789a66c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x0000789a66d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 6 (Thread 0x789a4cdf6640 (LWP 70660) "sdl-freerdp"):
#0  0x0000789a66d18bcf in __GI___poll (fds=0x789a4cdf5038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x0000789a66d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x0000789a675257db in poll (__timeout=<optimized out>, __nfds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, __fds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x0000789a67529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, bWaitAll=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, dwMilliseconds=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>, bAlertable=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/winpr/libwinpr/synch/wait.c:425
#5  0x0000789a6759c65b in thread_pool_work_func (arg=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libwinpr3.so.3]>) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x0000789a6759e8de in thread_launcher (arg=<optimized out>) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x0000789a66c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x0000789a66d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 5 (Thread 0x789a4e508640 (LWP 70657) "sdl-freerdp"):
Python Exception <class 'gdb.error'>: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libfreerdp-client3.so.3]

Thread 4 (Thread 0x789a4ede4640 (LWP 70656) "sdl-freerdp"):
#0  0x0000789a666d54c7 in BIO_read () at /lib/x86_64-linux-gnu/libcrypto.so.3
#1  0x0000789a67b3f886 in transport_read_layer (transport=<optimized out>, data=<optimized out>, bytes=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/libfreerdp/core/transport.c:786
#2  0x0000789a67b2dff0 in transport_read_layer_bytes (transport=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, s=<optimized out>, toRead=<optimized out>) at /FreeRDP/libfreerdp/core/transport.c:856
#3  0x0000789a67b3ff0d in transport_default_read_pdu (transport=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libfreerdp3.so.3]>, s=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/libfreerdp/core/transport.c:1080
#4  0x0000789a67b94327 in transport_read_pdu (s=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>, transport=<optimized out>) at /FreeRDP/libfreerdp/core/transport.c:881
#5  rdstls_recv_authentication_response (rdstls=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/libfreerdp/core/rdstls.c:798
#6  rdstls_client_authenticate (rdstls=<optimized out>) at /FreeRDP/libfreerdp/core/rdstls.c:845
#7  rdstls_authenticate (rdstls=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/libfreerdp/core/rdstls.c:865
#8  0x0000789a67a5cd47 in transport_connect_rdstls (transport=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/libfreerdp/core/transport.c:414
#9  nego_try_connect (nego=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/libfreerdp/core/nego.c:311
#10 0x0000789a67adccec in nego_security_connect (nego=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/libfreerdp/core/nego.c:347
#11 nego_connect (nego=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/libfreerdp/core/nego.c:282
#12 rdp_client_connect (rdp=<error reading variable: DW_FORM_addr_index used without .debug_addr section [in module /opt/freerdp-nightly-selfbuild/bin/../lib/libfreerdp3.so.3]>) at /FreeRDP/libfreerdp/core/connection.c:430
#13 0x0000789a67aa1259 in freerdp_connect_begin (instance=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/libfreerdp/core/freerdp.c:156
#14 freerdp_connect (instance=<error reading variable: dwarf2_find_location_expression: Corrupted DWARF expression.>) at /FreeRDP/libfreerdp/core/freerdp.c:174
#15 0x000058240debb10d in sdl_client_thread_proc(SdlContext*) (sdl=0x6120000007c0) at /FreeRDP/client/SDL/sdl_freerdp.cpp:1166
#16 0x0000789a670e62b3 in  () at /lib/x86_64-linux-gnu/libstdc++.so.6
#17 0x0000789a66c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#18 0x0000789a66d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 3 (Thread 0x789a4f61c640 (LWP 70653) "sdl-fre:disk$0"):
#0  __futex_abstimed_wait_common64 (private=0, cancel=true, abstime=0x0, op=393, expected=0, futex_word=0x616000001c20) at ./nptl/futex-internal.c:57
#1  __futex_abstimed_wait_common (cancel=true, private=0, abstime=0x0, clockid=0, expected=0, futex_word=0x616000001c20) at ./nptl/futex-internal.c:87
#2  __GI___futex_abstimed_wait_cancelable64 (futex_word=futex_word@entry=0x616000001c20, expected=expected@entry=0, clockid=clockid@entry=0, abstime=abstime@entry=0x0, private=private@entry=0) at ./nptl/futex-internal.c:139
#3  0x0000789a66c93a41 in __pthread_cond_wait_common (abstime=0x0, clockid=0, mutex=0x616000001bd0, cond=0x616000001bf8) at ./nptl/pthread_cond_wait.c:503
#4  ___pthread_cond_wait (cond=0x616000001bf8, mutex=0x616000001bd0) at ./nptl/pthread_cond_wait.c:627
#5  0x0000789a5691952d in  () at /usr/lib/x86_64-linux-gnu/dri/crocus_dri.so
#6  0x0000789a568c98bb in  () at /usr/lib/x86_64-linux-gnu/dri/crocus_dri.so
#7  0x0000789a5691945b in  () at /usr/lib/x86_64-linux-gnu/dri/crocus_dri.so
#8  0x0000789a66c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#9  0x0000789a66d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 2 (Thread 0x789a59bd3640 (LWP 70651) "SDLTimer"):
#0  __futex_abstimed_wait_common64 (private=<optimized out>, cancel=true, abstime=0x0, op=393, expected=0, futex_word=0x603000032ad0) at ./nptl/futex-internal.c:57
#1  __futex_abstimed_wait_common (cancel=true, private=<optimized out>, abstime=0x0, clockid=0, expected=0, futex_word=0x603000032ad0) at ./nptl/futex-internal.c:87
#2  __GI___futex_abstimed_wait_cancelable64 (futex_word=futex_word@entry=0x603000032ad0, expected=expected@entry=0, clockid=clockid@entry=0, abstime=abstime@entry=0x0, private=<optimized out>) at ./nptl/futex-internal.c:139
#3  0x0000789a66c9cbdf in do_futex_wait (sem=sem@entry=0x603000032ad0, abstime=0x0, clockid=0) at ./nptl/sem_waitcommon.c:111
#4  0x0000789a66c9cc78 in __new_sem_wait_slow64 (sem=0x603000032ad0, abstime=0x0, clockid=0) at ./nptl/sem_waitcommon.c:183
#5  0x0000789a68176e22 in  () at /lib/x86_64-linux-gnu/libSDL2-2.0.so.0
#6  0x0000789a680e82e5 in  () at /lib/x86_64-linux-gnu/libSDL2-2.0.so.0
#7  0x0000789a68176c6e in  () at /lib/x86_64-linux-gnu/libSDL2-2.0.so.0
#8  0x0000789a66c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#9  0x0000789a66d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 1 (Thread 0x789a5d741140 (LWP 70650) "sdl-freerdp"):
#0  0x0000789a66d18bcf in __GI___poll (fds=0x7ffd2386af58, nfds=1, timeout=1000) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x0000789a68660e30 in __interceptor_poll(__sanitizer::__sanitizer_pollfd*, __sanitizer::__sanitizer_nfds_t, int) (fds=0x7ffd2386af58, nfds=1, timeout=1000) at ../../../../src/libsanitizer/sanitizer_common/sanitizer_common_interceptors.inc:3961
#2  0x0000789a68152a6c in  () at /lib/x86_64-linux-gnu/libSDL2-2.0.so.0
#3  0x0000789a680ae9aa in  () at /lib/x86_64-linux-gnu/libSDL2-2.0.so.0
#4  0x000058240dea411b in sdl_run (sdl=0x6120000007c0) at /FreeRDP/client/SDL/sdl_freerdp.cpp:820
#5  main(int, char**) (argc=<optimized out>, argv=<optimized out>) at /FreeRDP/client/SDL/sdl_freerdp.cpp:1649

to reproduce you can just remove the accepted certificate from .config/freerdp/servers/somename.pem

Ah, yes, that's easier. Okay, I'll try to reproduce it today-tomorrow with the TRACE log level.

from freerdp.

progxaker avatar progxaker commented on September 23, 2024

I've successfully reproduced the problem.

TRACE logs
# gdb --args sdl-freerdp file.rdpw /gateway:type:arm /f /u:'<email>' /p:'<password>' /network:auto /auto-reconnect -decorations /log-level:TRACE
GNU gdb (Ubuntu 12.1-0ubuntu1~22.04) 12.1
Copyright (C) 2022 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.
Type "show copying" and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
Type "show configuration" for configuration details.
For bug reporting instructions, please see:
<https://www.gnu.org/software/gdb/bugs/>.
Find the GDB manual and other documentation resources online at:
    <http://www.gnu.org/software/gdb/documentation/>.

For help, type "help".
Type "apropos word" to search for commands related to "word"...
Reading symbols from /opt/freerdp-nightly-selfbuild/bin/sdl-freerdp...
(gdb) run
Starting program: sdl-freerdp file.rdpw /gateway:type:arm /f /u:'<email>' /p:'<password>' /network:auto /auto-reconnect -decorations log-level:TRACE
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
[13:51:32:458] [98488:000180b8] [WARN][com.freerdp.client.common.cmdline] - [freerdp_client_warn_experimental]: [experimental] /opt/freerdp-nightly-selfbuild/bin/sdl-freerdp client is currently experimental!
[13:51:32:458] [98488:000180b8] [WARN][com.freerdp.client.common.cmdline] - [freerdp_client_warn_experimental]:  If problems occur please check https://github.com/FreeRDP/FreeRDP/issues for known issues or create a new one!
[13:51:32:458] [98488:000180b8] [WARN][com.freerdp.client.common.cmdline] - [freerdp_client_warn_experimental]:  Developers hang out in https://matrix.to/#/#FreeRDP:matrix.org?via=matrix.org - dont hesitate to ask some questions. (replies might take some time depending on your timezone)
[13:51:32:463] [98488:000180b8] [INFO][com.winpr.timezone] - [winpr_detect_windows_time_zone]: tzid: Europe/Kyiv
[13:51:32:464] [98488:000180b8] [ERROR][com.winpr.timezone] - [winpr_detect_windows_time_zone]: Unable to find a match for unix timezone: Europe/Kyiv
[13:51:32:475] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: *************************************************
[13:51:32:475] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: This build is using [debug] build options:
[13:51:32:475] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_ALL=ON'
[13:51:32:475] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_CAPABILITIES=ON'
[13:51:32:475] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_CERTIFICATE=ON'
[13:51:32:475] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_CHANNELS=ON'
[13:51:32:475] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_CLIPRDR=ON'
[13:51:32:475] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_CODECS=ON'
[13:51:32:475] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_DVC=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_KBD=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_LICENSE=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_NEGO=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_NLA=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_RAIL=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_RDP=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_RDPDR=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_RDPEI=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_RDPGFX=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_REDIR=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_RFX=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_RINGBUFFER=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_SCARD=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_SND=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_SVC=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_TIMEZONE=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_TRANSPORT=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_TSG=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_WND=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_X11=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_X11_LOCAL_MOVESIZE=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: * 'WITH_DEBUG_XV=ON'
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]:
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: [debug] build options might leak sensitive information (credentials, ...)
[13:51:32:476] [98488:000180b8] [WARN][com.freerdp.core.rdp] - [log_build_warn][0x61f000000080]: *************************************************
[New Thread 0x7fffe8ad3640 (LWP 98491)]
[New Thread 0x7fffde4be640 (LWP 98493)]
[New Thread 0x7fffddc86640 (LWP 98494)]
[Thread 0x7fffddc86640 (LWP 98494) exited]
[New Thread 0x7fffddc86640 (LWP 98495)]
[Thread 0x7fffddc86640 (LWP 98495) exited]
[13:51:32:64] [98488:000180b8] [WARN][com.freerdp.client.common] - [freerdp_client_populate_settings_from_rdp_file]: This build does not support [MS-RDPECAM] camera redirection channel. Ignoring 'camerastoredirect'
[13:51:32:64] [98488:000180b8] [DEBUG][com.freerdp.client.common] - [freerdp_client_settings_parse_command_line]: This is 3.5.2-dev0 Build configuration: BUILD_TESTING=OFF WINPR_HAVE_AIO_H=1 WINPR_HAVE_EXECINFO_BACKTRACE=1 WINPR_HAVE_EXECINFO_BACKTRACE_SYMBOLS=1 WINPR_HAVE_EXECINFO_BACKTRACE_SYMBOLS_FD=1 WINPR_HAVE_EXECINFO_HEADER=1 WINPR_HAVE_FCNTL_H=1 WINPR_HAVE_GETLOGIN_R=1 WINPR_HAVE_GETPWUID_R=1 WINPR_HAVE_INTTYPES_H=1 WINPR_HAVE_POLL_H=1 WINPR_HAVE_PTHREAD_MUTEX_TIMEDLOCK_LIB=1 WINPR_HAVE_PTHREAD_MUTEX_TIMEDLOCK_LIBS= WINPR_HAVE_PTHREAD_MUTEX_TIMEDLOCK_SYMBOL=1 WINPR_HAVE_STDBOOL_H=1 WINPR_HAVE_STDINT_H=1 WINPR_HAVE_STRNDUP=1 WINPR_HAVE_SYSLOG_H=1 WINPR_HAVE_SYS_EVENTFD_H=1 WINPR_HAVE_SYS_FILIO_H= WINPR_HAVE_SYS_SELECT_H=1 WINPR_HAVE_SYS_SOCKIO_H= WINPR_HAVE_SYS_TIMERFD_H=1 WINPR_HAVE_TM_GMTOFF=1 WINPR_HAVE_UNISTD_H=1 WINPR_HAVE_UNWIND_H=1 WITH_AAD=ON WITH_ABSOLUTE_PLUGIN_LOAD_PATHS=ON WITH_ADD_PLUGIN_TO_RPATH=OFF WITH_ALSA=ON WITH_BINARY_VERSIONING=OFF WITH_CAIRO=ON WITH_CCACHE=OFF WITH_CHANNELS=ON WITH_CLANG_FORMAT=ON WITH_CLIENT=ON WITH_CLIENT_AVAILABLE=1 WITH_CLIENT_CHANNELS=ON WITH_CLIENT_CHANNELS_AVAILABLE=1 WITH_CLIENT_COMMON=ON WITH_CLIENT_INTERFACE=OFF WITH_CLIENT_SDL=ON WITH_CLIENT_SDL_AVAILABLE=1 WITH_CUPS=ON WITH_DEBUG_ALL=ON WITH_DEBUG_CAPABILITIES=ON WITH_DEBUG_CERTIFICATE=ON WITH_DEBUG_CHANNELS=ON WITH_DEBUG_CLIPRDR=ON WITH_DEBUG_CODECS=ON WITH_DEBUG_DVC=ON WITH_DEBUG_EVENTS=OFF WITH_DEBUG_KBD=ON WITH_DEBUG_LICENSE=ON WITH_DEBUG_MUTEX=OFF WITH_DEBUG_NEGO=ON WITH_DEBUG_NLA=ON WITH_DEBUG_NTLM=OFF WITH_DEBUG_RAIL=ON WITH_DEBUG_RDP=ON WITH_DEBUG_RDPDR=ON WITH_DEBUG_RDPEI=ON WITH_DEBUG_RDPGFX=ON WITH_DEBUG_REDIR=ON WITH_DEBUG_RFX=ON WITH_DEBUG_RINGBUFFER=ON WITH_DEBUG_SCARD=ON WITH_DEBUG_SCHANNEL=OFF WITH_DEBUG_SDL_EVENTS=OFF WITH_DEBUG_SDL_KBD_EVENTS=OFF WITH_DEBUG_SND=ON WITH_DEBUG_SVC=ON WITH_DEBUG_SYMBOLS=OFF WITH_DEBUG_THREADS=OFF WITH_DEBUG_TIMEZONE=ON WITH_DEBUG_TRANSPORT=ON WITH_DEBUG_TSG=ON WITH_DEBUG_TSMF=OFF WITH_DEBUG_TSMF_AVAILABLE=0 WITH_DEBUG_URBDRC=OFF WITH_DEBUG_WND=ON WITH_DEBUG_X11=ON WITH_DEBUG_X11_LOCAL_MOVESIZE=ON WITH_DEBUG_XV=ON WITH_DSP_EXPERIMENTAL=OFF WITH_DSP_FFMPEG=ON WITH_DSP_FFMPEG_AVAILABLE=1 WITH_EVENTFD_READ_WRITE=1 WITH_FAAC=ON WITH_FAAD2=ON WITH_FFMPEG=ON WITH_FREERDP_DEPRECATED=OFF WITH_FREERDP_DEPRECATED_COMMANDLINE=ON WITH_FUSE=ON WITH_GFX_H264=ON WITH_GPROF=OFF WITH_GSM=ON WITH_INTERNAL_MD4=OFF WITH_INTERNAL_MD5=OFF WITH_INTERNAL_RC4=OFF WITH_IPP=OFF WITH_JPEG=OFF WITH_KRB5=ON WITH_KRB5_NO_NTLM_FALLBACK=OFF WITH_LAME=OFF WITH_LIBRARY_VERSIONING=ON WITH_LIBRESSL=OFF WITH_LIBSYSTEMD=OFF WITH_LODEPNG=OFF WITH_MACAUDIO=OFF WITH_MACAUDIO_AVAILABLE=0 WITH_MANPAGES=ON WITH_MBEDTLS=OFF WITH_NATIVE_SSPI=OFF WITH_NEON=OFF WITH_OPAQUE_SETTINGS=OFF WITH_OPENCL=OFF WITH_OPENH264=OFF WITH_OPENSC_PKCS11_LINKED=OFF WITH_OPENSLES=OFF WITH_OPENSSL=ON WITH_OPUS=OFF WITH_OSS=ON WITH_PCSC=ON WITH_PKCS11=ON WITH_PLATFORM_SERVER=ON WITH_POLL=ON WITH_PROFILER=OFF WITH_PROXY=ON WITH_PROXY_APP=ON WITH_PROXY_EMULATE_SMARTCARD=OFF WITH_PROXY_MODULES=ON WITH_PULSE=ON WITH_RDTK=ON WITH_SAMPLE=OFF WITH_SANITIZE_ADDRESS=ON WITH_SANITIZE_ADDRESS_AVAILABLE=1 WITH_SANITIZE_MEMORY=OFF WITH_SANITIZE_MEMORY=OFF WITH_SANITIZE_MEMORY_AVAILABLE=0 WITH_SANITIZE_THREAD=OFF WITH_SANITIZE_THREAD=OFF WITH_SANITIZE_THREAD_AVAILABLE=0 WITH_SDL_IMAGE_DIALOGS=OFF WITH_SDL_LINK_SHARED=ON WITH_SERVER=ON WITH_SERVER_CHANNELS=ON WITH_SERVER_INTERFACE=ON WITH_SHADOW=ON WITH_SMARTCARD_EMULATE=OFF WITH_SMARTCARD_INSPECT=OFF WITH_SMARTCARD_PCSC=ON WITH_SOXR=OFF WITH_SSE2=ON WITH_SWSCALE=OFF WITH_SYSTEMD=OFF WITH_THIRD_PARTY=OFF WITH_UNICODE_BUILTIN=OFF WITH_URIPARSER=ON WITH_VAAPI=OFF WITH_VAAPI_AVAILABLE=1 WITH_VALGRIND_MEMCHECK=OFF WITH_VALGRIND_MEMCHECK=OFF WITH_VALGRIND_MEMCHECK_AVAILABLE=0 WITH_VERBOSE_WINPR_ASSERT=ON WITH_VIDEO_FFMPEG=ON WITH_VIDEO_FFMPEG_AVAILABLE=1 WITH_WAYLAND=ON WITH_WEBVIEW=OFF WITH_WINPR_DEPRECATED=OFF WITH_WINPR_TOOLS=ON WITH_WIN_CONSOLE=ON WITH_X11=ON WITH_XCURSOR=ON WITH_XEXT=ON WITH_XFIXES=ON WITH_XI=ON WITH_XINERAMA=ON WITH_XRANDR=ON WITH_XRENDER=ON WITH_XV=ON WITH_ZLIB=ON
Build type:          RelWithDebInfo
CFLAGS:               -Wall -Wpedantic -Wno-padded -Wno-cast-align -Wno-declaration-after-statement -fPIC -Wall -fvisibility=hidden -Wimplicit-function-declaration -Wredundant-decls -g -fno-omit-frame-pointer -fsanitize=address -fsanitize-address-use-after-scope
Compiler:            GNU, 11.4.0
Target architecture: x64

[New Thread 0x7fffddc86640 (LWP 98496)]
[13:51:32:65] [98488:000180c0] [DEBUG][com.freerdp.core] - [freerdp_connect_begin]: resetting error state
[13:51:32:66] [98488:000180c0] [TRACE][com.freerdp.api] - [freerdp_channels_process_message]: IFCALL(message->Free) == NULL
[13:51:32:66] [98488:000180c0] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpdr
[13:51:32:67] [98488:000180c0] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx rdpsnd
[13:51:32:67] [98488:000180c0] [DEBUG][com.freerdp.channels.drdynvc.client] - [drdynvc_VirtualChannelEntryEx]: VirtualChannelEntryEx
[13:51:32:67] [98488:000180c0] [DEBUG][com.freerdp.client.common.cmdline] - [freerdp_client_load_static_channel_addin]: loading channelEx drdynvc
[New Thread 0x7fffdd3c8640 (LWP 98497)]
[13:51:32:72] [98488:000180c0] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: primitives benchmark result:
[13:51:32:97] [98488:000180b8] [DEBUG][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_ERROR] Invalid renderer
[13:51:32:97] [98488:000180b8] [DEBUG][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_ERROR] Invalid window
[New Thread 0x7fffdc640640 (LWP 98498)]
[Thread 0x7fffdc640640 (LWP 98498) exited]
[New Thread 0x7fffdc640640 (LWP 98499)]
[13:51:33:241] [98488:000180c0] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]:  * generic= 11
[13:51:33:334] [98488:000180b8] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_RENDER] OpenGL shaders: ENABLED
[13:51:33:335] [98488:000180b8] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_RENDER] Created renderer: opengl
[13:51:33:405] [98488:000180c0] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]:  * optimized= 21
[13:51:33:406] [98488:000180c0] [DEBUG][com.freerdp.primitives] - [primitives_autodetect_best]: primitives autodetect, using optimized
[New Thread 0x7fffdaeb6640 (LWP 98500)]
[New Thread 0x7fffda6b5640 (LWP 98501)]
[New Thread 0x7fffd9e9e640 (LWP 98502)]
[New Thread 0x7fffd9673640 (LWP 98503)]
[New Thread 0x7fffd8b76640 (LWP 98504)]
[New Thread 0x7fffd8375640 (LWP 98505)]
[New Thread 0x7fffd7b6c640 (LWP 98506)]
[New Thread 0x7fffd7355640 (LWP 98507)]
[New Thread 0x7fffd6a5e640 (LWP 98508)]
[New Thread 0x7fffd6233640 (LWP 98509)]
[New Thread 0x7fffd5a1c640 (LWP 98510)]
[New Thread 0x7fffd51f1640 (LWP 98511)]
[13:51:33:582] [98488:000180c0] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: resetting error state
[13:51:33:582] [98488:000180c0] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: connecting to peer <ip-address>
[13:51:33:614] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.arm] - [arm_tls_connect]: connecting to <gateway-domain> 443
[13:51:33:615] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_init]: ringbuffer_init(0x6060000320d0)
[13:51:33:618] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x6060000320d0): sz: 342
[13:51:33:618] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x6060000320d0): sz: 342
[13:51:33:618] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x6060000320d0): sz: 342
[13:51:33:673] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x6060000320d0): sz: 194
[13:51:33:673] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x6060000320d0): sz: 194
[13:51:33:673] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x6060000320d0): sz: 194
Browse to: https://login.microsoftonline.com/common/oauth2/v2.0/authorize?client_id=a85cf173-4192-42f8-81fa-777a763e6e2c&response_type=code&scope=https%3A%2F%2Fwww.wvd.microsoft.com%2F.default&redirect_uri=https%3A%2F%2Flogin.microsoftonline.com%2Fcommon%2Foauth2%2Fnativeclient
Paste redirect URL here:
[13:51:33:60] [98488:000180bb] [TRACE][com.freerdp.client.SDL] - [OnTimer]: checking for display changes...
<redirect-url>
[13:51:43:208] [98488:000180c0] [DEBUG][com.freerdp.utils.http] - [freerdp_http_request]: headers:
POST /common/oauth2/v2.0/token HTTP/1.1
Host: login.microsoftonline.com
Content-Type: application/x-www-form-urlencoded
Content-Length: 1039


[13:51:43:432] [98488:000180c0] [DEBUG][com.freerdp.utils.http] - [freerdp_http_request]: body:
<response-body>
[13:51:43:725] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x6060000320d0): sz: 5122
[13:51:43:725] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x6060000320d0): sz: 5122
[13:51:43:725] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x6060000320d0): sz: 5122
[13:51:43:725] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x6060000320d0): sz: 245
[13:51:43:725] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x6060000320d0): sz: 245
[13:51:43:725] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x6060000320d0): sz: 245
[13:51:44:683] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.http] - [http_chuncked_read]: chunked encoding end of stream received
[13:51:44:683] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.arm] - [arm_handle_bad_request]: Got HTTP Response data: {
  "Code": "E_PROXY_ORCHESTRATION_LB_SESSIONHOST_DEALLOCATED",
  "Message": "Session Host with ID = '<id>' has been deallocated we are starting the session host for you. Please retry connecting after 5 minutes.",
  "Target": null,
  "Details": null,
  "InnerError": null
}
[13:51:44:683] [98488:000180c0] [WARN][com.freerdp.core.gateway.arm] - [arm_handle_bad_request]: Session Host with ID = '<id>' has been deallocated we are starting the session host for you. Please retry connecting after 5 minutes.
[13:51:44:683] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.arm] - [arm_resolve_endpoint]: Delay for 15000ms before next attempt
[Thread 0x7fffdc640640 (LWP 98499) exited]
[New Thread 0x7fffdc640640 (LWP 98553)]
[Thread 0x7fffdc640640 (LWP 98553) exited]
[New Thread 0x7fffdc640640 (LWP 98554)]
[13:51:44:849] [98488:000180b8] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_RENDER] OpenGL shaders: ENABLED
[13:51:44:849] [98488:000180b8] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_RENDER] Created renderer: opengl
[13:51:59:716] [98488:000180c0] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: resetting error state
[13:51:59:717] [98488:000180c0] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: connecting to peer <ip-address>
[13:51:59:747] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.arm] - [arm_tls_connect]: connecting to <gateway-domain> 443
[13:51:59:747] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_init]: ringbuffer_init(0x606000096e10)
[13:51:59:747] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x6060000320d0): sz: 31
[13:51:59:748] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x6060000320d0): sz: 31
[13:51:59:748] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x6060000320d0): sz: 31
[13:51:59:748] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_destroy]: ringbuffer_destroy(0x6060000320d0)
[13:51:59:750] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x606000096e10): sz: 342
[13:51:59:750] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x606000096e10): sz: 342
[13:51:59:751] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x606000096e10): sz: 342
[13:51:59:797] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x606000096e10): sz: 194
[13:51:59:797] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x606000096e10): sz: 194
[13:51:59:798] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x606000096e10): sz: 194
[13:51:59:834] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x606000096e10): sz: 5122
[13:51:59:835] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x606000096e10): sz: 5122
[13:51:59:835] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x606000096e10): sz: 5122
[13:51:59:835] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x606000096e10): sz: 245
[13:51:59:835] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x606000096e10): sz: 245
[13:51:59:835] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x606000096e10): sz: 245
[13:52:00:303] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.http] - [http_chuncked_read]: chunked encoding end of stream received
[13:52:00:303] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.arm] - [arm_handle_bad_request]: Got HTTP Response data: {
  "Code": "E_PROXY_ORCHESTRATION_LB_SESSIONHOST_DEALLOCATED",
  "Message": "Session Host with ID = '<id>' has been deallocated we are starting the session host for you. Please retry connecting after 5 minutes.",
  "Target": null,
  "Details": null,
  "InnerError": null
}
[13:52:00:303] [98488:000180c0] [WARN][com.freerdp.core.gateway.arm] - [arm_handle_bad_request]: Session Host with ID = '<id>' has been deallocated we are starting the session host for you. Please retry connecting after 5 minutes.
[13:52:00:303] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.arm] - [arm_resolve_endpoint]: Delay for 15000ms before next attempt
[Thread 0x7fffdc640640 (LWP 98554) exited]
[New Thread 0x7fffdc640640 (LWP 98561)]
[Thread 0x7fffdc640640 (LWP 98561) exited]
[New Thread 0x7fffdc640640 (LWP 98562)]
[13:52:00:496] [98488:000180b8] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_RENDER] OpenGL shaders: ENABLED
[13:52:00:497] [98488:000180b8] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_RENDER] Created renderer: opengl
[13:52:15:423] [98488:000180c0] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: resetting error state
[13:52:15:424] [98488:000180c0] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: connecting to peer <ip-address>
[13:52:15:456] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.arm] - [arm_tls_connect]: connecting to <gateway-domain> 443
[13:52:15:456] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_init]: ringbuffer_init(0x60600014c3d0)
[13:52:15:456] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x606000096e10): sz: 31
[13:52:15:456] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x606000096e10): sz: 31
[13:52:15:456] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x606000096e10): sz: 31
[13:52:15:457] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_destroy]: ringbuffer_destroy(0x606000096e10)
[13:52:15:458] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x60600014c3d0): sz: 342
[13:52:15:458] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x60600014c3d0): sz: 342
[13:52:15:458] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x60600014c3d0): sz: 342
[13:52:15:507] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x60600014c3d0): sz: 194
[13:52:15:507] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x60600014c3d0): sz: 194
[13:52:15:507] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x60600014c3d0): sz: 194
[13:52:15:544] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x60600014c3d0): sz: 5122
[13:52:15:544] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x60600014c3d0): sz: 5122
[13:52:15:544] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x60600014c3d0): sz: 5122
[13:52:15:544] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x60600014c3d0): sz: 245
[13:52:15:544] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x60600014c3d0): sz: 245
[13:52:15:544] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x60600014c3d0): sz: 245
[13:52:15:975] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.http] - [http_chuncked_read]: chunked encoding end of stream received
[13:52:15:975] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.arm] - [arm_handle_bad_request]: Got HTTP Response data: {
  "Code": "E_PROXY_ORCHESTRATION_LB_SESSIONHOST_DEALLOCATED",
  "Message": "Session Host with ID = '<id>' has been deallocated we are starting the session host for you. Please retry connecting after 5 minutes.",
  "Target": null,
  "Details": null,
  "InnerError": null
}
[13:52:15:975] [98488:000180c0] [WARN][com.freerdp.core.gateway.arm] - [arm_handle_bad_request]: Session Host with ID = '<id>' has been deallocated we are starting the session host for you. Please retry connecting after 5 minutes.
[13:52:15:976] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.arm] - [arm_resolve_endpoint]: Delay for 15000ms before next attempt
[Thread 0x7fffdc640640 (LWP 98562) exited]
[New Thread 0x7fffdc640640 (LWP 98563)]
[Thread 0x7fffdc640640 (LWP 98563) exited]
[New Thread 0x7fffdc640640 (LWP 98564)]
[13:52:16:180] [98488:000180b8] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_RENDER] OpenGL shaders: ENABLED
[13:52:16:181] [98488:000180b8] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_RENDER] Created renderer: opengl
[13:52:30:09] [98488:000180c0] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: resetting error state
[13:52:30:09] [98488:000180c0] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: connecting to peer <ip-address>
[13:52:30:39] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.arm] - [arm_tls_connect]: connecting to <gateway-domain> 443
[13:52:30:39] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_init]: ringbuffer_init(0x60600014e9b0)
[13:52:30:39] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x60600014c3d0): sz: 31
[13:52:30:39] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x60600014c3d0): sz: 31
[13:52:30:39] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x60600014c3d0): sz: 31
[13:52:30:40] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_destroy]: ringbuffer_destroy(0x60600014c3d0)
[13:52:30:41] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x60600014e9b0): sz: 342
[13:52:30:41] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x60600014e9b0): sz: 342
[13:52:30:41] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x60600014e9b0): sz: 342
[13:52:30:78] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x60600014e9b0): sz: 194
[13:52:30:78] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x60600014e9b0): sz: 194
[13:52:30:78] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x60600014e9b0): sz: 194
[13:52:30:112] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x60600014e9b0): sz: 5122
[13:52:30:112] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x60600014e9b0): sz: 5122
[13:52:30:112] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x60600014e9b0): sz: 5122
[13:52:30:112] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x60600014e9b0): sz: 245
[13:52:30:112] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x60600014e9b0): sz: 245
[13:52:30:113] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x60600014e9b0): sz: 245
[13:52:31:589] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.http] - [http_chuncked_read]: chunked encoding end of stream received
[13:52:31:589] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.arm] - [arm_handle_bad_request]: Got HTTP Response data: {
  "Code": "E_PROXY_ORCHESTRATION_LB_SESSIONHOST_DEALLOCATED",
  "Message": "Session Host with ID = '<id>' has been deallocated we are starting the session host for you. Please retry connecting after 5 minutes.",
  "Target": null,
  "Details": null,
  "InnerError": null
}
[13:52:31:589] [98488:000180c0] [WARN][com.freerdp.core.gateway.arm] - [arm_handle_bad_request]: Session Host with ID = '<id>' has been deallocated we are starting the session host for you. Please retry connecting after 5 minutes.
[13:52:31:589] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.arm] - [arm_resolve_endpoint]: Delay for 15000ms before next attempt
[Thread 0x7fffdc640640 (LWP 98564) exited]
[New Thread 0x7fffdc640640 (LWP 98567)]
[Thread 0x7fffdc640640 (LWP 98567) exited]
[New Thread 0x7fffdc640640 (LWP 98568)]
[13:52:31:781] [98488:000180b8] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_RENDER] OpenGL shaders: ENABLED
[13:52:31:781] [98488:000180b8] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_RENDER] Created renderer: opengl
[13:52:46:623] [98488:000180c0] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: resetting error state
[13:52:46:624] [98488:000180c0] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: connecting to peer <ip-address>
[13:52:46:654] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.arm] - [arm_tls_connect]: connecting to <gateway-domain> 443
[13:52:46:654] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_init]: ringbuffer_init(0x6060001a7f90)
[13:52:46:654] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x60600014e9b0): sz: 31
[13:52:46:654] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x60600014e9b0): sz: 31
[13:52:46:654] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x60600014e9b0): sz: 31
[13:52:46:655] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_destroy]: ringbuffer_destroy(0x60600014e9b0)
[13:52:46:656] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x6060001a7f90): sz: 342
[13:52:46:656] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x6060001a7f90): sz: 342
[13:52:46:656] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x6060001a7f90): sz: 342
[13:52:46:704] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x6060001a7f90): sz: 194
[13:52:46:704] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x6060001a7f90): sz: 194
[13:52:46:704] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x6060001a7f90): sz: 194
[13:52:46:742] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x6060001a7f90): sz: 5122
[13:52:46:742] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x6060001a7f90): sz: 5122
[13:52:46:742] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x6060001a7f90): sz: 5122
[13:52:46:742] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x6060001a7f90): sz: 245
[13:52:46:742] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x6060001a7f90): sz: 245
[13:52:46:742] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x6060001a7f90): sz: 245
[13:52:48:366] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.http] - [http_chuncked_read]: chunked encoding end of stream received
[13:52:48:366] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.arm] - [arm_handle_request_ok]: Got HTTP Response data: {
[REDACTED]
}
[13:52:48:367] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.arm] - [arm_fill_gateway_parameters]: extracted target url <target-url>
[13:52:48:371] [98488:000180c0] [TRACE][com.freerdp.core.redirection] - [rdp_redirection_read_target_cert]: Unknown TargetCertificate field type 32768, encoding 1 of length 32
[13:52:48:371] [98488:000180c0] [TRACE][com.freerdp.core.redirection] - [rdp_redirection_read_target_cert]: Unknown TargetCertificate field type 2, encoding 1 of length 156
[13:52:48:372] [98488:000180c0] [TRACE][com.freerdp.core.redirection] - [rdp_redirection_read_target_cert]: Unknown TargetCertificate field type 3, encoding 1 of length 20
[13:52:48:376] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x6060001a7f90): sz: 31
[13:52:48:376] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x6060001a7f90): sz: 31
[13:52:48:376] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x6060001a7f90): sz: 31
[13:52:48:376] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_destroy]: ringbuffer_destroy(0x6060001a7f90)
[13:52:48:376] [98488:000180c0] [DEBUG][com.freerdp.core.nego] - [nego_set_negotiation_enabled]: Enabling security layer negotiation: TRUE
[13:52:48:376] [98488:000180c0] [DEBUG][com.freerdp.core.nego] - [nego_set_restricted_admin_mode_required]: Enabling restricted admin mode: FALSE
[13:52:48:376] [98488:000180c0] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdp]: Enabling RDP security: FALSE
[13:52:48:376] [98488:000180c0] [DEBUG][com.freerdp.core.nego] - [nego_enable_tls]: Enabling TLS security: FALSE
[13:52:48:376] [98488:000180c0] [DEBUG][com.freerdp.core.nego] - [nego_enable_nla]: Enabling NLA security: FALSE
[13:52:48:376] [98488:000180c0] [DEBUG][com.freerdp.core.nego] - [nego_enable_ext]: Enabling NLA extended security: FALSE
[13:52:48:376] [98488:000180c0] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdstls]: Enabling RDSTLS security: TRUE
[13:52:48:376] [98488:000180c0] [DEBUG][com.freerdp.core.nego] - [nego_enable_aad]: Enabling RDS AAD security: FALSE
[13:52:48:376] [98488:000180c0] [DEBUG][com.freerdp.core.rdp] - [rdp_client_transition_to_state][0x61f000000080]: CONNECTION_STATE_INITIAL --> CONNECTION_STATE_NEGO
[13:52:48:537] [98488:000180c0] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: resetting error state
[13:52:48:537] [98488:000180c0] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: connecting to peer <ip-address>
[13:52:48:575] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.wst] - [wst_tls_connect]: connecting to <gateway-domain> 443
[13:52:48:575] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_init]: ringbuffer_init(0x6060001fee10)
[13:52:48:578] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x6060001fee10): sz: 345
[13:52:48:578] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x6060001fee10): sz: 345
[13:52:48:579] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x6060001fee10): sz: 345
[13:52:48:631] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x6060001fee10): sz: 126
[13:52:48:631] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x6060001fee10): sz: 126
[13:52:48:631] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x6060001fee10): sz: 126
[13:52:48:688] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x6060001fee10): sz: 5623
[13:52:48:688] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x6060001fee10): sz: 5623
[13:52:48:689] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x6060001fee10): sz: 5623
[13:52:48:753] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.wst] - [wst_handle_ok_or_forbidden]: Got Affinity cookie <cookie>
[13:52:48:753] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x6060001fee10): sz: 31
[13:52:48:753] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x6060001fee10): sz: 31
[13:52:48:753] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x6060001fee10): sz: 0
[13:52:48:753] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_destroy]: ringbuffer_destroy(0x6060001fee10)
[13:52:48:787] [98488:000180c0] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: resetting error state
[13:52:48:787] [98488:000180c0] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: connecting to peer <ip-address>
[13:52:48:822] [98488:000180c0] [DEBUG][com.freerdp.core.gateway.wst] - [wst_tls_connect]: connecting to <gateway-domain> 443
[13:52:48:822] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_init]: ringbuffer_init(0x606000202c50)
[13:52:48:824] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x606000202c50): sz: 345
[13:52:48:824] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x606000202c50): sz: 345
[13:52:48:824] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x606000202c50): sz: 345
[13:52:48:865] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x606000202c50): sz: 126
[13:52:48:865] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x606000202c50): sz: 126
[13:52:48:865] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x606000202c50): sz: 126
[13:52:48:904] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x606000202c50): sz: 10612
[13:52:48:905] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x606000202c50): sz: 10612
[13:52:48:905] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x606000202c50): sz: 10612
[13:52:48:955] [98488:000180c0] [DEBUG][com.freerdp.core.nego] - [nego_connect]: state: NEGO_STATE_RDSTLS
[13:52:48:955] [98488:000180c0] [DEBUG][com.freerdp.core.nego] - [nego_attempt_rdstls]: Attempting RDSTLS security
[13:52:48:955] [98488:000180c0] [DEBUG][com.freerdp.core.nego] - [nego_send_negotiation_request]: Adding terminating CRLF to routing token
[13:52:48:955] [98488:000180c0] [DEBUG][com.freerdp.core.nego] - [nego_send_negotiation_request]: RequestedProtocols: 5
[13:52:48:968] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x606000202c50): sz: 145
[13:52:48:968] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x606000202c50): sz: 145
[13:52:48:968] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x606000202c50): sz: 145
[13:52:48:93] [98488:000180c0] [DEBUG][com.freerdp.core.nego] - [nego_process_negotiation_response]: RDP_NEG_RSP::flags = { [0x3f] |EXTENDED_CLIENT_DATA_SUPPORTED|DYNVC_GFX_PROTOCOL_SUPPORTED|RDP_NEGRSP_RESERVED|RESTRICTED_ADMIN_MODE_SUPPORTED|REDIRECTED_AUTHENTICATION_MODE_SUPPORTED|UNKNOWN }
[13:52:48:93] [98488:000180c0] [DEBUG][com.freerdp.core.nego] - [nego_recv]: selected_protocol: 4
[13:52:48:93] [98488:000180c0] [DEBUG][com.freerdp.core.nego] - [nego_attempt_rdstls]: state: NEGO_STATE_FINAL
[13:52:48:93] [98488:000180c0] [DEBUG][com.freerdp.core.nego] - [nego_connect]: Negotiated RDSTLS security
[13:52:48:93] [98488:000180c0] [DEBUG][com.freerdp.core.nego] - [nego_try_connect]: nego_security_connect with PROTOCOL_RDSTLS
[13:52:48:95] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x606000202c50): sz: 375
[13:52:48:95] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x606000202c50): sz: 375
[13:52:48:95] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x606000202c50): sz: 375
[13:52:49:217] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x606000202c50): sz: 355
[13:52:49:218] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x606000202c50): sz: 355
[13:52:49:218] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x606000202c50): sz: 355
[13:52:49:343] [98488:000180c0] [WARN][com.freerdp.crypto] - [verify_cb]: Certificate verification failure 'self-signed certificate (18)' at stack position 0
[13:52:49:343] [98488:000180c0] [WARN][com.freerdp.crypto] - [verify_cb]: CN = <common-name>
[13:52:49:344] [98488:000180c0] [ERROR][com.freerdp.crypto] - [x509_utils_from_pem]: BIO_new failed for certificate
[13:52:49:345] [98488:000180c0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: The host key for <common-name> has changed
[13:52:49:349] [98488:000180c0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: @@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@
[13:52:49:349] [98488:000180c0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: @    WARNING: REMOTE HOST IDENTIFICATION HAS CHANGED!     @
[13:52:49:349] [98488:000180c0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: @@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@
[13:52:49:349] [98488:000180c0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: IT IS POSSIBLE THAT SOMEONE IS DOING SOMETHING NASTY!
[13:52:49:349] [98488:000180c0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: Someone could be eavesdropping on you right now (man-in-the-middle attack)!
[13:52:49:349] [98488:000180c0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: It is also possible that a host key has just been changed.
[13:52:49:349] [98488:000180c0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: The fingerprint for the host key sent by the remote host is <host-key>
[13:52:49:349] [98488:000180c0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: Please contact your system administrator.
[13:52:49:349] [98488:000180c0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: Add correct host key in <path>/<common-name>.pem to get rid of this message.
[13:52:49:349] [98488:000180c0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: Host key for <domain> has changed and you have requested strict checking.
[13:52:49:349] [98488:000180c0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: Host key verification failed.
[Thread 0x7fffdc640640 (LWP 98568) exited]
[Detaching after fork from child process 98569]
[13:56:05:788] [98488:000180c0] [DEBUG][com.freerdp.core.rdstls] - [rdstls_set_state]: -- RDSTLS_STATE_INITIAL  --> RDSTLS_STATE_CAPABILITIES
[13:56:05:791] [98488:000180c0] [DEBUG][com.freerdp.core.rdstls] - [rdstls_set_state]: -- RDSTLS_STATE_CAPABILITIES     --> RDSTLS_STATE_AUTH_REQ
[13:56:05:791] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x606000202c50): sz: 898
[13:56:05:791] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x606000202c50): sz: 898
[13:56:05:792] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x606000202c50): sz: 898
[13:56:05:792] [98488:000180c0] [DEBUG][com.freerdp.core.rdstls] - [rdstls_set_state]: -- RDSTLS_STATE_AUTH_REQ --> RDSTLS_STATE_AUTH_RSP
[13:56:05:792] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x606000202c50): sz: 37
[13:56:05:792] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x606000202c50): sz: 37
[13:56:05:792] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x606000202c50): sz: 37
[13:56:05:847] [98488:000180b8] [DEBUG][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_ERROR] Invalid renderer
[13:56:05:847] [98488:000180b8] [DEBUG][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_ERROR] Invalid window
[New Thread 0x7fffdc640640 (LWP 98721)]
[Thread 0x7fffdc640640 (LWP 98721) exited]
[New Thread 0x7fffdc640640 (LWP 98722)]
[13:56:05:35] [98488:000180b8] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_RENDER] OpenGL shaders: ENABLED
[13:56:05:36] [98488:000180b8] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_RENDER] Created renderer: opengl
[Thread 0x7fffdc640640 (LWP 98722) exited]

********** Clicked the "Close" button **********

[13:57:35:488] [98488:000180b8] [ERROR][com.freerdp.core] - [freerdp_abort_connect_context]: ERRCONNECT_CONNECT_CANCELLED [0x0002000B]
[13:57:35:488] [98488:000180c0] [ERROR][com.freerdp.core.transport] - [transport_connect_rdstls]: RDSTLS authentication failed
[13:57:35:488] [98488:000180c0] [DEBUG][com.freerdp.core.nego] - [nego_connect]: Failed to connect with RDSTLS security
[13:57:35:488] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x606000202c50): sz: 66
[13:57:35:488] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x606000202c50): sz: 66
[13:57:35:488] [98488:000180b8] [DEBUG][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_ERROR] Invalid renderer
[13:57:35:488] [98488:000180b8] [DEBUG][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_ERROR] Invalid window
[13:57:35:488] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x606000202c50): sz: 0
[13:57:35:489] [98488:000180c0] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_destroy]: ringbuffer_destroy(0x606000202c50)
[Thread 0x7fffdd3c8640 (LWP 98497) exited]
[13:57:35:491] [98488:000180c0] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags][0x61f000000080]: [CONNECTION_STATE_NEGO] reset finalize_sc_pdus
[13:57:35:491] [98488:000180c0] [DEBUG][com.freerdp.core.rdp] - [rdp_client_transition_to_state][0x61f000000080]: CONNECTION_STATE_NEGO --> CONNECTION_STATE_INITIAL
[Thread 0x7fffd9673640 (LWP 98503) exited]
[Thread 0x7fffd9e9e640 (LWP 98502) exited]
[Thread 0x7fffda6b5640 (LWP 98501) exited]
[Thread 0x7fffdaeb6640 (LWP 98500) exited]
[Thread 0x7fffd51f1640 (LWP 98511) exited]
[Thread 0x7fffd5a1c640 (LWP 98510) exited]
[Thread 0x7fffd6233640 (LWP 98509) exited]
[Thread 0x7fffd6a5e640 (LWP 98508) exited]
[Thread 0x7fffd7b6c640 (LWP 98506) exited]
[Thread 0x7fffd8375640 (LWP 98505) exited]
[Thread 0x7fffd7355640 (LWP 98507) exited]
[Thread 0x7fffd8b76640 (LWP 98504) exited]
[13:57:35:502] [98488:000180c0] [TRACE][com.freerdp.api] - [freerdp_channels_process_message]: IFCALL(message->Free) == NULL
[Thread 0x7fffe8ad3640 (LWP 98491) exited]
[Thread 0x7fffddc86640 (LWP 98496) exited]
[Thread 0x7fffde4be640 (LWP 98493) exited]
==98488==LeakSanitizer has encountered a fatal error.
==98488==HINT: For debugging, try setting environment variable LSAN_OPTIONS=verbosity=1:log_threads=1
==98488==HINT: LeakSanitizer does not work under ptrace (strace, gdb, etc)
[Inferior 1 (process 98488) exited with code 01]
(gdb) thread apply all bt
(gdb) bt full
No stack.
(gdb)

from freerdp.

progxaker avatar progxaker commented on September 23, 2024

If I wait a bit longer before click the "Close" button, I get an infinite loop of ringbuffer_write and ringbuffer_realloc.

TRACE logs + gdb
[14:34:42:481] [99100:00018322] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x6060001a65b0): sz: 0
[14:34:42:481] [99100:00018322] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x6060001a65b0): sz: 898
[14:34:42:481] [99100:00018322] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_realloc]: ringbuffer_realloc(0x6060001a65b0): targetSize: 38902240
^C[14:34:42:530] [99100:00018322] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_peek]: ringbuffer_peek(0x6060001a65b0): sz: 38901360
[14:34:42:530] [99100:00018322] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_commit_read_bytes]: ringbuffer_commit_read_bytes(0x6060001a65b0): sz: 0
[14:34:42:530] [99100:00018322] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_write]: ringbuffer_write(0x6060001a65b0): sz: 898
[14:34:42:530] [99100:00018322] [DEBUG][com.freerdp.utils.ringbuffer] - [ringbuffer_realloc]: ringbuffer_realloc(0x6060001a65b0): targetSize: 38903138


Thread 1 "sdl-freerdp" received signal SIGINT, Interrupt.
__futex_abstimed_wait_common64 (private=128, cancel=true, abstime=0x0, op=265, expected=99106, futex_word=0x7fffddc86910) at ./nptl/futex-internal.c:57
57      ./nptl/futex-internal.c: No such file or directory.
(gdb) thread apply all bt

Thread 21 (Thread 0x7fffd5383640 (LWP 99121) "sdl-freerdp"):
#0  0x00007ffff5d18bcf in __GI___poll (fds=0x7fffd5382038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x00007ffff5d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x00007ffff65257db in poll (__timeout=<optimized out>, __nfds=<optimized out>, __fds=<optimized out>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=set@entry=0x7fffd5382030, dwMilliseconds=dwMilliseconds@entry=4294967295) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x00007ffff6529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<optimized out>, bWaitAll=<optimized out>, dwMilliseconds=<optimized out>, bAlertable=0) at /FreeRDP/winpr/libwinpr/synch/wait.c:424
#5  0x00007ffff659d5cb in thread_pool_work_func (arg=0x604000030950) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x00007ffff659f84e in thread_launcher (arg=0x614000012240) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x00007ffff5c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x00007ffff5d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 20 (Thread 0x7fffd5b84640 (LWP 99120) "sdl-freerdp"):
#0  0x00007ffff5d18bcf in __GI___poll (fds=0x7fffd5b83038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x00007ffff5d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x00007ffff65257db in poll (__timeout=<optimized out>, __nfds=<optimized out>, __fds=<optimized out>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=set@entry=0x7fffd5b83030, dwMilliseconds=dwMilliseconds@entry=4294967295) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x00007ffff6529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<optimized out>, bWaitAll=<optimized out>, dwMilliseconds=<optimized out>, bAlertable=0) at /FreeRDP/winpr/libwinpr/synch/wait.c:424
#5  0x00007ffff659d5cb in thread_pool_work_func (arg=0x604000030950) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x00007ffff659f84e in thread_launcher (arg=0x614000012040) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x00007ffff5c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x00007ffff5d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 19 (Thread 0x7fffd6385640 (LWP 99119) "sdl-freerdp"):
#0  0x00007ffff5d18bcf in __GI___poll (fds=0x7fffd6384038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x00007ffff5d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x00007ffff65257db in poll (__timeout=<optimized out>, __nfds=<optimized out>, __fds=<optimized out>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=set@entry=0x7fffd6384030, dwMilliseconds=dwMilliseconds@entry=4294967295) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x00007ffff6529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<optimized out>, bWaitAll=<optimized out>, dwMilliseconds=<optimized out>, bAlertable=0) at /FreeRDP/winpr/libwinpr/synch/wait.c:424
#5  0x00007ffff659d5cb in thread_pool_work_func (arg=0x604000030950) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x00007ffff659f84e in thread_launcher (arg=0x614000011e40) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x00007ffff5c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x00007ffff5d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 18 (Thread 0x7fffd6b86640 (LWP 99118) "sdl-freerdp"):
--Type <RET> for more, q to quit, c to continue without paging--c
#0  0x00007ffff5d18bcf in __GI___poll (fds=0x7fffd6b85038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x00007ffff5d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x00007ffff65257db in poll (__timeout=<optimized out>, __nfds=<optimized out>, __fds=<optimized out>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=set@entry=0x7fffd6b85030, dwMilliseconds=dwMilliseconds@entry=4294967295) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x00007ffff6529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<optimized out>, bWaitAll=<optimized out>, dwMilliseconds=<optimized out>, bAlertable=0) at /FreeRDP/winpr/libwinpr/synch/wait.c:424
#5  0x00007ffff659d5cb in thread_pool_work_func (arg=0x604000030950) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x00007ffff659f84e in thread_launcher (arg=0x614000011c40) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x00007ffff5c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x00007ffff5d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 17 (Thread 0x7fffd7387640 (LWP 99117) "sdl-freerdp"):
#0  0x00007ffff5d18bcf in __GI___poll (fds=0x7fffd7386038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x00007ffff5d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x00007ffff65257db in poll (__timeout=<optimized out>, __nfds=<optimized out>, __fds=<optimized out>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=set@entry=0x7fffd7386030, dwMilliseconds=dwMilliseconds@entry=4294967295) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x00007ffff6529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<optimized out>, bWaitAll=<optimized out>, dwMilliseconds=<optimized out>, bAlertable=0) at /FreeRDP/winpr/libwinpr/synch/wait.c:424
#5  0x00007ffff659d5cb in thread_pool_work_func (arg=0x604000030850) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x00007ffff659f84e in thread_launcher (arg=0x614000011840) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x00007ffff5c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x00007ffff5d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 16 (Thread 0x7fffd7b88640 (LWP 99116) "sdl-freerdp"):
#0  0x00007ffff5d18bcf in __GI___poll (fds=0x7fffd7b87038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x00007ffff5d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x00007ffff65257db in poll (__timeout=<optimized out>, __nfds=<optimized out>, __fds=<optimized out>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=set@entry=0x7fffd7b87030, dwMilliseconds=dwMilliseconds@entry=4294967295) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x00007ffff6529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<optimized out>, bWaitAll=<optimized out>, dwMilliseconds=<optimized out>, bAlertable=0) at /FreeRDP/winpr/libwinpr/synch/wait.c:424
#5  0x00007ffff659d5cb in thread_pool_work_func (arg=0x604000030850) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x00007ffff659f84e in thread_launcher (arg=0x614000011640) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x00007ffff5c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x00007ffff5d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 15 (Thread 0x7fffd8389640 (LWP 99115) "sdl-freerdp"):
#0  0x00007ffff5d18bcf in __GI___poll (fds=0x7fffd8388038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x00007ffff5d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x00007ffff65257db in poll (__timeout=<optimized out>, __nfds=<optimized out>, __fds=<optimized out>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=set@entry=0x7fffd8388030, dwMilliseconds=dwMilliseconds@entry=4294967295) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x00007ffff6529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<optimized out>, bWaitAll=<optimized out>, dwMilliseconds=<optimized out>, bAlertable=0) at /FreeRDP/winpr/libwinpr/synch/wait.c:424
#5  0x00007ffff659d5cb in thread_pool_work_func (arg=0x604000030850) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x00007ffff659f84e in thread_launcher (arg=0x614000011440) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x00007ffff5c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x00007ffff5d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 14 (Thread 0x7fffd8b8a640 (LWP 99114) "sdl-freerdp"):
#0  0x00007ffff5d18bcf in __GI___poll (fds=0x7fffd8b89038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x00007ffff5d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x00007ffff65257db in poll (__timeout=<optimized out>, __nfds=<optimized out>, __fds=<optimized out>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=set@entry=0x7fffd8b89030, dwMilliseconds=dwMilliseconds@entry=4294967295) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x00007ffff6529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<optimized out>, bWaitAll=<optimized out>, dwMilliseconds=<optimized out>, bAlertable=0) at /FreeRDP/winpr/libwinpr/synch/wait.c:424
#5  0x00007ffff659d5cb in thread_pool_work_func (arg=0x604000030850) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x00007ffff659f84e in thread_launcher (arg=0x614000011240) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x00007ffff5c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x00007ffff5d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 13 (Thread 0x7fffd9675640 (LWP 99113) "sdl-freerdp"):
#0  0x00007ffff5d18bcf in __GI___poll (fds=0x7fffd9674038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x00007ffff5d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x00007ffff65257db in poll (__timeout=<optimized out>, __nfds=<optimized out>, __fds=<optimized out>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=set@entry=0x7fffd9674030, dwMilliseconds=dwMilliseconds@entry=4294967295) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x00007ffff6529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<optimized out>, bWaitAll=<optimized out>, dwMilliseconds=<optimized out>, bAlertable=0) at /FreeRDP/winpr/libwinpr/synch/wait.c:424
#5  0x00007ffff659d5cb in thread_pool_work_func (arg=0x6040000306d0) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x00007ffff659f84e in thread_launcher (arg=0x614000011040) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x00007ffff5c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x00007ffff5d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 12 (Thread 0x7fffd9eb4640 (LWP 99112) "sdl-freerdp"):
#0  0x00007ffff5d18bcf in __GI___poll (fds=0x7fffd9eb3038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x00007ffff5d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x00007ffff65257db in poll (__timeout=<optimized out>, __nfds=<optimized out>, __fds=<optimized out>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=set@entry=0x7fffd9eb3030, dwMilliseconds=dwMilliseconds@entry=4294967295) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x00007ffff6529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<optimized out>, bWaitAll=<optimized out>, dwMilliseconds=<optimized out>, bAlertable=0) at /FreeRDP/winpr/libwinpr/synch/wait.c:424
#5  0x00007ffff659d5cb in thread_pool_work_func (arg=0x6040000306d0) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x00007ffff659f84e in thread_launcher (arg=0x614000010e40) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x00007ffff5c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x00007ffff5d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 11 (Thread 0x7fffda6b5640 (LWP 99111) "sdl-freerdp"):
#0  0x00007ffff5d18bcf in __GI___poll (fds=0x7fffda6b4038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x00007ffff5d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x00007ffff65257db in poll (__timeout=<optimized out>, __nfds=<optimized out>, __fds=<optimized out>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=set@entry=0x7fffda6b4030, dwMilliseconds=dwMilliseconds@entry=4294967295) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x00007ffff6529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<optimized out>, bWaitAll=<optimized out>, dwMilliseconds=<optimized out>, bAlertable=0) at /FreeRDP/winpr/libwinpr/synch/wait.c:424
#5  0x00007ffff659d5cb in thread_pool_work_func (arg=0x6040000306d0) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x00007ffff659f84e in thread_launcher (arg=0x614000010c40) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x00007ffff5c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x00007ffff5d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 10 (Thread 0x7fffdaf96640 (LWP 99110) "sdl-freerdp"):
#0  0x00007ffff5d18bcf in __GI___poll (fds=0x7fffdaf95038, nfds=2, timeout=-1) at ../sysdeps/unix/sysv/linux/poll.c:29
#1  0x00007ffff5d364f2 in __poll_chk (fds=<optimized out>, nfds=<optimized out>, timeout=<optimized out>, fdslen=fdslen@entry=18446744073709551615) at ./debug/poll_chk.c:27
#2  0x00007ffff65257db in poll (__timeout=<optimized out>, __nfds=<optimized out>, __fds=<optimized out>) at /usr/include/x86_64-linux-gnu/bits/poll2.h:39
#3  pollset_poll (set=set@entry=0x7fffdaf95030, dwMilliseconds=dwMilliseconds@entry=4294967295) at /FreeRDP/winpr/libwinpr/synch/pollset.c:143
#4  0x00007ffff6529c17 in WaitForMultipleObjectsEx (nCount=<optimized out>, lpHandles=<optimized out>, bWaitAll=<optimized out>, dwMilliseconds=<optimized out>, bAlertable=0) at /FreeRDP/winpr/libwinpr/synch/wait.c:424
#5  0x00007ffff659d5cb in thread_pool_work_func (arg=0x6040000306d0) at /FreeRDP/winpr/libwinpr/pool/pool.c:75
#6  0x00007ffff659f84e in thread_launcher (arg=0x614000010a40) at /FreeRDP/winpr/libwinpr/thread/thread.c:528
#7  0x00007ffff5c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#8  0x00007ffff5d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 6 (Thread 0x7fffddc86640 (LWP 99106) "sdl-freerdp"):
#0  0x00007ffff74cde5b in __sanitizer::internal_munmap(void*, unsigned long) (addr=addr@entry=0x7fffcbfe0000, length=length@entry=38907904) at ../../../../src/libsanitizer/sanitizer_common/sanitizer_linux.cpp:184
#1  0x00007ffff74d0e7f in __sanitizer::UnmapOrDie(void*, unsigned long) (addr=0x7fffcbfe0000, size=38907904) at ../../../../src/libsanitizer/sanitizer_common/sanitizer_posix.cpp:57
#2  0x00007ffff742aca6 in __sanitizer::LargeMmapAllocator<__asan::AsanMapUnmapCallback, __sanitizer::LargeMmapAllocatorPtrArrayDynamic, __sanitizer::LocalAddressSpaceView>::Deallocate(__sanitizer::AllocatorStats*, void*) (p=0x7fffcbfe1000, stat=0x7ffff75350a0 <__asan::instance+672>, this=0x7ffff7534e30 <__asan::instance+48>) at ../../../../src/libsanitizer/sanitizer_common/sanitizer_allocator_secondary.h:150
#3  0x00007ffff742b384 in __asan::QuarantineCallback::Recycle(__asan::AsanChunk*) (m=<optimized out>, this=<synthetic pointer>) at ../../../../src/libsanitizer/asan/asan_allocator.cpp:869
#4  __sanitizer::Quarantine<__asan::QuarantineCallback, __asan::AsanChunk>::DoRecycle(__sanitizer::QuarantineCache<__asan::QuarantineCallback>*, __asan::QuarantineCallback) (c=c@entry=0x7fffddc833b0, cb=..., this=0x7ffff75350c8 <__asan::instance+712>) at ../../../../src/libsanitizer/sanitizer_common/sanitizer_quarantine.h:192
#5  0x00007ffff742b6ee in __sanitizer::Quarantine<__asan::QuarantineCallback, __asan::AsanChunk>::Recycle(unsigned long, __asan::QuarantineCallback) (this=this@entry=0x7ffff75350c8 <__asan::instance+712>, min_size=241591905, cb=...) at ../../../../src/libsanitizer/sanitizer_common/sanitizer_quarantine.h:180
#6  0x00007ffff742b89c in __sanitizer::Quarantine<__asan::QuarantineCallback, __asan::AsanChunk>::Drain(__sanitizer::QuarantineCache<__asan::QuarantineCallback>*, __asan::QuarantineCallback) (this=this@entry=0x7ffff75350c8 <__asan::instance+712>, c=c@entry=0x7fffe76f6060, cb=...) at ../../../../src/libsanitizer/sanitizer_common/sanitizer_quarantine.h:121
#7  0x00007ffff74289a0 in __sanitizer::Quarantine<__asan::QuarantineCallback, __asan::AsanChunk>::Put(__sanitizer::QuarantineCache<__asan::QuarantineCallback>*, __asan::QuarantineCallback, __asan::AsanChunk*, unsigned long) (size=<optimized out>, ptr=0x7fffbbaa97f0, cb=..., c=0x7fffe76f6060, this=<optimized out>) at ../../../../src/libsanitizer/sanitizer_common/sanitizer_quarantine.h:112
#8  __asan::Allocator::QuarantineChunk(__asan::AsanChunk*, void*, __sanitizer::BufferedStackTrace*) (this=this@entry=0x7ffff7534e00 <__asan::instance>, m=m@entry=0x7fffbbaa97f0, stack=stack@entry=0x7fffddc834e0, ptr=0x7fffbbaa9800) at ../../../../src/libsanitizer/asan/asan_allocator.cpp:666
#9  0x00007ffff7428dbf in __asan::Allocator::Deallocate(void*, unsigned long, unsigned long, __sanitizer::BufferedStackTrace*, __asan::AllocType) (alloc_type=__asan::FROM_MALLOC, stack=0x7fffddc834e0, delete_alignment=0, delete_size=0, ptr=0x7fffbbaa9800, this=0x7ffff7534e00 <__asan::instance>) at ../../../../src/libsanitizer/asan/asan_allocator.cpp:714
#10 __asan::Allocator::Reallocate(void*, unsigned long, __sanitizer::BufferedStackTrace*) (stack=0x7fffddc834e0, new_size=38903138, old_ptr=0x7fffbbaa9800, this=0x7ffff7534e00 <__asan::instance>) at ../../../../src/libsanitizer/asan/asan_allocator.cpp:737
#11 __asan::asan_realloc(void*, unsigned long, __sanitizer::BufferedStackTrace*) (p=p@entry=0x7fffbbaa9800, size=size@entry=38903138, stack=stack@entry=0x7fffddc834e0) at ../../../../src/libsanitizer/asan/asan_allocator.cpp:1009
#12 0x00007ffff74b4c15 in __interceptor_realloc(void*, __sanitizer::uptr) (ptr=0x7fffbbaa9800, size=size@entry=38903138) at ../../../../src/libsanitizer/asan/asan_malloc_linux.cpp:165
#13 0x00007ffff69768e4 in ringbuffer_realloc (rb=rb@entry=0x6060001a65b0, targetSize=38903138) at /FreeRDP/libfreerdp/utils/ringbuffer.c:100
#14 0x00007ffff6976bfb in ringbuffer_write (rb=0x6060001a65b0, ptr=0x629000271203 "\027<somebytes>\036", sz=898) at /FreeRDP/libfreerdp/utils/ringbuffer.c:167
#15 0x00007ffff6b19108 in transport_bio_buffered_write (bio=<optimized out>, buf=0x629000271203 "\027<somebytes>\036", num=<optimized out>) at /FreeRDP/libfreerdp/core/tcp.c:489
#16 0x00007ffff56d231b in  () at /lib/x86_64-linux-gnu/libcrypto.so.3
#17 0x00007ffff56d5c26 in  () at /lib/x86_64-linux-gnu/libcrypto.so.3
#18 0x00007ffff56d5d57 in BIO_write () at /lib/x86_64-linux-gnu/libcrypto.so.3
#19 0x00007ffff6fa8e5e in  () at /lib/x86_64-linux-gnu/libssl.so.3
#20 0x00007ffff6fab8f9 in  () at /lib/x86_64-linux-gnu/libssl.so.3
#21 0x00007ffff6f8f267 in SSL_write () at /lib/x86_64-linux-gnu/libssl.so.3
#22 0x00007ffff6a14de9 in bio_rdp_tls_write (bio=0x60d0003ae500, buf=0x61800001cc80 "\202<somebytes>\340v:"..., size=869) at /FreeRDP/libfreerdp/crypto/tls.c:127
#23 0x00007ffff56d231b in  () at /lib/x86_64-linux-gnu/libcrypto.so.3
#24 0x00007ffff56d5c26 in  () at /lib/x86_64-linux-gnu/libcrypto.so.3
#25 0x00007ffff56d5d57 in BIO_write () at /lib/x86_64-linux-gnu/libcrypto.so.3
#26 0x00007ffff6bce35a in websocket_write_all (length=869, data=0x61800001cc80 "\202<somebytes>\340v:"..., bio=0x60d0003ae500) at /FreeRDP/libfreerdp/core/gateway/websocket.c:112
#27 websocket_write (opcode=WebsocketBinaryOpcode, isize=<optimized out>, buf=<optimized out>, bio=<optimized out>) at /FreeRDP/libfreerdp/core/gateway/websocket.c:201
#28 wst_bio_write (bio=<optimized out>, buf=<optimized out>, num=<optimized out>) at /FreeRDP/libfreerdp/core/gateway/wst.c:542
#29 0x00007ffff56d231b in  () at /lib/x86_64-linux-gnu/libcrypto.so.3
#30 0x00007ffff56d5c26 in  () at /lib/x86_64-linux-gnu/libcrypto.so.3
#31 0x00007ffff56d5d57 in BIO_write () at /lib/x86_64-linux-gnu/libcrypto.so.3
#32 0x00007ffff6fa8e5e in  () at /lib/x86_64-linux-gnu/libssl.so.3
#33 0x00007ffff6fab8f9 in  () at /lib/x86_64-linux-gnu/libssl.so.3
#34 0x00007ffff6f8f267 in SSL_write () at /lib/x86_64-linux-gnu/libssl.so.3
#35 0x00007ffff6a14de9 in bio_rdp_tls_write (bio=0x60d0003afa20, buf=0x621000192900 "\001", size=832) at /FreeRDP/libfreerdp/crypto/tls.c:127
#36 0x00007ffff56d231b in  () at /lib/x86_64-linux-gnu/libcrypto.so.3
#37 0x00007ffff56d5c26 in  () at /lib/x86_64-linux-gnu/libcrypto.so.3
#38 0x00007ffff56d5d57 in BIO_write () at /lib/x86_64-linux-gnu/libcrypto.so.3
#39 0x00007ffff6b3c71c in transport_default_write (transport=0x617000000080, s=0x6060001a9f00) at /FreeRDP/libfreerdp/core/transport.c:1159
#40 0x00007ffff6b86299 in transport_write (s=0x6060001a9f00, transport=<optimized out>) at /FreeRDP/libfreerdp/core/transport.c:1119
#41 rdstls_send (transport=<optimized out>, s=s@entry=0x6060001a9f00, extra=extra@entry=0x6040000f9d90) at /FreeRDP/libfreerdp/core/rdstls.c:591
#42 0x00007ffff6b917a5 in rdstls_send_authentication_request (rdstls=0x6040000f9d90) at /FreeRDP/libfreerdp/core/rdstls.c:774
#43 rdstls_client_authenticate (rdstls=0x6040000f9d90) at /FreeRDP/libfreerdp/core/rdstls.c:842
#44 rdstls_authenticate (rdstls=0x6040000f9d90) at /FreeRDP/libfreerdp/core/rdstls.c:865
#45 0x00007ffff6a5c317 in transport_connect_rdstls (transport=0x617000000080) at /FreeRDP/libfreerdp/core/transport.c:414
#46 nego_try_connect (nego=0x611000011480) at /FreeRDP/libfreerdp/core/nego.c:311
#47 0x00007ffff6ada00c in nego_security_connect (nego=0x611000011480) at /FreeRDP/libfreerdp/core/nego.c:347
#48 nego_connect (nego=0x611000011480) at /FreeRDP/libfreerdp/core/nego.c:282
#49 rdp_client_connect (rdp=0x616000000680) at /FreeRDP/libfreerdp/core/connection.c:430
#50 0x00007ffff6aae729 in freerdp_connect_begin (instance=0x616000000380) at /FreeRDP/libfreerdp/core/freerdp.c:156
#51 freerdp_connect (instance=0x616000000380) at /FreeRDP/libfreerdp/core/freerdp.c:174
#52 0x000055555558828d in sdl_client_thread_proc(SdlContext*) (sdl=0x613000000580) at /FreeRDP/client/SDL/sdl_freerdp.cpp:1166
#53 0x00007ffff60e62b3 in  () at /lib/x86_64-linux-gnu/libstdc++.so.6
#54 0x00007ffff5c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#55 0x00007ffff5d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 3 (Thread 0x7fffde4be640 (LWP 99103) "sdl-fre:disk$0"):
#0  __futex_abstimed_wait_common64 (private=0, cancel=true, abstime=0x0, op=393, expected=0, futex_word=0x616000001f20) at ./nptl/futex-internal.c:57
#1  __futex_abstimed_wait_common (cancel=true, private=0, abstime=0x0, clockid=0, expected=0, futex_word=0x616000001f20) at ./nptl/futex-internal.c:87
#2  __GI___futex_abstimed_wait_cancelable64 (futex_word=futex_word@entry=0x616000001f20, expected=expected@entry=0, clockid=clockid@entry=0, abstime=abstime@entry=0x0, private=private@entry=0) at ./nptl/futex-internal.c:139
#3  0x00007ffff5c93a41 in __pthread_cond_wait_common (abstime=0x0, clockid=0, mutex=0x616000001ed0, cond=0x616000001ef8) at ./nptl/pthread_cond_wait.c:503
#4  ___pthread_cond_wait (cond=0x616000001ef8, mutex=0x616000001ed0) at ./nptl/pthread_cond_wait.c:627
#5  0x00007fffe571952d in  () at /usr/lib/x86_64-linux-gnu/dri/crocus_dri.so
#6  0x00007fffe56c98bb in  () at /usr/lib/x86_64-linux-gnu/dri/crocus_dri.so
#7  0x00007fffe571945b in  () at /usr/lib/x86_64-linux-gnu/dri/crocus_dri.so
#8  0x00007ffff5c94ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#9  0x00007ffff5d26850 in clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:81

Thread 1 (Thread 0x7fffec611140 (LWP 99100) "sdl-freerdp"):
#0  __futex_abstimed_wait_common64 (private=128, cancel=true, abstime=0x0, op=265, expected=99106, futex_word=0x7fffddc86910) at ./nptl/futex-internal.c:57
#1  __futex_abstimed_wait_common (cancel=true, private=128, abstime=0x0, clockid=0, expected=99106, futex_word=0x7fffddc86910) at ./nptl/futex-internal.c:87
#2  __GI___futex_abstimed_wait_cancelable64 (futex_word=futex_word@entry=0x7fffddc86910, expected=99106, clockid=clockid@entry=0, abstime=abstime@entry=0x0, private=private@entry=128) at ./nptl/futex-internal.c:139
#3  0x00007ffff5c96624 in __pthread_clockjoin_ex (threadid=140736914286144, thread_return=0x0, clockid=0, abstime=0x0, block=<optimized out>) at ./nptl/pthread_join_common.c:105
#4  0x00007ffff60e6327 in std::thread::join() () at /lib/x86_64-linux-gnu/libstdc++.so.6
#5  0x00005555555893e7 in sdl_client_stop(rdpContext*) (context=<optimized out>) at /FreeRDP/client/SDL/sdl_freerdp.cpp:1412
#6  0x0000555555570eff in main(int, char**) (argc=<optimized out>, argv=<optimized out>) at /FreeRDP/client/SDL/sdl_freerdp.cpp:1651
(gdb)

from freerdp.

akallabeth avatar akallabeth commented on September 23, 2024

@progxaker rereading this issue, are you sure the connection did already work?
windows systems starting up sometimes take a very long time before they actually show the login screen (even over RDP, not deterministic most of the time though)

from freerdp.

progxaker avatar progxaker commented on September 23, 2024

Hi @akallabeth. I think yes, it did, but I'll check again to be sure. Do I understand correctly that it will be enough to just click "Permanent" once the host key window appears and then see if the connection is established, or will FreePRD keep trying to starting up an AVD instance?

from freerdp.

akallabeth avatar akallabeth commented on September 23, 2024

@progxaker yes, that accepts the certificate permanently.
the issue here is that you

  1. connect to the management interface and issue a start command as the VM is shut down.
  2. wait until the VM is in state ready (polling)
  3. connect to the VM (this is most likely where you get the certificate warning)

so it should only try to start an instance if it was shut down before.

from freerdp.

progxaker avatar progxaker commented on September 23, 2024

Hello @akallabeth. Is there any action required of me?

from freerdp.

akallabeth avatar akallabeth commented on September 23, 2024

@progxaker well, no.
so can close this as resolved?

from freerdp.

progxaker avatar progxaker commented on September 23, 2024

@akallabeth yes, you can if you want to close the issue with the wont-fix label.
P.S. The issue is still reproducible.

from freerdp.

akallabeth avatar akallabeth commented on September 23, 2024

@progxaker ok? did sound as resolved from your last statements.
do you have a log of such a test? (not the successful ones like above)

from freerdp.

progxaker avatar progxaker commented on September 23, 2024

@akallabeth

ok? did sound as resolved from your last statements.

Not really. I stated that if a user clicks the button within a minute, FreeRDP will connect to an AVD instance w/o problem.
But

the problem only occurs if a user waits for more than 1 minute (that's what we tested, but a shorter delay is possible) and then clicks the button.

Screenshots
  • Wait 0
  • Wait 1
  • Wait 2
  • Wait 3
  • New certificate
  • Wait 3 again

do you have a log of such a test? (not the successful ones like above)

freerdp-hangs.log

from freerdp.

akallabeth avatar akallabeth commented on September 23, 2024

ok, did improve logging a bit with #10287 to replace magic numbers with readable strings.

anyway, the log includes the following:

  1. OAUTH2 with Browse to: https://login.microsoftonline.com/common/oauth2/v2.0/authorize
  2. trigger VM startup ([arm_handle_bad_request]: Session Host with ID = '[REDACTED]' has been deallocated we are starting the session host for you. Please retry connecting after 5 minutes.) repeated message until reachable
  3. get the new VM certificagte
  4. RDSTLS auth successful
  5. no more data from remote

this is strange as there is no failure indication for authentication in the log so this means it succeeded but then the remote did not initiate the session.
maybe some timeout reached (server side, did you configure something there?) and the connection was already dropped due to being idle?

I guess the connection then terminates after the timeout? (somehow the termination messages are missing from your logs)

from freerdp.

progxaker avatar progxaker commented on September 23, 2024

maybe some timeout reached (server side, did you configure something there?) and the connection was already dropped due to being idle?

Perhaps, but as far as I understand, at this point (when the certification check failed) we have already initialized the session, all that is left is to wait for Permanent/Temporary signals from a user to continue the connection (at this point, as you could saw in the screenshots in my previous comment, the reconnect window has returned when the websocket viewer window normally appears) or Cancel/Close signals to abort the initialization.
If we don't get any ideas, I might try looking at network traffic.

did you configure something there?

No, I didn't.

I guess the connection then terminates after the timeout? (somehow the termination messages are missing from your logs)

No, I terminated FreeRDP manually with Ctrl+C.
Today I clicked "Close" in the reconnect window instead and the latest logs were as follows:

  1. The certificate window appeared.
  2. I waited 3 minutes.
  3. Clicked "Permanent".
  4. The certificate window disappeared.
  5. The reconnect window appeared.
  6. Waited 10 minutes (to check if there is a time out limit; as a result, no, the problem is not related to timeout).
  7. Clicked "Close".
Details
[08:30:59:139] [142009:00022ac0] [WARN][com.freerdp.crypto] - [verify_cb]: Certificate verification failure 'self-signed certificate (18)' at stack position 0
[08:30:59:139] [142009:00022ac0] [WARN][com.freerdp.crypto] - [verify_cb]: CN = [REDACTED]
[08:30:59:140] [142009:00022ac0] [ERROR][com.freerdp.crypto] - [x509_utils_from_pem]: BIO_new failed for certificate
[08:30:59:140] [142009:00022ac0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: The host key for [REDACTED]:3389 has changed
[08:30:59:140] [142009:00022ac0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: @@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@
[08:30:59:140] [142009:00022ac0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: @    WARNING: REMOTE HOST IDENTIFICATION HAS CHANGED!     @
[08:30:59:140] [142009:00022ac0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: @@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@
[08:30:59:141] [142009:00022ac0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: IT IS POSSIBLE THAT SOMEONE IS DOING SOMETHING NASTY!
[08:30:59:141] [142009:00022ac0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: Someone could be eavesdropping on you right now (man-in-the-middle attack)!
[08:30:59:141] [142009:00022ac0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: It is also possible that a host key has just been changed.
[08:30:59:141] [142009:00022ac0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: The fingerprint for the host key sent by the remote host is [REDACTED]
[08:30:59:141] [142009:00022ac0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: Please contact your system administrator.
[08:30:59:141] [142009:00022ac0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: Add correct host key in [REDACTED]_3389.pem to get rid of this message.
[08:30:59:141] [142009:00022ac0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: Host key for [REDACTED] has changed and you have requested strict checking.
[08:30:59:141] [142009:00022ac0] [ERROR][com.freerdp.crypto] - [tls_print_new_certificate_warn]: Host key verification failed.
ertificate field type 2, encoding 1 of length 156
[08:30:57:410] [142009:00022ac0] [TRACE][com.freerdp.core.redirection] - [rdp_redirection_read_target_cert]: Unknown TargetCertificate field type 3, encoding 1 of length 20
[08:30:57:413] [142009:00022ac0] [DEBUG][com.freerdp.core.nego] - [nego_set_negotiation_enabled]: Enabling security layer negotiation: TRUE
[08:30:57:413] [142009:00022ac0] [DEBUG][com.freerdp.core.nego] - [nego_set_restricted_admin_mode_required]: Enabling restricted admin mode: FALSE
[08:30:57:413] [142009:00022ac0] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdp]: Enabling RDP security: FALSE
[08:30:57:413] [142009:00022ac0] [DEBUG][com.freerdp.core.nego] - [nego_enable_tls]: Enabling TLS security: FALSE
[08:30:57:413] [142009:00022ac0] [DEBUG][com.freerdp.core.nego] - [nego_enable_nla]: Enabling NLA security: FALSE
[08:30:57:413] [142009:00022ac0] [DEBUG][com.freerdp.core.nego] - [nego_enable_ext]: Enabling NLA extended security: FALSE
[08:30:57:413] [142009:00022ac0] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdstls]: Enabling RDSTLS security: TRUE
[08:30:57:413] [142009:00022ac0] [DEBUG][com.freerdp.core.nego] - [nego_enable_aad]: Enabling RDS AAD security: FALSE
[08:30:57:413] [142009:00022ac0] [DEBUG][com.freerdp.core.rdp] - [rdp_client_transition_to_state][0x56a515083280]: CONNECTION_STATE_INITIAL --> CONNECTION_STATE_NEGO
[08:30:58:550] [142009:00022ac0] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: resetting error state
[08:30:58:550] [142009:00022ac0] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: connecting to peer [REDACTED]
[08:30:58:580] [142009:00022ac0] [DEBUG][com.freerdp.core.gateway.wst] - [wst_tls_connect]: connecting to [REDACTED] 443
[08:30:58:709] [142009:00022ac0] [DEBUG][com.freerdp.core.gateway.wst] - [wst_handle_ok_or_forbidden]: Got Affinity cookie [REDACTED]
[08:30:58:743] [142009:00022ac0] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: resetting error state
[08:30:58:743] [142009:00022ac0] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: connecting to peer [REDACTED]
[08:30:58:772] [142009:00022ac0] [DEBUG][com.freerdp.core.gateway.wst] - [wst_tls_connect]: connecting to [REDACTED]
[08:30:58:897] [142009:00022ac0] [DEBUG][com.freerdp.core.nego] - [nego_connect]: state: NEGO_STATE_RDSTLS
[08:30:58:897] [142009:00022ac0] [DEBUG][com.freerdp.core.nego] - [nego_attempt_rdstls]: Attempting RDSTLS security
[08:30:58:897] [142009:00022ac0] [DEBUG][com.freerdp.core.nego] - [nego_send_negotiation_request]: Adding terminating CRLF to routing token
[08:30:58:897] [142009:00022ac0] [DEBUG][com.freerdp.core.nego] - [nego_send_negotiation_request]: RequestedProtocols: [SSL|RDSTLS][0x00000005]
[08:30:59:861] [142009:00022ac0] [DEBUG][com.freerdp.core.nego] - [nego_process_negotiation_response]: RDP_NEG_RSP::flags = { [0x3f] |EXTENDED_CLIENT_DATA_SUPPORTED|DYNVC_GFX_PROTOCOL_SUPPORTED|RDP_NEGRSP_RESERVED|RESTRICTED_ADMIN_MODE_SUPPORTED|REDIRECTED_AUTHENTICATION_MODE_SUPPORTED|UNKNOWN }
[08:30:59:861] [142009:00022ac0] [DEBUG][com.freerdp.core.nego] - [nego_recv]: selected_protocol: [RDSTLS][0x00000004]
[08:30:59:861] [142009:00022ac0] [DEBUG][com.freerdp.core.nego] - [nego_attempt_rdstls]: state: NEGO_STATE_FINAL
[08:30:59:861] [142009:00022ac0] [DEBUG][com.freerdp.core.nego] - [nego_connect]: Negotiated [RDSTLS][0x00000004] security
[08:30:59:861] [142009:00022ac0] [DEBUG][com.freerdp.core.nego] - [nego_try_connect]: nego_security_connect with PROTOCOL_RDSTLS
[08:30:59:141] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_USEREVENT_RETRY_DIALOG [0x0000800e]
[08:30:59:154] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_USEREVENT_RETRY_DIALOG [0x0000800e]
[08:30:59:154] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_USEREVENT_CERT_DIALOG [0x0000800a]
[08:33:04:923] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_WINDOWEVENT [0x00000200]
[08:33:04:924] [142009:00022ac0] [DEBUG][com.freerdp.core.rdstls] - [rdstls_set_state]: -- RDSTLS_STATE_INITIAL	--> RDSTLS_STATE_CAPABILITIES
[08:33:04:924] [142009:00022ac0] [DEBUG][com.freerdp.core.rdstls] - [rdstls_set_state]: -- RDSTLS_STATE_CAPABILITIES	--> RDSTLS_STATE_AUTH_REQ
[08:33:04:924] [142009:00022ac0] [DEBUG][com.freerdp.core.rdstls] - [rdstls_set_state]: -- RDSTLS_STATE_AUTH_REQ	--> RDSTLS_STATE_AUTH_RSP
[08:33:04:940] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_WINDOWEVENT [0x00000200]
[08:33:04:940] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_USEREVENT_RETRY_DIALOG [0x0000800e]
[08:33:04:940] [142009:00022ab9] [DEBUG][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_ERROR] Invalid renderer
[08:33:04:940] [142009:00022ab9] [DEBUG][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_ERROR] Invalid window
[08:33:04:050] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_RENDER] OpenGL shaders: ENABLED
[08:33:04:051] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_RENDER] Created renderer: opengl
[08:33:04:062] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_USEREVENT_RETRY_DIALOG [0x0000800e]
[08:33:04:062] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_KEYMAPCHANGED [0x00000304]
[08:33:04:062] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_KEYMAPCHANGED [0x00000304]
[08:33:04:062] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_WINDOWEVENT [0x00000200]
[08:33:04:083] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_WINDOWEVENT [0x00000200]
[08:33:04:094] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_WINDOWEVENT [0x00000200]
[08:33:04:104] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_WINDOWEVENT [0x00000200]
[08:33:04:110] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_WINDOWEVENT [0x00000200]
[08:33:04:127] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_WINDOWEVENT [0x00000200]
[08:33:04:133] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:04:143] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_WINDOWEVENT [0x00000200]
[08:33:04:162] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_WINDOWEVENT [0x00000200]
[08:33:06:601] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:617] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:628] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:642] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:656] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:670] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:684] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:698] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:712] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:726] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:740] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:754] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:767] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:781] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:823] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:836] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:849] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:915] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:928] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:008] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:141] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:154] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:167] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:181] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:193] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:225] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:33:06:231] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_WINDOWEVENT [0x00000200]
[08:44:32:421] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_WINDOWEVENT [0x00000200]
[08:44:32:431] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:32:439] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:33:450] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:33:460] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:33:472] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:33:486] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:33:500] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:33:512] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:33:579] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:33:592] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:33:605] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:33:659] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:33:672] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:33:685] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:33:699] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:33:707] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_WINDOWEVENT [0x00000200]
[08:44:37:305] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_WINDOWEVENT [0x00000200]
[08:44:37:315] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:37:323] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:37:331] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:37:344] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:37:413] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:37:426] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:38:453] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:38:480] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEMOTION [0x00000400]
[08:44:38:520] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MO
[08:44:38:095] [142009:00022ab9] [ERROR][com.freerdp.core] - [freerdp_abort_connect_context]: ERRCONNECT_CONNECT_CANCELLED [0x0002000B]
[08:44:38:095] [142009:00022ac0] [ERROR][com.freerdp.core.transport] - [transport_connect_rdstls]: RDSTLS authentication failed
USEMOTION [0x00000400]
[08:44:38:980] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_KEYMAPCHANGED [0x00000304]
[08:44:38:980] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEBUTTONDOWN [0x00000401]
[08:44:38:080] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_MOUSEBUTTONUP [0x00000402]
[08:44:38:088] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_KEYMAPCHANGED [0x00000304]
[08:44:38:088] [142009:00022ab9] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_QUIT [0x00000100]
[08:44:38:096] [142009:00022ac0] [DEBUG][com.freerdp.core.nego] - [nego_connect]: Failed to connect with [RDSTLS][0x00000004] security
[08:44:38:097] [142009:00022ab9] [DEBUG][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_ERROR] Invalid renderer
[08:44:38:097] [142009:00022ab9] [DEBUG][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_ERROR] Invalid window
[08:44:38:098] [142009:00022ac0] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags][0x56a515083280]: [CONNECTION_STATE_NEGO] reset finalize_sc_pdus
[08:44:38:098] [142009:00022ac0] [DEBUG][com.freerdp.core.rdp] - [rdp_client_transition_to_state][0x56a515083280]: CONNECTION_STATE_NEGO --> CONNECTION_STATE_INITIAL
[08:44:38:107] [142009:00022ac0] [TRACE][com.freerdp.api] - [freerdp_channels_process_message]: IFCALL(message->Free) == NULL

from freerdp.

progxaker avatar progxaker commented on September 23, 2024

Hello @akallabeth. The fix may be working, but now the TLS certification window doesn't appear (and the reconnect window is still there when before it disappeared and the TLS window appeared), and after 15 seconds the connection times out.

[09:36:14:540] [71368:000116db] [DEBUG][com.freerdp.core.gateway.arm] - [arm_fill_gateway_parameters]: extracted target url [REDACTED]
[09:36:14:545] [71368:000116db] [TRACE][com.freerdp.core.redirection] - [rdp_redirection_read_target_cert]: Unknown TargetCertificate field type 32768, encoding 1 of length 32
[09:36:14:545] [71368:000116db] [TRACE][com.freerdp.core.redirection] - [rdp_redirection_read_target_cert]: Unknown TargetCertificate field type 2, encoding 1 of length 156
[09:36:14:545] [71368:000116db] [TRACE][com.freerdp.core.redirection] - [rdp_redirection_read_target_cert]: Unknown TargetCertificate field type 3, encoding 1 of length 20
[09:36:14:548] [71368:000116db] [DEBUG][com.freerdp.core.nego] - [nego_set_negotiation_enabled]: Enabling security layer negotiation: TRUE
[09:36:14:548] [71368:000116db] [DEBUG][com.freerdp.core.nego] - [nego_set_restricted_admin_mode_required]: Enabling restricted admin mode: FALSE
[09:36:14:548] [71368:000116db] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdp]: Enabling RDP security: FALSE
[09:36:14:548] [71368:000116db] [DEBUG][com.freerdp.core.nego] - [nego_enable_tls]: Enabling TLS security: FALSE
[09:36:14:548] [7[09:36:32:700] [71368:000116db] [ERROR][com.freerdp.core.gateway.http] - [http_response_recv]: [BIO_wait] timeout exceeded
[09:36:32:704] [71368:000116db] [ERROR][com.freerdp.core.nego] - [nego_connect]: Failed to connect
[09:36:32:704] [71368:000116db] [ERROR][com.freerdp.core] - [rdp_client_connect]: ERRCONNECT_SECURITY_NEGO_CONNECT_FAILED [0x0002000C]
[09:36:32:704] [71368:000116db] [ERROR][com.freerdp.core.connection] - [rdp_client_connect]: Error: protocol security negotiation or connection failure

The same with the AVD running.

[09:48:58:910] [82468:0001422a] [DEBUG][com.freerdp.core.gateway.arm] - [arm_fill_gateway_parameters]: extracted target url [REDACTED]
[09:48:58:910] [82468:0001422a] [TRACE][com.freerdp.core.redirection] - [rdp_redirection_read_target_cert]: Unknown TargetCertificate field type 32768, encoding 1 of length 32
[09:48:58:910] [82468:0001422a] [TRACE][com.freerdp.core.redirection] - [rdp_redirection_read_target_cert]: Unknown TargetCertificate field type 2, encoding 1 of length 156
[09:48:58:911] [82468:0001422a] [TRACE][com.freerdp.core.redirection] - [rdp_redirection_read_target_cert]: Unknown TargetCertificate field type 3, encoding 1 of length 20
[09:48:58:914] [82468:0001422a] [DEBUG][com.freerdp.core.nego] - [nego_set_negotiation_enabled]: Enabling security layer negotiation: TRUE
[09:48:58:914] [82468:0001422a] [DEBUG][com.freerdp.core.nego] - [nego_set_restricted_admin_mode_required]: Enabling restricted admin mode: FALSE
[09:48:58:914] [82468:0001422a] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdp]: Enabling RDP security: FALSE
[09:48:58:914] [82468:0001422a] [DEBUG][com.freerdp.core.nego] - [nego_enable_tls]: Enabling TLS security: FALSE
[09:48:58:914] [82468:0001422a] [DEBUG][com.freerdp.core.nego] - [nego_enable_nla]: Enabling NLA security: FALSE
[09:48:58:914] [82468:0001422a] [DEBUG][com.freerdp.core.nego] - [nego_enable_ext]: Enabling NLA extended security: FALSE
[09:48:58:915] [82468:0001422a] [DEBUG][com.freerdp.core.nego] - [nego_enable_rdstls]: Enabling RDSTLS security: TRUE
[09:48:58:915] [82468:0001422a] [DEBUG][com.freerdp.core.nego] - [nego_enable_aad]: Enabling RDS AAD security: FALSE
[09:48:58:915] [82468:0001422a] [DEBUG][com.freerdp.core.rdp] - [rdp_client_transition_to_state][0x61f000000080]: CONNECTION_STATE_INITIAL --> CONNECTION_STATE_NEGO
[09:48:58:138] [82468:0001422a] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: resetting error state
[09:48:58:138] [82468:0001422a] [DEBUG][com.freerdp.core] - [freerdp_tcp_default_connect]: connecting to peer [REDACTED]
[09:48:58:214] [82468:0001422a] [DEBUG][com.freerdp.core.gateway.wst] - [wst_tls_connect]: connecting to [REDACTED] 443
[09:49:13:499] [82468:0001422a] [ERROR][com.freerdp.core.gateway.http] - [http_response_recv]: [BIO_wait] timeout exceeded
[09:49:13:500] [82468:0001422a] [ERROR][com.freerdp.core.nego] - [nego_connect]: Failed to connect
[09:49:13:500] [82468:0001422a] [ERROR][com.freerdp.core] - [rdp_client_connect]: ERRCONNECT_SECURITY_NEGO_CONNECT_FAILED [0x0002000C]
[09:49:13:500] [82468:0001422a] [ERROR][com.freerdp.core.connection] - [rdp_client_connect]: Error: protocol security negotiation or connection failure
[09:49:13:501] [82468:0001422a] [DEBUG][com.freerdp.core.rdp] - [rdp_finalize_reset_flags][0x61f000000080]: [CONNECTION_STATE_NEGO] reset finalize_sc_pdus
[09:49:13:501] [82468:0001422a] [DEBUG][com.freerdp.core.rdp] - [rdp_client_transition_to_state][0x61f000000080]: CONNECTION_STATE_NEGO --> CONNECTION_STATE_INITIAL
[09:49:13:507] [82468:0001422a] [TRACE][com.freerdp.api] - [freerdp_channels_process_message]: IFCALL(message->Free) == NULL
[09:49:13:508] [82468:00014224] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_USEREVENT_RETRY_DIALOG [0x0000800e]
[09:49:13:508] [82468:00014224] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_USEREVENT_QUIT [0x00008009]
[09:49:28:509] [82468:00014224] [INFO][com.freerdp.client.SDL] - [winpr_LogOutputFunction]: [SDL_LOG_CATEGORY_APPLICATION] got event SDL_USEREVENT_RETRY_DIALOG [0x0000800e]

from freerdp.

akallabeth avatar akallabeth commented on September 23, 2024

@progxaker this looks like you already accepted the certificate?
as for the timeout that is expected if there is no response.

from freerdp.

progxaker avatar progxaker commented on September 23, 2024

this looks like you already accepted the certificate?

I deleted all certificates (and also the build/ folder) before the run.

from freerdp.

progxaker avatar progxaker commented on September 23, 2024

Just checked to see if the observing behavior is related to the fix.

git revert 66f31e5bb968c3bead7449b86852e14154f479aa
git revert 55258cd9e -m 1

And yes, after reverting, I was able to apply the certificate (the window appeared) and connect to the AVD instance.

from freerdp.

Related Issues (20)

Recommend Projects

  • React photo React

    A declarative, efficient, and flexible JavaScript library for building user interfaces.

  • Vue.js photo Vue.js

    🖖 Vue.js is a progressive, incrementally-adoptable JavaScript framework for building UI on the web.

  • Typescript photo Typescript

    TypeScript is a superset of JavaScript that compiles to clean JavaScript output.

  • TensorFlow photo TensorFlow

    An Open Source Machine Learning Framework for Everyone

  • Django photo Django

    The Web framework for perfectionists with deadlines.

  • D3 photo D3

    Bring data to life with SVG, Canvas and HTML. 📊📈🎉

Recommend Topics

  • javascript

    JavaScript (JS) is a lightweight interpreted programming language with first-class functions.

  • web

    Some thing interesting about web. New door for the world.

  • server

    A server is a program made to process requests and deliver data to clients.

  • Machine learning

    Machine learning is a way of modeling and interpreting data that allows a piece of software to respond intelligently.

  • Game

    Some thing interesting about game, make everyone happy.

Recommend Org

  • Facebook photo Facebook

    We are working to build community through open source technology. NB: members must have two-factor auth.

  • Microsoft photo Microsoft

    Open source projects and samples from Microsoft.

  • Google photo Google

    Google ❤️ Open Source for everyone.

  • D3 photo D3

    Data-Driven Documents codes.