ASL 3 can't connect to nodes

App_rpt-users
1

Good Evening,
I’ll try to keep this short as possible. For about a year I used ASL3 on my Starlink and Spacex router with no issues. I switched the Starlink dish to 12 volt and connected it to my Pepwave router (deleting the starlink router). I have port forwarded port 4569 to the internal address of the raspi4B. Asl 3 registers on the ASL Website, and I get audio from Asl “Node xxx failed to connect”, and time and weather report. However, I cannot connect to any Node. I use Allscan primarily, and it shows PTT initializing, and then “Node xxx failed to connect”. I am running Open VPN on the Pepwave router, but if I disable it, still the same no connect. I have also tried Supermon and Allmon-same results. Probably a simple answer, but I’ve been to several blogs to read and Googled for answers with no luck. I have an Asterisk diagnostic report if anyone is interested.It does show a warning in red, and a mention of “unauthorized”. I’m not savvy enough to know what it all means. I’ve checked passwords and everything in every .conf ,etc. I can think of. OK this is long enough…hope I gave enough pertinent info. Thanks.

KK7STW

2

Ron, while I am definitely not going to lead you to an answer,
I just want to say this becomes a bit more complex because of startlink and VPN.
But it may help to say what nodes of yours the issue is with, making it more telling with data in the network.
Also the exact errors you are getting. Also see logs.

And just a FYI, Allmon,Supermon, allscan are just management interfaces.
They do not make connections, they tell the ASL software what to do.
Think of them as a control head with a status display.

Someone with a bit more experience with your exact setup is bound to catch your RFI.

3

Thanks for the reply. It is any node I try to connect to Parrot (55553), local net (44045), east coast hub,etc. The forum won’t allow me to post the diagnostic report, so I guess thats that.
Thanks
Ron

4

What is the node number you are connecting from ?
(your node numbers)

5

That is node 636510.
Ron

6

well, I can tell you that node is not registered.

So you need to check networking and fix that first.

No network connections for non-registered nodes.

Proably the best I can help at this point.

And just a fyi,
If you turn off the vpn, the system has to re-register with the new IP to be a valid connection in the network.

You can view /var/lib/asterisk/rpt_extnodes list to check you status/info.
If your current connection request does not match that registration data… no connect.
Wait for up to 10min for update after changes/restart asterisk.

7

Hi Mike,
I had the node offline last night and part of this AM…so not registered. I tinkered with it this PM, using clone SD cards in case of corruption…no change. I had the OpenVPN disabled all PM, no difference. I’ve gone thru all of the Pepwave settings…have no firewall restrictions for anything (including DOS-wide open). I’m stumped. Would it be possible to somehow send you the Asterisk diagnostic report? I’m not allowed to post it…new user restriction or something. There are a couple of red flags in it re: not authorized, and a WARNING in red. I have no idea what they are pointing to.
Thank You
Ron

8

Edit /etc/asterisk/logger.conf to enable debugging to console:

console => notice,warning,error,debug,verbose
messages.log => notice,warning,error,dtmf,vebose,debug

Then go into asterisk -rvvvv and do:

core set debug 4 app_rpt.so
core reload now

Then watch the console for DEBUG or VERBOSE messages about registration issues.

9

OK, here is what I’m getting on the console over and over. WARNING is in red.

Connected to Asterisk 22.2.0+asl3-3.3.0-6.deb12 currently running on node636510 (pid = 71188)
[2025-03-27 17:01:18.305] WARNING[73578]: app_rpt.c:1034 perform_statpost: statpost to URL ‘http://stats.allstarlink.org/uhandler?node=636510&time=1743120072&seqno=134&nodes=&apprptvers=3.3.0&apprptuptime=1952&totalkerchunks=1&totalkeyups=10&totaltxtime=193&timeouts=0&totalexecdcommands=0’ failed with code 401 : Unauthorized

Thanks,
Ron

10

This is probably the data that is pertinent.

ron@node636510:~ $ sudo asterisk -rvvvv
Asterisk 22.2.0+asl3-3.3.0-6.deb12, Copyright (C) 1999 - 2025, Sangoma Technologies Corporation and others.
Created by Mark Spencer markster@digium.com
Asterisk comes with ABSOLUTELY NO WARRANTY; type 'core show warranty' for details.
This is free software, with components licensed under the GNU General Public
License version 2 and other licenses; you are welcome to redistribute it under
certain conditions. Type 'core show license' for details.

Connected to Asterisk 22.2.0+asl3-3.3.0-6.deb12 currently running on node636510 (pid = 1056)
node636510CLI> core set debug 4 app_rpt.so
Core debug was 0 and has been set to 4 for 'app_rpt'.
[2025-03-31 14:33:12.590] DEBUG[3457]: app_rpt.c:1041 perform_statpost: Response: ok
[2025-03-31 14:33:31.000] DEBUG[1428]: app_rpt.c:1071 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=636510&time=1743456810&seqno=103&nodes=&apprptvers=3.3.0&apprptuptime=2720&totalkerchunks=1&totalkeyups=8&totaltxtime=143&timeouts=0&totalexecdcommands=0
[2025-03-31 14:33:36.363] DEBUG[3479]: app_rpt.c:1041 perform_statpost: Response: ok
[2025-03-31 14:33:38.907] DEBUG[1428]: app_rpt.c:1071 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=636510&time=1743456818&seqno=104&keyed=0&keytime=2729
[2025-03-31 14:33:44.194] DEBUG[3481]: app_rpt.c:1041 perform_statpost: Response: ok
node636510CLI> core reload now
Usage: core reload
Execute a global reload.
[2025-03-31 14:34:02.577] DEBUG[1428]: app_rpt.c:1071 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=636510&time=1743456842&seqno=105&nodes=&apprptvers=3.3.0&apprptuptime=2752&totalkerchunks=1&totalkeyups=8&totaltxtime=143&timeouts=0&totalexecdcommands=0
[2025-03-31 14:34:07.954] DEBUG[3488]: app_rpt.c:1041 perform_statpost: Response: ok
[2025-03-31 14:34:10.467] DEBUG[1428]: app_rpt.c:1071 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=636510&time=1743456850&seqno=106&keyed=0&keytime=2761
[2025-03-31 14:34:15.761] DEBUG[3521]: app_rpt.c:1041 perform_statpost: Response: ok
[2025-03-31 14:34:34.147] DEBUG[1428]: app_rpt.c:1071 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=636510&time=1743456874&seqno=107&nodes=&apprptvers=3.3.0&apprptuptime=2784&totalkerchunks=1&totalkeyups=8&totaltxtime=143&timeouts=0&totalexecdcommands=0
[2025-03-31 14:34:42.047] DEBUG[1428]: app_rpt.c:1071 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=636510&time=1743456882&seqno=108&keyed=0&keytime=2793
[2025-03-31 14:34:54.149] WARNING[3529]: app_rpt.c:1024 perform_statpost: statpost to URL 'http://stats.allstarlink.org/uhandler?node=636510&time=1743456874&seqno=107&nodes=&apprptvers=3.3.0&apprptuptime=2784&totalkerchunks=1&totalkeyups=8&totaltxtime=143&timeouts=0&totalexecdcommands=0' failed with error: Could not resolve host: stats.allstarlink.org
[2025-03-31 14:34:54.149] DEBUG[3529]: app_rpt.c:1041 perform_statpost: Response:
[2025-03-31 14:35:02.049] WARNING[3531]: app_rpt.c:1024 perform_statpost: statpost to URL 'http://stats.allstarlink.org/uhandler?node=636510&time=1743456882&seqno=108&keyed=0&keytime=2793' failed with error: Could not resolve host: stats.allstarlink.org
[2025-03-31 14:35:02.049] DEBUG[3531]: app_rpt.c:1041 perform_statpost: Response:
[2025-03-31 14:35:05.727] DEBUG[1428]: app_rpt.c:1071 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=636510&time=1743456905&seqno=109&nodes=&apprptvers=3.3.0&apprptuptime=2815&totalkerchunks=1&totalkeyups=8&totaltxtime=143&timeouts=0&totalexecdcommands=0
[2025-03-31 14:35:11.071] DEBUG[3550]: app_rpt.c:1041 perform_statpost: Response: ok
[2025-03-31 14:35:13.626] DEBUG[1428]: app_rpt.c:1071 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=636510&time=1743456913&seqno=110&keyed=0&keytime=2824
[2025-03-31 14:35:18.929] DEBUG[3554]: app_rpt.c:1041 perform_statpost: Response: ok
[2025-03-31 14:35:37.307] DEBUG[1428]: app_rpt.c:1071 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=636510&time=1743456937&seqno=111&nodes=&apprptvers=3.3.0&apprptuptime=2847&totalkerchunks=1&totalkeyups=8&totaltxtime=143&timeouts=0&totalexecdcommands=0
[2025-03-31 14:35:42.614] DEBUG[3558]: app_rpt.c:1041 perform_statpost: Response: ok
[2025-03-31 14:35:45.207] DEBUG[1428]: app_rpt.c:1071 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=636510&time=1743456945&seqno=112&keyed=0&keytime=2856
[2025-03-31 14:35:50.498] DEBUG[3561]: app_rpt.c:1041 perform_statpost: Response: ok
[2025-03-31 14:36:08.886] DEBUG[1428]: app_rpt.c:1071 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=636510&time=1743456968&seqno=113&nodes=&apprptvers=3.3.0&apprptuptime=2878&totalkerchunks=1&totalkeyups=8&totaltxtime=143&timeouts=0&totalexecdcommands=0
[2025-03-31 14:36:14.209] DEBUG[3615]: app_rpt.c:1041 perform_statpost: Response: ok
[2025-03-31 14:36:16.781] DEBUG[1428]: app_rpt.c:1071 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=636510&time=1743456976&seqno=114&keyed=0&keytime=2887
[2025-03-31 14:36:22.076] DEBUG[3619]: app_rpt.c:1041 perform_statpost: Response: ok
[2025-03-31 14:36:40.485] DEBUG[1428]: app_rpt.c:1071 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=636510&time=1743457000&seqno=115&nodes=&apprptvers=3.3.0&apprptuptime=2910&totalkerchunks=1&totalkeyups=8&totaltxtime=143&timeouts=0&totalexecdcommands=0
[2025-03-31 14:36:45.873] DEBUG[3621]: app_rpt.c:1041 perform_statpost: Response: ok
[2025-03-31 14:36:48.367] DEBUG[1428]: app_rpt.c:1071 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=636510&time=1743457008&seqno=116&keyed=0&keytime=2919
[2025-03-31 14:36:53.660] DEBUG[3624]: app_rpt.c:1041 perform_statpost: Response: ok
== Manager 'admin' logged on from 127.0.0.1
== Manager 'admin' logged on from 127.0.0.1
== Manager 'admin' logged off from 127.0.0.1
[2025-03-31 14:37:03.048] DEBUG[1428]: app_rpt/rpt_config.c:397 node_lookup_bydns: Resolving DNS SRV records for: _iax._udp.55553.nodes.allstarlink.org
[2025-03-31 14:37:08.328] DEBUG[1428]: app_rpt/rpt_config.c:420 node_lookup_bydns: Resolving A record for host: 55553.nodes.allstarlink.org, port: 4569
[2025-03-31 14:37:13.546] DEBUG[1428]: app_rpt/rpt_config.c:555 node_lookup: Resolved by DNS: node 55553 to radio@104.232.32.242:4569/55553,104.232.32.242
[2025-03-31 14:37:13.546] DEBUG[1428]: app_rpt/rpt_link.c:662 connect_link: Connect attempt to node 55553, Mode = Transceive, Connection type: Normal
[2025-03-31 14:37:13.546] DEBUG[1428]: app_rpt/rpt_call.c:44 rpt_setup_call: Requested channel IAX2/104.232.32.242:4569-5991
[2025-03-31 14:37:13.546] DEBUG[1428]: app_rpt/rpt_call.c:32 rpt_disable_cdr: No CDR present on IAX2/104.232.32.242:4569-5991
[2025-03-31 14:37:13.546] DEBUG[1428]: app_rpt/rpt_call.c:55 rpt_setup_call: rpt ((Remote Rx)) initiating call to IAX2/radio@104.232.32.242:4569/55553 on IAX2/104.232.32.242:4569-5991
[2025-03-31 14:37:13.547] DEBUG[1428]: app_rpt/rpt_bridging.c:308 __rpt_request_pseudo: Requested channel DAHDI/pseudo-592436106
[2025-03-31 14:37:13.547] DEBUG[1428]: app_rpt/rpt_call.c:32 rpt_disable_cdr: No CDR present on DAHDI/pseudo-592436106
[2025-03-31 14:37:13.547] DEBUG[1428]: app_rpt/rpt_bridging.c:374 dahdi_conf_add: Channel DAHDI/pseudo-592436106 joining conference 1022
[2025-03-31 14:37:13.548] DEBUG[1428]: app_rpt.c:1071 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=636510&time=1743457033&seqno=117&nodes=C55553&apprptvers=3.3.0&apprptuptime=2943&totalkerchunks=1&totalkeyups=9&totaltxtime=143&timeouts=0&totalexecdcommands=0
[2025-03-31 14:37:13.548] DEBUG[3650]: app_rpt/rpt_telemetry.c:1028 rpt_tele_thread: Requested channel DAHDI/pseudo-1061667677
[2025-03-31 14:37:13.548] DEBUG[3650]: app_rpt/rpt_call.c:32 rpt_disable_cdr: No CDR present on DAHDI/pseudo-1061667677
[2025-03-31 14:37:13.548] DEBUG[3650]: app_rpt/rpt_bridging.c:374 dahdi_conf_add: Channel DAHDI/pseudo-1061667677 joining conference 1021
[2025-03-31 14:37:13.548] DEBUG[3650]: app_rpt/rpt_channel.c:56 wait_interval: Delay interval = 2000
[2025-03-31 14:37:13.549] DEBUG[1428]: app_rpt.c:4355 process_link_channels: Failed to read frame on IAX2/104.232.32.242:4569-5991, must've hung up
[2025-03-31 14:37:13.550] DEBUG[1428]: app_rpt.c:4160 safe_hangup: Hard hanging up channel IAX2/104.232.32.242:4569-5991
-- Hungup 'IAX2/104.232.32.242:4569-5991'
-- Hungup 'DAHDI/pseudo-592436106'
[2025-03-31 14:37:13.551] DEBUG[3653]: app_rpt/rpt_telemetry.c:1028 rpt_tele_thread: Requested channel DAHDI/pseudo-1823210447
[2025-03-31 14:37:13.551] DEBUG[3653]: app_rpt/rpt_call.c:32 rpt_disable_cdr: No CDR present on DAHDI/pseudo-1823210447
[2025-03-31 14:37:13.767] DEBUG[1428]: app_rpt.c:1071 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=636510&time=1743457033&seqno=118&nodes=&apprptvers=3.3.0&apprptuptime=2943&totalkerchunks=1&totalkeyups=9&totaltxtime=154&timeouts=0&totalexecdcommands=0
[2025-03-31 14:37:15.549] DEBUG[3650]: app_rpt/rpt_channel.c:60 wait_interval: Delay complete
-- Hungup 'DAHDI/pseudo-1061667677'
[2025-03-31 14:37:16.052] DEBUG[3653]: app_rpt/rpt_bridging.c:374 dahdi_conf_add: Channel DAHDI/pseudo-1823210447 joining conference 1021
[2025-03-31 14:37:16.052] DEBUG[3653]: app_rpt/rpt_channel.c:56 wait_interval: Delay interval = 2000
[2025-03-31 14:37:18.053] DEBUG[3653]: app_rpt/rpt_channel.c:60 wait_interval: Delay complete
[2025-03-31 14:37:18.054] WARNING[3653]: file.c:825 ast_openstream_full: File custom/rpt/node does not exist in any format
-- <DAHDI/pseudo-1823210447> Playing 'rpt/node.gsm' (language 'en')
[2025-03-31 14:37:18.695] WARNING[3653]: file.c:825 ast_openstream_full: File custom/digits/5 does not exist in any format
-- <DAHDI/pseudo-1823210447> Playing 'digits/5.ulaw' (language 'en')
[2025-03-31 14:37:18.839] DEBUG[3651]: app_rpt.c:1041 perform_statpost: Response: ok
[2025-03-31 14:37:19.064] DEBUG[3654]: app_rpt.c:1041 perform_statpost: Response: ok
[2025-03-31 14:37:19.387] DEBUG[1428]: app_rpt.c:1071 statpost: Making statpost to http://stats.allstarlink.org/uhandler?node=636510&time=1743457039&seqno=119&keyed=0&keytime=2950
[2025-03-31 14:37:19.517] WARNING[3653]: file.c:825 ast_openstream_full: File custom/digits/5 does not exist in any format
-- <DAHDI/pseudo-1823210447> Playing 'digits/5.ulaw' (language 'en')
[2025-03-31 14:37:20.338] WARNING[3653]: file.c:825 ast_openstream_full: File custom/digits/5 does not exist in any format
-- <DAHDI/pseudo-1823210447> Playing 'digits/5.ulaw' (language 'en')
[2025-03-31 14:37:21.160] WARNING[3653]: file.c:825 ast_openstream_full: File custom/digits/5 does not exist in any format
-- <DAHDI/pseudo-1823210447> Playing 'digits/5.ulaw' (language 'en')
[2025-03-31 14:37:21.982] WARNING[3653]: file.c:825 ast_openstream_full: File custom/digits/3 does not exist in any format
-- <DAHDI/pseudo-1823210447> Playing 'digits/3.ulaw' (language 'en')
[2025-03-31 14:37:22.821] WARNING[3653]: file.c:825 ast_openstream_full: File custom/rpt/connection_failed does not exist in any format
-- <DAHDI/pseudo-1823210447> Playing 'rpt/connection_failed.gsm' (language 'en')
-- Hungup 'DAHDI/pseudo-1823210447'
[2025-03-31 14:37:24.691] DEBUG[3672]: app_rpt.c:1041 perform_statpost: Response: ok
node636510*CLI>

11

Either the other end is dropping your calls or you have a network issue. Given that in the same logs you're having random DNS resolution issues, it looks like networking.

12

I would agree. Thanks for the feed back. I am getting a public IPv4 address from Starlink, which I think will solve the problem. No more CGNAT. Thanks again and have a good Day.

Ron
KK7STW