DJ2LS / FreeDATA

A free, open-source, multi-platform application for sending files and messages, using the codec2 HF modems
https://wiki.freedata.app/
GNU General Public License v3.0
146 stars 18 forks source link

Bug: Failed info session. #429

Closed jpronans closed 1 year ago

jpronans commented 1 year ago

Describe the bug During a "info request" session. My station appeared to retry sending an old message to a different callsign even though they hadn't been heard in a few hours

To Reproduce Unsure

Expected behavior That the "station info" request session would complete.

Logfiles 2023-05-21T20:55:27.971406Z [debug ] [TNC] send_data_to_socket_queue: jsondata={"freedata":"tnc-message","arq":"transmission","status":"opened","mycallsign":"EI7IG-0","dxcallsign":"G0HWW-0","irs":"True"} 2023-05-21T20:55:27.972106Z [info ] [TNC] ARQ | DATA | RX | [EI7IG-0]>>|<<[G0HWW-0] bandwidth=wide snr=3.1 2023-05-21T20:55:28.968851Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=3 sync_flag=--ST 2023-05-21T20:55:29.061845Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=3 sync_flag=--ST 2023-05-21T20:55:29.167712Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:29.262220Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:29.367669Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:29.460505Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:29.563989Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:29.666061Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:29.770131Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:29.863677Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:30.068587Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:30.163809Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:30.268043Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:30.363457Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:30.466480Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:30.559447Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:30.664572Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:30.770666Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:30.864369Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:30.967937Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:31.165466Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:31.269429Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:31.363513Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:31.466609Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:31.559701Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:31.664544Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:31.770785Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:31.864833Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:31.967943Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:32.061163Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:32.269253Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:32.363738Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:32.466761Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:32.559854Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:32.664720Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:32.770627Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:32.866565Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=2 sync_flag=--S- 2023-05-21T20:55:33.198084Z [debug ] [MDM] [demod_audio] modem state mode=dat0-datac1 rx_status=6 sync_flag=-BS- 2023-05-21T20:55:33.199602Z [debug ] [MDM] [demod_audio] Pushing received data to received_queue nbytes=512 2023-05-21T20:55:33.200537Z [debug ] [MDM] worker_received: received data! 2023-05-21T20:55:33.201347Z [debug ] [TNC] process_data: n_retries_per_burst=0 2023-05-21T20:55:33.202115Z [debug ] [HLP] check_callsign: Checking: callsign=b'EI7IG-0' 2023-05-21T20:55:33.204738Z [debug ] [HLP] check_callsign: Checking: callsign=b'EI7IG-0' 2023-05-21T20:55:33.206547Z [debug ] [HLP] check_sessionid: Checking: check=b'\x01' ownid=b'.' 2023-05-21T20:55:33.207337Z [debug ] [HLP] check_sessionid: Checking: check=b'.' ownid=b'.' 2023-05-21T20:55:33.208060Z [debug ] [TNC] RX SNR snr=3.1 2023-05-21T20:55:33.208943Z [debug ] [TNC] temp_burst_buffer buffer=b'BOF\x90\xf8\t\xe6\x00\x00\x00\r\x01\xfd7zXZ\x00\x00\x04\xe6\xd6\xb4F\x02\x00!\x01\x16\x00\x00\x00t/\xe5\xa3\x01\x00\x0cm\x00;\x01;req\x00;\x01;0\x00\x00\x00\x00\x081\xe9de%.\xaa\x00\x01%\rq\x19\xc4\xb6\x1f\xb6\xf3}\x01\x00\x00\x00\x00\x04YZEOF\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00' 2023-05-21T20:55:33.210252Z [debug ] [TNC] ARQ.rx_frame_buffer buffer=b'' 2023-05-21T20:55:33.210959Z [debug ] [TNC] ARQ | RX | appending data to buffer 2023-05-21T20:55:33.211919Z [debug ] [TNC] arq_data_received: bof_position=0 eof_position=84 2023-05-21T20:55:33.212993Z [info ] [TNC] ARQ | RX | DATA FRAME SUCCESSFULLY RECEIVED bytesperminute=5805 duration=5.240276336669922 nacks=0 total_bytes=13 2023-05-21T20:55:33.226088Z [info ] [TNC] ARQ | RX | saving data to rx buffer buffer_size=8 maxsize=16 2023-05-21T20:55:33.238443Z [debug ] [TNC] send_data_to_socket_queue: jsondata={"freedata":"tnc-message","arq":"transmission","status":"received","uuid":"c17e2212-8bc5-4fcc-86c7-d3b7132abec2","percent":100,"bytesperminute":5805,"compression":0.18055555555555555,"timestamp":1684702533,"finished":0,"mycallsign":"EI7IG-0","dxcallsign":"G0HWW-0","dxgrid":"------","data":"bQA7ATtyZXEAOwE7MA==","irs":"True"} {"callsign":"EI7IG-0","dxcallsign":"G0HWW-0","gridsquare":"IO62KE","dxgridsquare":"------","frequency":7053000,"avgstrength":0,"avgsnr":3.1,"bytesperminute":5805,"filesize":13,"compressionfactor":0.18055555555555555,"nacks":0,"crcerror":false,"duration":5.297319412231445,"percentage":100,"status":"received","version":"0.9.2-alpha.5"} 2023-05-21T20:55:33.298593Z [info ] [MDM] calculate_snr: snr=5.0 2023-05-21T20:55:33.303746Z [debug ] Starting new HTTPS connection (1): api.freedata.app:443 2023-05-21T20:55:33.356475Z [debug ] [SCK] CMD command={'type': 'arq', 'command': 'send_raw', 'parameter': [{'dxcallsign': 'DL3NEY-0', 'mode': '255', 'n_frames': '1', 'data': 'bQA7ATtyZXMtMAA7ATtkYXRhOmltYWdlL2pwZWc7YmFzZTY0LC85ai80QUFRU2taSlJnQUJBUUFBQVFBQkFBRC80Z0hZU1VORFgxQlNUMFpKVEVVQUFRRUFBQUhJQUFBQUFBUXdBQUJ0Ym5SeVVrZENJRmhaV2lBQUFBQUFBQUFBQUFBQUFBQmhZM053QUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQVFBQTl0WUFBUUFBQUFEVExRQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFsa1pYTmpBQUFBOEFBQUFDUnlXRmxhQUFBQkZBQUFBQlJuV0ZsYUFBQUJLQUFBQUJSaVdGbGFBQUFCUEFBQUFCUjNkSEIwQUFBQlVBQUFBQlJ5VkZKREFBQUJaQUFBQUNoblZGSkRBQUFCWkFBQUFDaGlWRkpEQUFBQlpBQUFBQ2hqY0hKMEFBQUJqQUFBQUR4dGJIVmpBQUFBQUFBQUFBRUFBQUFNWlc1VlV3QUFBQWdBQUFBY0FITUFVZ0JIQUVKWVdWb2dBQUFBQUFBQWI2SUFBRGoxQUFBRGtGaFpXaUFBQUFBQUFBQmltUUFBdDRVQUFCamFXRmxhSUFBQUFBQUFBQ1NnQUFBUGhBQUF0czlZV1ZvZ0FBQUFBQUFBOXRZQUFRQUFBQURUTFhCaGNtRUFBQUFBQUFRQUFBQUNabVlBQVBLbkFBQU5XUUFBRTlBQUFBcGJBQUFBQUFBQUFBQnRiSFZqQUFBQUFBQUFBQUVBQUFBTVpXNVZVd0FBQUNBQUFBQWNBRWNBYndCdkFHY0FiQUJsQUNBQVNRQnVBR01BTGdBZ0FESUFNQUF4QURiLzJ3QkRBQUlCQVFFQkFRSUJBUUVDQWdJQ0FnUURBZ0lDQWdVRUJBTUVCZ1VHQmdZRkJnWUdCd2tJQmdjSkJ3WUdDQXNJQ1FvS0Nnb0tCZ2dMREFzS0RBa0tDZ3IvMndCREFRSUNBZ0lDQWdVREF3VUtCd1lIQ2dvS0Nnb0tDZ29LQ2dvS0Nnb0tDZ29LQ2dvS0Nnb0tDZ29LQ2dvS0Nnb0tDZ29LQ2dvS0Nnb0tDZ29LQ2dvS0Nnci93QUFSQ0FCeUFIWURBU0lBQWhFQkF4RUIvOFFBSFFBQUFBY0JBUUVBQUFBQUFBQUFBQUFBQUFNRUJRWUhDQUlKQWYvRUFEMFFBQUVEQXdNQ0F3Y0JCZ1VEQlFBQUFBRUNBd1FBQlJFR0VpRUhNUWdUUVJRaVVXRnhnWkV5Q1NOQ29iSEJGUlpTMGZBWEpDVXpRMktDa3YvRUFCd0JBQUVGQVFFQkFBQUFBQUFBQUFBQUFBY0RCQVVHQ0FJQkFQL0VBRFFSQUFFREF3RUZCUWdDQWdNQUFBQUFBQUVBQWdNRUJSRWhCaEl4UVhFSFVXR1JzUk1VSWpJemdhSEJJL0ExNFRaQ2N2L2FBQXdEQVFBQ0VRTVJBRDhBejJ6RVZnRUQ3MHJaaWpBRzNQRkd0TVpIQW85SVMybkZZamZJU2tGeXpFSTVJNHBVM0Z4eHMvbFN2VEZ1WGVaUVpRbkl6Vm5XTHBDMU5paHhVY2s0NzRxUXQxaXVsM0JOTzNRYzBvSWlSa0tyVzRaSXdPQlVkMXgxTjBwb0ZoUW5MY2xTZ25LWWNSTzVaL3NQdlU3OFEybmI1bzYyd3RQNk5oT0t1VnpXUUhFb3lXMndRazQvK1JLZ0I4NmNQREo0RFcySHY4NWRRblZ6SDVHRnRzT2s0SEF3dFFQcWNaeFZwdHV3N1lHKzhYWitHNTBZM2k3cWVRNmE5RllyQnN6VjN5bzNHYURtZkJVYy93QlZ1cDg5MWx1emRQR0k2WkFDbVZ5M1ZxS2tFOGNCSXdmWEJQcCtDcnAxYjZnNmNiOXZ1Rm9pU01zSS93QzJZYUtRaFE1VVN0U3Vma0JXM2RWZUdiUzgxSWNpUTNFUEpSaFBrcVR0QkdjY0hqNENxVTZ4OURvMWxEVUMyMnFRV1ZQSlMzSExZS2R3TzdrOStGYnNmSFB5b2dXdTA3SFM0akZJejc1UDVKSlZydW13TWx0aTM4YndWVWFMNjg2WTFNMGxxNXhINFVnQkljUzQzbElKT0IySnFleGtNUzJreVl5MHVOcS9TcEJ5RCtLV1hyd2pyVHBsVi90a05jZVp0RWd4dzJBVjQ1S1IvcFVSbjcxUmRtMWhxWG9yclpUdDBXdVhiWmIvQUpiOXVVVHVBSEtsSUF6c0tRcmNvOEFEbkh2Q29uYURzMHQ5d2hkUFpEdVNEaXdrbHJ1aE9TMCtZNWFLbVhTeFZGdkFjUm9WZGlvZ09jbzUrT0tKTU1CT0FpckVoOVBJOXpzRWEvUUVxOHFYSFE4MHJPZmRVa0VmMXFOM2l3dTI1OHR2SXlQUTBHYm5hTHBaeVBlbVlVQmpDamlvWUl3TzlGT1F5a2toSSsxT3pzWDFTS0lXMWlvMXN1VjhtdHhncE9DS0ZMSEVCS3NwUitLRkxDUTRYbVUySlp3QVU1NCtkRnlHeUVaQ2VmaFM5RWZLZUNQdFJiN0dVWUlwVVNEZVNuTFJTTG96RjgrNmU4Yys4QWEwOXBHMHRmNGVuYzBuOVB3ck9QUkNOLzVRbkg4WGI3MXFUU01aSXRpZHc3SjVKby9kbXdCdE9jY3o2cDR6aG9vN0s2VksxSnJ6L004aUF3N0dqUkVOTkZmSlFvRmFpRTU5MUpPY2s4a2hJSEhOV05vNjFJa29EYW16Z3JJVVVqSEE3WXhTUnU5SmFzRFRWcVdGcWx6VnRTRnB4N29DZU9QeCthaytuR0k4T0NGaHdJT0NSN3d5UlVkdEZVU1RWMkJ5SjlWb1RZU2xaVDIzT01FNDlFZlAwaEZZaSswbE8xT09TY2Q2aTkxc0ZwdUMwcVMwSERqTzExQUpTUUIvemlwQmU3bzlkWUc5bDB0Z1lDa2hYNmg4VDg2alRpMTJ0dHU0S2VTdFFTc0s5L252aW1NVW54RGRSRkZJNTBKRHpxbWFkcHlHcHp5WFdVa0hoUUNmN2ZTc3YrTHp3c1FaUW42OXNNUlBrTlNXWFpqWlNuSGtFZVdzWVVuRzdLOTJkMk1BOFpJSjFySExGNGZNNURod1AxSkpxSTlXYm5EYzB4Y2JCZFdVUFJKZXo5MjRrYmR3T2NxOWVkdTNQKzlFN1prbHd5VUdOdVd0OW51bmtvbjBXdGFmK2lWa2pQcFdyMmVFR1VyZFJoU2twR0U1NDlCeDlSVUk2a3dVTnl3RUl4eWUxV3IwN2FoSHA4MnEzdWxUS25YQzBnays0bmdZNTV4a0dxNDZtczRtRDRaTlVEdGhheUtoT0J6SHFFRTVzQjZyMlFrcFVjZ0Q1VWtrSTdxQVA5cWRKVFhmM2ZyU0IxUEJBSHI2MW5xTnlTSktieWtic2tlbnBRb3g5cFNUeGtVS2Rod3d2TVpYQVpTQmdBRDQ1b21ReW55eWNjZWxMRXQ3UmpIZnVhS2tOaGFTRHlLOGE4N3lYM1JoUzdvVkgzWE01R01xSGV0UTZlam8vd0FGQWNCd1FCd085WnI2Q3NicmdySS9qeHhXbzlQd25wRnBiYWFVbEpLaGdxR1JXZ05oQzRiTFNPYngzWC90VDJ6ckk1TDFTdGVRQVpHWnp3K1lLSFhxV25RRjRqeG9NU2JPTnd1R3lSQ3RjQnlUNUxpa0QzbkMxdURJQ1FvbFN3RWtsS1NRU2tHQmRWOWQzMjBOM0J5eGRPNzNyR1o3TTQvNVVlZXBscERZUERTQ2tFaFo5TUpJQkhKVFY4cGhMdFZ5dHNLVTBqMmgwdktjZVFrQU9qY25hY2ZuOFViZGRDQ1k0dVZhV1l1WEVuelpDeVd5bmtua3AvM3FGRlZJSldrdHp3QjE0NDZMU3d0alh6eXRqZGdGeE9nR2hQWEkvQ3pGNGZPcTNVbHVQRm0zM3AvcUN6UnBzNXFNN2I1c2xVd3dTODZsdEpWdTJxSUcvSjJoUkNRVGdZb25yVDFmNmpYV2FqU05vVzdweDlUNmx5WTAxOWhNcG5uakttWEhtV3dVNFVDVkh1T09EaS9MQnBDRWJzbE1DREhjZTh4UlU5SGNPRlo0N2tBazkrYXIzcS9BMDNwL1hzQ2RxbTF0aE55dUNXV0pUblpoNG5hQ3JIWUt6alBmdFUxYllvYXVTU1FzQXdDUnFlUzR1VVZiUjA3SVJNVGx3YWVBNGpqb0JqUGwrcWMwZjFsbTNFTjJOVjI2ZzJXNng1bmtpYmQwTk94WlMwazh0cURhU3RDZ0RoU2tJQjdBOXF2QzZDWDFBMGJBTHNCeUtYSTZuNWwza1JsQmh0SUc3WUFGRGN0UmJPQUQ3dkpVUmxPNlR3T25zU1MyMmlYRUR5RGpoNXd1QWY4QTdKcnZxS21FeG9pWHBQMm9zZTBXOThGNlB3V1NFSDNrOXdEay93Qkt1T3p0U1E0bmQrRWE4ZWFvTzA5cWxZd01sZmx4MC9vVlNkRDliM2EzWDVIU2lmTWRuc3F0ajB0bTR2dGxDMXFRNlVGT01ZNHgzOWM1OWE1Nm1NNW0vbW1Ud0k2WjE3RTA1TmxhK1E5STltaWhxMVRKajZuSHZKVVFTa2tuSXp0QndlZUtrM1V4Z2UyZzQrUGVoeDJzenlTMmNTT1BFajFDRmUxVUZOVFhUMlVMUUFHak9PWjQ1OHNLdkpUQkJLVDJwQTlFV1ZlNm42VSt5SXdVVDZVamRqQUhnQ3MveHlxdDQwVEtwZ2xXUWduTkNuSnlPT3g5S0ZPUkt2TUpyS1BkNEZFdklHd25IRktRQURuTkV5VTRRY0dsbW5CVGdLZGRCR3dxNEU0UDY2MVBwVm9LdHFSamdwckwvUUJyZk96aitPdFRhYVFVMjlBeG5pdE05bDdjMk52am4xS1hhWE53UWNKdTFySW14Wmxza095RTdHQXRDRkFZTzNLZUQrZTlPRXFhN2U3RVlzaVFwbUtzN1hnMzdxblBsblBBK2RjYS9nZTA2YWNtQkl6RlBtSytPM3NvZmc1KzFmTGZBcytwTEVtQTZmM1pRbFNrQmZ2RWNIQi81NlV3Mm90OFZ0ci9BT051R0VBakg1L09Wb1RZZS9WVnp0TzlJN2VrQndTZVBnZVhMR3ZoM3FMYXUwMU92VXVEY2RMYWp1RnZpMjlhMUNMYjBmdTVCMktRTjZ0cHlCa25IYmNBVHlCVk9kUU9oMnBKR29icFp0ZTlYTGpLdDF4ZlpmYmp2UTIwYlNoUVdnb1dBT1BkQS9QeHE1OWJkQjlKdXhqZm83K29YT2R6YkxHcDVTRU5uNHBTWE1KSHlHQjhxaTBmb1RaYmsycTVYS2RxWmU5R1hXWDlWekZvS2gzd0M1eDYxemFLbW5ZY2pnUmp4Vm11dE9acWNQYzdMZ2M0MXdwRnA3VmhaMHUybEpVNHVJd04yZVNwSFlLUDRwazFOQnVtcjlGeXpaSWpzeVpjQUdtV21EZzdWS1NDY250eGtrazBkY2hwL1FXaWY4djI5NVNIUzJVRkxyaW5GN1BUS2ljcVB6T1RVdTZJUjNIck1xVXNLS1drQnRLbER1cFhLaDhlT1B6VncyWXB5Nko3RG8wazQ3OElkYllYaDdHc2xkZ3VhQVQzWnpva0dtZW5yWFQvQUVpTFlwM3pKTHFkOGx3NC9WanQ5cXFqcWEwZmJlUjZtdEM2cGIzUkRrREcwMVF2VXhqTS90OGFIWGJPMXNOckRSM3Q5UWdyVlR5MWRRWlpUbHp0U29CSlFTU2FTdXRraW5PUTNqMEh6cEhJUmprZHF6Zkc5TitDYlhtc252UW8xNUpTckpKSitHS0ZQQVRoZWFKaUNNamJSTWtFTm1qODhBQWZlaUpaOXoxK2xQMjUzazRHT0tzYncrSUJra2cvKzVXcGROdEEyOXZubmJXWGZEencrQ2tkMTFiM2lKNjROK0g3b0hjK29UVFljbXR0QmkxdEtIQ3BEbkNNL0lkL3RXb2V6QWJ0Z1lldnFsc0YyQWxuVlh4TjlFdEY2cGk5Rjd0cmFPNXFlK09waVE3UEcvZU9wVzV3QzVqaEErcHo4cVNqVTEzMEpLYmFaWlU4d3BRTGZ6eDNUbitsZVkzZ2swZHFYcng0NGoxcDF0cUc0U0dOSjZtaG9XR0VGYXB0eWtva3VndUxVTUlhYmJZZFVvOXlyeWtEOWVSNnMzcTJzVExZQXRqSVI3d1dQVDgwbnRsVlJ5M0ZrWTEzVzRQVTYrbUVhT3oraWxpdGNqaG9TN0lQZmdZUDV5bTY4ZUl2UWxvanRLdjgxTU1ra2JKR1VsSkk0eG5nNE5RbTVlTHZwVVpiN0ZqMVBHa09rRWhodGU0RWtjQUVkNmtsNDBKYjdqQ1ZLYmhOT0tDQ2YwQWsrb3dUL2FxWTFUb1dMY0o2R0RibWtyU3NqLzBBRHRBSHFPYzUvcG1vK3p3d3ZsR25EKzl5czk1dU54aHBkM1RYdy8ybk9GcnlkMUwxTElrcml1SmpvVWxPOVNNQVk5RS9Ha1BXL3dEYW1kRWZBbDFMc25RdnFwbys4UG92R25tN3lMemIxSVdsdExqNzdCU3BzNEpPWTVPYy93QVFxVDZXMFJJam9ZalFHMUlhYlNDc2hBeG40NXJMZjdXbnBqWnRVWGZUT3I3eFprWGlMRXR2c04zdHhTQzZoanpIRnBmWVVQZVF0Sld2T09WQS9MQ2lEUlZFZEpsd0djSVlYYWlucTZJZ25VbGJmNlJlTDN3NytLZlRxcnYwVDZrUTdxNDIzdWt3Q3J5NUxBK0NtMWMvY1pIenFJOVN4aTRZMitocnlaOE1qZXJmQ1QxK045c2Qzayt6TlNtSDdaSjNZRTZJNm5jRXF3TUhqM1R4MytGZXFsNTFSQjFsWjRHcUxlc0ZtZkVTOGphck9Od0J4eFFwN2JHZTBzVVZVelZqeU1IeDBQcCswT3FpQjlQTHV2NHFNeVU3Y21rVWdaNUErdE9FbFNjbkp5ZnBTSnhPN2dER1BuV1o0eWtIRUpBKzN1SUovR0tGSHV0YzhaKzFDbmdkb3VlcWlvVnp4L00xd3VOSm1EeVl6QzNGSHNsQ1NUL0twUkUweGE0R0JNeEpkM2UrQXJDUjlQalR2RW54bVZpUGJXUFp4bkJDVUJQKzVOR2EwOWxsNHFtdGtySkd4QTh2bWQ5K0FIbVZMdzIyUTZ2T0VwNlJ0VDlJdy9iN3BFVWdrN2doWjV4V1hmSGg0bzcvQU5adGVMNmJ3Sm9UYWJFMk5zZG5sQ245M3ZyVi9xMmpqODFmWFgyNzlROUxkTGJscUxRdWxwZHptb2h1TFphWklLOW9TZHkwcHpsWkdjN1J5Zm5qbnpUaGFydmJzdVZmTGw3U0RMSzBGUlFmZVdzYzgrdndvN2JOMlNDelVBcDRYRWh2TThUNUp6SkRGQVd0YURudksyVit5K2JjdFoxOHhBZVNYRzlWV3E0U0U3UnVjYWVia3hFWXg4SG5taWZnRW12Unl6cERyU1dYazdrT0pBSTlNNHJ6ei9aUVdDNGJIZW9Db3BrZTJ5MVdLNHhZcElVOHk2VUt5bmFjK1kyb29Vazl4N3dBQklJOUdyUlo1MWpoQzMzOVNWU1dYU0daR01COUk3SDRCWHhUNkVmREZVYmFXbmZUM1YrL3dkcUQzNkFFZFJoR1BZcXNqZmJteFoxR2Z5Y3FNNm5oWHJUVEx5WXNaVHJTd2NGQ08zSDlhcitQcEcrNmh1Wm5MaGxHRkhHNFlJKzNyV2hwbG9STWhwZmNKU0ZKL1NVbkIrZlBhbXhuVDBKaE85SlNlK0ZBRHZTTkRQN0VaQ3MxZFMrOGp3VmJTTFlkSzJjQjFHSFZKd29tczg5WSttczNxeDFJdDBTZXZFSkN3SGxLOVU5OGZ6L25XbnRZV2VaZEp5ME5uQ1VwOTNjZ2tFMUdwR243WHBsbC9WbDRncWNSSFNOaUVvNVVySUFBKzVHVDZmY1ZOeVZibzZjdGJxNTJtT3FyODlIRmpmazBZM1ZlY2Y3UkhUR210QTlVTFhwRFM3TGJRZ1d0cENVTnA5T1ZqNzVXcXBQNEQvRU5ObnVMNkw2am5QU2hIOHBVVjByM0ZuekFvbFAwRzBINUVtcVk4ZVhYVmpXM2lEdjEzWWhvVW0yUCt5RnhwZVN0U2YxQWNjRUVrZmFrdmdqdXMzUWZVWWFodjRSL2lGMVI3VjdJY0FqWVZMRFB5VXBCN2VtN250emRvckJicm5zMjIzWE9JU05jQmtIUHpjY2dqQkJCNWdvS1htWmxaY255TitYZVBrdlJpWHBpUTRrdXdaYk1nSkdTRUx3cjhVMVNZRXlLTVNJeTBnZXBUeG11ckZxTzNhcnRUV29iTklVcU02Z0ZEbTRjRDFTY0hnZzVwYkd1OHVNa01zVFE4aGZLbVgxQXBVUGhtaFBkdXcyeVRrbTN6dmlkeUR2amIrbmZrcG82aFk0WllVMUZ0UVBBeFFwOWtXMjBYRlJjanVwaE9aejVUeWdFcVQvcVNmeHhRb1MxL1pUdDFSVlRvV1VwbEE0T1lRV2tlR1NEOWlBVXhkR1dPd1FtdzJ5UTJ5RmxrS0FXUWNqT0IrYU1tVzF0VVZUc0U3VHN3cEtnY0VmYWptcGpVaUtVcmRXZzU1U3JzVHlNZlRqK2RLYmI3SzhsU1ZlWHV3T3k4WVZqR1B4V3FnY3NWd0xRMTJBbWFCcVMrV09mN1hiQ21YR1czNWNxM1A0SXdNNUxaeDdpaURqbmdrNTlLZ1BVUFRQZzc2aTNmek9yblNKeTEzS1FWSHpYSUsyL01XUDQxT05FQmZHTUtYbXJLZVNpMTNWUVdvK1dYY0JBQUJ6OGVLN3UwTzJhZ1EwWlZ1YWxvVWs3Z3BJV0NmbUQvZXVSbU4yV2tnRmRaMzI3cnNIcW1yd3NzK0czb3BOWXNQU2JVemJ6Y2E3b3UwaUc3TUc5U2tGcmdrRENSaEtFOXV3OWU5Yk5pOVkrbkhWQ0ttOTJlVTJ5NjhFKzB3blNsU0NzOGh4S2djYzkrUGtlS3hxT2gvVFc2UWx4WHRGd21pNnY5NnVFa3NsMGM0U1NnalAwK2xJMTJhKzJHZVd0T2F4bHhtME9IeTJWblBscDJnQUhqQ2twSEFIcFRDNVVNVjFwblF5ODlRZVlQSWoralRSUGFPcWxvWld2WnBqa09ZVzRIWmlubWpEV1NrSTRRRC92VFpManpVdHFDWmJTU3JrOG5HUjlxcUhvTjEwbTNHNm5wZHJ5NW9GM1JGODYxdnVqSHRyUTRPUFhjbkhZOGtmSEJxUWRhT3JFZnBocGx5OFNVZWUrNG9vaU1CWlNDY1pLbHEvaFFCeVQ5QU1rZ0VaR0s1MHRZS1BHOC9PQmdjZTVFQ0creSs2ZTFEL2c1NXdjS1MzaTlXU3dNcGR1OTJiYnpqZVR3a0Q0NTcxWDNYRHhCOUM5VmFKYjBYbzNWY1FHTEw4eDJlNjRqYStVcFdrNEFKUDZqd0RqMTlheDExajFsNG1mRU5mWlZwMGJQTnRoSWVEVHR4bUtLRXRLQkIydG85RkpQd3llY0UxRk5NK0FqMm00RzlhMjZ0WFdiY0gwNWZNZDVUS0FSeCtrWW9wMmZaeDlEL0xWUEJrODkzdy8ycUJkOXBxbTVuY1lEdWVXVkhicit6cjBOcjNWbDAxbHFYeEMyank1dHlma1Iwd1ZKS2tCU3lvQWhhd0FSbjZldFNucDU0S2ZEN29UVTdPb2RYOWFaTjljaHlVUHNOR2UzR1pUdEh2SkphVVZiU0FNNEtUOWMwNVdUd0tkTXJjNDg3TG5TMVBIM3dYSlc0L2ZQRktUNFIrblRHOXB1N1QyeXNncENTajNray9ISHpIMnEyRnUrM0JmajdLc1lJT2ZaZy9kS2JsMWhzbWkrckxyR2laTVNYcHlmaHhobUdBRzR5Z3BUYTl2MVVqZGcvNnF0Vm00cm5SVVM0cXc2RklDOCtVRG5QZlBHQ01WQ0xONGNPbkZoWTlvVTNJVTdrRU9Pck8wajBOUytIR1JhMlVzUWo1YVVKeHNXczR4MnpqdGlsbjdoYTNCMTcrOWN4KzFCTzl3N3U1T1l1NWpLOWpmWVpjU0JrcFUxa0pQMkZDa2daZGRiMlRQZE84a0ZJenhnQWRqL3dBeFFxUmlZNHhoTm55TmE3Q1U3bE4yWUtRb3BLVkpLU0RqSE5QTTFTbzZXeXdvb0pmVGtvT00rNmZoUW9WUlcvSXJDM2lFZmNFcEx6aVNrRWUwcTRJK29wclFTaTdodEJ3bkI5MGRxRkNsRy9JdWYrd1QyMHBYczZsN2p1Q0ZZT2VSd2FaYnk2NmlaS0NIRkFiejJQMG9VS1JaeFM1NEpEcWdsblZXajU3SjJQdGF1dGFHMzA4TFFsYWxCYVFlNENod1I2anZVeDhUMGFQSzFGRmNrc0ljVXl5bnlWT0pCS01seFJ4bnR5aEI0OVVKUG9LRkNvR1AvbVZOL3dDVDZGU0x2OEZQMUg2VmJkTkdta2FNYlFodElIbUw0QTQ1Y1ZtcExib3NaeGxRY2pvVnRkd25LQWNBcXlhRkNpQS82cDZxc3gvVEhRTG0zdHRtL0thS0J0OHo5T09QMDAyc3FVTUlDamd2Y2pQQjRvVUsrWHZOT3lFSWRnT0xkUUZLK0toazB4VDJXbVp3OGxwS005OXFjZHdjMEtGS3U0QkpCY3hTVGI5eFBQbURuLzZpaFFvVk5SL1RDakpmcUZmLzJRPT0AOwE7RUk3SUctMAA7ATtJTzYyS0UAOwE7Sm9obgA7ATsyADsBO1RyYW1vcmUAOwE7SWNvbSBJQy03MjAwADsBO0tlbGxlbWVuIDgwLzQwLzIwbSBUcmFwIERpcG9sZQA7ATtqcHJvbmFuc0BnbWFpbC5jb20AOwE7d3d3LmVpN2lnLm9yZwA7ATtHZW5lcmFsIEdvcGhlciBhbmQgZG9nc2JvZHkAOwE7', 'attempts': '10'}]} 2023-05-21T20:55:33.554463Z [debug ] https://api.freedata.app:443 "POST /stats.php HTTP/1.1" 200 None 2023-05-21T20:55:34.225471Z [info ] [STATS] push code=200 2023-05-21T20:55:34.239517Z [info ] [TNC] ARQ | RX | SENDING DATA FRAME ACK 2023-05-21T20:55:34.265093Z [debug ] [TNC] enqueue_frame_for_tx c2_mode=sig0 data=[bytearray(b'=.\x1f\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00')] type=FR_ACK 2023-05-21T20:55:34.288602Z [debug ] [MDM] TRANSMIT delay=0 mode=19 payload=14

Screenshots

Desktop (please complete the following information): TNC on Raspberry Pi, Desktop on Pop-OS 22.04 Laptop

Additional context DL3NEY hadn't been heard since 4:34PM.

DJ2LS commented 1 year ago

Thanks for the report, @jpronans !

We might keep this in mind for checking if it occurs again. I have no idea why this happened.

g0hww commented 1 year ago

I have to come to describe the scenario in which this happened.

After a day of poor propagation, when John's station eventually appeared with a good SNR, I decided to fetch his profile and go to slump on the sofa.

My request to John's station was delivered OK, and after a brief pause, his TNC attempted to open an ARQ connection, but not to my station! Looking at the TNC console output here, I could tell that his TNC was trying to open a session, but it was considered to be foreign, not addressed to my station. There was no response to those attempts to open an ARQ and eventually his TNC gave up.

I suspected that John's TNC attempted to open an ARQ session with whatever station happened to be selected in his chat window, instead of my station.

This seemed like a repeat of a similar occurrence some time ago,, in which I tried to fetch Simon's profile and observed what appeared to be his TNC immediately attempt to open an ARQ session with some unknown 3rd station. UPDATE: This happened a long time before the auto-retry behaviour for ARQ transfers was implemented, so that would not have been relevant then. I therefore think that this issue is independent of that mechanism.

I hope this info is useful.

DJ2LS commented 1 year ago

Todo: check if Callsign selection can affect response request

Mashintime commented 1 year ago

I observed this myself and should be fixed in the most recently released alpha.