LTTng » LTTng-tools

DBG3 - 14:29:08.269747693 [2589952/2589952]: URI string: tcp://0.0.0.0:5342 (in uri_parse() at uri.cpp:329)

DBG2 - 14:29:08.269836394 [2589952/2589952]: IP address resolved to 0.0.0.0 (in set_ip_address() at uri.cpp:185)

DBG3 - 14:29:08.269845083 [2589952/2589952]: URI dtype: 1, proto: 1, host: 0.0.0.0, subdir: , ctrl: 5342, data: 0 (in uri_parse() at uri.cpp:540)

DBG3 - 14:29:08.269856031 [2589952/2589952]: URI string: tcp://0.0.0.0:5343 (in uri_parse() at uri.cpp:329)

DBG2 - 14:29:08.269867514 [2589952/2589952]: IP address resolved to 0.0.0.0 (in set_ip_address() at uri.cpp:185)

DBG3 - 14:29:08.269873598 [2589952/2589952]: URI dtype: 1, proto: 1, host: 0.0.0.0, subdir: , ctrl: 5343, data: 0 (in uri_parse() at uri.cpp:540)

DBG3 - 14:29:08.269883487 [2589952/2589952]: URI string: tcp://localhost:5344 (in uri_parse() at uri.cpp:329)

DBG2 - 14:29:08.270018520 [2589952/2589952]: IP address resolved to 127.0.0.1 (in set_ip_address() at uri.cpp:185)

DBG3 - 14:29:08.270027777 [2589952/2589952]: URI dtype: 1, proto: 1, host: localhost, subdir: , ctrl: 5344, data: 0 (in uri_parse() at uri.cpp:540)

DBG1 - 14:29:08.270038719 [2589952/2589952]: File descriptor count limits are 1024 (soft) and 1048576 (hard) (in set_fd_pool_size() at main.cpp:554)

DBG1 - 14:29:08.270056298 [2589952/2589952]: Signal handler set for SIGTERM, SIGUSR1, SIGPIPE and SIGINT (in set_signal_handler() at main.cpp:925)

DBG1 - 14:29:08.270066016 [2589952/2589952]: LTTng-relayd 2.14.0-pre - O-Beer - v2.12.0-rc1-1558-g7d46777ba-dirty (in relayd_config_log() at main.cpp:278)

DBG1 - 14:29:08.270077232 [2589952/2589952]: Clear command allowed (in main() at main.cpp:4285)

DBG1 - 14:29:08.270195027 [2589952/2589952]: Unlinked file pool created at: /tmp/tmp.gbLqUMdxlb//.unlinked (in lttng_unlinked_file_pool_create() at fd-tracker/inode.cpp:266)

DBG1 - 14:29:08.270208679 [2589952/2589952]: File descriptor tracker created with a limit of 1014 simultaneously-opened FDs (in fd_tracker_create() at fd-tracker/fd-tracker.cpp:388)

DBG1 - 14:29:08.270225606 [2589952/2589952]: Health check time delta in seconds set to 20 (in health_init() at health/health.cpp:60)

DBG1 - 14:29:08.270280919 [2589952/2589952]: TCP inet operation timeout set to 216 sec (in lttcomm_inet_init() at sessiond-comm/inet.cpp:528)

DBG3 - 14:29:08.270293395 [2589952/2589952]: Created hashtable size 4 at 0x55a95553b300 of type U64 (in lttng_ht_new() at hashtable/hashtable.cpp:153)

DBG3 - 14:29:08.270303724 [2589952/2589952]: Created hashtable size 4 at 0x55a95553b890 of type U64 (in lttng_ht_new() at hashtable/hashtable.cpp:153)

DBG3 - 14:29:08.270313451 [2589952/2589952]: Created hashtable size 4 at 0x55a95553be20 of type U64 (in lttng_ht_new() at hashtable/hashtable.cpp:153)

DBG1 - 14:29:08.270415334 [2589952/2589962]: [thread] Manage health check started (in thread_manage_health_relayd() at health-relayd.cpp:255)

DBG1 - 14:29:08.270434488 [2589952/2589963]: [thread] Relay dispatcher started (in relay_thread_dispatcher() at main.cpp:1283)

DBG1 - 14:29:08.270450803 [2589952/2589963]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.cpp:64)

DBG1 - 14:29:08.270457870 [2589952/2589963]: Woken up but nothing in the relay command queue (in relay_thread_dispatcher() at main.cpp:1310)

DBG3 - 14:29:08.270470730 [2589952/2589962]: Creating LTTng run directory: /home/kstewart/src/efficios/lttng/master/home/.lttng (in create_lttng_rundir_with_perm() at health-relayd.cpp:68)

DBG1 - 14:29:08.270481552 [2589952/2589965]: [thread] Relay listener started (in relay_thread_listener() at main.cpp:1082)

DBG1 - 14:29:08.270494704 [2589952/2589964]: [thread] Relay worker started (in relay_thread_worker() at main.cpp:3905)

DBG3 - 14:29:08.270495052 [2589952/2589962]: Creating LTTng run directory: /home/kstewart/src/efficios/lttng/master/home/.lttng/relayd (in create_lttng_rundir_with_perm() at health-relayd.cpp:68)

DBG1 - 14:29:08.270463154 [2589952/2589952]: epoll set max size is 3570688 (in compat_epoll_set_max_size() at compat/poll.cpp:340)

DBG1 - 14:29:08.270606016 [2589952/2589966]: [thread] Live viewer relay dispatcher started (in thread_dispatcher() at live.cpp:881)

DBG1 - 14:29:08.270654316 [2589952/2589966]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.cpp:64)

DBG1 - 14:29:08.270611253 [2589952/2589962]: Health check ready (in thread_manage_health_relayd() at health-relayd.cpp:347)

DBG1 - 14:29:08.270668014 [2589952/2589968]: [thread] Relay live listener started (in thread_listener() at live.cpp:720)

DBG1 - 14:29:08.270654889 [2589952/2589965]: Listening on Control listener socket 12 (in relay_socket_create() at main.cpp:1030)

DBG1 - 14:29:08.270706456 [2589952/2589965]: Listening on Data listener socket 13 (in relay_socket_create() at main.cpp:1030)

DBG3 - 14:29:08.270639001 [2589952/2589964]: Created hashtable size 4 at 0x7f3e34000b90 of type ULONG (in lttng_ht_new() at hashtable/hashtable.cpp:153)

DBG3 - 14:29:08.270755680 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.270668428 [2589952/2589966]: Woken up but nothing in the live-viewer relay command queue (in thread_dispatcher() at live.cpp:908)

DBG1 - 14:29:08.270646073 [2589952/2589967]: [thread] Live viewer relay worker started (in thread_worker() at live.cpp:2591)

DBG1 - 14:29:08.270725298 [2589952/2589965]: Listener accepting connections (in relay_thread_listener() at main.cpp:1129)

DBG1 - 14:29:08.270760122 [2589952/2589968]: Listening on Live listener socket 16 (in init_socket() at live.cpp:686)

DBG3 - 14:29:08.270831935 [2589952/2589967]: Created hashtable size 4 at 0x7f3e28000b90 of type ULONG (in lttng_ht_new() at hashtable/hashtable.cpp:153)

DBG1 - 14:29:08.270878594 [2589952/2589968]: Listener accepting live viewers connections (in thread_listener() at live.cpp:753)

DBG3 - 14:29:08.270888189 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:08.468283265 [2589952/2589965]: Relay new connection received (in relay_thread_listener() at main.cpp:1147)

DBG1 - 14:29:08.468397224 [2589952/2589965]: Control socket to relayd accepted, socket 19 (in accept_relayd_sock() at main.cpp:1067)

DBG1 - 14:29:08.468472434 [2589952/2589965]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG1 - 14:29:08.468515427 [2589952/2589965]: Futex n to 1 wake done (in futex_nto1_wake() at futex.cpp:116)

DBG1 - 14:29:08.468535958 [2589952/2589965]: Listener accepting connections (in relay_thread_listener() at main.cpp:1129)

DBG1 - 14:29:08.468567304 [2589952/2589963]: Futex n to 1 wait done (in futex_nto1_wait() at futex.cpp:100)

DBG1 - 14:29:08.468620160 [2589952/2589963]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.cpp:64)

DBG1 - 14:29:08.468643197 [2589952/2589963]: Dispatching request waiting on sock 19 (in relay_thread_dispatcher() at main.cpp:1316)

DBG1 - 14:29:08.468699125 [2589952/2589963]: Woken up but nothing in the relay command queue (in relay_thread_dispatcher() at main.cpp:1310)

DBG1 - 14:29:08.468797034 [2589952/2589964]: Connection socket 19 added (in relay_thread_worker() at main.cpp:3994)

DBG3 - 14:29:08.468842870 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.468888812 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_VERSION, cmd_version = 0, payload size = 8 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:08.468924540 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.468970015 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 8 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:08.469004947 [2589952/2589964]: Processing "RELAYD_VERSION" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:08.469104332 [2589952/2589964]: Version check done using protocol 2.14 (in relay_send_version() at main.cpp:2030)

DBG1 - 14:29:08.469132065 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:08.469212326 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.469429110 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_GET_CONFIGURATION, cmd_version = 0, payload size = 8 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:08.469501062 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.469533541 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 8 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:08.469567279 [2589952/2589964]: Processing "RELAYD_GET_CONFIGURATION" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:08.469639513 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:08.469676852 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.469980356 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_CREATE_SESSION, cmd_version = 0, payload size = 81 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:08.470050781 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.470083848 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 81 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:08.470117403 [2589952/2589964]: Processing "RELAYD_CREATE_SESSION" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG3 - 14:29:08.470200060 [2589952/2589964]: Created hashtable size 4 at 0x7f3e34003540 of type STRING (in lttng_ht_new() at hashtable/hashtable.cpp:153)

DBG1 - 14:29:08.470264569 [2589952/2589964]: Created trace chunk registry for sessiond {5716460d-cd2b-46af-9fbc-53d64ff620de} (in trace_chunk_registry_ht_element_create() at sessiond-trace-chunks.cpp:218)

DBG1 - 14:29:08.470628668 [2589952/2589964]: Created session 1 (in relay_create_session() at main.cpp:1453)

DBG1 - 14:29:08.470703305 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:08.470742373 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.472074802 [2589952/2589965]: Relay new connection received (in relay_thread_listener() at main.cpp:1147)

DBG1 - 14:29:08.472171389 [2589952/2589965]: Data socket to relayd accepted, socket 21 (in accept_relayd_sock() at main.cpp:1067)

DBG1 - 14:29:08.472222188 [2589952/2589965]: Reset communication state of relay connection (fd = 21) (in connection_reset_protocol_state() at connection.cpp:79)

DBG1 - 14:29:08.472276363 [2589952/2589965]: Futex n to 1 wake done (in futex_nto1_wake() at futex.cpp:116)

DBG1 - 14:29:08.472298926 [2589952/2589965]: Listener accepting connections (in relay_thread_listener() at main.cpp:1129)

DBG1 - 14:29:08.472317514 [2589952/2589963]: Futex n to 1 wait done (in futex_nto1_wait() at futex.cpp:100)

DBG1 - 14:29:08.472377029 [2589952/2589963]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.cpp:64)

DBG1 - 14:29:08.472401638 [2589952/2589963]: Dispatching request waiting on sock 21 (in relay_thread_dispatcher() at main.cpp:1316)

DBG1 - 14:29:08.472442915 [2589952/2589963]: Woken up but nothing in the relay command queue (in relay_thread_dispatcher() at main.cpp:1310)

DBG1 - 14:29:08.472554915 [2589952/2589964]: Connection socket 21 added (in relay_thread_worker() at main.cpp:3994)

DBG3 - 14:29:08.472603160 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.557488864 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_CREATE_TRACE_CHUNK, cmd_version = 0, payload size = 20 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:08.557540741 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.557558921 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 20 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:08.557576825 [2589952/2589964]: Processing "RELAYD_CREATE_TRACE_CHUNK" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:08.557595942 [2589952/2589964]: Creating trace chunk: chunk_id = 0, creation time = 20231214-142908 (in lttng_trace_chunk_create() at trace-chunk.cpp:419)

DBG1 - 14:29:08.557614230 [2589952/2589964]: Chunk name set to "(none)" (in lttng_trace_chunk_create() at trace-chunk.cpp:450)

DBG1 - 14:29:08.557627776 [2589952/2589964]: Attempting to publish trace chunk: sessiond {5716460d-cd2b-46af-9fbc-53d64ff620de}, session_id = 0, chunk_id = 0 (in sessiond_trace_chunk_registry_publish_chunk() at sessiond-trace-chunks.cpp:369)

DBG1 - 14:29:08.557677089 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:08.557697443 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.560289034 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_ADD_STREAM, cmd_version = 0, payload size = 86 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:08.560319301 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.560335798 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 86 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:08.560353259 [2589952/2589964]: Processing "RELAYD_ADD_STREAM" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:08.560372612 [2589952/2589964]: CTF Trace path ust/pid/gen-ust-events-2590002-20231214-142908 not found (in ctf_trace_get_by_path_or_create() at ctf-trace.cpp:157)

DBG1 - 14:29:08.560393210 [2589952/2589964]: Created ctf_trace 1 of session "live" from host "laptop-kstewart" with path: ust/pid/gen-ust-events-2590002-20231214-142908 (in ctf_trace_create() at ctf-trace.cpp:128)

DBG3 - 14:29:08.560413139 [2589952/2589964]: Created hashtable size 4 at 0x7f3e34004870 of type U64 (in lttng_ht_new() at hashtable/hashtable.cpp:153)

DBG1 - 14:29:08.560430048 [2589952/2589964]: Creating trace chunk subdirectory "ust/pid/gen-ust-events-2590002-20231214-142908" (in lttng_trace_chunk_create_subdirectory() at trace-chunk.cpp:1178)

DBG1 - 14:29:08.560592299 [2589952/2589964]: Adding new top-level directory "ust/pid/gen-ust-events-2590002-20231214-142908" to trace chunk "(unnamed)" (in add_top_level_directory_unique() at trace-chunk.cpp:1153)

DBG1 - 14:29:08.560617554 [2589952/2589964]: Opening trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/chan_0" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:08.560634413 [2589952/2589964]: Adding new file "ust/pid/gen-ust-events-2590002-20231214-142908/chan_0" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:08.560689745 [2589952/2589964]: Relay new stream added chan_0 with ID 1 (in stream_create() at stream.cpp:659)

DBG1 - 14:29:08.560724971 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:08.560744350 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.560930927 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_ADD_STREAM, cmd_version = 0, payload size = 86 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:08.560951286 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.560976931 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 86 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:08.560994056 [2589952/2589964]: Processing "RELAYD_ADD_STREAM" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG3 - 14:29:08.561014557 [2589952/2589964]: Created hashtable size 4 at 0x7f3e34005240 of type U64 (in lttng_ht_new() at hashtable/hashtable.cpp:153)

DBG1 - 14:29:08.561031461 [2589952/2589964]: Creating trace chunk subdirectory "ust/pid/gen-ust-events-2590002-20231214-142908" (in lttng_trace_chunk_create_subdirectory() at trace-chunk.cpp:1178)

DBG1 - 14:29:08.561062055 [2589952/2589964]: Opening trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/chan_1" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:08.561078727 [2589952/2589964]: Adding new file "ust/pid/gen-ust-events-2590002-20231214-142908/chan_1" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:08.561129625 [2589952/2589964]: Relay new stream added chan_1 with ID 2 (in stream_create() at stream.cpp:659)

DBG1 - 14:29:08.561159343 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:08.561192819 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.561320516 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_ADD_STREAM, cmd_version = 0, payload size = 86 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:08.561340616 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.561355062 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 86 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:08.561371589 [2589952/2589964]: Processing "RELAYD_ADD_STREAM" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG3 - 14:29:08.561391286 [2589952/2589964]: Created hashtable size 4 at 0x7f3e34005bd0 of type U64 (in lttng_ht_new() at hashtable/hashtable.cpp:153)

DBG1 - 14:29:08.561408064 [2589952/2589964]: Creating trace chunk subdirectory "ust/pid/gen-ust-events-2590002-20231214-142908" (in lttng_trace_chunk_create_subdirectory() at trace-chunk.cpp:1178)

DBG1 - 14:29:08.561435502 [2589952/2589964]: Opening trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/chan_2" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:08.561451888 [2589952/2589964]: Adding new file "ust/pid/gen-ust-events-2590002-20231214-142908/chan_2" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:08.561503991 [2589952/2589964]: Relay new stream added chan_2 with ID 3 (in stream_create() at stream.cpp:659)

DBG1 - 14:29:08.561533553 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:08.561551749 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.561724400 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_ADD_STREAM, cmd_version = 0, payload size = 86 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:08.561744071 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.561758536 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 86 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:08.561774946 [2589952/2589964]: Processing "RELAYD_ADD_STREAM" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG3 - 14:29:08.561794192 [2589952/2589964]: Created hashtable size 4 at 0x7f3e34006570 of type U64 (in lttng_ht_new() at hashtable/hashtable.cpp:153)

DBG1 - 14:29:08.561819899 [2589952/2589964]: Creating trace chunk subdirectory "ust/pid/gen-ust-events-2590002-20231214-142908" (in lttng_trace_chunk_create_subdirectory() at trace-chunk.cpp:1178)

DBG1 - 14:29:08.561847483 [2589952/2589964]: Opening trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/chan_3" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:08.561863763 [2589952/2589964]: Adding new file "ust/pid/gen-ust-events-2590002-20231214-142908/chan_3" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:08.561915208 [2589952/2589964]: Relay new stream added chan_3 with ID 4 (in stream_create() at stream.cpp:659)

DBG1 - 14:29:08.561943535 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:08.561961844 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.564561191 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_ADD_STREAM, cmd_version = 0, payload size = 88 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:08.564589564 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.564606228 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 88 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:08.564623470 [2589952/2589964]: Processing "RELAYD_ADD_STREAM" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG3 - 14:29:08.564645231 [2589952/2589964]: Created hashtable size 4 at 0x7f3e34006f00 of type U64 (in lttng_ht_new() at hashtable/hashtable.cpp:153)

DBG1 - 14:29:08.564662353 [2589952/2589964]: Creating trace chunk subdirectory "ust/pid/gen-ust-events-2590002-20231214-142908" (in lttng_trace_chunk_create_subdirectory() at trace-chunk.cpp:1178)

DBG1 - 14:29:08.564693144 [2589952/2589964]: Opening trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/metadata" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:08.564710131 [2589952/2589964]: Adding new file "ust/pid/gen-ust-events-2590002-20231214-142908/metadata" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:08.564769818 [2589952/2589964]: Relay new stream added metadata with ID 5 (in stream_create() at stream.cpp:659)

DBG1 - 14:29:08.564804504 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:08.564829306 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.564907647 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_STREAMS_SENT, cmd_version = 0, payload size = 0 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG1 - 14:29:08.564929281 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 0 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:08.564945822 [2589952/2589964]: Processing "RELAYD_STREAMS_SENT" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:08.564962098 [2589952/2589964]: Relay receiving streams_sent (in relay_streams_sent() at main.cpp:2469)

DBG1 - 14:29:08.564986587 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:08.565004703 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:08.578735802 [2589952/2589968]: Relay new viewer connection received (in thread_listener() at live.cpp:770)

DBG1 - 14:29:08.578792827 [2589952/2589968]: Live socket to client accepted, socket 27 (in accept_live_sock() at live.cpp:641)

DBG1 - 14:29:08.578823387 [2589952/2589968]: Relay viewer connection accepted socket 27 (in thread_listener() at live.cpp:802)

DBG1 - 14:29:08.578841894 [2589952/2589968]: Futex n to 1 wake done (in futex_nto1_wake() at futex.cpp:116)

DBG1 - 14:29:08.578852904 [2589952/2589968]: Listener accepting live viewers connections (in thread_listener() at live.cpp:753)

DBG1 - 14:29:08.578861299 [2589952/2589966]: Futex n to 1 wait done (in futex_nto1_wait() at futex.cpp:100)

DBG1 - 14:29:08.578889258 [2589952/2589966]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.cpp:64)

DBG1 - 14:29:08.578901917 [2589952/2589966]: Dispatching viewer request waiting on sock 27 (in thread_dispatcher() at live.cpp:914)

DBG1 - 14:29:08.578929177 [2589952/2589966]: Woken up but nothing in the live-viewer relay command queue (in thread_dispatcher() at live.cpp:908)

DBG1 - 14:29:08.578991470 [2589952/2589967]: Connection socket 27 added to poll (in thread_worker() at live.cpp:2678)

DBG3 - 14:29:08.579018234 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:08.579041262 [2589952/2589967]: Processing CONNECT viewer command from connection 27 (in process_control() at live.cpp:2522)

DBG1 - 14:29:08.579094227 [2589952/2589967]: Version check done using protocol 2.4 (in viewer_connect() at live.cpp:1030)

DBG3 - 14:29:08.579109071 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:08.579159650 [2589952/2589967]: Processing LIST_SESSIONS viewer command from connection 27 (in process_control() at live.cpp:2522)

DBG3 - 14:29:08.579215262 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:08.621816729 [2589952/2589967]: Viewer control conn closed with 27 (in thread_worker() at live.cpp:2705)

DBG3 - 14:29:08.621912735 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:09.138384556 [2589952/2589968]: Relay new viewer connection received (in thread_listener() at live.cpp:770)

DBG1 - 14:29:09.138433066 [2589952/2589968]: Live socket to client accepted, socket 27 (in accept_live_sock() at live.cpp:641)

DBG1 - 14:29:09.138442813 [2589952/2589968]: Relay viewer connection accepted socket 27 (in thread_listener() at live.cpp:802)

DBG1 - 14:29:09.138464284 [2589952/2589968]: Futex n to 1 wake done (in futex_nto1_wake() at futex.cpp:116)

DBG1 - 14:29:09.138472964 [2589952/2589968]: Listener accepting live viewers connections (in thread_listener() at live.cpp:753)

DBG1 - 14:29:09.138526709 [2589952/2589966]: Futex n to 1 wait done (in futex_nto1_wait() at futex.cpp:100)

DBG1 - 14:29:09.138547504 [2589952/2589966]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.cpp:64)

DBG1 - 14:29:09.138556693 [2589952/2589966]: Dispatching viewer request waiting on sock 27 (in thread_dispatcher() at live.cpp:914)

DBG1 - 14:29:09.138574865 [2589952/2589966]: Woken up but nothing in the live-viewer relay command queue (in thread_dispatcher() at live.cpp:908)

DBG1 - 14:29:09.138628915 [2589952/2589967]: Connection socket 27 added to poll (in thread_worker() at live.cpp:2678)

DBG3 - 14:29:09.138645795 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:09.138662165 [2589952/2589967]: Processing CONNECT viewer command from connection 27 (in process_control() at live.cpp:2522)

DBG1 - 14:29:09.138698467 [2589952/2589967]: Version check done using protocol 2.4 (in viewer_connect() at live.cpp:1030)

DBG3 - 14:29:09.138708461 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:09.138802778 [2589952/2589967]: Processing LIST_SESSIONS viewer command from connection 27 (in process_control() at live.cpp:2522)

DBG3 - 14:29:09.138845575 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:09.185491088 [2589952/2589967]: Viewer control conn closed with 27 (in thread_worker() at live.cpp:2705)

DBG3 - 14:29:09.185532699 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:09.560324924 [2589952/2589964]: Received data connection header on fd 21: circuit_id = 0, stream_id = 2, data_size = 84, net_seq_num = 0, padding_size = 4012 (in relay_process_data_receive_header() at main.cpp:3629)

DBG3 - 14:29:09.560357151 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:09.560365332 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:09.560378150 [2589952/2589964]: Receiving data for stream id 2 seqnum 0, 0 bytes received, 84 bytes left to receive (in relay_process_data_receive_payload() at main.cpp:3680)

DBG1 - 14:29:09.560410568 [2589952/2589964]: Wrote to stream 2: data_length = 84, padding_length = 0 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:09.560430564 [2589952/2589964]: Wrote to stream 2: data_length = 0, padding_length = 4012 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:09.560441597 [2589952/2589964]: handle_index_data: stream 2 net_seq_num 0 data offset 0 (in stream_update_index() at stream.cpp:1148)

DBG3 - 14:29:09.560456812 [2589952/2589964]: Finding index for stream id 2 and seq_num 0 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:09.560467635 [2589952/2589964]: Creating relay index for stream id 2 and seqnum 0 (in relay_index_create() at index.cpp:34)

DBG2 - 14:29:09.560478980 [2589952/2589964]: Adding relay index with stream id 2 and seqnum 0 (in relay_index_add_unique() at index.cpp:73)

DBG2 - 14:29:09.560489722 [2589952/2589964]: Index found or created in HT for stream ID 2 and seqnum 0 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG1 - 14:29:09.560500141 [2589952/2589964]: Creating trace chunk subdirectory "ust/pid/gen-ust-events-2590002-20231214-142908/index" (in lttng_trace_chunk_create_subdirectory() at trace-chunk.cpp:1178)

DBG1 - 14:29:09.560585744 [2589952/2589964]: Unlinking trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_1.idx" (in lttng_trace_chunk_unlink_file() at trace-chunk.cpp:1416)

DBG1 - 14:29:09.560607530 [2589952/2589964]: Opening trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_1.idx" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:09.560618329 [2589952/2589964]: Adding new file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_1.idx" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:09.560661803 [2589952/2589964]: Reset communication state of relay connection (fd = 21) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:09.560675319 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:09.560848541 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_METADATA, cmd_version = 0, payload size = 5172 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:09.560883952 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:09.601307315 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 5172 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:09.601346233 [2589952/2589964]: Processing "RELAYD_SEND_METADATA" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:09.601388018 [2589952/2589964]: Wrote to metadata stream 5: data_length = 5160, padding_length = 3032 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:09.601399203 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:09.601408937 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:09.601423029 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:09.601433158 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:09.601441036 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:09.601450111 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:09.601459088 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:09.601464987 [2589952/2589964]: stream_add_index for stream 2 (in stream_add_index() at stream.cpp:1243)

DBG3 - 14:29:09.601470680 [2589952/2589964]: Finding index for stream id 2 and seq_num 0 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:09.601480042 [2589952/2589964]: Index found or created in HT for stream ID 2 and seqnum 0 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG2 - 14:29:09.601489588 [2589952/2589964]: Writing index for stream ID 2 and seq num 0 (in relay_index_try_flush() at index.cpp:283)

DBG2 - 14:29:09.601502610 [2589952/2589964]: index put for stream id 2 and seqnum 0 refcount 1 (in relay_index_put() at index.cpp:245)

DBG1 - 14:29:09.601536732 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:09.601547601 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:09.601728230 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:09.601752565 [2589952/2589964]: Received data connection header on fd 21: circuit_id = 0, stream_id = 3, data_size = 84, net_seq_num = 0, padding_size = 4012 (in relay_process_data_receive_header() at main.cpp:3629)

DBG3 - 14:29:09.601765525 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:09.601772216 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:09.601779113 [2589952/2589964]: Receiving data for stream id 3 seqnum 0, 0 bytes received, 84 bytes left to receive (in relay_process_data_receive_payload() at main.cpp:3680)

DBG1 - 14:29:09.601805694 [2589952/2589964]: Wrote to stream 3: data_length = 84, padding_length = 0 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:09.601821972 [2589952/2589964]: Wrote to stream 3: data_length = 0, padding_length = 4012 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:09.601832493 [2589952/2589964]: handle_index_data: stream 3 net_seq_num 0 data offset 0 (in stream_update_index() at stream.cpp:1148)

DBG3 - 14:29:09.601843794 [2589952/2589964]: Finding index for stream id 3 and seq_num 0 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:09.601853987 [2589952/2589964]: Creating relay index for stream id 3 and seqnum 0 (in relay_index_create() at index.cpp:34)

DBG2 - 14:29:09.601864547 [2589952/2589964]: Adding relay index with stream id 3 and seqnum 0 (in relay_index_add_unique() at index.cpp:73)

DBG2 - 14:29:09.601876914 [2589952/2589964]: Index found or created in HT for stream ID 3 and seqnum 0 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG1 - 14:29:09.601886827 [2589952/2589964]: Creating trace chunk subdirectory "ust/pid/gen-ust-events-2590002-20231214-142908/index" (in lttng_trace_chunk_create_subdirectory() at trace-chunk.cpp:1178)

DBG1 - 14:29:09.601910433 [2589952/2589964]: Unlinking trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_2.idx" (in lttng_trace_chunk_unlink_file() at trace-chunk.cpp:1416)

DBG1 - 14:29:09.601932875 [2589952/2589964]: Opening trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_2.idx" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:09.601950995 [2589952/2589964]: Adding new file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_2.idx" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:09.602009291 [2589952/2589964]: Reset communication state of relay connection (fd = 21) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:09.602020609 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:09.602030193 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:09.602039732 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:09.602047947 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:09.602057511 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:09.602066641 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:09.602072359 [2589952/2589964]: stream_add_index for stream 3 (in stream_add_index() at stream.cpp:1243)

DBG3 - 14:29:09.602077788 [2589952/2589964]: Finding index for stream id 3 and seq_num 0 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:09.602086853 [2589952/2589964]: Index found or created in HT for stream ID 3 and seqnum 0 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG2 - 14:29:09.602095956 [2589952/2589964]: Writing index for stream ID 3 and seq num 0 (in relay_index_try_flush() at index.cpp:283)

DBG2 - 14:29:09.602107237 [2589952/2589964]: index put for stream id 3 and seqnum 0 refcount 1 (in relay_index_put() at index.cpp:245)

DBG1 - 14:29:09.602128507 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:09.602139245 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:09.602249607 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:09.602270937 [2589952/2589964]: Received data connection header on fd 21: circuit_id = 0, stream_id = 4, data_size = 84, net_seq_num = 0, padding_size = 4012 (in relay_process_data_receive_header() at main.cpp:3629)

DBG3 - 14:29:09.602284314 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:09.602291150 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:09.602297725 [2589952/2589964]: Receiving data for stream id 4 seqnum 0, 0 bytes received, 84 bytes left to receive (in relay_process_data_receive_payload() at main.cpp:3680)

DBG1 - 14:29:09.602322359 [2589952/2589964]: Wrote to stream 4: data_length = 84, padding_length = 0 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:09.602335699 [2589952/2589964]: Wrote to stream 4: data_length = 0, padding_length = 4012 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:09.602344855 [2589952/2589964]: handle_index_data: stream 4 net_seq_num 0 data offset 0 (in stream_update_index() at stream.cpp:1148)

DBG3 - 14:29:09.602354072 [2589952/2589964]: Finding index for stream id 4 and seq_num 0 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:09.602363167 [2589952/2589964]: Creating relay index for stream id 4 and seqnum 0 (in relay_index_create() at index.cpp:34)

DBG2 - 14:29:09.602372722 [2589952/2589964]: Adding relay index with stream id 4 and seqnum 0 (in relay_index_add_unique() at index.cpp:73)

DBG2 - 14:29:09.602381959 [2589952/2589964]: Index found or created in HT for stream ID 4 and seqnum 0 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG1 - 14:29:09.602396132 [2589952/2589964]: Creating trace chunk subdirectory "ust/pid/gen-ust-events-2590002-20231214-142908/index" (in lttng_trace_chunk_create_subdirectory() at trace-chunk.cpp:1178)

DBG1 - 14:29:09.602416238 [2589952/2589964]: Unlinking trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_3.idx" (in lttng_trace_chunk_unlink_file() at trace-chunk.cpp:1416)

DBG1 - 14:29:09.602431969 [2589952/2589964]: Opening trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_3.idx" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:09.602441723 [2589952/2589964]: Adding new file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_3.idx" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:09.602480474 [2589952/2589964]: Reset communication state of relay connection (fd = 21) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:09.602491225 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:09.602686811 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:09.602700347 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:09.602708858 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:09.602718747 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:09.602727863 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:09.602733706 [2589952/2589964]: stream_add_index for stream 4 (in stream_add_index() at stream.cpp:1243)

DBG3 - 14:29:09.602739204 [2589952/2589964]: Finding index for stream id 4 and seq_num 0 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:09.602748156 [2589952/2589964]: Index found or created in HT for stream ID 4 and seqnum 0 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG2 - 14:29:09.602757219 [2589952/2589964]: Writing index for stream ID 4 and seq num 0 (in relay_index_try_flush() at index.cpp:283)

DBG2 - 14:29:09.602768636 [2589952/2589964]: index put for stream id 4 and seqnum 0 refcount 1 (in relay_index_put() at index.cpp:245)

DBG1 - 14:29:09.602790410 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:09.602801094 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:09.602855594 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:09.602865836 [2589952/2589964]: Received data connection header on fd 21: circuit_id = 0, stream_id = 1, data_size = 84, net_seq_num = 0, padding_size = 4012 (in relay_process_data_receive_header() at main.cpp:3629)

DBG3 - 14:29:09.602876717 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:09.602883500 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:09.602890518 [2589952/2589964]: Receiving data for stream id 1 seqnum 0, 0 bytes received, 84 bytes left to receive (in relay_process_data_receive_payload() at main.cpp:3680)

DBG1 - 14:29:09.602914616 [2589952/2589964]: Wrote to stream 1: data_length = 84, padding_length = 0 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:09.602926922 [2589952/2589964]: Wrote to stream 1: data_length = 0, padding_length = 4012 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:09.602935933 [2589952/2589964]: handle_index_data: stream 1 net_seq_num 0 data offset 0 (in stream_update_index() at stream.cpp:1148)

DBG3 - 14:29:09.602944779 [2589952/2589964]: Finding index for stream id 1 and seq_num 0 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:09.602957850 [2589952/2589964]: Creating relay index for stream id 1 and seqnum 0 (in relay_index_create() at index.cpp:34)

DBG2 - 14:29:09.602967283 [2589952/2589964]: Adding relay index with stream id 1 and seqnum 0 (in relay_index_add_unique() at index.cpp:73)

DBG2 - 14:29:09.602976452 [2589952/2589964]: Index found or created in HT for stream ID 1 and seqnum 0 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG1 - 14:29:09.602985751 [2589952/2589964]: Creating trace chunk subdirectory "ust/pid/gen-ust-events-2590002-20231214-142908/index" (in lttng_trace_chunk_create_subdirectory() at trace-chunk.cpp:1178)

DBG1 - 14:29:09.603003760 [2589952/2589964]: Unlinking trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_0.idx" (in lttng_trace_chunk_unlink_file() at trace-chunk.cpp:1416)

DBG1 - 14:29:09.603017905 [2589952/2589964]: Opening trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_0.idx" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:09.603027291 [2589952/2589964]: Adding new file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_0.idx" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:09.603073737 [2589952/2589964]: Reset communication state of relay connection (fd = 21) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:09.603084275 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:09.603284652 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:09.603297451 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:09.603305990 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:09.603315546 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:09.603324580 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:09.603330370 [2589952/2589964]: stream_add_index for stream 1 (in stream_add_index() at stream.cpp:1243)

DBG3 - 14:29:09.603335842 [2589952/2589964]: Finding index for stream id 1 and seq_num 0 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:09.603344836 [2589952/2589964]: Index found or created in HT for stream ID 1 and seqnum 0 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG2 - 14:29:09.603353805 [2589952/2589964]: Writing index for stream ID 1 and seq num 0 (in relay_index_try_flush() at index.cpp:283)

DBG2 - 14:29:09.603365006 [2589952/2589964]: index put for stream id 1 and seqnum 0 refcount 1 (in relay_index_put() at index.cpp:245)

DBG1 - 14:29:09.603383890 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:09.603394073 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:09.692308559 [2589952/2589968]: Relay new viewer connection received (in thread_listener() at live.cpp:770)

DBG1 - 14:29:09.692350661 [2589952/2589968]: Live socket to client accepted, socket 31 (in accept_live_sock() at live.cpp:641)

DBG1 - 14:29:09.692357728 [2589952/2589968]: Relay viewer connection accepted socket 31 (in thread_listener() at live.cpp:802)

DBG1 - 14:29:09.692372124 [2589952/2589968]: Futex n to 1 wake done (in futex_nto1_wake() at futex.cpp:116)

DBG1 - 14:29:09.692378405 [2589952/2589968]: Listener accepting live viewers connections (in thread_listener() at live.cpp:753)

DBG1 - 14:29:09.692389777 [2589952/2589966]: Futex n to 1 wait done (in futex_nto1_wait() at futex.cpp:100)

DBG1 - 14:29:09.692404959 [2589952/2589966]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.cpp:64)

DBG1 - 14:29:09.692410675 [2589952/2589966]: Dispatching viewer request waiting on sock 31 (in thread_dispatcher() at live.cpp:914)

DBG1 - 14:29:09.692424187 [2589952/2589966]: Woken up but nothing in the live-viewer relay command queue (in thread_dispatcher() at live.cpp:908)

DBG1 - 14:29:09.692480364 [2589952/2589967]: Connection socket 31 added to poll (in thread_worker() at live.cpp:2678)

DBG3 - 14:29:09.692493841 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:09.692507033 [2589952/2589967]: Processing CONNECT viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:09.692533133 [2589952/2589967]: Version check done using protocol 2.4 (in viewer_connect() at live.cpp:1030)

DBG3 - 14:29:09.692540422 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:09.692635605 [2589952/2589967]: Processing LIST_SESSIONS viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG3 - 14:29:09.692666858 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:09.733451747 [2589952/2589967]: Viewer control conn closed with 31 (in thread_worker() at live.cpp:2705)

DBG3 - 14:29:09.733479535 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:09.917715213 [2589952/2589968]: Relay new viewer connection received (in thread_listener() at live.cpp:770)

DBG1 - 14:29:09.917745888 [2589952/2589968]: Live socket to client accepted, socket 31 (in accept_live_sock() at live.cpp:641)

DBG1 - 14:29:09.917752460 [2589952/2589968]: Relay viewer connection accepted socket 31 (in thread_listener() at live.cpp:802)

DBG1 - 14:29:09.917764098 [2589952/2589968]: Futex n to 1 wake done (in futex_nto1_wake() at futex.cpp:116)

DBG1 - 14:29:09.917769702 [2589952/2589968]: Listener accepting live viewers connections (in thread_listener() at live.cpp:753)

DBG1 - 14:29:09.917815953 [2589952/2589966]: Futex n to 1 wait done (in futex_nto1_wait() at futex.cpp:100)

DBG1 - 14:29:09.917828587 [2589952/2589966]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.cpp:64)

DBG1 - 14:29:09.917834669 [2589952/2589966]: Dispatching viewer request waiting on sock 31 (in thread_dispatcher() at live.cpp:914)

DBG1 - 14:29:09.917847912 [2589952/2589966]: Woken up but nothing in the live-viewer relay command queue (in thread_dispatcher() at live.cpp:908)

DBG1 - 14:29:09.917909324 [2589952/2589967]: Connection socket 31 added to poll (in thread_worker() at live.cpp:2678)

DBG3 - 14:29:09.917921553 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:09.917933630 [2589952/2589967]: Processing CONNECT viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:09.917957771 [2589952/2589967]: Version check done using protocol 2.4 (in viewer_connect() at live.cpp:1030)

DBG3 - 14:29:09.917964637 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:09.918090080 [2589952/2589967]: Processing CREATE_SESSION viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG3 - 14:29:09.918117809 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:09.918248841 [2589952/2589967]: Processing LIST_SESSIONS viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG3 - 14:29:09.918278855 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:09.962196925 [2589952/2589967]: Processing ATTACH_SESSION viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:09.962234454 [2589952/2589967]: Session find by ID 1 id found (in session_get_by_id() at session.cpp:466)

DBG1 - 14:29:09.962253477 [2589952/2589967]: Attach relay session ID 1 received (in viewer_attach_session() at live.cpp:1323)

DBG1 - 14:29:09.962263019 [2589952/2589967]: Copying relay session's current trace chunk to the viewer session (in viewer_session_set_trace_chunk_copy() at viewer-session.cpp:45)

DBG1 - 14:29:09.962282014 [2589952/2589967]: Relay viewer stream 1 not found (in viewer_stream_get_by_id() at viewer-stream.cpp:270)

DBG1 - 14:29:09.962313497 [2589952/2589967]: Opening trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_0.idx" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:09.962327182 [2589952/2589967]: Adding new file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_0.idx" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:09.962373893 [2589952/2589967]: Opening trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/chan_0" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:09.962387619 [2589952/2589967]: Adding new file "ust/pid/gen-ust-events-2590002-20231214-142908/chan_0" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:09.962416400 [2589952/2589967]: Relay viewer stream 2 not found (in viewer_stream_get_by_id() at viewer-stream.cpp:270)

DBG1 - 14:29:09.962431141 [2589952/2589967]: Opening trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_1.idx" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:09.962443086 [2589952/2589967]: Adding new file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_1.idx" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:09.962469164 [2589952/2589967]: Opening trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/chan_1" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:09.962481765 [2589952/2589967]: Adding new file "ust/pid/gen-ust-events-2590002-20231214-142908/chan_1" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:09.962504164 [2589952/2589967]: Relay viewer stream 3 not found (in viewer_stream_get_by_id() at viewer-stream.cpp:270)

DBG1 - 14:29:09.962517870 [2589952/2589967]: Opening trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_2.idx" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:09.962529654 [2589952/2589967]: Adding new file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_2.idx" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:09.962554444 [2589952/2589967]: Opening trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/chan_2" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:09.962566538 [2589952/2589967]: Adding new file "ust/pid/gen-ust-events-2590002-20231214-142908/chan_2" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:09.962588799 [2589952/2589967]: Relay viewer stream 4 not found (in viewer_stream_get_by_id() at viewer-stream.cpp:270)

DBG1 - 14:29:09.962602289 [2589952/2589967]: Opening trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_3.idx" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:09.962614203 [2589952/2589967]: Adding new file "ust/pid/gen-ust-events-2590002-20231214-142908/index/chan_3.idx" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:09.962638239 [2589952/2589967]: Opening trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/chan_3" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:09.962650414 [2589952/2589967]: Adding new file "ust/pid/gen-ust-events-2590002-20231214-142908/chan_3" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:09.962678756 [2589952/2589967]: Relay viewer stream 5 not found (in viewer_stream_get_by_id() at viewer-stream.cpp:270)

DBG1 - 14:29:09.962692397 [2589952/2589967]: Opening trace chunk file "ust/pid/gen-ust-events-2590002-20231214-142908/metadata" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:09.962704257 [2589952/2589967]: Adding new file "ust/pid/gen-ust-events-2590002-20231214-142908/metadata" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:09.962746997 [2589952/2589967]: Sending stream 1 to viewer (in send_viewer_streams() at live.cpp:325)

DBG1 - 14:29:09.962761927 [2589952/2589967]: Sending stream 2 to viewer (in send_viewer_streams() at live.cpp:325)

DBG1 - 14:29:09.962772676 [2589952/2589967]: Sending stream 5 to viewer (in send_viewer_streams() at live.cpp:325)

DBG1 - 14:29:09.962782634 [2589952/2589967]: Sending stream 4 to viewer (in send_viewer_streams() at live.cpp:325)

DBG1 - 14:29:09.962792508 [2589952/2589967]: Sending stream 3 to viewer (in send_viewer_streams() at live.cpp:325)

DBG3 - 14:29:09.962802791 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.006880162 [2589952/2589967]: Processing GET_METADATA viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.007076149 [2589952/2589967]: Sent 8192 bytes of metadata for stream 5 (in viewer_get_metadata() at live.cpp:2374)

DBG1 - 14:29:10.007120374 [2589952/2589967]: Metadata sent (in viewer_get_metadata() at live.cpp:2378)

DBG3 - 14:29:10.007142876 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.050357710 [2589952/2589967]: Processing GET_METADATA viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.050497832 [2589952/2589967]: Sent 0 bytes of metadata for stream 5 (in viewer_get_metadata() at live.cpp:2374)

DBG1 - 14:29:10.050528214 [2589952/2589967]: Metadata sent (in viewer_get_metadata() at live.cpp:2378)

DBG3 - 14:29:10.050549626 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.074825511 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.074929920 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:10.074969240 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:10.075001916 [2589952/2589967]: Check index status:did not received beacon for stream 1, returning status=INDEX_RETRY (in check_index_status() at live.cpp:1563)

DBG1 - 14:29:10.075033405 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:10.075107738 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:10.075134275 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.176626914 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.176724622 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:10.176761563 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:10.176794120 [2589952/2589967]: Check index status:did not received beacon for stream 1, returning status=INDEX_RETRY (in check_index_status() at live.cpp:1563)

DBG1 - 14:29:10.176825799 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:10.176940312 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:10.176968446 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.250501098 [2589952/2589968]: Relay new viewer connection received (in thread_listener() at live.cpp:770)

DBG1 - 14:29:10.250629743 [2589952/2589968]: Live socket to client accepted, socket 41 (in accept_live_sock() at live.cpp:641)

DBG1 - 14:29:10.250656784 [2589952/2589968]: Relay viewer connection accepted socket 41 (in thread_listener() at live.cpp:802)

DBG1 - 14:29:10.250694637 [2589952/2589968]: Futex n to 1 wake done (in futex_nto1_wake() at futex.cpp:116)

DBG1 - 14:29:10.250715581 [2589952/2589968]: Listener accepting live viewers connections (in thread_listener() at live.cpp:753)

DBG1 - 14:29:10.250769584 [2589952/2589966]: Futex n to 1 wait done (in futex_nto1_wait() at futex.cpp:100)

DBG1 - 14:29:10.250825892 [2589952/2589966]: Futex n to 1 prepare done (in futex_nto1_prepare() at futex.cpp:64)

DBG1 - 14:29:10.250850155 [2589952/2589966]: Dispatching viewer request waiting on sock 41 (in thread_dispatcher() at live.cpp:914)

DBG1 - 14:29:10.250897197 [2589952/2589966]: Woken up but nothing in the live-viewer relay command queue (in thread_dispatcher() at live.cpp:908)

DBG1 - 14:29:10.250998248 [2589952/2589967]: Connection socket 41 added to poll (in thread_worker() at live.cpp:2678)

DBG3 - 14:29:10.251045566 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.251086408 [2589952/2589967]: Processing CONNECT viewer command from connection 41 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.251183742 [2589952/2589967]: Version check done using protocol 2.4 (in viewer_connect() at live.cpp:1030)

DBG3 - 14:29:10.251213136 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.251404111 [2589952/2589967]: Processing LIST_SESSIONS viewer command from connection 41 (in process_control() at live.cpp:2522)

DBG3 - 14:29:10.251526626 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.277914013 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.277971835 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:10.277991915 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:10.278011829 [2589952/2589967]: Check index status:did not received beacon for stream 1, returning status=INDEX_RETRY (in check_index_status() at live.cpp:1563)

DBG1 - 14:29:10.278030448 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:10.278080221 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:10.278096161 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.293928779 [2589952/2589967]: Viewer control conn closed with 41 (in thread_worker() at live.cpp:2705)

DBG3 - 14:29:10.294016356 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.379553829 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.379651013 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:10.379687704 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:10.379721484 [2589952/2589967]: Check index status:did not received beacon for stream 1, returning status=INDEX_RETRY (in check_index_status() at live.cpp:1563)

DBG1 - 14:29:10.379778971 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:10.379865263 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:10.379893416 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.481574906 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.481682919 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:10.481724716 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:10.481761996 [2589952/2589967]: Check index status:did not received beacon for stream 1, returning status=INDEX_RETRY (in check_index_status() at live.cpp:1563)

DBG1 - 14:29:10.481797893 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:10.481896494 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:10.481927650 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.560828288 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:10.560907587 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.560942698 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:10.560979207 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:10.561011430 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:10.561033665 [2589952/2589964]: stream_add_index for stream 1 (in stream_add_index() at stream.cpp:1243)

DBG1 - 14:29:10.561053190 [2589952/2589964]: Received live beacon for stream 1 (in stream_add_index() at stream.cpp:1247)

DBG1 - 14:29:10.561129210 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:10.561168770 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.561531114 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:10.561602600 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.561636161 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:10.561669805 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:10.561701341 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:10.561722882 [2589952/2589964]: stream_add_index for stream 2 (in stream_add_index() at stream.cpp:1243)

DBG1 - 14:29:10.561742483 [2589952/2589964]: Received live beacon for stream 2 (in stream_add_index() at stream.cpp:1247)

DBG1 - 14:29:10.561805030 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:10.561843120 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.562171231 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:10.562241120 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.562274594 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:10.562308715 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:10.562340057 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:10.562360707 [2589952/2589964]: stream_add_index for stream 3 (in stream_add_index() at stream.cpp:1243)

DBG1 - 14:29:10.562379874 [2589952/2589964]: Received live beacon for stream 3 (in stream_add_index() at stream.cpp:1247)

DBG1 - 14:29:10.562441280 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:10.562479256 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.562805506 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:10.562875646 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.562908206 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:10.562942084 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:10.562973935 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:10.562994551 [2589952/2589964]: stream_add_index for stream 4 (in stream_add_index() at stream.cpp:1243)

DBG1 - 14:29:10.563013659 [2589952/2589964]: Received live beacon for stream 4 (in stream_add_index() at stream.cpp:1247)

DBG1 - 14:29:10.563073974 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:10.563111705 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.583889688 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.583987201 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:10.584023891 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:10.584057342 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:10.584088958 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:10.584176880 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:10.584205447 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.584944270 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.585026394 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:10.585061653 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 2 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:10.585117935 [2589952/2589967]: Check index status: inactive with beacon, for stream 2, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:10.585149631 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:10.585251806 [2589952/2589967]: Index 1 for stream 2 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:10.585282351 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.586026774 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.586108683 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:10.586143254 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 4 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:10.586176040 [2589952/2589967]: Check index status: inactive with beacon, for stream 4, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:10.586207192 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:10.586279894 [2589952/2589967]: Index 1 for stream 4 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:10.586306536 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.587027695 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.587109290 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:10.587144138 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 3 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:10.587176669 [2589952/2589967]: Check index status: inactive with beacon, for stream 3, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:10.587208018 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:10.587280777 [2589952/2589967]: Index 1 for stream 3 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:10.587307135 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.588253991 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.588335027 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:10.588370094 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:10.588402365 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:10.588433713 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:10.588506264 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:10.588532503 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.589455856 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.589539725 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:10.589596273 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:10.589629439 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:10.589660600 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:10.589733618 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:10.589759371 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.590875198 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.590956728 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:10.590991965 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:10.591024305 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:10.591055652 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:10.591127560 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:10.591154013 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.692716136 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.692814532 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:10.692850635 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:10.692884378 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:10.692915983 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:10.692993301 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:10.693020339 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.794617607 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.794714333 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:10.794751192 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:10.794784665 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:10.794816378 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:10.794895862 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:10.794923711 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.855410037 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_ADD_STREAM, cmd_version = 0, payload size = 86 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:10.855491162 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.855549490 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 86 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:10.855584055 [2589952/2589964]: Processing "RELAYD_ADD_STREAM" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:10.855621360 [2589952/2589964]: CTF Trace path ust/pid/gen-ust-events-2590106-20231214-142910 not found (in ctf_trace_get_by_path_or_create() at ctf-trace.cpp:157)

DBG1 - 14:29:10.855656960 [2589952/2589964]: Created ctf_trace 2 of session "live" from host "laptop-kstewart" with path: ust/pid/gen-ust-events-2590106-20231214-142910 (in ctf_trace_create() at ctf-trace.cpp:128)

DBG3 - 14:29:10.855695256 [2589952/2589964]: Created hashtable size 4 at 0x7f3e340084b0 of type U64 (in lttng_ht_new() at hashtable/hashtable.cpp:153)

DBG1 - 14:29:10.855727683 [2589952/2589964]: Creating trace chunk subdirectory "ust/pid/gen-ust-events-2590106-20231214-142910" (in lttng_trace_chunk_create_subdirectory() at trace-chunk.cpp:1178)

DBG1 - 14:29:10.855929103 [2589952/2589964]: Opening trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/chan_0" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:10.855970427 [2589952/2589964]: Adding new file "ust/pid/gen-ust-events-2590106-20231214-142910/chan_0" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:10.856081263 [2589952/2589964]: Relay new stream added chan_0 with ID 6 (in stream_create() at stream.cpp:659)

DBG1 - 14:29:10.856162822 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:10.856202172 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.856553638 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_ADD_STREAM, cmd_version = 0, payload size = 86 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:10.856626101 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.856658846 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 86 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:10.856692886 [2589952/2589964]: Processing "RELAYD_ADD_STREAM" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG3 - 14:29:10.856752722 [2589952/2589964]: Created hashtable size 4 at 0x7f3e34008e40 of type U64 (in lttng_ht_new() at hashtable/hashtable.cpp:153)

DBG1 - 14:29:10.856788455 [2589952/2589964]: Creating trace chunk subdirectory "ust/pid/gen-ust-events-2590106-20231214-142910" (in lttng_trace_chunk_create_subdirectory() at trace-chunk.cpp:1178)

DBG1 - 14:29:10.856848867 [2589952/2589964]: Opening trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/chan_1" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:10.856882560 [2589952/2589964]: Adding new file "ust/pid/gen-ust-events-2590106-20231214-142910/chan_1" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:10.856999044 [2589952/2589964]: Relay new stream added chan_1 with ID 7 (in stream_create() at stream.cpp:659)

DBG1 - 14:29:10.857075524 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:10.857114456 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.857528586 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_ADD_STREAM, cmd_version = 0, payload size = 86 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:10.857603626 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.857660676 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 86 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:10.857694744 [2589952/2589964]: Processing "RELAYD_ADD_STREAM" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG3 - 14:29:10.857737505 [2589952/2589964]: Created hashtable size 4 at 0x7f3e340097d0 of type U64 (in lttng_ht_new() at hashtable/hashtable.cpp:153)

DBG1 - 14:29:10.857771016 [2589952/2589964]: Creating trace chunk subdirectory "ust/pid/gen-ust-events-2590106-20231214-142910" (in lttng_trace_chunk_create_subdirectory() at trace-chunk.cpp:1178)

DBG1 - 14:29:10.857831246 [2589952/2589964]: Opening trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/chan_2" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:10.857864740 [2589952/2589964]: Adding new file "ust/pid/gen-ust-events-2590106-20231214-142910/chan_2" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:10.857981931 [2589952/2589964]: Relay new stream added chan_2 with ID 8 (in stream_create() at stream.cpp:659)

DBG1 - 14:29:10.858053313 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:10.858091224 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.858449142 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_ADD_STREAM, cmd_version = 0, payload size = 86 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:10.858521990 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.858555338 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 86 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:10.858589229 [2589952/2589964]: Processing "RELAYD_ADD_STREAM" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG3 - 14:29:10.858648536 [2589952/2589964]: Created hashtable size 4 at 0x7f3e3400a160 of type U64 (in lttng_ht_new() at hashtable/hashtable.cpp:153)

DBG1 - 14:29:10.858683918 [2589952/2589964]: Creating trace chunk subdirectory "ust/pid/gen-ust-events-2590106-20231214-142910" (in lttng_trace_chunk_create_subdirectory() at trace-chunk.cpp:1178)

DBG1 - 14:29:10.858744703 [2589952/2589964]: Opening trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/chan_3" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:10.858777826 [2589952/2589964]: Adding new file "ust/pid/gen-ust-events-2590106-20231214-142910/chan_3" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:10.858894983 [2589952/2589964]: Relay new stream added chan_3 with ID 9 (in stream_create() at stream.cpp:659)

DBG1 - 14:29:10.858966165 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:10.859004383 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.864181171 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_ADD_STREAM, cmd_version = 0, payload size = 88 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:10.864299662 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.864332742 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 88 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:10.864366475 [2589952/2589964]: Processing "RELAYD_ADD_STREAM" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG3 - 14:29:10.864425407 [2589952/2589964]: Created hashtable size 4 at 0x7f3e3400aaf0 of type U64 (in lttng_ht_new() at hashtable/hashtable.cpp:153)

DBG1 - 14:29:10.864480004 [2589952/2589964]: Creating trace chunk subdirectory "ust/pid/gen-ust-events-2590106-20231214-142910" (in lttng_trace_chunk_create_subdirectory() at trace-chunk.cpp:1178)

DBG1 - 14:29:10.864540925 [2589952/2589964]: Opening trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/metadata" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:10.864574500 [2589952/2589964]: Adding new file "ust/pid/gen-ust-events-2590106-20231214-142910/metadata" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:10.864705053 [2589952/2589964]: Relay new stream added metadata with ID 10 (in stream_create() at stream.cpp:659)

DBG1 - 14:29:10.864780048 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:10.864818354 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.865071340 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_STREAMS_SENT, cmd_version = 0, payload size = 0 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG1 - 14:29:10.865143952 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 0 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:10.865201980 [2589952/2589964]: Processing "RELAYD_STREAMS_SENT" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:10.865239563 [2589952/2589964]: Relay receiving streams_sent (in relay_streams_sent() at main.cpp:2469)

DBG1 - 14:29:10.865304444 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:10.865343135 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:10.896364295 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.896469038 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:10.896504900 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:10.896537507 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:10.896568990 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:10.896645827 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:10.896672045 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:10.998284983 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:10.998385800 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:10.998423081 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:10.998455426 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:10.998486818 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:10.998565196 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:10.998592093 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:11.100158589 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:11.100258676 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:11.100295136 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:11.100327906 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:11.100359193 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:11.100437873 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:11.100465114 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:11.202189112 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:11.202289943 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:11.202326548 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:11.202359637 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:11.202391471 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:11.202470897 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:11.202497945 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:11.304105698 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:11.304206995 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:11.304244502 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:11.304277139 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:11.304308299 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:11.304387055 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:11.304414433 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:11.406152708 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:11.406251980 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:11.406288916 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:11.406321545 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:11.406353127 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:11.406432442 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:11.406458890 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:11.508133185 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:11.508236015 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:11.508273020 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:11.508306032 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:11.508337949 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:11.508416713 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:11.508443096 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:11.560694346 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:11.560776106 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.560812239 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:11.560847355 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:11.560879274 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:11.560901357 [2589952/2589964]: stream_add_index for stream 1 (in stream_add_index() at stream.cpp:1243)

DBG1 - 14:29:11.560921137 [2589952/2589964]: Received live beacon for stream 1 (in stream_add_index() at stream.cpp:1247)

DBG1 - 14:29:11.560996734 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:11.561037424 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.561399721 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:11.561474494 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.561507776 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:11.561542391 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:11.561573714 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:11.561594731 [2589952/2589964]: stream_add_index for stream 2 (in stream_add_index() at stream.cpp:1243)

DBG1 - 14:29:11.561614110 [2589952/2589964]: Received live beacon for stream 2 (in stream_add_index() at stream.cpp:1247)

DBG1 - 14:29:11.561688328 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:11.561726042 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.562051858 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:11.562122356 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.562155098 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:11.562217490 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:11.562249080 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:11.562270131 [2589952/2589964]: stream_add_index for stream 3 (in stream_add_index() at stream.cpp:1243)

DBG1 - 14:29:11.562289117 [2589952/2589964]: Received live beacon for stream 3 (in stream_add_index() at stream.cpp:1247)

DBG1 - 14:29:11.562349937 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:11.562387602 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.562711480 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:11.562781925 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.562814905 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:11.562848543 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:11.562880097 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:11.562901085 [2589952/2589964]: stream_add_index for stream 4 (in stream_add_index() at stream.cpp:1243)

DBG1 - 14:29:11.562920074 [2589952/2589964]: Received live beacon for stream 4 (in stream_add_index() at stream.cpp:1247)

DBG1 - 14:29:11.562980726 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:11.563018059 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.609907779 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:11.610008504 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:11.610047934 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:11.610082212 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:11.610114814 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:11.610193117 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:11.610220054 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:11.611117176 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:11.611201985 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:11.611236813 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 2 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:11.611269194 [2589952/2589967]: Check index status: inactive with beacon, for stream 2, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:11.611300223 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:11.611372228 [2589952/2589967]: Index 1 for stream 2 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:11.611421841 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:11.612345555 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:11.612430312 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:11.612465770 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 3 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:11.612498215 [2589952/2589967]: Check index status: inactive with beacon, for stream 3, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:11.612529233 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:11.612601886 [2589952/2589967]: Index 1 for stream 3 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:11.612627285 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:11.613610473 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:11.613703639 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:11.613738622 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 4 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:11.613772744 [2589952/2589967]: Check index status: inactive with beacon, for stream 4, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:11.613804184 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:11.613880328 [2589952/2589967]: Index 1 for stream 4 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:11.613906462 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:11.614755893 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:11.614841630 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:11.614876344 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:11.614908470 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:11.614939352 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:11.615013794 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:11.615040190 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:11.616125211 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:11.616206367 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:11.616240308 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:11.616273119 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:11.616304379 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:11.616399967 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:11.616426560 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:11.617750271 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:11.617834388 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:11.617869110 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:11.617901780 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:11.617932855 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:11.618005773 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:11.618031479 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:11.719494892 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:11.719591995 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:11.719628005 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:11.719660521 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:11.719692288 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:11.719768620 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:11.719795989 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:11.821223978 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:11.821318187 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:11.821353722 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:11.821385953 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:11.821417438 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:11.821493998 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:11.821520516 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG3 - 14:29:11.855326141 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.855412086 [2589952/2589964]: Received data connection header on fd 21: circuit_id = 0, stream_id = 7, data_size = 84, net_seq_num = 0, padding_size = 4012 (in relay_process_data_receive_header() at main.cpp:3629)

DBG3 - 14:29:11.855458079 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:11.855481182 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:11.855504383 [2589952/2589964]: Receiving data for stream id 7 seqnum 0, 0 bytes received, 84 bytes left to receive (in relay_process_data_receive_payload() at main.cpp:3680)

DBG1 - 14:29:11.855615633 [2589952/2589964]: Wrote to stream 7: data_length = 84, padding_length = 0 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:11.855674598 [2589952/2589964]: Wrote to stream 7: data_length = 0, padding_length = 4012 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:11.855723598 [2589952/2589964]: handle_index_data: stream 7 net_seq_num 0 data offset 0 (in stream_update_index() at stream.cpp:1148)

DBG3 - 14:29:11.855803287 [2589952/2589964]: Finding index for stream id 7 and seq_num 0 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:11.855846039 [2589952/2589964]: Creating relay index for stream id 7 and seqnum 0 (in relay_index_create() at index.cpp:34)

DBG2 - 14:29:11.855881425 [2589952/2589964]: Adding relay index with stream id 7 and seqnum 0 (in relay_index_add_unique() at index.cpp:73)

DBG2 - 14:29:11.855914049 [2589952/2589964]: Index found or created in HT for stream ID 7 and seqnum 0 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG1 - 14:29:11.855949620 [2589952/2589964]: Creating trace chunk subdirectory "ust/pid/gen-ust-events-2590106-20231214-142910/index" (in lttng_trace_chunk_create_subdirectory() at trace-chunk.cpp:1178)

DBG1 - 14:29:11.856167853 [2589952/2589964]: Unlinking trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_1.idx" (in lttng_trace_chunk_unlink_file() at trace-chunk.cpp:1416)

DBG1 - 14:29:11.856248214 [2589952/2589964]: Opening trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_1.idx" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:11.856289163 [2589952/2589964]: Adding new file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_1.idx" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:11.856425077 [2589952/2589964]: Reset communication state of relay connection (fd = 21) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:11.856477772 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.857402713 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_METADATA, cmd_version = 0, payload size = 5172 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:11.857497719 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.901745061 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 5172 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:11.901853773 [2589952/2589964]: Processing "RELAYD_SEND_METADATA" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:11.901972031 [2589952/2589964]: Wrote to metadata stream 10: data_length = 5160, padding_length = 3032 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:11.902010608 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:11.902043885 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.902078633 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:11.902112128 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.902140704 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:11.902172518 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:11.902203402 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:11.902237598 [2589952/2589964]: stream_add_index for stream 7 (in stream_add_index() at stream.cpp:1243)

DBG3 - 14:29:11.902257518 [2589952/2589964]: Finding index for stream id 7 and seq_num 0 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:11.902289866 [2589952/2589964]: Index found or created in HT for stream ID 7 and seqnum 0 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG2 - 14:29:11.902322561 [2589952/2589964]: Writing index for stream ID 7 and seq num 0 (in relay_index_try_flush() at index.cpp:283)

DBG2 - 14:29:11.902364404 [2589952/2589964]: index put for stream id 7 and seqnum 0 refcount 1 (in relay_index_put() at index.cpp:245)

DBG1 - 14:29:11.902474795 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:11.902516851 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:11.902907631 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.902990810 [2589952/2589964]: Received data connection header on fd 21: circuit_id = 0, stream_id = 8, data_size = 2132, net_seq_num = 0, padding_size = 1964 (in relay_process_data_receive_header() at main.cpp:3629)

DBG3 - 14:29:11.903034485 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:11.903058073 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:11.903080770 [2589952/2589964]: Receiving data for stream id 8 seqnum 0, 0 bytes received, 2132 bytes left to receive (in relay_process_data_receive_payload() at main.cpp:3680)

DBG1 - 14:29:11.903182316 [2589952/2589964]: Wrote to stream 8: data_length = 2132, padding_length = 0 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:11.903298076 [2589952/2589964]: Wrote to stream 8: data_length = 0, padding_length = 1964 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:11.903356282 [2589952/2589964]: handle_index_data: stream 8 net_seq_num 0 data offset 0 (in stream_update_index() at stream.cpp:1148)

DBG3 - 14:29:11.903440209 [2589952/2589964]: Finding index for stream id 8 and seq_num 0 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:11.903474299 [2589952/2589964]: Creating relay index for stream id 8 and seqnum 0 (in relay_index_create() at index.cpp:34)

DBG2 - 14:29:11.903510881 [2589952/2589964]: Adding relay index with stream id 8 and seqnum 0 (in relay_index_add_unique() at index.cpp:73)

DBG2 - 14:29:11.903548124 [2589952/2589964]: Index found or created in HT for stream ID 8 and seqnum 0 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG1 - 14:29:11.903582864 [2589952/2589964]: Creating trace chunk subdirectory "ust/pid/gen-ust-events-2590106-20231214-142910/index" (in lttng_trace_chunk_create_subdirectory() at trace-chunk.cpp:1178)

DBG1 - 14:29:11.903686978 [2589952/2589964]: Unlinking trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_2.idx" (in lttng_trace_chunk_unlink_file() at trace-chunk.cpp:1416)

DBG1 - 14:29:11.903828743 [2589952/2589964]: Opening trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_2.idx" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:11.903874915 [2589952/2589964]: Adding new file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_2.idx" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:11.904173706 [2589952/2589964]: Reset communication state of relay connection (fd = 21) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:11.904236517 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.904342222 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:11.904417430 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.904452575 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:11.904485951 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:11.904517157 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:11.904537414 [2589952/2589964]: stream_add_index for stream 8 (in stream_add_index() at stream.cpp:1243)

DBG3 - 14:29:11.904556525 [2589952/2589964]: Finding index for stream id 8 and seq_num 0 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:11.904587699 [2589952/2589964]: Index found or created in HT for stream ID 8 and seqnum 0 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG2 - 14:29:11.904619240 [2589952/2589964]: Writing index for stream ID 8 and seq num 0 (in relay_index_try_flush() at index.cpp:283)

DBG2 - 14:29:11.904658733 [2589952/2589964]: index put for stream id 8 and seqnum 0 refcount 1 (in relay_index_put() at index.cpp:245)

DBG1 - 14:29:11.904737925 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:11.904775925 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:11.905022137 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.905123986 [2589952/2589964]: Received data connection header on fd 21: circuit_id = 0, stream_id = 6, data_size = 84, net_seq_num = 0, padding_size = 4012 (in relay_process_data_receive_header() at main.cpp:3629)

DBG3 - 14:29:11.905258245 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:11.905331735 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:11.905409805 [2589952/2589964]: Receiving data for stream id 6 seqnum 0, 0 bytes received, 84 bytes left to receive (in relay_process_data_receive_payload() at main.cpp:3680)

DBG1 - 14:29:11.905587464 [2589952/2589964]: Wrote to stream 6: data_length = 84, padding_length = 0 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:11.905713947 [2589952/2589964]: Wrote to stream 6: data_length = 0, padding_length = 4012 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:11.905809817 [2589952/2589964]: handle_index_data: stream 6 net_seq_num 0 data offset 0 (in stream_update_index() at stream.cpp:1148)

DBG3 - 14:29:11.905891071 [2589952/2589964]: Finding index for stream id 6 and seq_num 0 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:11.905942643 [2589952/2589964]: Creating relay index for stream id 6 and seqnum 0 (in relay_index_create() at index.cpp:34)

DBG2 - 14:29:11.906037705 [2589952/2589964]: Adding relay index with stream id 6 and seqnum 0 (in relay_index_add_unique() at index.cpp:73)

DBG2 - 14:29:11.906106163 [2589952/2589964]: Index found or created in HT for stream ID 6 and seqnum 0 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG1 - 14:29:11.906164564 [2589952/2589964]: Creating trace chunk subdirectory "ust/pid/gen-ust-events-2590106-20231214-142910/index" (in lttng_trace_chunk_create_subdirectory() at trace-chunk.cpp:1178)

DBG1 - 14:29:11.906271307 [2589952/2589964]: Unlinking trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_0.idx" (in lttng_trace_chunk_unlink_file() at trace-chunk.cpp:1416)

DBG1 - 14:29:11.906333009 [2589952/2589964]: Opening trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_0.idx" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:11.906368531 [2589952/2589964]: Adding new file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_0.idx" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:11.906530829 [2589952/2589964]: Reset communication state of relay connection (fd = 21) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:11.906569483 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.906604027 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:11.906637170 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.906665842 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:11.906698100 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:11.906729142 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:11.906748562 [2589952/2589964]: stream_add_index for stream 6 (in stream_add_index() at stream.cpp:1243)

DBG3 - 14:29:11.906767332 [2589952/2589964]: Finding index for stream id 6 and seq_num 0 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:11.906797841 [2589952/2589964]: Index found or created in HT for stream ID 6 and seqnum 0 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG2 - 14:29:11.906828708 [2589952/2589964]: Writing index for stream ID 6 and seq num 0 (in relay_index_try_flush() at index.cpp:283)

DBG2 - 14:29:11.906867145 [2589952/2589964]: index put for stream id 6 and seqnum 0 refcount 1 (in relay_index_put() at index.cpp:245)

DBG1 - 14:29:11.906946863 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:11.906985223 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:11.907318160 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.907451270 [2589952/2589964]: Received data connection header on fd 21: circuit_id = 0, stream_id = 9, data_size = 84, net_seq_num = 0, padding_size = 4012 (in relay_process_data_receive_header() at main.cpp:3629)

DBG3 - 14:29:11.907564845 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:11.907609650 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:11.907667159 [2589952/2589964]: Receiving data for stream id 9 seqnum 0, 0 bytes received, 84 bytes left to receive (in relay_process_data_receive_payload() at main.cpp:3680)

DBG1 - 14:29:11.907773209 [2589952/2589964]: Wrote to stream 9: data_length = 84, padding_length = 0 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:11.907873534 [2589952/2589964]: Wrote to stream 9: data_length = 0, padding_length = 4012 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:11.907925960 [2589952/2589964]: handle_index_data: stream 9 net_seq_num 0 data offset 0 (in stream_update_index() at stream.cpp:1148)

DBG3 - 14:29:11.908012104 [2589952/2589964]: Finding index for stream id 9 and seq_num 0 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:11.908093001 [2589952/2589964]: Creating relay index for stream id 9 and seqnum 0 (in relay_index_create() at index.cpp:34)

DBG2 - 14:29:11.908165691 [2589952/2589964]: Adding relay index with stream id 9 and seqnum 0 (in relay_index_add_unique() at index.cpp:73)

DBG2 - 14:29:11.908233496 [2589952/2589964]: Index found or created in HT for stream ID 9 and seqnum 0 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG1 - 14:29:11.908360988 [2589952/2589964]: Creating trace chunk subdirectory "ust/pid/gen-ust-events-2590106-20231214-142910/index" (in lttng_trace_chunk_create_subdirectory() at trace-chunk.cpp:1178)

DBG1 - 14:29:11.908506662 [2589952/2589964]: Unlinking trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_3.idx" (in lttng_trace_chunk_unlink_file() at trace-chunk.cpp:1416)

DBG1 - 14:29:11.908567638 [2589952/2589964]: Opening trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_3.idx" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:11.908602322 [2589952/2589964]: Adding new file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_3.idx" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:11.908739457 [2589952/2589964]: Reset communication state of relay connection (fd = 21) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:11.908777097 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.908811891 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:11.908845083 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.908873365 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:11.908906123 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:11.908937566 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:11.908957369 [2589952/2589964]: stream_add_index for stream 9 (in stream_add_index() at stream.cpp:1243)

DBG3 - 14:29:11.908976702 [2589952/2589964]: Finding index for stream id 9 and seq_num 0 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:11.909007724 [2589952/2589964]: Index found or created in HT for stream ID 9 and seqnum 0 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG2 - 14:29:11.909039086 [2589952/2589964]: Writing index for stream ID 9 and seq num 0 (in relay_index_try_flush() at index.cpp:283)

DBG2 - 14:29:11.909077327 [2589952/2589964]: index put for stream id 9 and seqnum 0 refcount 1 (in relay_index_put() at index.cpp:245)

DBG1 - 14:29:11.909154967 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:11.909220820 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:11.922993237 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:11.923091695 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:11.923129020 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:11.923161546 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:11.923192581 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:11.923270110 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:11.923297320 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:12.025018588 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:12.025116362 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:12.025152366 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:12.025249224 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:12.025282006 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:12.025361223 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:12.025387824 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:12.126794062 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:12.126896033 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:12.126931056 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:12.126963539 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:12.126994965 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:12.127072484 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:12.127098736 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:12.229255857 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:12.229373683 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:12.229409642 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:12.229441825 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:12.229473283 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:12.229552068 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:12.229578279 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:12.331061198 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:12.331160596 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:12.331198039 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:12.331230974 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:12.331262442 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:12.331341823 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:12.331369496 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:12.433045741 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:12.433145023 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:12.433213450 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:12.433278218 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:12.433310457 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:12.433391394 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:12.433418019 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:12.535094773 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:12.535195000 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:12.535231406 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:12.535264389 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:12.535295935 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:12.535374717 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:12.535401739 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:12.560648095 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:12.560731341 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:12.560768542 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:12.560805745 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:12.560840016 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:12.560863073 [2589952/2589964]: stream_add_index for stream 1 (in stream_add_index() at stream.cpp:1243)

DBG1 - 14:29:12.560884044 [2589952/2589964]: Received live beacon for stream 1 (in stream_add_index() at stream.cpp:1247)

DBG1 - 14:29:12.560962961 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:12.561005053 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:12.561412607 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:12.561495523 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:12.561529311 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:12.561562798 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:12.561594368 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:12.561616001 [2589952/2589964]: stream_add_index for stream 2 (in stream_add_index() at stream.cpp:1243)

DBG1 - 14:29:12.561635451 [2589952/2589964]: Received live beacon for stream 2 (in stream_add_index() at stream.cpp:1247)

DBG1 - 14:29:12.561698749 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:12.561764451 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:12.562101171 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:12.562177213 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:12.562210200 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:12.562243658 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:12.562275346 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:12.562296545 [2589952/2589964]: stream_add_index for stream 3 (in stream_add_index() at stream.cpp:1243)

DBG1 - 14:29:12.562315750 [2589952/2589964]: Received live beacon for stream 3 (in stream_add_index() at stream.cpp:1247)

DBG1 - 14:29:12.562374721 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:12.562411442 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:12.562752911 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:12.562825902 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:12.562858810 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:12.562892127 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:12.562923553 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:12.562944287 [2589952/2589964]: stream_add_index for stream 4 (in stream_add_index() at stream.cpp:1243)

DBG1 - 14:29:12.562963305 [2589952/2589964]: Received live beacon for stream 4 (in stream_add_index() at stream.cpp:1247)

DBG1 - 14:29:12.563023073 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:12.563061823 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:12.637126184 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:12.637282324 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:12.637321821 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:12.637355901 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:12.637388554 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:12.637468679 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:12.637495289 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:12.638408669 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:12.638493168 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:12.638551162 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 2 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:12.638583682 [2589952/2589967]: Check index status: inactive with beacon, for stream 2, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:12.638615155 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:12.638688229 [2589952/2589967]: Index 1 for stream 2 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:12.638714381 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:12.639585729 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:12.639668284 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:12.639703051 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 3 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:12.639735133 [2589952/2589967]: Check index status: inactive with beacon, for stream 3, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:12.639766356 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:12.639838378 [2589952/2589967]: Index 1 for stream 3 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:12.639864013 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:12.640749172 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:12.640831060 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:12.640866229 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 4 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:12.640898555 [2589952/2589967]: Check index status: inactive with beacon, for stream 4, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:12.640929520 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:12.641001430 [2589952/2589967]: Index 1 for stream 4 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:12.641027483 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:12.641932217 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:12.642015897 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:12.642050410 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:12.642082789 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:12.642113799 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:12.642187272 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:12.642213675 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:12.643427553 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:12.643531662 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:12.643566493 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:12.643598791 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:12.643629953 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:12.643701643 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:12.643727864 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:12.644952184 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:12.645033719 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:12.645068586 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:12.645101233 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:12.645132366 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:12.645231392 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:12.645263636 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:12.746696421 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:12.746796378 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:12.746831857 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:12.746865255 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:12.746897587 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:12.746975687 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:12.747002575 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:12.848571100 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:12.848672467 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:12.848711077 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:12.848743855 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:12.848775397 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:12.848853313 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:12.848879909 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:12.855171651 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:12.855278869 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:12.855314494 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:12.855350181 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:12.855382098 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:12.855404076 [2589952/2589964]: stream_add_index for stream 6 (in stream_add_index() at stream.cpp:1243)

DBG1 - 14:29:12.855423941 [2589952/2589964]: Received live beacon for stream 6 (in stream_add_index() at stream.cpp:1247)

DBG1 - 14:29:12.855497190 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:12.855537292 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:12.855878202 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:12.855951596 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:12.855985005 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:12.856018697 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:12.856049949 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:12.856070820 [2589952/2589964]: stream_add_index for stream 7 (in stream_add_index() at stream.cpp:1243)

DBG1 - 14:29:12.856089848 [2589952/2589964]: Received live beacon for stream 7 (in stream_add_index() at stream.cpp:1247)

DBG1 - 14:29:12.856151228 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:12.856189071 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:12.856448257 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:12.856493143 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:12.856521468 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:12.856553303 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:12.856584241 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:12.856604122 [2589952/2589964]: stream_add_index for stream 8 (in stream_add_index() at stream.cpp:1243)

DBG1 - 14:29:12.856622507 [2589952/2589964]: Received live beacon for stream 8 (in stream_add_index() at stream.cpp:1247)

DBG1 - 14:29:12.856667766 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:12.856702142 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:12.856961778 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:12.856999975 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:12.857051708 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:12.857083913 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:12.857114333 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:12.857133907 [2589952/2589964]: stream_add_index for stream 9 (in stream_add_index() at stream.cpp:1243)

DBG1 - 14:29:12.857152291 [2589952/2589964]: Received live beacon for stream 9 (in stream_add_index() at stream.cpp:1247)

DBG1 - 14:29:12.857226442 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:12.857267354 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:12.950495921 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:12.950594110 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:12.950631860 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:12.950665292 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:12.950696906 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:12.950776833 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:12.950803303 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:13.052460707 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:13.052561188 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:13.052597416 [2589952/2589967]: Check index status: index_received_seqcount 1 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:13.052630071 [2589952/2589967]: Check index status: inactive with beacon, for stream 1, returning status=INDEX_INACTIVE (in check_index_status() at live.cpp:1542)

DBG1 - 14:29:13.052661493 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:13.052740800 [2589952/2589967]: Index 1 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:13.052768133 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG3 - 14:29:13.130486469 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.130520734 [2589952/2589964]: Received data connection header on fd 21: circuit_id = 0, stream_id = 2, data_size = 84, net_seq_num = 1, padding_size = 4012 (in relay_process_data_receive_header() at main.cpp:3629)

DBG3 - 14:29:13.130545370 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.130554135 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.130562733 [2589952/2589964]: Receiving data for stream id 2 seqnum 1, 0 bytes received, 84 bytes left to receive (in relay_process_data_receive_payload() at main.cpp:3680)

DBG1 - 14:29:13.130607986 [2589952/2589964]: Wrote to stream 2: data_length = 84, padding_length = 0 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:13.130625456 [2589952/2589964]: Wrote to stream 2: data_length = 0, padding_length = 4012 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:13.130643526 [2589952/2589964]: handle_index_data: stream 2 net_seq_num 1 data offset 4096 (in stream_update_index() at stream.cpp:1148)

DBG3 - 14:29:13.130657318 [2589952/2589964]: Finding index for stream id 2 and seq_num 1 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:13.130680217 [2589952/2589964]: Creating relay index for stream id 2 and seqnum 1 (in relay_index_create() at index.cpp:34)

DBG2 - 14:29:13.130694725 [2589952/2589964]: Adding relay index with stream id 2 and seqnum 1 (in relay_index_add_unique() at index.cpp:73)

DBG2 - 14:29:13.130708934 [2589952/2589964]: Index found or created in HT for stream ID 2 and seqnum 1 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG1 - 14:29:13.130725162 [2589952/2589964]: Reset communication state of relay connection (fd = 21) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.130739954 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.131184934 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.131203157 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.131214022 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.131225595 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.131236651 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:13.131243811 [2589952/2589964]: stream_add_index for stream 2 (in stream_add_index() at stream.cpp:1243)

DBG3 - 14:29:13.131250490 [2589952/2589964]: Finding index for stream id 2 and seq_num 1 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:13.131261415 [2589952/2589964]: Index found or created in HT for stream ID 2 and seqnum 1 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG2 - 14:29:13.131272404 [2589952/2589964]: Writing index for stream ID 2 and seq num 1 (in relay_index_try_flush() at index.cpp:283)

DBG2 - 14:29:13.131287816 [2589952/2589964]: index put for stream id 2 and seqnum 1 refcount 1 (in relay_index_put() at index.cpp:245)

DBG1 - 14:29:13.131322190 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.131336026 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.131400047 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.131412184 [2589952/2589964]: Received data connection header on fd 21: circuit_id = 0, stream_id = 3, data_size = 84, net_seq_num = 1, padding_size = 4012 (in relay_process_data_receive_header() at main.cpp:3629)

DBG3 - 14:29:13.131426306 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.131434506 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.131442960 [2589952/2589964]: Receiving data for stream id 3 seqnum 1, 0 bytes received, 84 bytes left to receive (in relay_process_data_receive_payload() at main.cpp:3680)

DBG1 - 14:29:13.131467984 [2589952/2589964]: Wrote to stream 3: data_length = 84, padding_length = 0 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:13.131495232 [2589952/2589964]: Wrote to stream 3: data_length = 0, padding_length = 4012 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:13.131519512 [2589952/2589964]: handle_index_data: stream 3 net_seq_num 1 data offset 4096 (in stream_update_index() at stream.cpp:1148)

DBG3 - 14:29:13.131533387 [2589952/2589964]: Finding index for stream id 3 and seq_num 1 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:13.131556565 [2589952/2589964]: Creating relay index for stream id 3 and seqnum 1 (in relay_index_create() at index.cpp:34)

DBG2 - 14:29:13.131568319 [2589952/2589964]: Adding relay index with stream id 3 and seqnum 1 (in relay_index_add_unique() at index.cpp:73)

DBG2 - 14:29:13.131580672 [2589952/2589964]: Index found or created in HT for stream ID 3 and seqnum 1 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG1 - 14:29:13.131593384 [2589952/2589964]: Reset communication state of relay connection (fd = 21) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.131604974 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.131801093 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.131817174 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.131827386 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.131838745 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.131849431 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:13.131856085 [2589952/2589964]: stream_add_index for stream 3 (in stream_add_index() at stream.cpp:1243)

DBG3 - 14:29:13.131862486 [2589952/2589964]: Finding index for stream id 3 and seq_num 1 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:13.131873128 [2589952/2589964]: Index found or created in HT for stream ID 3 and seqnum 1 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG2 - 14:29:13.131883773 [2589952/2589964]: Writing index for stream ID 3 and seq num 1 (in relay_index_try_flush() at index.cpp:283)

DBG2 - 14:29:13.131899735 [2589952/2589964]: index put for stream id 3 and seqnum 1 refcount 1 (in relay_index_put() at index.cpp:245)

DBG1 - 14:29:13.131922739 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.131935490 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.131998192 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.132010454 [2589952/2589964]: Received data connection header on fd 21: circuit_id = 0, stream_id = 4, data_size = 84, net_seq_num = 1, padding_size = 4012 (in relay_process_data_receive_header() at main.cpp:3629)

DBG3 - 14:29:13.132025780 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.132033801 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.132042874 [2589952/2589964]: Receiving data for stream id 4 seqnum 1, 0 bytes received, 84 bytes left to receive (in relay_process_data_receive_payload() at main.cpp:3680)

DBG1 - 14:29:13.132066771 [2589952/2589964]: Wrote to stream 4: data_length = 84, padding_length = 0 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:13.132099987 [2589952/2589964]: Wrote to stream 4: data_length = 0, padding_length = 4012 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:13.132113820 [2589952/2589964]: handle_index_data: stream 4 net_seq_num 1 data offset 4096 (in stream_update_index() at stream.cpp:1148)

DBG3 - 14:29:13.132125823 [2589952/2589964]: Finding index for stream id 4 and seq_num 1 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:13.132138537 [2589952/2589964]: Creating relay index for stream id 4 and seqnum 1 (in relay_index_create() at index.cpp:34)

DBG2 - 14:29:13.132160116 [2589952/2589964]: Adding relay index with stream id 4 and seqnum 1 (in relay_index_add_unique() at index.cpp:73)

DBG2 - 14:29:13.132174586 [2589952/2589964]: Index found or created in HT for stream ID 4 and seqnum 1 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG1 - 14:29:13.132186914 [2589952/2589964]: Reset communication state of relay connection (fd = 21) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.132198709 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.132360409 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.132374175 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.132383662 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.132394577 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.132404978 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:13.132411540 [2589952/2589964]: stream_add_index for stream 4 (in stream_add_index() at stream.cpp:1243)

DBG3 - 14:29:13.132417957 [2589952/2589964]: Finding index for stream id 4 and seq_num 1 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:13.132428397 [2589952/2589964]: Index found or created in HT for stream ID 4 and seqnum 1 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG2 - 14:29:13.132438821 [2589952/2589964]: Writing index for stream ID 4 and seq num 1 (in relay_index_try_flush() at index.cpp:283)

DBG2 - 14:29:13.132454249 [2589952/2589964]: index put for stream id 4 and seqnum 1 refcount 1 (in relay_index_put() at index.cpp:245)

DBG1 - 14:29:13.132475337 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.132487500 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.132552677 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.132566944 [2589952/2589964]: Received data connection header on fd 21: circuit_id = 0, stream_id = 1, data_size = 84, net_seq_num = 1, padding_size = 4012 (in relay_process_data_receive_header() at main.cpp:3629)

DBG3 - 14:29:13.132579950 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.132588798 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.132596886 [2589952/2589964]: Receiving data for stream id 1 seqnum 1, 0 bytes received, 84 bytes left to receive (in relay_process_data_receive_payload() at main.cpp:3680)

DBG1 - 14:29:13.132620687 [2589952/2589964]: Wrote to stream 1: data_length = 84, padding_length = 0 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:13.132637092 [2589952/2589964]: Wrote to stream 1: data_length = 0, padding_length = 4012 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:13.132649871 [2589952/2589964]: handle_index_data: stream 1 net_seq_num 1 data offset 4096 (in stream_update_index() at stream.cpp:1148)

DBG3 - 14:29:13.132663288 [2589952/2589964]: Finding index for stream id 1 and seq_num 1 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:13.132677646 [2589952/2589964]: Creating relay index for stream id 1 and seqnum 1 (in relay_index_create() at index.cpp:34)

DBG2 - 14:29:13.132688807 [2589952/2589964]: Adding relay index with stream id 1 and seqnum 1 (in relay_index_add_unique() at index.cpp:73)

DBG2 - 14:29:13.132699683 [2589952/2589964]: Index found or created in HT for stream ID 1 and seqnum 1 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG1 - 14:29:13.132716763 [2589952/2589964]: Reset communication state of relay connection (fd = 21) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.132728081 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.132899477 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.132913973 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.132923559 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.132934392 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.132944863 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:13.132951470 [2589952/2589964]: stream_add_index for stream 1 (in stream_add_index() at stream.cpp:1243)

DBG3 - 14:29:13.132957788 [2589952/2589964]: Finding index for stream id 1 and seq_num 1 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:13.132968362 [2589952/2589964]: Index found or created in HT for stream ID 1 and seqnum 1 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG2 - 14:29:13.132978912 [2589952/2589964]: Writing index for stream ID 1 and seq num 1 (in relay_index_try_flush() at index.cpp:283)

DBG2 - 14:29:13.132994714 [2589952/2589964]: index put for stream id 1 and seqnum 1 refcount 1 (in relay_index_put() at index.cpp:245)

DBG1 - 14:29:13.133015953 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.133028032 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.133108482 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.133120316 [2589952/2589964]: Received data connection header on fd 21: circuit_id = 0, stream_id = 7, data_size = 84, net_seq_num = 1, padding_size = 4012 (in relay_process_data_receive_header() at main.cpp:3629)

DBG3 - 14:29:13.133134999 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.133143516 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.133161108 [2589952/2589964]: Receiving data for stream id 7 seqnum 1, 0 bytes received, 84 bytes left to receive (in relay_process_data_receive_payload() at main.cpp:3680)

DBG1 - 14:29:13.133218989 [2589952/2589964]: Wrote to stream 7: data_length = 84, padding_length = 0 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:13.133243504 [2589952/2589964]: Wrote to stream 7: data_length = 0, padding_length = 4012 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:13.133260139 [2589952/2589964]: handle_index_data: stream 7 net_seq_num 1 data offset 4096 (in stream_update_index() at stream.cpp:1148)

DBG3 - 14:29:13.133270839 [2589952/2589964]: Finding index for stream id 7 and seq_num 1 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:13.133284310 [2589952/2589964]: Creating relay index for stream id 7 and seqnum 1 (in relay_index_create() at index.cpp:34)

DBG2 - 14:29:13.133296986 [2589952/2589964]: Adding relay index with stream id 7 and seqnum 1 (in relay_index_add_unique() at index.cpp:73)

DBG2 - 14:29:13.133311215 [2589952/2589964]: Index found or created in HT for stream ID 7 and seqnum 1 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG1 - 14:29:13.133328724 [2589952/2589964]: Reset communication state of relay connection (fd = 21) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.133343430 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.133557293 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.133575275 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.133585919 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.133597088 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.133607798 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:13.133615172 [2589952/2589964]: stream_add_index for stream 7 (in stream_add_index() at stream.cpp:1243)

DBG3 - 14:29:13.133621930 [2589952/2589964]: Finding index for stream id 7 and seq_num 1 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:13.133632775 [2589952/2589964]: Index found or created in HT for stream ID 7 and seqnum 1 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG2 - 14:29:13.133643864 [2589952/2589964]: Writing index for stream ID 7 and seq num 1 (in relay_index_try_flush() at index.cpp:283)

DBG2 - 14:29:13.133660312 [2589952/2589964]: index put for stream id 7 and seqnum 1 refcount 1 (in relay_index_put() at index.cpp:245)

DBG1 - 14:29:13.133684646 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.133697619 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.133760029 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.133772058 [2589952/2589964]: Received data connection header on fd 21: circuit_id = 0, stream_id = 8, data_size = 84, net_seq_num = 1, padding_size = 4012 (in relay_process_data_receive_header() at main.cpp:3629)

DBG3 - 14:29:13.133786767 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.133794835 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.133803919 [2589952/2589964]: Receiving data for stream id 8 seqnum 1, 0 bytes received, 84 bytes left to receive (in relay_process_data_receive_payload() at main.cpp:3680)

DBG1 - 14:29:13.133828302 [2589952/2589964]: Wrote to stream 8: data_length = 84, padding_length = 0 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:13.133854622 [2589952/2589964]: Wrote to stream 8: data_length = 0, padding_length = 4012 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:13.133874194 [2589952/2589964]: handle_index_data: stream 8 net_seq_num 1 data offset 4096 (in stream_update_index() at stream.cpp:1148)

DBG3 - 14:29:13.133889316 [2589952/2589964]: Finding index for stream id 8 and seq_num 1 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:13.133906171 [2589952/2589964]: Creating relay index for stream id 8 and seqnum 1 (in relay_index_create() at index.cpp:34)

DBG2 - 14:29:13.133918713 [2589952/2589964]: Adding relay index with stream id 8 and seqnum 1 (in relay_index_add_unique() at index.cpp:73)

DBG2 - 14:29:13.133929735 [2589952/2589964]: Index found or created in HT for stream ID 8 and seqnum 1 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG1 - 14:29:13.133946214 [2589952/2589964]: Reset communication state of relay connection (fd = 21) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.133968957 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.134145291 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.134165489 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.134175582 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.134186542 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.134197059 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:13.134203776 [2589952/2589964]: stream_add_index for stream 8 (in stream_add_index() at stream.cpp:1243)

DBG3 - 14:29:13.134210284 [2589952/2589964]: Finding index for stream id 8 and seq_num 1 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:13.134220832 [2589952/2589964]: Index found or created in HT for stream ID 8 and seqnum 1 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG2 - 14:29:13.134231462 [2589952/2589964]: Writing index for stream ID 8 and seq num 1 (in relay_index_try_flush() at index.cpp:283)

DBG2 - 14:29:13.134246003 [2589952/2589964]: index put for stream id 8 and seqnum 1 refcount 1 (in relay_index_put() at index.cpp:245)

DBG1 - 14:29:13.134267238 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.134279225 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.134384649 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.134397560 [2589952/2589964]: Received data connection header on fd 21: circuit_id = 0, stream_id = 6, data_size = 84, net_seq_num = 1, padding_size = 4012 (in relay_process_data_receive_header() at main.cpp:3629)

DBG3 - 14:29:13.134411529 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.134421446 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.134431054 [2589952/2589964]: Receiving data for stream id 6 seqnum 1, 0 bytes received, 84 bytes left to receive (in relay_process_data_receive_payload() at main.cpp:3680)

DBG1 - 14:29:13.134454730 [2589952/2589964]: Wrote to stream 6: data_length = 84, padding_length = 0 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:13.134469210 [2589952/2589964]: Wrote to stream 6: data_length = 0, padding_length = 4012 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:13.134482423 [2589952/2589964]: handle_index_data: stream 6 net_seq_num 1 data offset 4096 (in stream_update_index() at stream.cpp:1148)

DBG3 - 14:29:13.134494254 [2589952/2589964]: Finding index for stream id 6 and seq_num 1 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:13.134507229 [2589952/2589964]: Creating relay index for stream id 6 and seqnum 1 (in relay_index_create() at index.cpp:34)

DBG2 - 14:29:13.134521931 [2589952/2589964]: Adding relay index with stream id 6 and seqnum 1 (in relay_index_add_unique() at index.cpp:73)

DBG2 - 14:29:13.134533964 [2589952/2589964]: Index found or created in HT for stream ID 6 and seqnum 1 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG1 - 14:29:13.134547679 [2589952/2589964]: Reset communication state of relay connection (fd = 21) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.134558337 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.134747274 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.134761494 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.134771049 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.134786621 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.134797216 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:13.134803887 [2589952/2589964]: stream_add_index for stream 6 (in stream_add_index() at stream.cpp:1243)

DBG3 - 14:29:13.134810312 [2589952/2589964]: Finding index for stream id 6 and seq_num 1 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:13.134820810 [2589952/2589964]: Index found or created in HT for stream ID 6 and seqnum 1 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG2 - 14:29:13.134831334 [2589952/2589964]: Writing index for stream ID 6 and seq num 1 (in relay_index_try_flush() at index.cpp:283)

DBG2 - 14:29:13.134846375 [2589952/2589964]: index put for stream id 6 and seqnum 1 refcount 1 (in relay_index_put() at index.cpp:245)

DBG1 - 14:29:13.134867020 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.134878945 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.134940167 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.134951922 [2589952/2589964]: Received data connection header on fd 21: circuit_id = 0, stream_id = 9, data_size = 84, net_seq_num = 1, padding_size = 4012 (in relay_process_data_receive_header() at main.cpp:3629)

DBG3 - 14:29:13.134965233 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.134975465 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG3 - 14:29:13.134986183 [2589952/2589964]: Receiving data for stream id 9 seqnum 1, 0 bytes received, 84 bytes left to receive (in relay_process_data_receive_payload() at main.cpp:3680)

DBG1 - 14:29:13.135013633 [2589952/2589964]: Wrote to stream 9: data_length = 84, padding_length = 0 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:13.135037576 [2589952/2589964]: Wrote to stream 9: data_length = 0, padding_length = 4012 (in stream_write() at stream.cpp:1117)

DBG1 - 14:29:13.135056892 [2589952/2589964]: handle_index_data: stream 9 net_seq_num 1 data offset 4096 (in stream_update_index() at stream.cpp:1148)

DBG3 - 14:29:13.135076329 [2589952/2589964]: Finding index for stream id 9 and seq_num 1 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:13.135087964 [2589952/2589964]: Creating relay index for stream id 9 and seqnum 1 (in relay_index_create() at index.cpp:34)

DBG2 - 14:29:13.135099436 [2589952/2589964]: Adding relay index with stream id 9 and seqnum 1 (in relay_index_add_unique() at index.cpp:73)

DBG2 - 14:29:13.135118872 [2589952/2589964]: Index found or created in HT for stream ID 9 and seqnum 1 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG1 - 14:29:13.135135123 [2589952/2589964]: Reset communication state of relay connection (fd = 21) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.135146817 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.135312364 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_SEND_INDEX, cmd_version = 0, payload size = 80 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.135326294 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.135335871 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 80 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.135346593 [2589952/2589964]: Processing "RELAYD_SEND_INDEX" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.135356990 [2589952/2589964]: Relay receiving index (in relay_recv_index() at main.cpp:2386)

DBG1 - 14:29:13.135368411 [2589952/2589964]: stream_add_index for stream 9 (in stream_add_index() at stream.cpp:1243)

DBG3 - 14:29:13.135374831 [2589952/2589964]: Finding index for stream id 9 and seq_num 1 (in relay_index_get_by_id_or_create() at index.cpp:119)

DBG2 - 14:29:13.135385265 [2589952/2589964]: Index found or created in HT for stream ID 9 and seqnum 1 (in relay_index_get_by_id_or_create() at index.cpp:152)

DBG2 - 14:29:13.135395832 [2589952/2589964]: Writing index for stream ID 9 and seq num 1 (in relay_index_try_flush() at index.cpp:283)

DBG2 - 14:29:13.135409887 [2589952/2589964]: index put for stream id 9 and seqnum 1 refcount 1 (in relay_index_put() at index.cpp:245)

DBG1 - 14:29:13.135429764 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.135441503 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.153576246 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:13.153609913 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:13.153622323 [2589952/2589967]: Check index status: index_received_seqcount 2 index_sent_seqcount 1 for stream 1 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:13.153639089 [2589952/2589967]: Read index file for stream id 1, returning status=INDEX_OK (in viewer_get_next_index() at live.cpp:1925)

DBG1 - 14:29:13.153650433 [2589952/2589967]: Sending viewer index for stream 1 offset 4096 (in viewer_get_next_index() at live.cpp:1935)

DBG1 - 14:29:13.153661287 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:13.153687297 [2589952/2589967]: Index 2 for stream 1 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:13.153696044 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:13.153878107 [2589952/2589967]: Processing GET_NEW_STREAMS viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:13.153904002 [2589952/2589967]: Session find by ID 1 id found (in session_get_by_id() at session.cpp:466)

DBG1 - 14:29:13.153915778 [2589952/2589967]: Relay viewer stream 6 not found (in viewer_stream_get_by_id() at viewer-stream.cpp:270)

DBG1 - 14:29:13.153930230 [2589952/2589967]: Opening trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_0.idx" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:13.153941638 [2589952/2589967]: Adding new file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_0.idx" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:13.153973828 [2589952/2589967]: Opening trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/chan_0" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:13.153985617 [2589952/2589967]: Adding new file "ust/pid/gen-ust-events-2590106-20231214-142910/chan_0" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:13.154005331 [2589952/2589967]: Relay viewer stream 7 not found (in viewer_stream_get_by_id() at viewer-stream.cpp:270)

DBG1 - 14:29:13.154017619 [2589952/2589967]: Opening trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_1.idx" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:13.154028370 [2589952/2589967]: Adding new file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_1.idx" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:13.154049657 [2589952/2589967]: Opening trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/chan_1" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:13.154068722 [2589952/2589967]: Adding new file "ust/pid/gen-ust-events-2590106-20231214-142910/chan_1" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:13.154087795 [2589952/2589967]: Relay viewer stream 8 not found (in viewer_stream_get_by_id() at viewer-stream.cpp:270)

DBG1 - 14:29:13.154099796 [2589952/2589967]: Opening trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_2.idx" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:13.154110481 [2589952/2589967]: Adding new file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_2.idx" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:13.154131419 [2589952/2589967]: Opening trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/chan_2" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:13.154142236 [2589952/2589967]: Adding new file "ust/pid/gen-ust-events-2590106-20231214-142910/chan_2" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:13.154194554 [2589952/2589967]: Relay viewer stream 9 not found (in viewer_stream_get_by_id() at viewer-stream.cpp:270)

DBG1 - 14:29:13.154206199 [2589952/2589967]: Opening trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_3.idx" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:13.154216722 [2589952/2589967]: Adding new file "ust/pid/gen-ust-events-2590106-20231214-142910/index/chan_3.idx" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:13.154237415 [2589952/2589967]: Opening trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/chan_3" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:13.154248295 [2589952/2589967]: Adding new file "ust/pid/gen-ust-events-2590106-20231214-142910/chan_3" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:13.154267143 [2589952/2589967]: Relay viewer stream 10 not found (in viewer_stream_get_by_id() at viewer-stream.cpp:270)

DBG1 - 14:29:13.154279110 [2589952/2589967]: Opening trace chunk file "ust/pid/gen-ust-events-2590106-20231214-142910/metadata" (in _lttng_trace_chunk_open_fs_handle_locked() at trace-chunk.cpp:1303)

DBG1 - 14:29:13.154289670 [2589952/2589967]: Adding new file "ust/pid/gen-ust-events-2590106-20231214-142910/metadata" to trace chunk "(unnamed)" (in lttng_trace_chunk_add_file() at trace-chunk.cpp:1260)

DBG1 - 14:29:13.154329275 [2589952/2589967]: Sending stream 8 to viewer (in send_viewer_streams() at live.cpp:325)

DBG1 - 14:29:13.154342464 [2589952/2589967]: Sending stream 9 to viewer (in send_viewer_streams() at live.cpp:325)

DBG1 - 14:29:13.154352023 [2589952/2589967]: Sending stream 10 to viewer (in send_viewer_streams() at live.cpp:325)

DBG1 - 14:29:13.154360942 [2589952/2589967]: Sending stream 7 to viewer (in send_viewer_streams() at live.cpp:325)

DBG1 - 14:29:13.154370103 [2589952/2589967]: Sending stream 6 to viewer (in send_viewer_streams() at live.cpp:325)

DBG3 - 14:29:13.154379382 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:13.198172224 [2589952/2589967]: Processing GET_METADATA viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:13.198245639 [2589952/2589967]: Sent 8192 bytes of metadata for stream 10 (in viewer_get_metadata() at live.cpp:2374)

DBG1 - 14:29:13.198261697 [2589952/2589967]: Metadata sent (in viewer_get_metadata() at live.cpp:2378)

DBG3 - 14:29:13.198269570 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:13.241604376 [2589952/2589967]: Processing GET_METADATA viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:13.241690945 [2589952/2589967]: Sent 0 bytes of metadata for stream 10 (in viewer_get_metadata() at live.cpp:2374)

DBG1 - 14:29:13.241731369 [2589952/2589967]: Metadata sent (in viewer_get_metadata() at live.cpp:2378)

DBG3 - 14:29:13.241745719 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:13.263880313 [2589952/2589967]: Processing GET_PACKET viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:13.264039664 [2589952/2589967]: Sent 4108 bytes for stream 1 (in viewer_get_packet() at live.cpp:2105)

DBG3 - 14:29:13.264070922 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:13.265454341 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:13.265540017 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:13.265575790 [2589952/2589967]: Check index status: index_received_seqcount 2 index_sent_seqcount 0 for stream 8 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:13.265618191 [2589952/2589967]: Read index file for stream id 8, returning status=INDEX_OK (in viewer_get_next_index() at live.cpp:1925)

DBG1 - 14:29:13.265650373 [2589952/2589967]: Sending viewer index for stream 8 offset 0 (in viewer_get_next_index() at live.cpp:1935)

DBG1 - 14:29:13.265681657 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:13.265753108 [2589952/2589967]: Index 1 for stream 8 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:13.265778528 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:13.266116641 [2589952/2589967]: Processing GET_PACKET viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:13.266255787 [2589952/2589967]: Sent 4108 bytes for stream 8 (in viewer_get_packet() at live.cpp:2105)

DBG3 - 14:29:13.266286100 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:13.267674634 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:13.267755304 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:13.267790256 [2589952/2589967]: Check index status: index_received_seqcount 2 index_sent_seqcount 0 for stream 9 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:13.267831524 [2589952/2589967]: Read index file for stream id 9, returning status=INDEX_OK (in viewer_get_next_index() at live.cpp:1925)

DBG1 - 14:29:13.267863133 [2589952/2589967]: Sending viewer index for stream 9 offset 0 (in viewer_get_next_index() at live.cpp:1935)

DBG1 - 14:29:13.267894203 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:13.267964841 [2589952/2589967]: Index 1 for stream 9 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:13.267990928 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:13.268327110 [2589952/2589967]: Processing GET_PACKET viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:13.268466018 [2589952/2589967]: Sent 4108 bytes for stream 9 (in viewer_get_packet() at live.cpp:2105)

DBG3 - 14:29:13.268496325 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:13.269906674 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:13.269990148 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:13.270024960 [2589952/2589967]: Check index status: index_received_seqcount 2 index_sent_seqcount 0 for stream 7 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:13.270090159 [2589952/2589967]: Read index file for stream id 7, returning status=INDEX_OK (in viewer_get_next_index() at live.cpp:1925)

DBG1 - 14:29:13.270121953 [2589952/2589967]: Sending viewer index for stream 7 offset 0 (in viewer_get_next_index() at live.cpp:1935)

DBG1 - 14:29:13.270152862 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:13.270235097 [2589952/2589967]: Index 1 for stream 7 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:13.270262143 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:13.270595487 [2589952/2589967]: Processing GET_PACKET viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:13.270733038 [2589952/2589967]: Sent 4108 bytes for stream 7 (in viewer_get_packet() at live.cpp:2105)

DBG3 - 14:29:13.270763274 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:13.272128324 [2589952/2589967]: Processing GET_NEXT_INDEX viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:13.272208962 [2589952/2589967]: Transition to latest chunk check (0 -> 0): Same chunk, no need to rotate (in viewer_get_next_index() at live.cpp:1785)

DBG1 - 14:29:13.272243393 [2589952/2589967]: Check index status: index_received_seqcount 2 index_sent_seqcount 0 for stream 6 (in check_index_status() at live.cpp:1499)

DBG1 - 14:29:13.272284488 [2589952/2589967]: Read index file for stream id 6, returning status=INDEX_OK (in viewer_get_next_index() at live.cpp:1925)

DBG1 - 14:29:13.272316509 [2589952/2589967]: Sending viewer index for stream 6 offset 0 (in viewer_get_next_index() at live.cpp:1935)

DBG1 - 14:29:13.272347385 [2589952/2589967]: get next index metadata check: recv 8192 sent 8192 (in viewer_get_next_index() at live.cpp:1954)

DBG1 - 14:29:13.272418277 [2589952/2589967]: Index 1 for stream 6 sent (in viewer_get_next_index() at live.cpp:1976)

DBG3 - 14:29:13.272443601 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:13.272780397 [2589952/2589967]: Processing GET_PACKET viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:13.272918433 [2589952/2589967]: Sent 4108 bytes for stream 6 (in viewer_get_packet() at live.cpp:2105)

DBG3 - 14:29:13.272948779 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:13.277387215 [2589952/2589967]: Processing DETACH_SESSION viewer command from connection 31 (in process_control() at live.cpp:2522)

DBG1 - 14:29:13.277464538 [2589952/2589967]: Detaching from session ID 1 (in viewer_detach_session() at live.cpp:2454)

DBG1 - 14:29:13.277487252 [2589952/2589967]: Session find by ID 1 id found (in session_get_by_id() at session.cpp:466)

DBG1 - 14:29:13.277629351 [2589952/2589967]: Session 1 detached. (in viewer_detach_session() at live.cpp:2472)

DBG3 - 14:29:13.277694330 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:13.285859260 [2589952/2589967]: Viewer control conn closed with 31 (in thread_worker() at live.cpp:2705)

DBG3 - 14:29:13.285925483 [2589952/2589967]: Relayd live viewer worker thread polling... (in thread_worker() at live.cpp:2624)

DBG1 - 14:29:13.333315599 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_BEGIN_DATA_PENDING, cmd_version = 0, payload size = 8 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.333392272 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.333426571 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 8 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.333483533 [2589952/2589964]: Processing "RELAYD_BEGIN_DATA_PENDING" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.333515897 [2589952/2589964]: Init streams for data pending (in relay_begin_data_pending() at main.cpp:2204)

DBG1 - 14:29:13.333537290 [2589952/2589964]: Set begin data pending flag to stream 1 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.333568351 [2589952/2589964]: Set begin data pending flag to stream 2 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.333599929 [2589952/2589964]: Set begin data pending flag to stream 5 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.333630116 [2589952/2589964]: Set begin data pending flag to stream 4 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.333660294 [2589952/2589964]: Set begin data pending flag to stream 8 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.333690335 [2589952/2589964]: Set begin data pending flag to stream 9 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.333720502 [2589952/2589964]: Set begin data pending flag to stream 3 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.333750539 [2589952/2589964]: Set begin data pending flag to stream 10 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.333780525 [2589952/2589964]: Set begin data pending flag to stream 7 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.333810293 [2589952/2589964]: Set begin data pending flag to stream 6 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.333893050 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.333930701 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.334183772 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_DATA_PENDING, cmd_version = 0, payload size = 16 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.334252876 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.334285521 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 16 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.334318974 [2589952/2589964]: Processing "RELAYD_DATA_PENDING" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.334350150 [2589952/2589964]: Data pending command received (in relay_data_pending() at main.cpp:2051)

DBG1 - 14:29:13.334370334 [2589952/2589964]: Data pending for stream id 1: prev_data_seq 1, prev_index_seq 1, and last_seq 1 (in relay_data_pending() at main.cpp:2087)

DBG1 - 14:29:13.334442518 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.334480349 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.334779156 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_DATA_PENDING, cmd_version = 0, payload size = 16 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.334847982 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.334880524 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 16 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.334914052 [2589952/2589964]: Processing "RELAYD_DATA_PENDING" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.334945294 [2589952/2589964]: Data pending command received (in relay_data_pending() at main.cpp:2051)

DBG1 - 14:29:13.334965461 [2589952/2589964]: Data pending for stream id 2: prev_data_seq 1, prev_index_seq 1, and last_seq 1 (in relay_data_pending() at main.cpp:2087)

DBG1 - 14:29:13.335059352 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.335097850 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.335389018 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_DATA_PENDING, cmd_version = 0, payload size = 16 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.335458093 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.335490601 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 16 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.335524586 [2589952/2589964]: Processing "RELAYD_DATA_PENDING" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.335555780 [2589952/2589964]: Data pending command received (in relay_data_pending() at main.cpp:2051)

DBG1 - 14:29:13.335575633 [2589952/2589964]: Data pending for stream id 3: prev_data_seq 1, prev_index_seq 1, and last_seq 1 (in relay_data_pending() at main.cpp:2087)

DBG1 - 14:29:13.335647369 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.335684737 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.335987460 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_DATA_PENDING, cmd_version = 0, payload size = 16 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.336056538 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.336088971 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 16 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.336122334 [2589952/2589964]: Processing "RELAYD_DATA_PENDING" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.336153632 [2589952/2589964]: Data pending command received (in relay_data_pending() at main.cpp:2051)

DBG1 - 14:29:13.336173646 [2589952/2589964]: Data pending for stream id 4: prev_data_seq 1, prev_index_seq 1, and last_seq 1 (in relay_data_pending() at main.cpp:2087)

DBG1 - 14:29:13.336244728 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.336282061 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.336520459 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_QUIESCENT_CONTROL, cmd_version = 0, payload size = 8 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.336559585 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.336587137 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 8 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.336619063 [2589952/2589964]: Processing "RELAYD_QUIESCENT_CONTROL" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.336650068 [2589952/2589964]: Checking quiescent state on control socket (in relay_quiescent_control() at main.cpp:2140)

DBG1 - 14:29:13.336680755 [2589952/2589964]: Relay quiescent control pending flag set to 5 (in relay_quiescent_control() at main.cpp:2166)

DBG1 - 14:29:13.336736541 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.336770985 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.336972060 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_DATA_PENDING, cmd_version = 0, payload size = 16 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.337032043 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.337060889 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 16 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.337092847 [2589952/2589964]: Processing "RELAYD_DATA_PENDING" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.337123248 [2589952/2589964]: Data pending command received (in relay_data_pending() at main.cpp:2051)

DBG1 - 14:29:13.337142457 [2589952/2589964]: Data pending for stream id 6: prev_data_seq 1, prev_index_seq 1, and last_seq 1 (in relay_data_pending() at main.cpp:2087)

DBG1 - 14:29:13.337230405 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.337270930 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.337486545 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_DATA_PENDING, cmd_version = 0, payload size = 16 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.337555135 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.337587643 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 16 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.337621155 [2589952/2589964]: Processing "RELAYD_DATA_PENDING" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.337652234 [2589952/2589964]: Data pending command received (in relay_data_pending() at main.cpp:2051)

DBG1 - 14:29:13.337672260 [2589952/2589964]: Data pending for stream id 7: prev_data_seq 1, prev_index_seq 1, and last_seq 1 (in relay_data_pending() at main.cpp:2087)

DBG1 - 14:29:13.337743256 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.337780946 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.338081773 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_DATA_PENDING, cmd_version = 0, payload size = 16 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.338151184 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.338183108 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 16 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.338217112 [2589952/2589964]: Processing "RELAYD_DATA_PENDING" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.338248363 [2589952/2589964]: Data pending command received (in relay_data_pending() at main.cpp:2051)

DBG1 - 14:29:13.338268218 [2589952/2589964]: Data pending for stream id 8: prev_data_seq 1, prev_index_seq 1, and last_seq 1 (in relay_data_pending() at main.cpp:2087)

DBG1 - 14:29:13.338339470 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.338376718 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.338617752 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_DATA_PENDING, cmd_version = 0, payload size = 16 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.338656949 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.338684684 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 16 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.338739074 [2589952/2589964]: Processing "RELAYD_DATA_PENDING" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.338769688 [2589952/2589964]: Data pending command received (in relay_data_pending() at main.cpp:2051)

DBG1 - 14:29:13.338789024 [2589952/2589964]: Data pending for stream id 9: prev_data_seq 1, prev_index_seq 1, and last_seq 1 (in relay_data_pending() at main.cpp:2087)

DBG1 - 14:29:13.338847666 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.338882594 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.339181203 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_QUIESCENT_CONTROL, cmd_version = 0, payload size = 8 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.339249891 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.339282523 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 8 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.339316105 [2589952/2589964]: Processing "RELAYD_QUIESCENT_CONTROL" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.339347610 [2589952/2589964]: Checking quiescent state on control socket (in relay_quiescent_control() at main.cpp:2140)

DBG1 - 14:29:13.339379650 [2589952/2589964]: Relay quiescent control pending flag set to 10 (in relay_quiescent_control() at main.cpp:2166)

DBG1 - 14:29:13.339449224 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.339486310 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.339737124 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_END_DATA_PENDING, cmd_version = 0, payload size = 8 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.339806243 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.339838931 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 8 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.339872195 [2589952/2589964]: Processing "RELAYD_END_DATA_PENDING" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.339903727 [2589952/2589964]: End data pending command (in relay_end_data_pending() at main.cpp:2285)

DBG1 - 14:29:13.339965999 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.340003214 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.388494176 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_BEGIN_DATA_PENDING, cmd_version = 0, payload size = 8 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.388571280 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.388604760 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 8 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.388638816 [2589952/2589964]: Processing "RELAYD_BEGIN_DATA_PENDING" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.388670273 [2589952/2589964]: Init streams for data pending (in relay_begin_data_pending() at main.cpp:2204)

DBG1 - 14:29:13.388691459 [2589952/2589964]: Set begin data pending flag to stream 1 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.388745209 [2589952/2589964]: Set begin data pending flag to stream 2 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.388777925 [2589952/2589964]: Set begin data pending flag to stream 5 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.388808089 [2589952/2589964]: Set begin data pending flag to stream 4 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.388838103 [2589952/2589964]: Set begin data pending flag to stream 8 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.388867779 [2589952/2589964]: Set begin data pending flag to stream 9 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.388897426 [2589952/2589964]: Set begin data pending flag to stream 3 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.388927208 [2589952/2589964]: Set begin data pending flag to stream 10 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.388957275 [2589952/2589964]: Set begin data pending flag to stream 7 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.388987280 [2589952/2589964]: Set begin data pending flag to stream 6 (in relay_begin_data_pending() at main.cpp:2240)

DBG1 - 14:29:13.389057063 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.389094112 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.389356675 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_DATA_PENDING, cmd_version = 0, payload size = 16 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.389434314 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.389467738 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 16 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.389501701 [2589952/2589964]: Processing "RELAYD_DATA_PENDING" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.389533259 [2589952/2589964]: Data pending command received (in relay_data_pending() at main.cpp:2051)

DBG1 - 14:29:13.389553676 [2589952/2589964]: Data pending for stream id 1: prev_data_seq 1, prev_index_seq 1, and last_seq 1 (in relay_data_pending() at main.cpp:2087)

DBG1 - 14:29:13.389626586 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.389664757 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.389907647 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_DATA_PENDING, cmd_version = 0, payload size = 16 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.389981715 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.390014477 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 16 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.390048144 [2589952/2589964]: Processing "RELAYD_DATA_PENDING" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.390079491 [2589952/2589964]: Data pending command received (in relay_data_pending() at main.cpp:2051)

DBG1 - 14:29:13.390099554 [2589952/2589964]: Data pending for stream id 2: prev_data_seq 1, prev_index_seq 1, and last_seq 1 (in relay_data_pending() at main.cpp:2087)

DBG1 - 14:29:13.390173269 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.390219345 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.390412414 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_DATA_PENDING, cmd_version = 0, payload size = 16 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.390505840 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.390538985 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 16 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.390572692 [2589952/2589964]: Processing "RELAYD_DATA_PENDING" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.390604099 [2589952/2589964]: Data pending command received (in relay_data_pending() at main.cpp:2051)

DBG1 - 14:29:13.390624048 [2589952/2589964]: Data pending for stream id 3: prev_data_seq 1, prev_index_seq 1, and last_seq 1 (in relay_data_pending() at main.cpp:2087)

DBG1 - 14:29:13.390695418 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.390732546 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.390984138 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_DATA_PENDING, cmd_version = 0, payload size = 16 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.391059026 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.391091907 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 16 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.391125837 [2589952/2589964]: Processing "RELAYD_DATA_PENDING" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.391157099 [2589952/2589964]: Data pending command received (in relay_data_pending() at main.cpp:2051)

DBG1 - 14:29:13.391177357 [2589952/2589964]: Data pending for stream id 4: prev_data_seq 1, prev_index_seq 1, and last_seq 1 (in relay_data_pending() at main.cpp:2087)

DBG1 - 14:29:13.391249375 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.391286772 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.391526650 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_QUIESCENT_CONTROL, cmd_version = 0, payload size = 8 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.391572505 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.391601136 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 8 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.391633224 [2589952/2589964]: Processing "RELAYD_QUIESCENT_CONTROL" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.391664675 [2589952/2589964]: Checking quiescent state on control socket (in relay_quiescent_control() at main.cpp:2140)

DBG1 - 14:29:13.391696189 [2589952/2589964]: Relay quiescent control pending flag set to 5 (in relay_quiescent_control() at main.cpp:2166)

DBG1 - 14:29:13.391755773 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.391791851 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.391946600 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_DATA_PENDING, cmd_version = 0, payload size = 16 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.391988118 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.392017188 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 16 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.392077605 [2589952/2589964]: Processing "RELAYD_DATA_PENDING" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.392110071 [2589952/2589964]: Data pending command received (in relay_data_pending() at main.cpp:2051)

DBG1 - 14:29:13.392131080 [2589952/2589964]: Data pending for stream id 6: prev_data_seq 1, prev_index_seq 1, and last_seq 1 (in relay_data_pending() at main.cpp:2087)

DBG1 - 14:29:13.392193164 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.392230266 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.392442187 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_DATA_PENDING, cmd_version = 0, payload size = 16 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.392485117 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.392514366 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 16 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.392577796 [2589952/2589964]: Processing "RELAYD_DATA_PENDING" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.392610305 [2589952/2589964]: Data pending command received (in relay_data_pending() at main.cpp:2051)

DBG1 - 14:29:13.392631042 [2589952/2589964]: Data pending for stream id 7: prev_data_seq 1, prev_index_seq 1, and last_seq 1 (in relay_data_pending() at main.cpp:2087)

DBG1 - 14:29:13.392692669 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.392732102 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.393018463 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_DATA_PENDING, cmd_version = 0, payload size = 16 bytes (in relay_process_control_receive_header() at main.cpp:3508)

DBG3 - 14:29:13.393083947 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.393113494 [2589952/2589964]: Done receiving control command payload: fd = 19, payload size = 16 bytes (in relay_process_control_receive_payload() at main.cpp:3423)

DBG3 - 14:29:13.393145635 [2589952/2589964]: Processing "RELAYD_DATA_PENDING" command for socket 19 (in relay_process_control_command() at main.cpp:3299)

DBG1 - 14:29:13.393202505 [2589952/2589964]: Data pending command received (in relay_data_pending() at main.cpp:2051)

DBG1 - 14:29:13.393228972 [2589952/2589964]: Data pending for stream id 8: prev_data_seq 1, prev_index_seq 1, and last_seq 1 (in relay_data_pending() at main.cpp:2087)

DBG1 - 14:29:13.393296817 [2589952/2589964]: Reset communication state of relay connection (fd = 19) (in connection_reset_protocol_state() at connection.cpp:79)

DBG3 - 14:29:13.393332457 [2589952/2589964]: Relayd worker thread polling... (in relay_thread_worker() at main.cpp:3940)

DBG1 - 14:29:13.393653215 [2589952/2589964]: Done receiving control command header: fd = 19, cmd = RELAYD_DATA_PENDING, cmd_version = 0, payload size = 16 bytes (in relay_process_control_receive_header() at main.cpp:3508)