dgorski / app_tdd

TDD Module for Asterisk
3 stars 2 forks source link

tdd_put_msg: Assertion due to invalid UTF-8 string #23

Open InterLinked1 opened 10 months ago

InterLinked1 commented 10 months ago

Noticed this at the end of a call today, though it didn't reproduce later, so possibly intermittent - reporting just for sake of completeness:

[2024-01-12 13:10:17.112] DEBUG[1799143][C-00000016]: app_tdd.c:368 spandsp_log: FLOW baudot returned 0x20 ( )
[2024-01-12 13:10:17.291] DEBUG[1799143][C-00000016]: app_tdd.c:368 spandsp_log: FLOW Rx byte 5; rs_msg_len=114
[2024-01-12 13:10:17.291] DEBUG[1799143][C-00000016]: app_tdd.c:368 spandsp_log: FLOW baudot returned 0x53 (S)
[2024-01-12 13:10:17.451] DEBUG[1799143][C-00000016]: app_tdd.c:368 spandsp_log: FLOW Rx byte f; rs_msg_len=115
[2024-01-12 13:10:17.451] DEBUG[1799143][C-00000016]: app_tdd.c:368 spandsp_log: FLOW baudot returned 0x4b (K)
[2024-01-12 13:10:17.631] DEBUG[1799143][C-00000016]: app_tdd.c:368 spandsp_log: FLOW Rx byte 5; rs_msg_len=116
[2024-01-12 13:10:17.631] DEBUG[1799143][C-00000016]: app_tdd.c:368 spandsp_log: FLOW baudot returned 0x53 (S)
[2024-01-12 13:10:17.811] DEBUG[1799143][C-00000016]: app_tdd.c:368 spandsp_log: FLOW Rx byte f; rs_msg_len=117
[2024-01-12 13:10:17.811] DEBUG[1799143][C-00000016]: app_tdd.c:368 spandsp_log: FLOW baudot returned 0x4b (K)
[2024-01-12 13:10:17.851] DEBUG[1799143][C-00000016]: app_tdd.c:368 spandsp_log: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:10:17.851] DEBUG[1799143][C-00000016]: app_tdd.c:368 spandsp_log: FLOW V.18 message buffer: 118
[2024-01-12 13:10:17.851] DEBUG[1799143][C-00000016]: app_tdd.c:368 spandsp_log: FLOW [status] calling put_msg with 118 chars
[2024-01-12 13:10:17.851] ERROR[1799143][C-00000016]: json.c:618 ast_json_vpack: Error building JSON from '{s: s}': Invalid UTF-8 string.
[2024-01-12 13:10:18.044] ERROR[1799143][C-00000016]:   Got 25 backtrace records
# 0: asterisk ast_json_vpack()
# 1: asterisk ast_json_pack()
# 2: [0x7f378dff6ab7] app_tdd.so app_tdd.c:677 tdd_put_msg()
# 3: [0x7f378dff5b98] app_tdd.so app_tdd.c:469 my_v18_tdd_put_async_byte()
# 4: [0x7f378dff6d62] app_tdd.so app_tdd.c:715 modem_rx_status()
# 5: [0x7f378ff60298] libspandsp.so.2 :0 fsk_rx()
# 6: [0x7f378ff980fc] libspandsp.so.2 :0 v18_rx()
# 7: [0x7f378dff65fe] app_tdd.so app_tdd.c:608 hook_callback()
# 8: asterisk <unknown>()
# 9: asterisk ast_audiohook_write_list()
#10: asterisk <unknown>()
#11: asterisk ast_read_stream()
#12: asterisk <unknown>()
#13: asterisk <unknown>()
#14: asterisk bridge_channel_internal_join()
#15: asterisk ast_bridge_join()
#16: asterisk <unknown>()
#17: asterisk pbx_exec()
#18: asterisk <unknown>()
#19: asterisk ast_spawn_extension()
#20: asterisk <unknown>()
#21: asterisk <unknown>()
#22: asterisk <unknown>()
#23: [0x7f37b0e57044] libc.so.6 pthread_create.c:442 start_thread()
#24: [0x7f37b0ed761c] libc.so.6 clone3.S:83 clone3()
dgorski commented 10 months ago

any chance you captured ALL of the "RX byte" entries leading to this? I can't think of a char that could be returned by the receiver that would be a problem for UTF8... I wonder if it's \b or \n that's causing this. I escape these for the manager but not for stasis - perhaps I'll switch that so they come as '\' and 'n' instead of '\n' (\b is used instead of NULL because most use of NULL is really backspace, and the current code filters \r, but not \n - which I plan to change - shouldn't filter out \r). I'll take a closer look at this. Thanks for reporting it.

InterLinked1 commented 10 months ago

Here's some more complete logs from today... looks like the assertion actually happened several times, I just didn't notice it the other times - looks like at the end of every call:

[2024-01-12 13:09:52.889] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:52.889] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:52.889] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:52.929] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:52.949] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:52.949] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:53.081] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:53.521] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:53.521] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:53.541] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:53.661] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:53.661] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:53.761] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:53.841] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:53.841] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:53.981] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:54.161] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:54.161] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:54.241] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:54.381] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:54.381] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:54.421] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:54.941] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:54.941] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:55.181] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:55.301] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:55.301] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:55.341] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:55.401] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:55.401] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:55.501] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:55.601] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:55.601] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:55.661] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:55.781] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:55.781] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:55.801] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:55.821] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:55.821] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:55.881] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:55.981] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:55.981] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:56.041] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:56.061] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:56.061] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:56.141] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:56.221] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:56.221] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:56.301] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:56.401] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:56.401] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:56.501] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:56.661] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:56.661] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:56.761] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:56.761] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:09:56.761] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:09:57.052] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:09:57.211] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=0
[2024-01-12 13:09:57.211] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:09:57.391] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=1
[2024-01-12 13:09:57.571] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 10; rs_msg_len=2
[2024-01-12 13:09:57.571] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x54 (T)
[2024-01-12 13:09:57.751] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 6; rs_msg_len=3
[2024-01-12 13:09:57.751] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x49 (I)
[2024-01-12 13:09:57.931] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1c; rs_msg_len=4
[2024-01-12 13:09:57.931] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x4d (M)
[2024-01-12 13:09:58.091] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1; rs_msg_len=5
[2024-01-12 13:09:58.091] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x45 (E)
[2024-01-12 13:09:58.271] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=6
[2024-01-12 13:09:58.271] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:09:58.451] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=7
[2024-01-12 13:09:58.631] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 16; rs_msg_len=8
[2024-01-12 13:09:58.631] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:09:58.811] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 6; rs_msg_len=9
[2024-01-12 13:09:58.811] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x38 (8)
[2024-01-12 13:09:58.971] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte e; rs_msg_len=10
[2024-01-12 13:09:58.971] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x3a (:)
[2024-01-12 13:09:59.151] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 16; rs_msg_len=11
[2024-01-12 13:09:59.151] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:09:59.331] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 18; rs_msg_len=12
[2024-01-12 13:09:59.331] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x39 (9)
[2024-01-12 13:09:59.511] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=13
[2024-01-12 13:09:59.691] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 3; rs_msg_len=14
[2024-01-12 13:09:59.691] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x41 (A)
[2024-01-12 13:09:59.851] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1c; rs_msg_len=15
[2024-01-12 13:09:59.851] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x4d (M)
[2024-01-12 13:10:00.031] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=16
[2024-01-12 13:10:00.031] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:10:00.212] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=17
[2024-01-12 13:10:00.391] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1; rs_msg_len=18
[2024-01-12 13:10:00.391] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x33 (3)
[2024-01-12 13:10:00.571] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1; rs_msg_len=19
[2024-01-12 13:10:00.571] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x33 (3)
[2024-01-12 13:10:00.731] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=20
[2024-01-12 13:10:00.912] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte d; rs_msg_len=21
[2024-01-12 13:10:00.912] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x46 (F)
[2024-01-12 13:10:01.091] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=22
[2024-01-12 13:10:01.091] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:10:01.271] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=23
[2024-01-12 13:10:01.451] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 16; rs_msg_len=24
[2024-01-12 13:10:01.451] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:10:01.611] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=25
[2024-01-12 13:10:01.791] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte e; rs_msg_len=26
[2024-01-12 13:10:01.791] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x43 (C)
[2024-01-12 13:10:01.972] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=27
[2024-01-12 13:10:01.972] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:10:02.152] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 14; rs_msg_len=28
[2024-01-12 13:10:02.152] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x48 (H)
[2024-01-12 13:10:02.332] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 6; rs_msg_len=29
[2024-01-12 13:10:02.332] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x49 (I)
[2024-01-12 13:10:02.491] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=30
[2024-01-12 13:10:02.491] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:10:02.672] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=31
[2024-01-12 13:10:02.851] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1; rs_msg_len=32
[2024-01-12 13:10:02.851] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x33 (3)
[2024-01-12 13:10:03.032] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 7; rs_msg_len=33
[2024-01-12 13:10:03.032] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x37 (7)
[2024-01-12 13:10:03.211] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=34
[2024-01-12 13:10:03.372] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte d; rs_msg_len=35
[2024-01-12 13:10:03.372] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x46 (F)
[2024-01-12 13:10:03.551] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=36
[2024-01-12 13:10:03.551] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:10:03.731] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=37
[2024-01-12 13:10:03.911] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1; rs_msg_len=38
[2024-01-12 13:10:03.911] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x33 (3)
[2024-01-12 13:10:04.091] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=39
[2024-01-12 13:10:04.251] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte e; rs_msg_len=40
[2024-01-12 13:10:04.251] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x43 (C)
[2024-01-12 13:10:04.431] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=41
[2024-01-12 13:10:04.431] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:10:04.611] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 12; rs_msg_len=42
[2024-01-12 13:10:04.611] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x4c (L)
[2024-01-12 13:10:04.791] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 18; rs_msg_len=43
[2024-01-12 13:10:04.791] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x4f (O)
[2024-01-12 13:10:04.971] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=44
[2024-01-12 13:10:04.971] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:10:05.131] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=45
[2024-01-12 13:10:05.311] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 13; rs_msg_len=46
[2024-01-12 13:10:05.311] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x32 (2)
[2024-01-12 13:10:05.491] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 7; rs_msg_len=47
[2024-01-12 13:10:05.491] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x37 (7)
[2024-01-12 13:10:05.671] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=48
[2024-01-12 13:10:05.851] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte d; rs_msg_len=49
[2024-01-12 13:10:05.851] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x46 (F)
[2024-01-12 13:10:06.011] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=50
[2024-01-12 13:10:06.011] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:10:06.191] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=51
[2024-01-12 13:10:06.371] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 3; rs_msg_len=52
[2024-01-12 13:10:06.371] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x2d (-)
[2024-01-12 13:10:06.551] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1; rs_msg_len=53
[2024-01-12 13:10:06.551] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x33 (3)
[2024-01-12 13:10:06.731] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=54
[2024-01-12 13:10:06.891] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte e; rs_msg_len=55
[2024-01-12 13:10:06.891] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x43 (C)
[2024-01-12 13:10:07.071] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=56
[2024-01-12 13:10:07.071] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:10:07.251] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 16; rs_msg_len=57
[2024-01-12 13:10:07.251] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x50 (P)
[2024-01-12 13:10:07.431] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte a; rs_msg_len=58
[2024-01-12 13:10:07.431] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x52 (R)
[2024-01-12 13:10:07.611] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1; rs_msg_len=59
[2024-01-12 13:10:07.611] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x45 (E)
[2024-01-12 13:10:07.771] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 5; rs_msg_len=60
[2024-01-12 13:10:07.771] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x53 (S)
[2024-01-12 13:10:07.951] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 5; rs_msg_len=61
[2024-01-12 13:10:07.951] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x53 (S)
[2024-01-12 13:10:08.131] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 7; rs_msg_len=62
[2024-01-12 13:10:08.131] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x55 (U)
[2024-01-12 13:10:08.311] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte a; rs_msg_len=63
[2024-01-12 13:10:08.311] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x52 (R)
[2024-01-12 13:10:08.491] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1; rs_msg_len=64
[2024-01-12 13:10:08.491] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x45 (E)
[2024-01-12 13:10:08.651] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=65
[2024-01-12 13:10:08.651] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:10:08.831] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=66
[2024-01-12 13:10:09.011] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 17; rs_msg_len=67
[2024-01-12 13:10:09.011] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x31 (1)
[2024-01-12 13:10:09.191] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 16; rs_msg_len=68
[2024-01-12 13:10:09.191] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:10:09.371] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 17; rs_msg_len=69
[2024-01-12 13:10:09.371] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x31 (1)
[2024-01-12 13:10:09.532] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 6; rs_msg_len=70
[2024-01-12 13:10:09.532] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x38 (8)
[2024-01-12 13:10:09.711] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=71
[2024-01-12 13:10:09.711] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:10:09.891] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=72
[2024-01-12 13:10:10.071] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 13; rs_msg_len=73
[2024-01-12 13:10:10.071] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x57 (W)
[2024-01-12 13:10:10.251] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 6; rs_msg_len=74
[2024-01-12 13:10:10.251] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x49 (I)
[2024-01-12 13:10:10.411] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte c; rs_msg_len=75
[2024-01-12 13:10:10.411] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x4e (N)
[2024-01-12 13:10:10.591] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 9; rs_msg_len=76
[2024-01-12 13:10:10.591] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x44 (D)
[2024-01-12 13:10:10.771] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=77
[2024-01-12 13:10:10.772] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:10:10.951] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=78
[2024-01-12 13:10:11.131] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 16; rs_msg_len=79
[2024-01-12 13:10:11.131] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:10:11.291] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=80
[2024-01-12 13:10:11.291] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:10:11.471] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=81
[2024-01-12 13:10:11.651] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 9; rs_msg_len=82
[2024-01-12 13:10:11.651] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x44 (D)
[2024-01-12 13:10:11.831] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 3; rs_msg_len=83
[2024-01-12 13:10:11.831] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x41 (A)
[2024-01-12 13:10:12.011] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 15; rs_msg_len=84
[2024-01-12 13:10:12.011] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x59 (Y)
[2024-01-12 13:10:12.171] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 12; rs_msg_len=85
[2024-01-12 13:10:12.171] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x4c (L)
[2024-01-12 13:10:12.351] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 6; rs_msg_len=86
[2024-01-12 13:10:12.351] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x49 (I)
[2024-01-12 13:10:12.531] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1a; rs_msg_len=87
[2024-01-12 13:10:12.531] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x47 (G)
[2024-01-12 13:10:12.711] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 14; rs_msg_len=88
[2024-01-12 13:10:12.711] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x48 (H)
[2024-01-12 13:10:12.891] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 10; rs_msg_len=89
[2024-01-12 13:10:12.891] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x54 (T)
[2024-01-12 13:10:13.051] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=90
[2024-01-12 13:10:13.051] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:10:13.231] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=91
[2024-01-12 13:10:13.411] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 16; rs_msg_len=92
[2024-01-12 13:10:13.411] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:10:13.591] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 7; rs_msg_len=93
[2024-01-12 13:10:13.591] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x37 (7)
[2024-01-12 13:10:13.771] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte e; rs_msg_len=94
[2024-01-12 13:10:13.771] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x3a (:)
[2024-01-12 13:10:13.931] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 13; rs_msg_len=95
[2024-01-12 13:10:13.931] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x32 (2)
[2024-01-12 13:10:14.111] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 17; rs_msg_len=96
[2024-01-12 13:10:14.111] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x31 (1)
[2024-01-12 13:10:14.291] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=97
[2024-01-12 13:10:14.471] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 3; rs_msg_len=98
[2024-01-12 13:10:14.471] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x41 (A)
[2024-01-12 13:10:14.651] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1c; rs_msg_len=99
[2024-01-12 13:10:14.651] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x4d (M)
[2024-01-12 13:10:14.811] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=100
[2024-01-12 13:10:14.811] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:10:14.991] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 10; rs_msg_len=101
[2024-01-12 13:10:14.991] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x54 (T)
[2024-01-12 13:10:15.171] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 18; rs_msg_len=102
[2024-01-12 13:10:15.171] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x4f (O)
[2024-01-12 13:10:15.351] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=103
[2024-01-12 13:10:15.351] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:10:15.531] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=104
[2024-01-12 13:10:15.691] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 16; rs_msg_len=105
[2024-01-12 13:10:15.691] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:10:15.871] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte a; rs_msg_len=106
[2024-01-12 13:10:15.871] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x34 (4)
[2024-01-12 13:10:16.051] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte e; rs_msg_len=107
[2024-01-12 13:10:16.051] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x3a (:)
[2024-01-12 13:10:16.231] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 10; rs_msg_len=108
[2024-01-12 13:10:16.231] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x35 (5)
[2024-01-12 13:10:16.411] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 10; rs_msg_len=109
[2024-01-12 13:10:16.411] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x35 (5)
[2024-01-12 13:10:16.571] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=110
[2024-01-12 13:10:16.751] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 16; rs_msg_len=111
[2024-01-12 13:10:16.751] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x50 (P)
[2024-01-12 13:10:16.931] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 1c; rs_msg_len=112
[2024-01-12 13:10:16.931] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x4d (M)
[2024-01-12 13:10:17.112] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 4; rs_msg_len=113
[2024-01-12 13:10:17.112] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:10:17.291] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 5; rs_msg_len=114
[2024-01-12 13:10:17.291] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x53 (S)
[2024-01-12 13:10:17.451] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte f; rs_msg_len=115
[2024-01-12 13:10:17.451] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x4b (K)
[2024-01-12 13:10:17.631] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte 5; rs_msg_len=116
[2024-01-12 13:10:17.631] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x53 (S)
[2024-01-12 13:10:17.811] DEBUG[1799143][C-00000016] app_tdd.c: FLOW Rx byte f; rs_msg_len=117
[2024-01-12 13:10:17.811] DEBUG[1799143][C-00000016] app_tdd.c: FLOW baudot returned 0x4b (K)
[2024-01-12 13:10:17.851] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:10:17.851] DEBUG[1799143][C-00000016] app_tdd.c: FLOW V.18 message buffer: 118
[2024-01-12 13:10:17.851] DEBUG[1799143][C-00000016] app_tdd.c: FLOW [status] calling put_msg with 118 chars
# 2: [0x7f378dff6ab7] app_tdd.so app_tdd.c:677 tdd_put_msg()
# 3: [0x7f378dff5b98] app_tdd.so app_tdd.c:469 my_v18_tdd_put_async_byte()
# 4: [0x7f378dff6d62] app_tdd.so app_tdd.c:715 modem_rx_status()
# 7: [0x7f378dff65fe] app_tdd.so app_tdd.c:608 hook_callback()
[2024-01-12 13:11:48.132] DEBUG[1799101][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:11:48.132] DEBUG[1799101][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:11:48.132] DEBUG[1799101][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:11:48.392] DEBUG[1799101][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:11:48.392] DEBUG[1799101][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:11:48.392] DEBUG[1799101][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:11:49.613] DEBUG[1799101][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:11:49.633] DEBUG[1799101][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:11:49.633] DEBUG[1799101][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:11:49.673] DEBUG[1799101][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:11:49.693] DEBUG[1799101][C-00000016] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:11:49.693] DEBUG[1799101][C-00000016] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:24.397] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:24.869] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:24.869] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:24.969] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:24.989] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:24.989] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:25.010] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:25.042] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:25.042] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:25.372] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:25.629] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:25.629] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:25.669] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:25.811] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:25.812] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:25.893] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:25.989] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:25.989] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:26.051] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:26.148] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:26.148] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:26.232] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:26.350] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:26.350] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:26.449] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:26.917] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:26.920] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:26.931] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:26.971] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:26.971] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:26.988] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:27.151] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:27.151] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:27.171] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:27.248] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:27.248] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:27.335] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:27.469] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:27.469] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:27.549] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:27.631] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:27.631] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:27.708] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:27.852] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:27.852] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:27.890] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:27.948] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:27.948] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:28.017] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:28.029] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:28.029] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:28.057] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:28.168] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:28.168] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:28.230] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:28.312] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:28.312] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:28.389] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:28.610] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:28.610] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:28.689] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:28.809] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:28.809] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:12:29.189] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:12:29.346] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=0
[2024-01-12 13:12:29.346] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:29.527] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=1
[2024-01-12 13:12:29.710] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 10; rs_msg_len=2
[2024-01-12 13:12:29.710] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x54 (T)
[2024-01-12 13:12:29.886] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 6; rs_msg_len=3
[2024-01-12 13:12:29.886] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x49 (I)
[2024-01-12 13:12:30.066] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1c; rs_msg_len=4
[2024-01-12 13:12:30.066] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x4d (M)
[2024-01-12 13:12:30.226] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1; rs_msg_len=5
[2024-01-12 13:12:30.226] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x45 (E)
[2024-01-12 13:12:30.409] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=6
[2024-01-12 13:12:30.409] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:30.587] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=7
[2024-01-12 13:12:30.768] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 16; rs_msg_len=8
[2024-01-12 13:12:30.770] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:12:30.949] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 6; rs_msg_len=9
[2024-01-12 13:12:30.949] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x38 (8)
[2024-01-12 13:12:31.110] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte e; rs_msg_len=10
[2024-01-12 13:12:31.111] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x3a (:)
[2024-01-12 13:12:31.287] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 17; rs_msg_len=11
[2024-01-12 13:12:31.288] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x31 (1)
[2024-01-12 13:12:31.466] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 13; rs_msg_len=12
[2024-01-12 13:12:31.466] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x32 (2)
[2024-01-12 13:12:31.647] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=13
[2024-01-12 13:12:31.828] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 3; rs_msg_len=14
[2024-01-12 13:12:31.828] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x41 (A)
[2024-01-12 13:12:31.989] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1c; rs_msg_len=15
[2024-01-12 13:12:31.989] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x4d (M)
[2024-01-12 13:12:32.167] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=16
[2024-01-12 13:12:32.167] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:32.346] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=17
[2024-01-12 13:12:32.526] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1; rs_msg_len=18
[2024-01-12 13:12:32.526] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x33 (3)
[2024-01-12 13:12:32.709] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1; rs_msg_len=19
[2024-01-12 13:12:32.710] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x33 (3)
[2024-01-12 13:12:32.868] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=20
[2024-01-12 13:12:33.048] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte d; rs_msg_len=21
[2024-01-12 13:12:33.048] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x46 (F)
[2024-01-12 13:12:33.228] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=22
[2024-01-12 13:12:33.228] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:33.406] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=23
[2024-01-12 13:12:33.586] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 16; rs_msg_len=24
[2024-01-12 13:12:33.586] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:12:33.750] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=25
[2024-01-12 13:12:33.926] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte e; rs_msg_len=26
[2024-01-12 13:12:33.927] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x43 (C)
[2024-01-12 13:12:34.106] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=27
[2024-01-12 13:12:34.106] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:34.290] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 14; rs_msg_len=28
[2024-01-12 13:12:34.290] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x48 (H)
[2024-01-12 13:12:34.466] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 6; rs_msg_len=29
[2024-01-12 13:12:34.466] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x49 (I)
[2024-01-12 13:12:34.627] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=30
[2024-01-12 13:12:34.627] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:34.808] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=31
[2024-01-12 13:12:34.987] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1; rs_msg_len=32
[2024-01-12 13:12:34.987] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x33 (3)
[2024-01-12 13:12:35.169] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 7; rs_msg_len=33
[2024-01-12 13:12:35.169] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x37 (7)
[2024-01-12 13:12:35.349] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=34
[2024-01-12 13:12:35.507] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte d; rs_msg_len=35
[2024-01-12 13:12:35.510] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x46 (F)
[2024-01-12 13:12:35.691] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=36
[2024-01-12 13:12:35.691] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:35.869] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=37
[2024-01-12 13:12:36.048] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1; rs_msg_len=38
[2024-01-12 13:12:36.048] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x33 (3)
[2024-01-12 13:12:36.226] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=39
[2024-01-12 13:12:36.388] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte e; rs_msg_len=40
[2024-01-12 13:12:36.388] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x43 (C)
[2024-01-12 13:12:36.568] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=41
[2024-01-12 13:12:36.568] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:36.746] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 12; rs_msg_len=42
[2024-01-12 13:12:36.746] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x4c (L)
[2024-01-12 13:12:36.928] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 18; rs_msg_len=43
[2024-01-12 13:12:36.928] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x4f (O)
[2024-01-12 13:12:37.106] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=44
[2024-01-12 13:12:37.106] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:37.266] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=45
[2024-01-12 13:12:37.448] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 13; rs_msg_len=46
[2024-01-12 13:12:37.448] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x32 (2)
[2024-01-12 13:12:37.627] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 7; rs_msg_len=47
[2024-01-12 13:12:37.627] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x37 (7)
[2024-01-12 13:12:37.806] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=48
[2024-01-12 13:12:37.988] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte d; rs_msg_len=49
[2024-01-12 13:12:37.989] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x46 (F)
[2024-01-12 13:12:38.146] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=50
[2024-01-12 13:12:38.146] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:38.327] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=51
[2024-01-12 13:12:38.507] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 3; rs_msg_len=52
[2024-01-12 13:12:38.507] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x2d (-)
[2024-01-12 13:12:38.686] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1; rs_msg_len=53
[2024-01-12 13:12:38.686] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x33 (3)
[2024-01-12 13:12:38.870] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=54
[2024-01-12 13:12:39.029] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte e; rs_msg_len=55
[2024-01-12 13:12:39.029] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x43 (C)
[2024-01-12 13:12:39.206] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=56
[2024-01-12 13:12:39.206] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:39.390] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 16; rs_msg_len=57
[2024-01-12 13:12:39.390] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x50 (P)
[2024-01-12 13:12:39.566] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte a; rs_msg_len=58
[2024-01-12 13:12:39.566] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x52 (R)
[2024-01-12 13:12:39.746] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1; rs_msg_len=59
[2024-01-12 13:12:39.746] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x45 (E)
[2024-01-12 13:12:39.908] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 5; rs_msg_len=60
[2024-01-12 13:12:39.908] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x53 (S)
[2024-01-12 13:12:40.089] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 5; rs_msg_len=61
[2024-01-12 13:12:40.089] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x53 (S)
[2024-01-12 13:12:40.270] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 7; rs_msg_len=62
[2024-01-12 13:12:40.270] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x55 (U)
[2024-01-12 13:12:40.447] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte a; rs_msg_len=63
[2024-01-12 13:12:40.447] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x52 (R)
[2024-01-12 13:12:40.626] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1; rs_msg_len=64
[2024-01-12 13:12:40.626] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x45 (E)
[2024-01-12 13:12:40.787] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=65
[2024-01-12 13:12:40.788] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:40.968] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=66
[2024-01-12 13:12:41.148] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 17; rs_msg_len=67
[2024-01-12 13:12:41.148] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x31 (1)
[2024-01-12 13:12:41.326] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 16; rs_msg_len=68
[2024-01-12 13:12:41.326] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:12:41.506] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 17; rs_msg_len=69
[2024-01-12 13:12:41.506] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x31 (1)
[2024-01-12 13:12:41.666] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 6; rs_msg_len=70
[2024-01-12 13:12:41.666] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x38 (8)
[2024-01-12 13:12:41.846] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=71
[2024-01-12 13:12:41.846] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:42.028] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=72
[2024-01-12 13:12:42.208] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 13; rs_msg_len=73
[2024-01-12 13:12:42.209] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x57 (W)
[2024-01-12 13:12:42.391] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 6; rs_msg_len=74
[2024-01-12 13:12:42.391] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x49 (I)
[2024-01-12 13:12:42.550] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte c; rs_msg_len=75
[2024-01-12 13:12:42.550] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x4e (N)
[2024-01-12 13:12:42.729] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 9; rs_msg_len=76
[2024-01-12 13:12:42.729] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x44 (D)
[2024-01-12 13:12:42.908] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=77
[2024-01-12 13:12:42.908] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:43.086] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=78
[2024-01-12 13:12:43.267] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 16; rs_msg_len=79
[2024-01-12 13:12:43.267] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:12:43.428] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=80
[2024-01-12 13:12:43.428] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:43.607] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=81
[2024-01-12 13:12:43.786] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 9; rs_msg_len=82
[2024-01-12 13:12:43.787] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x44 (D)
[2024-01-12 13:12:43.966] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 3; rs_msg_len=83
[2024-01-12 13:12:43.966] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x41 (A)
[2024-01-12 13:12:44.146] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 15; rs_msg_len=84
[2024-01-12 13:12:44.147] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x59 (Y)
[2024-01-12 13:12:44.307] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 12; rs_msg_len=85
[2024-01-12 13:12:44.307] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x4c (L)
[2024-01-12 13:12:44.486] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 6; rs_msg_len=86
[2024-01-12 13:12:44.486] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x49 (I)
[2024-01-12 13:12:44.666] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1a; rs_msg_len=87
[2024-01-12 13:12:44.666] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x47 (G)
[2024-01-12 13:12:44.846] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 14; rs_msg_len=88
[2024-01-12 13:12:44.846] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x48 (H)
[2024-01-12 13:12:45.026] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 10; rs_msg_len=89
[2024-01-12 13:12:45.026] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x54 (T)
[2024-01-12 13:12:45.186] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=90
[2024-01-12 13:12:45.186] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:45.368] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=91
[2024-01-12 13:12:45.549] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 16; rs_msg_len=92
[2024-01-12 13:12:45.549] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:12:45.729] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 7; rs_msg_len=93
[2024-01-12 13:12:45.729] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x37 (7)
[2024-01-12 13:12:45.906] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte e; rs_msg_len=94
[2024-01-12 13:12:45.906] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x3a (:)
[2024-01-12 13:12:46.066] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 13; rs_msg_len=95
[2024-01-12 13:12:46.066] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x32 (2)
[2024-01-12 13:12:46.247] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 17; rs_msg_len=96
[2024-01-12 13:12:46.247] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x31 (1)
[2024-01-12 13:12:46.427] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=97
[2024-01-12 13:12:46.607] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 3; rs_msg_len=98
[2024-01-12 13:12:46.607] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x41 (A)
[2024-01-12 13:12:46.789] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1c; rs_msg_len=99
[2024-01-12 13:12:46.789] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x4d (M)
[2024-01-12 13:12:46.950] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=100
[2024-01-12 13:12:46.950] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:47.126] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 10; rs_msg_len=101
[2024-01-12 13:12:47.126] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x54 (T)
[2024-01-12 13:12:47.306] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 18; rs_msg_len=102
[2024-01-12 13:12:47.306] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x4f (O)
[2024-01-12 13:12:47.487] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=103
[2024-01-12 13:12:47.487] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:47.668] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=104
[2024-01-12 13:12:47.827] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 16; rs_msg_len=105
[2024-01-12 13:12:47.827] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:12:48.007] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte a; rs_msg_len=106
[2024-01-12 13:12:48.007] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x34 (4)
[2024-01-12 13:12:48.197] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte e; rs_msg_len=107
[2024-01-12 13:12:48.197] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x3a (:)
[2024-01-12 13:12:48.368] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 10; rs_msg_len=108
[2024-01-12 13:12:48.368] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x35 (5)
[2024-01-12 13:12:48.546] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 10; rs_msg_len=109
[2024-01-12 13:12:48.546] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x35 (5)
[2024-01-12 13:12:48.710] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=110
[2024-01-12 13:12:48.887] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 16; rs_msg_len=111
[2024-01-12 13:12:48.887] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x50 (P)
[2024-01-12 13:12:49.068] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 1c; rs_msg_len=112
[2024-01-12 13:12:49.068] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x4d (M)
[2024-01-12 13:12:49.247] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 4; rs_msg_len=113
[2024-01-12 13:12:49.247] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:12:49.427] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 5; rs_msg_len=114
[2024-01-12 13:12:49.427] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x53 (S)
[2024-01-12 13:12:49.586] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte f; rs_msg_len=115
[2024-01-12 13:12:49.586] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x4b (K)
[2024-01-12 13:12:49.766] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte 5; rs_msg_len=116
[2024-01-12 13:12:49.766] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x53 (S)
[2024-01-12 13:12:49.947] DEBUG[1799252][C-00000019] app_tdd.c: FLOW Rx byte f; rs_msg_len=117
[2024-01-12 13:12:49.947] DEBUG[1799252][C-00000019] app_tdd.c: FLOW baudot returned 0x4b (K)
[2024-01-12 13:12:49.986] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:12:49.986] DEBUG[1799252][C-00000019] app_tdd.c: FLOW V.18 message buffer: 118
[2024-01-12 13:12:49.986] DEBUG[1799252][C-00000019] app_tdd.c: FLOW [status] calling put_msg with 118 chars
# 2: [0x7f378dff6ab7] app_tdd.so app_tdd.c:677 tdd_put_msg()
# 3: [0x7f378dff5b98] app_tdd.so app_tdd.c:469 my_v18_tdd_put_async_byte()
# 4: [0x7f378dff6d62] app_tdd.so app_tdd.c:715 modem_rx_status()
# 7: [0x7f378dff65fe] app_tdd.so app_tdd.c:608 hook_callback()
[2024-01-12 13:17:37.718] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:38.176] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:38.176] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:38.297] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:38.317] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:38.317] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:38.337] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:38.357] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:38.357] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:38.493] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:38.934] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:38.934] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:38.953] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:39.073] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:39.073] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:39.173] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:39.253] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:39.253] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:39.393] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:39.573] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:39.573] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:39.653] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:39.793] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:39.793] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:39.833] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:40.353] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:40.353] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:40.593] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:40.713] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:40.713] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:40.753] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:40.813] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:40.813] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:40.914] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:41.013] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:41.013] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:41.074] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:41.193] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:41.193] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:41.213] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:41.253] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:41.253] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:41.293] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:41.413] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:41.413] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:41.453] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:41.473] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:41.473] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:41.553] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:41.633] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:41.633] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:41.713] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:41.813] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:41.813] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:41.913] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:42.073] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:42.073] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:42.173] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:42.173] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:17:42.173] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 0
[2024-01-12 13:17:42.460] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier up (-2)
[2024-01-12 13:17:42.620] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=0
[2024-01-12 13:17:42.620] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:17:42.800] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=1
[2024-01-12 13:17:42.980] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 10; rs_msg_len=2
[2024-01-12 13:17:42.980] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x54 (T)
[2024-01-12 13:17:43.160] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 6; rs_msg_len=3
[2024-01-12 13:17:43.160] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x49 (I)
[2024-01-12 13:17:43.340] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1c; rs_msg_len=4
[2024-01-12 13:17:43.340] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x4d (M)
[2024-01-12 13:17:43.500] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1; rs_msg_len=5
[2024-01-12 13:17:43.500] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x45 (E)
[2024-01-12 13:17:43.680] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=6
[2024-01-12 13:17:43.680] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:17:43.860] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=7
[2024-01-12 13:17:44.040] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 16; rs_msg_len=8
[2024-01-12 13:17:44.040] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:17:44.220] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 6; rs_msg_len=9
[2024-01-12 13:17:44.220] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x38 (8)
[2024-01-12 13:17:44.380] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte e; rs_msg_len=10
[2024-01-12 13:17:44.380] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x3a (:)
[2024-01-12 13:17:44.560] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 17; rs_msg_len=11
[2024-01-12 13:17:44.560] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x31 (1)
[2024-01-12 13:17:44.740] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 7; rs_msg_len=12
[2024-01-12 13:17:44.740] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x37 (7)
[2024-01-12 13:17:44.920] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=13
[2024-01-12 13:17:45.100] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 3; rs_msg_len=14
[2024-01-12 13:17:45.100] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x41 (A)
[2024-01-12 13:17:45.260] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1c; rs_msg_len=15
[2024-01-12 13:17:45.260] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x4d (M)
[2024-01-12 13:17:45.440] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=16
[2024-01-12 13:17:45.440] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:17:45.620] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=17
[2024-01-12 13:17:45.800] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1; rs_msg_len=18
[2024-01-12 13:17:45.800] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x33 (3)
[2024-01-12 13:17:45.980] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1; rs_msg_len=19
[2024-01-12 13:17:45.980] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x33 (3)
[2024-01-12 13:17:46.140] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=20
[2024-01-12 13:17:46.320] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte d; rs_msg_len=21
[2024-01-12 13:17:46.320] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x46 (F)
[2024-01-12 13:17:46.500] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=22
[2024-01-12 13:17:46.500] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:17:46.680] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=23
[2024-01-12 13:17:46.860] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 16; rs_msg_len=24
[2024-01-12 13:17:46.860] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:17:47.020] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=25
[2024-01-12 13:17:47.200] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte e; rs_msg_len=26
[2024-01-12 13:17:47.200] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x43 (C)
[2024-01-12 13:17:47.380] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=27
[2024-01-12 13:17:47.380] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:17:47.560] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 14; rs_msg_len=28
[2024-01-12 13:17:47.560] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x48 (H)
[2024-01-12 13:17:47.740] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 6; rs_msg_len=29
[2024-01-12 13:17:47.740] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x49 (I)
[2024-01-12 13:17:47.900] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=30
[2024-01-12 13:17:47.900] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:17:48.080] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=31
[2024-01-12 13:17:48.260] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1; rs_msg_len=32
[2024-01-12 13:17:48.260] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x33 (3)
[2024-01-12 13:17:48.440] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 7; rs_msg_len=33
[2024-01-12 13:17:48.440] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x37 (7)
[2024-01-12 13:17:48.620] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=34
[2024-01-12 13:17:48.780] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte d; rs_msg_len=35
[2024-01-12 13:17:48.780] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x46 (F)
[2024-01-12 13:17:48.963] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=36
[2024-01-12 13:17:48.963] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:17:49.140] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=37
[2024-01-12 13:17:49.320] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1; rs_msg_len=38
[2024-01-12 13:17:49.320] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x33 (3)
[2024-01-12 13:17:49.500] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=39
[2024-01-12 13:17:49.660] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte e; rs_msg_len=40
[2024-01-12 13:17:49.660] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x43 (C)
[2024-01-12 13:17:49.840] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=41
[2024-01-12 13:17:49.840] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:17:50.020] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 12; rs_msg_len=42
[2024-01-12 13:17:50.020] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x4c (L)
[2024-01-12 13:17:50.200] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 18; rs_msg_len=43
[2024-01-12 13:17:50.200] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x4f (O)
[2024-01-12 13:17:50.380] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=44
[2024-01-12 13:17:50.380] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:17:50.540] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=45
[2024-01-12 13:17:50.720] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 13; rs_msg_len=46
[2024-01-12 13:17:50.720] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x32 (2)
[2024-01-12 13:17:50.900] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 7; rs_msg_len=47
[2024-01-12 13:17:50.900] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x37 (7)
[2024-01-12 13:17:51.080] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=48
[2024-01-12 13:17:51.260] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte d; rs_msg_len=49
[2024-01-12 13:17:51.260] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x46 (F)
[2024-01-12 13:17:51.420] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=50
[2024-01-12 13:17:51.420] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:17:51.600] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=51
[2024-01-12 13:17:51.780] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 3; rs_msg_len=52
[2024-01-12 13:17:51.780] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x2d (-)
[2024-01-12 13:17:51.960] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1; rs_msg_len=53
[2024-01-12 13:17:51.960] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x33 (3)
[2024-01-12 13:17:52.140] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=54
[2024-01-12 13:17:52.300] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte e; rs_msg_len=55
[2024-01-12 13:17:52.300] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x43 (C)
[2024-01-12 13:17:52.480] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=56
[2024-01-12 13:17:52.480] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:17:52.660] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 16; rs_msg_len=57
[2024-01-12 13:17:52.660] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x50 (P)
[2024-01-12 13:17:52.840] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte a; rs_msg_len=58
[2024-01-12 13:17:52.840] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x52 (R)
[2024-01-12 13:17:53.020] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1; rs_msg_len=59
[2024-01-12 13:17:53.020] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x45 (E)
[2024-01-12 13:17:53.180] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 5; rs_msg_len=60
[2024-01-12 13:17:53.180] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x53 (S)
[2024-01-12 13:17:53.360] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 5; rs_msg_len=61
[2024-01-12 13:17:53.360] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x53 (S)
[2024-01-12 13:17:53.540] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 7; rs_msg_len=62
[2024-01-12 13:17:53.540] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x55 (U)
[2024-01-12 13:17:53.720] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte a; rs_msg_len=63
[2024-01-12 13:17:53.720] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x52 (R)
[2024-01-12 13:17:53.900] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1; rs_msg_len=64
[2024-01-12 13:17:53.900] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x45 (E)
[2024-01-12 13:17:54.060] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=65
[2024-01-12 13:17:54.060] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:17:54.240] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=66
[2024-01-12 13:17:54.420] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 17; rs_msg_len=67
[2024-01-12 13:17:54.420] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x31 (1)
[2024-01-12 13:17:54.600] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 16; rs_msg_len=68
[2024-01-12 13:17:54.600] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:17:54.780] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 17; rs_msg_len=69
[2024-01-12 13:17:54.780] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x31 (1)
[2024-01-12 13:17:54.940] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 6; rs_msg_len=70
[2024-01-12 13:17:54.940] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x38 (8)
[2024-01-12 13:17:55.120] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=71
[2024-01-12 13:17:55.120] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:17:55.300] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=72
[2024-01-12 13:17:55.480] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 13; rs_msg_len=73
[2024-01-12 13:17:55.480] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x57 (W)
[2024-01-12 13:17:55.660] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 6; rs_msg_len=74
[2024-01-12 13:17:55.660] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x49 (I)
[2024-01-12 13:17:55.820] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte c; rs_msg_len=75
[2024-01-12 13:17:55.820] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x4e (N)
[2024-01-12 13:17:56.000] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 9; rs_msg_len=76
[2024-01-12 13:17:56.000] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x44 (D)
[2024-01-12 13:17:56.180] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=77
[2024-01-12 13:17:56.180] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:17:56.360] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=78
[2024-01-12 13:17:56.540] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 16; rs_msg_len=79
[2024-01-12 13:17:56.540] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:17:56.700] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=80
[2024-01-12 13:17:56.700] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:17:56.880] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=81
[2024-01-12 13:17:57.060] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 9; rs_msg_len=82
[2024-01-12 13:17:57.060] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x44 (D)
[2024-01-12 13:17:57.240] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 3; rs_msg_len=83
[2024-01-12 13:17:57.240] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x41 (A)
[2024-01-12 13:17:57.420] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 15; rs_msg_len=84
[2024-01-12 13:17:57.420] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x59 (Y)
[2024-01-12 13:17:57.580] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 12; rs_msg_len=85
[2024-01-12 13:17:57.580] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x4c (L)
[2024-01-12 13:17:57.760] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 6; rs_msg_len=86
[2024-01-12 13:17:57.760] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x49 (I)
[2024-01-12 13:17:57.940] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1a; rs_msg_len=87
[2024-01-12 13:17:57.940] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x47 (G)
[2024-01-12 13:17:58.120] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 14; rs_msg_len=88
[2024-01-12 13:17:58.120] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x48 (H)
[2024-01-12 13:17:58.300] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 10; rs_msg_len=89
[2024-01-12 13:17:58.300] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x54 (T)
[2024-01-12 13:17:58.460] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=90
[2024-01-12 13:17:58.460] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:17:58.640] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=91
[2024-01-12 13:17:58.820] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 16; rs_msg_len=92
[2024-01-12 13:17:58.820] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:17:59.000] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 7; rs_msg_len=93
[2024-01-12 13:17:59.000] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x37 (7)
[2024-01-12 13:17:59.180] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte e; rs_msg_len=94
[2024-01-12 13:17:59.180] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x3a (:)
[2024-01-12 13:17:59.340] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 13; rs_msg_len=95
[2024-01-12 13:17:59.340] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x32 (2)
[2024-01-12 13:17:59.520] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 17; rs_msg_len=96
[2024-01-12 13:17:59.520] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x31 (1)
[2024-01-12 13:17:59.700] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=97
[2024-01-12 13:17:59.880] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 3; rs_msg_len=98
[2024-01-12 13:17:59.880] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x41 (A)
[2024-01-12 13:18:00.060] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1c; rs_msg_len=99
[2024-01-12 13:18:00.060] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x4d (M)
[2024-01-12 13:18:00.220] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=100
[2024-01-12 13:18:00.220] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:18:00.400] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 10; rs_msg_len=101
[2024-01-12 13:18:00.400] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x54 (T)
[2024-01-12 13:18:00.580] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 18; rs_msg_len=102
[2024-01-12 13:18:00.580] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x4f (O)
[2024-01-12 13:18:00.760] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=103
[2024-01-12 13:18:00.760] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:18:00.940] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1b; rs_msg_len=104
[2024-01-12 13:18:01.100] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 16; rs_msg_len=105
[2024-01-12 13:18:01.100] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x30 (0)
[2024-01-12 13:18:01.280] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte a; rs_msg_len=106
[2024-01-12 13:18:01.280] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x34 (4)
[2024-01-12 13:18:01.460] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte e; rs_msg_len=107
[2024-01-12 13:18:01.460] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x3a (:)
[2024-01-12 13:18:01.640] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 10; rs_msg_len=108
[2024-01-12 13:18:01.640] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x35 (5)
[2024-01-12 13:18:01.820] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 10; rs_msg_len=109
[2024-01-12 13:18:01.820] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x35 (5)
[2024-01-12 13:18:01.985] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1f; rs_msg_len=110
[2024-01-12 13:18:02.160] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 16; rs_msg_len=111
[2024-01-12 13:18:02.160] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x50 (P)
[2024-01-12 13:18:02.340] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 1c; rs_msg_len=112
[2024-01-12 13:18:02.340] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x4d (M)
[2024-01-12 13:18:02.520] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 4; rs_msg_len=113
[2024-01-12 13:18:02.520] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x20 ( )
[2024-01-12 13:18:02.700] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 5; rs_msg_len=114
[2024-01-12 13:18:02.700] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x53 (S)
[2024-01-12 13:18:02.860] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte f; rs_msg_len=115
[2024-01-12 13:18:02.860] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x4b (K)
[2024-01-12 13:18:03.040] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte 5; rs_msg_len=116
[2024-01-12 13:18:03.040] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x53 (S)
[2024-01-12 13:18:03.220] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW Rx byte f; rs_msg_len=117
[2024-01-12 13:18:03.220] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW baudot returned 0x4b (K)
[2024-01-12 13:18:03.260] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 signal status is Carrier down (-1)
[2024-01-12 13:18:03.260] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW V.18 message buffer: 118
[2024-01-12 13:18:03.260] DEBUG[1799390][C-0000001c] app_tdd.c: FLOW [status] calling put_msg with 118 chars
# 2: [0x7f378dff6ab7] app_tdd.so app_tdd.c:677 tdd_put_msg()
# 3: [0x7f378dff5b98] app_tdd.so app_tdd.c:469 my_v18_tdd_put_async_byte()
# 4: [0x7f378dff6d62] app_tdd.so app_tdd.c:715 modem_rx_status()
# 7: [0x7f378dff65fe] app_tdd.so app_tdd.c:608 hook_callback()
dgorski commented 10 months ago

I don't see any chars that should irritate utf8... just letters, numbers, space and colon. Will have a look at it though. Thank's for the log.

InterLinked1 commented 10 months ago

I think I figured something out - this happens when decoding on a channel a message that should be legitimate to send from the other channel. I have some debug logs of AMI activity and found this there:

1705090291:205 : 966 : <== AMI Event: Event: TddRxMsg
Privilege: call,all
Timestamp: 1705090291.192495
SystemName: REDACTED
Channel: REDACTED
Message:  ▒TIME ▒03:11▒PM ▒49▒F ▒9▒C HI ▒50▒F ▒10▒C LO ▒46▒F ▒8▒C PRESSURE ▒1016 ▒WIND ▒15 ▒DAYLIGHT ▒07:21▒AM TO ▒04:55▒PM SKSK

As you can see, that's probably a sure sign of non-printable characters or garbage creeping into the message somehow. I'll bet that's what's causing the assertion.

Looking at the message, the garbage characters could actually be removed and it would still make perfect sense - it seems like between each word, typically after a space, something weird is going on...

InterLinked1 commented 10 months ago

More logs, when reducing the character to 1 byte, now it happens for every character:

I thought maybe it could be due to not null terminating something, but I took a quick look and that doesn't appear to be it. However, the character in question appears to be 0xff.

I think you might have fixed this here already: dec1d4a5d332b3f11d022372695d8569c2e07a7f

I think my revision is from right before that, so feel free to close if that's the case.

[2024-01-12 20:26:08.164] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW Rx byte 18; rs_msg_len=0
[2024-01-12 20:26:08.164] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW baudot returned 0x39 (9)
[2024-01-12 20:26:08.165] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW [bufsiz] calling put_msg with 1 chars
[2024-01-12 20:26:08.324] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW Rx byte 1f; rs_msg_len=0
[2024-01-12 20:26:08.324] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW baudot returned 0xff (▒)
[2024-01-12 20:26:08.325] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW [bufsiz] calling put_msg with 1 chars
[2024-01-12 20:26:08.325] ERROR[1806181][C-00000054]: json.c:618 ast_json_vpack: Error building JSON from '{s: s}': Invalid UTF-8 string.
[2024-01-12 20:26:08.476] ERROR[1806181][C-00000054]:   Got 24 backtrace records
# 0: asterisk ast_json_vpack()
# 1: asterisk ast_json_pack()
# 2: [0x7f378dff6ab7] app_tdd.so app_tdd.c:677 tdd_put_msg()
# 3: [0x7f378dff5da4] app_tdd.so app_tdd.c:498 my_v18_tdd_put_async_byte()
# 4: [0x7f378ff60322] libspandsp.so.2 :0 fsk_rx()
# 5: [0x7f378ff980fc] libspandsp.so.2 :0 v18_rx()
# 6: [0x7f378dff65fe] app_tdd.so app_tdd.c:608 hook_callback()
# 7: asterisk <unknown>()
# 8: asterisk ast_audiohook_write_list()
# 9: asterisk <unknown>()
#10: asterisk ast_read_stream()
#11: asterisk <unknown>()
#12: asterisk <unknown>()
#13: asterisk bridge_channel_internal_join()
#14: asterisk ast_bridge_join()
#15: asterisk <unknown>()
#16: asterisk pbx_exec()
#17: asterisk <unknown>()
#18: asterisk ast_spawn_extension()
#19: asterisk <unknown>()
#20: asterisk <unknown>()
#21: asterisk <unknown>()
#22: [0x7f37b0e57044] libc.so.6 pthread_create.c:442 start_thread()
#23: [0x7f37b0ed761c] libc.so.6 clone3.S:83 clone3()

[2024-01-12 20:26:08.504] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW Rx byte e; rs_msg_len=0
[2024-01-12 20:26:08.504] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW baudot returned 0x43 (C)
[2024-01-12 20:26:08.505] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW [bufsiz] calling put_msg with 1 chars
[2024-01-12 20:26:08.684] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW Rx byte 4; rs_msg_len=0
[2024-01-12 20:26:08.685] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW baudot returned 0x20 ( )
[2024-01-12 20:26:08.685] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW [bufsiz] calling put_msg with 1 chars
[2024-01-12 20:26:08.864] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW Rx byte 14; rs_msg_len=0
[2024-01-12 20:26:08.864] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW baudot returned 0x48 (H)
[2024-01-12 20:26:08.864] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW [bufsiz] calling put_msg with 1 chars
[2024-01-12 20:26:09.044] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW Rx byte 6; rs_msg_len=0
[2024-01-12 20:26:09.044] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW baudot returned 0x49 (I)
[2024-01-12 20:26:09.044] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW [bufsiz] calling put_msg with 1 chars
[2024-01-12 20:26:09.204] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW Rx byte 4; rs_msg_len=0
[2024-01-12 20:26:09.204] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW baudot returned 0x20 ( )
[2024-01-12 20:26:09.204] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW [bufsiz] calling put_msg with 1 chars
[2024-01-12 20:26:09.384] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW Rx byte 1b; rs_msg_len=0
[2024-01-12 20:26:09.384] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW baudot returned 0xff (▒)
[2024-01-12 20:26:09.384] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW [bufsiz] calling put_msg with 1 chars
[2024-01-12 20:26:09.384] ERROR[1806181][C-00000054]: json.c:618 ast_json_vpack: Error building JSON from '{s: s}': Invalid UTF-8 string.
[2024-01-12 20:26:09.557] ERROR[1806181][C-00000054]:   Got 24 backtrace records
# 0: asterisk ast_json_vpack()
# 1: asterisk ast_json_pack()
# 2: [0x7f378dff6ab7] app_tdd.so app_tdd.c:677 tdd_put_msg()
# 3: [0x7f378dff5da4] app_tdd.so app_tdd.c:498 my_v18_tdd_put_async_byte()
# 4: [0x7f378ff60322] libspandsp.so.2 :0 fsk_rx()
# 5: [0x7f378ff980fc] libspandsp.so.2 :0 v18_rx()
# 6: [0x7f378dff65fe] app_tdd.so app_tdd.c:608 hook_callback()
# 7: asterisk <unknown>()
# 8: asterisk ast_audiohook_write_list()
# 9: asterisk <unknown>()
#10: asterisk ast_read_stream()
#11: asterisk <unknown>()
#12: asterisk <unknown>()
#13: asterisk bridge_channel_internal_join()
#14: asterisk ast_bridge_join()
#15: asterisk <unknown>()
#16: asterisk pbx_exec()
#17: asterisk <unknown>()
#18: asterisk ast_spawn_extension()
#19: asterisk <unknown>()
#20: asterisk <unknown>()
#21: asterisk <unknown>()
#22: [0x7f37b0e57044] libc.so.6 pthread_create.c:442 start_thread()
#23: [0x7f37b0ed761c] libc.so.6 clone3.S:83 clone3()

[2024-01-12 20:26:09.564] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW Rx byte 10; rs_msg_len=0
[2024-01-12 20:26:09.564] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW baudot returned 0x35 (5)
[2024-01-12 20:26:09.565] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW [bufsiz] calling put_msg with 1 chars
[2024-01-12 20:26:09.744] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW Rx byte 16; rs_msg_len=0
[2024-01-12 20:26:09.744] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW baudot returned 0x30 (0)
[2024-01-12 20:26:09.744] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW [bufsiz] calling put_msg with 1 chars
[2024-01-12 20:26:09.924] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW Rx byte 1f; rs_msg_len=0
[2024-01-12 20:26:09.924] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW baudot returned 0xff (▒)
[2024-01-12 20:26:09.924] DEBUG[1806181][C-00000054]: app_tdd.c:368 spandsp_log: FLOW [bufsiz] calling put_msg with 1 chars
[2024-01-12 20:26:09.925] ERROR[1806181][C-00000054]: json.c:618 ast_json_vpack: Error building JSON from '{s: s}': Invalid UTF-8 string.
[2024-01-12 20:26:10.088] ERROR[1806181][C-00000054]:   Got 24 backtrace records
# 0: asterisk ast_json_vpack()