Unable to connect to 5 digit node #386

PadreAndrew · 2024-08-20T14:59:16Z

Unable to connect to a five digit node using DTMF from a radio keypad or Supermon. Also unable to connect to a five digit node from CLI using: rpt fun 58846 *355553. Can connect to a four digit node using the mentioned methods.

Connected to Asterisk 20.9.1+asl3-3.0.4-1.deb12 currently running on node58846 (pid = 903)
node58846*CLI> rpt fun 58846 *32462
node58846*CLI> rpt fun 58846 *355553
node58846*CLI> rpt lstats 58846
NODE      PEER                RECONNECTS  DIRECTION  CONNECT TIME        CONNECT STATE
----      ----                ----------  ---------  ------------        -------------
2462      44.25.240.25        0           OUT        00:00:26:530        ESTABLISHED
node58846*CLI>

The text was updated successfully, but these errors were encountered:

KB4MDD · 2024-08-20T15:47:36Z

Please edit /etc/asterisk/logger.conf. Change the following:

console => notice,warning,error,dtmf
to be
console => notice,warning,error,dtmf,debug

In the cli type
logger reload
core set debug 4 app_rpt.so
Then try your connection. Post the debug messages.

You can turn off the debug messages with core set debug 0 app_rpt.so

PadreAndrew · 2024-08-20T17:12:03Z

node58846*CLI> core set debug 4 app_rpt.so
Core debug was 0 and has been set to 4 for 'app_rpt'.
[2024-08-20 13:05:17.896] DEBUG[10081]: app_rpt.c:1038 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=58846&time=1724173517&seqno=328&keyed=0&keytime=5146
[2024-08-20 13:05:38.966] DEBUG[10081]: app_rpt.c:1038 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=58846&time=1724173538&seqno=329&nodes=T2462&apprptvers=3.0.4&apprptuptime=5166&totalkerchunks=1&totalkeyups=37&totaltxtime=3236&timeouts=1&totalexecdcommands=3
node58846*CLI> rpt fun 58846 *355553
[2024-08-20 13:05:44.906] DEBUG[10081]: app_rpt/rpt_telemetry.c:381 cancel_pfxtone: cancel_pfxfone!!
[2024-08-20 13:05:44.906] DEBUG[10081]: app_rpt.c:1487 collect_function_digits: @@@@ action: ilink, param = 3
[2024-08-20 13:05:44.906] DEBUG[10081]: app_rpt.c:1493 collect_function_digits: @@@@ table index i = 3
[2024-08-20 13:05:45.015] DEBUG[10081]: app_rpt/rpt_telemetry.c:381 cancel_pfxtone: cancel_pfxfone!!
[2024-08-20 13:05:45.015] DEBUG[10081]: app_rpt.c:1487 collect_function_digits: @@@@ action: ilink, param = 3
[2024-08-20 13:05:45.015] DEBUG[10081]: app_rpt.c:1493 collect_function_digits: @@@@ table index i = 3
[2024-08-20 13:05:45.121] DEBUG[10081]: app_rpt/rpt_telemetry.c:381 cancel_pfxtone: cancel_pfxfone!!
[2024-08-20 13:05:45.121] DEBUG[10081]: app_rpt.c:1487 collect_function_digits: @@@@ action: ilink, param = 3
[2024-08-20 13:05:45.121] DEBUG[10081]: app_rpt.c:1493 collect_function_digits: @@@@ table index i = 3
[2024-08-20 13:05:45.226] DEBUG[10081]: app_rpt/rpt_telemetry.c:381 cancel_pfxtone: cancel_pfxfone!!
[2024-08-20 13:05:45.226] DEBUG[10081]: app_rpt.c:1487 collect_function_digits: @@@@ action: ilink, param = 3
[2024-08-20 13:05:45.226] DEBUG[10081]: app_rpt.c:1493 collect_function_digits: @@@@ table index i = 3
[2024-08-20 13:05:45.335] DEBUG[10081]: app_rpt/rpt_telemetry.c:381 cancel_pfxtone: cancel_pfxfone!!
[2024-08-20 13:05:45.335] DEBUG[10081]: app_rpt.c:1487 collect_function_digits: @@@@ action: ilink, param = 3
[2024-08-20 13:05:45.335] DEBUG[10081]: app_rpt.c:1493 collect_function_digits: @@@@ table index i = 3
[2024-08-20 13:05:45.335] DEBUG[10081]: app_rpt/rpt_config.c:396 node_lookup_bydns: Resolving DNS SRV records for: _iax._udp.5555.nodes.allstarlink.org
[2024-08-20 13:05:53.240] DEBUG[10081]: app_rpt/rpt_config.c:411 node_lookup_bydns: No SRV records returned for _iax._udp.5555.nodes.allstarlink.org
[2024-08-20 13:05:53.261] DEBUG[10081]: app_rpt/rpt_telemetry.c:381 cancel_pfxtone: cancel_pfxfone!!
[2024-08-20 13:05:53.262] DEBUG[10081]: app_rpt.c:1038 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=58846&time=1724173553&seqno=330&keyed=0&keytime=5182
[2024-08-20 13:05:54.480] DEBUG[15547]: app_rpt/rpt_telemetry.c:1028 rpt_tele_thread: Requested channel DAHDI/pseudo-1680273457
[2024-08-20 13:05:54.480] DEBUG[15547]: app_rpt/rpt_call.c:32 rpt_disable_cdr: No CDR present on DAHDI/pseudo-1680273457[2024-08-20 13:05:54.480] DEBUG[15547]: app_rpt/rpt_bridging.c:374 dahdi_conf_add: Channel DAHDI/pseudo-1680273457 joining conference 1021
[2024-08-20 13:05:54.723] DEBUG[15548]: app_rpt/rpt_telemetry.c:1028 rpt_tele_thread: Requested channel DAHDI/pseudo-1594997525
[2024-08-20 13:05:54.723] DEBUG[15548]: app_rpt/rpt_call.c:32 rpt_disable_cdr: No CDR present on DAHDI/pseudo-1594997525[2024-08-20 13:05:54.723] DEBUG[15548]: app_rpt/rpt_bridging.c:374 dahdi_conf_add: Channel DAHDI/pseudo-1594997525 joining conference 1021
[2024-08-20 13:06:10.122] DEBUG[10081]: app_rpt.c:1038 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=58846&time=1724173570&seqno=331&nodes=T2462&apprptvers=3.0.4&apprptuptime=5198&totalkerchunks=1&totalkeyups=38&totaltxtime=3239&timeouts=1&totalexecdcommands=3
node58846*CLI> core set debug 0 app_rpt.so
Core debug was 4 and has been set to 0 for 'app_rpt'.
node58846*CLI>

Looking at the debug the following two lines are telling:

[2024-08-20 13:05:45.335] DEBUG[10081]: app_rpt/rpt_config.c:396 node_lookup_bydns: Resolving DNS SRV records for: _iax._udp.5555.nodes.allstarlink.org
[2024-08-20 13:05:53.240] DEBUG[10081]: app_rpt/rpt_config.c:411 node_lookup_bydns: No SRV records returned for _iax._udp.5555.nodes.allstarlink.org

Even though I entered
rpt fun 58846 *355553
it only looking at the first four digits
_iax._udp.5555.nodes.allstarlink.org

KB4MDD · 2024-08-20T18:15:48Z

I cannot duplicate the issue here. Turn up the debugging core set debug 7 app_rpt.so, then try and connect again. Post your results.

PadreAndrew · 2024-08-20T18:36:39Z

Connected to Asterisk 20.9.1+asl3-3.0.4-1.deb12 currently running on node58846 (pid = 10035)
node58846*CLI> core set debug 7 app_rpt.so
Core debug was 0 and has been set to 7 for 'app_rpt'.
[2024-08-20 14:35:00.121] DEBUG[10081]: app_rpt.c:2594 do_scheduler: Time now: 14:35 20 08 02
node58846*CLI> rpt fun 58846 *355553
[2024-08-20 14:35:04.476] DEBUG[10081]: app_rpt/rpt_telemetry.c:381 cancel_pfxtone: cancel_pfxfone!!
[2024-08-20 14:35:04.476] DEBUG[10081]: app_rpt.c:1435 collect_function_digits: digits=3  source=0
[2024-08-20 14:35:04.476] DEBUG[10081]: app_rpt.c:1487 collect_function_digits: @@@@ action: ilink, param = 3
[2024-08-20 14:35:04.476] DEBUG[10081]: app_rpt.c:1493 collect_function_digits: @@@@ table index i = 3
[2024-08-20 14:35:04.476] DEBUG[10081]: app_rpt/rpt_functions.c:69 function_ilink: @@@@ ilink param = 3, digitbuf =
[2024-08-20 14:35:04.476] DEBUG[10081]: app_rpt.c:1505 collect_function_digits: rv=0
[2024-08-20 14:35:04.581] DEBUG[10081]: app_rpt/rpt_telemetry.c:381 cancel_pfxtone: cancel_pfxfone!!
[2024-08-20 14:35:04.581] DEBUG[10081]: app_rpt.c:1435 collect_function_digits: digits=35  source=0
[2024-08-20 14:35:04.581] DEBUG[10081]: app_rpt.c:1487 collect_function_digits: @@@@ action: ilink, param = 3
[2024-08-20 14:35:04.581] DEBUG[10081]: app_rpt.c:1493 collect_function_digits: @@@@ table index i = 3
[2024-08-20 14:35:04.581] DEBUG[10081]: app_rpt/rpt_functions.c:69 function_ilink: @@@@ ilink param = 3, digitbuf = 5
[2024-08-20 14:35:04.581] DEBUG[10081]: app_rpt/rpt_config.c:312 tlb_query_node_exists: chan_tlb not loaded.
[2024-08-20 14:35:04.591] DEBUG[10081]: app_rpt.c:1505 collect_function_digits: rv=0
[2024-08-20 14:35:04.690] DEBUG[10081]: app_rpt/rpt_telemetry.c:381 cancel_pfxtone: cancel_pfxfone!!
[2024-08-20 14:35:04.690] DEBUG[10081]: app_rpt.c:1435 collect_function_digits: digits=355  source=0
[2024-08-20 14:35:04.690] DEBUG[10081]: app_rpt.c:1487 collect_function_digits: @@@@ action: ilink, param = 3
[2024-08-20 14:35:04.690] DEBUG[10081]: app_rpt.c:1493 collect_function_digits: @@@@ table index i = 3
[2024-08-20 14:35:04.690] DEBUG[10081]: app_rpt/rpt_functions.c:69 function_ilink: @@@@ ilink param = 3, digitbuf = 55
[2024-08-20 14:35:04.690] DEBUG[10081]: app_rpt/rpt_config.c:312 tlb_query_node_exists: chan_tlb not loaded.
[2024-08-20 14:35:04.700] DEBUG[10081]: app_rpt.c:1505 collect_function_digits: rv=0
[2024-08-20 14:35:04.796] DEBUG[10081]: app_rpt/rpt_telemetry.c:381 cancel_pfxtone: cancel_pfxfone!!
[2024-08-20 14:35:04.796] DEBUG[10081]: app_rpt.c:1435 collect_function_digits: digits=3555  source=0
[2024-08-20 14:35:04.796] DEBUG[10081]: app_rpt.c:1487 collect_function_digits: @@@@ action: ilink, param = 3
[2024-08-20 14:35:04.796] DEBUG[10081]: app_rpt.c:1493 collect_function_digits: @@@@ table index i = 3
[2024-08-20 14:35:04.796] DEBUG[10081]: app_rpt/rpt_functions.c:69 function_ilink: @@@@ ilink param = 3, digitbuf = 555
[2024-08-20 14:35:04.796] DEBUG[10081]: app_rpt/rpt_config.c:312 tlb_query_node_exists: chan_tlb not loaded.
[2024-08-20 14:35:04.806] DEBUG[10081]: app_rpt.c:1505 collect_function_digits: rv=0
[2024-08-20 14:35:04.901] DEBUG[10081]: app_rpt/rpt_telemetry.c:381 cancel_pfxtone: cancel_pfxfone!!
[2024-08-20 14:35:04.901] DEBUG[10081]: app_rpt.c:1435 collect_function_digits: digits=35555  source=0
[2024-08-20 14:35:04.901] DEBUG[10081]: app_rpt.c:1487 collect_function_digits: @@@@ action: ilink, param = 3
[2024-08-20 14:35:04.901] DEBUG[10081]: app_rpt.c:1493 collect_function_digits: @@@@ table index i = 3
[2024-08-20 14:35:04.901] DEBUG[10081]: app_rpt/rpt_functions.c:69 function_ilink: @@@@ ilink param = 3, digitbuf = 5555
[2024-08-20 14:35:04.901] DEBUG[10081]: app_rpt/rpt_config.c:312 tlb_query_node_exists: chan_tlb not loaded.
[2024-08-20 14:35:04.901] DEBUG[10081]: app_rpt/rpt_config.c:396 node_lookup_bydns: Resolving DNS SRV records for: _iax._udp.5555.nodes.allstarlink.org
[2024-08-20 14:35:11.319] DEBUG[10081]: app_rpt/rpt_config.c:411 node_lookup_bydns: No SRV records returned for _iax._udp.5555.nodes.allstarlink.org
[2024-08-20 14:35:11.341] DEBUG[10081]: app_rpt.c:1505 collect_function_digits: rv=0
[2024-08-20 14:35:11.341] DEBUG[10081]: app_rpt/rpt_telemetry.c:381 cancel_pfxtone: cancel_pfxfone!!
[2024-08-20 14:35:11.341] DEBUG[10081]: app_rpt.c:1038 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=58846&time=1724178911&seqno=670&nodes=&apprptvers=3.0.4&apprptuptime=10539&totalkerchunks=1&totalkeyups=52&totaltxtime=3389&timeouts=1&totalexecdcommands=5
node58846*CLI>

It is just not picking up that last digit.

Allan-N · 2024-08-20T18:45:35Z

Just checking ...

in your rpt.conf file, do you have an [uncommented] line with max_dns_node_length = ... ? (note: the expected answer is "No")
in your rpt.conf file, do you have node_lookup_method = both ?
is DNS OK on this device? Can you ping "www.allstarlink.org" ?

KB4MDD · 2024-08-20T18:46:27Z

It almost seems like you don't have this fix - #372.

I don't think this will fix the problem, but you can give it a try.

Edit rpt.conf, under [general] add
max_dns_node_length = 6

Allan-N · 2024-08-20T18:47:45Z

Ha! @KB4MDD and are were thinking the same thing :-)

More info on node resolution can be found @ https://allstarlink.github.io/adv-topics/noderesolution/

PadreAndrew · 2024-08-20T19:48:10Z

Well, I found the problem, it was a loose nut behind the keyboard (me). Connected my AllStar node to my phone's hotspot and Bob's your uncle I am able to connect to a five-digit node. So, what in my home network is preventing me from connecting to a five-digit node?

Allan-N · 2024-08-20T19:53:52Z

Wi-Fi? Ethernet? DHCP or static IP addressing? and if static did you also configure DNS?

PadreAndrew · 2024-08-20T19:57:00Z

When the node as not connecting to five-digit nodes it was Ethernet DHCP. Right now my node is wi-fi to my phone's hotspot and works great.

Allan-N · 2024-08-20T20:09:27Z

Well, you've narrowed things down a bunch. Does this system have a keyboard/display? If so, when connected via Ethernet I would suggest checking that the system has an IP address and that a viable DNS configuration was provided by your DHCP server. Else, can you SSH the device and again check the DNS configuration.

In short, without DNS you can't lookup hosts (or nodes).

PadreAndrew · 2024-08-20T20:34:03Z

Definitely a DNS problem. The DNS assigned by DHCP was not working so I made a manual entry under the Ethernet connection and now I have a wired node that connects to other five-digit nodes.

Thanks for all the help and I learned a little bit more about Asterisk. Thanks for a great product.

73 Andrew
de N7JRR

PadreAndrew closed this as completed Aug 20, 2024

Allan-N mentioned this issue Aug 23, 2024

DTMF-Based Linking + DNS Node Lookups Fail Due to Timer Issues #392

Open

Provide feedback

Saved searches

Use saved searches to filter your results more quickly

Unable to connect to 5 digit node #386

Unable to connect to 5 digit node #386

PadreAndrew commented Aug 20, 2024 •

edited

Loading

KB4MDD commented Aug 20, 2024

PadreAndrew commented Aug 20, 2024 •

edited

Loading

KB4MDD commented Aug 20, 2024

PadreAndrew commented Aug 20, 2024

Allan-N commented Aug 20, 2024 •

edited

Loading

KB4MDD commented Aug 20, 2024

Allan-N commented Aug 20, 2024

PadreAndrew commented Aug 20, 2024 •

edited

Loading

Allan-N commented Aug 20, 2024

PadreAndrew commented Aug 20, 2024

Allan-N commented Aug 20, 2024

PadreAndrew commented Aug 20, 2024 •

edited

Loading

Unable to connect to 5 digit node #386

Unable to connect to 5 digit node #386

Comments

PadreAndrew commented Aug 20, 2024 • edited Loading

KB4MDD commented Aug 20, 2024

PadreAndrew commented Aug 20, 2024 • edited Loading

KB4MDD commented Aug 20, 2024

PadreAndrew commented Aug 20, 2024

Allan-N commented Aug 20, 2024 • edited Loading

KB4MDD commented Aug 20, 2024

Allan-N commented Aug 20, 2024

PadreAndrew commented Aug 20, 2024 • edited Loading

Allan-N commented Aug 20, 2024

PadreAndrew commented Aug 20, 2024

Allan-N commented Aug 20, 2024

PadreAndrew commented Aug 20, 2024 • edited Loading

PadreAndrew commented Aug 20, 2024 •

edited

Loading

PadreAndrew commented Aug 20, 2024 •

edited

Loading

Allan-N commented Aug 20, 2024 •

edited

Loading

PadreAndrew commented Aug 20, 2024 •

edited

Loading

PadreAndrew commented Aug 20, 2024 •

edited

Loading