I’m not able to connect to cellphone/mobile number via FreePBX

student_pl · April 12, 2023, 7:42pm

I’m a student and for my academic project I test capabilities of VoIP telephony. I’ve set up freePBX, SIP trunk and Zoiper client. I’m able to connect to various phone numbers, mobile and regional polish numbers (for the purpose of my academic project I’ve chosen my home country) via WebDialer utility using Telnyx:

And I was able to connect numbers with polish country codes using freePBX but not mobile numbers which is very important for my project.
Today after some changes to Outbound route I’m not able to connect to neither regional and mobile numbers.

I think that the only issue is with Outbound routes but I’m new to freePBX and don’t know what exactly need to be changed. I will be grateful for any advice.

Configuration:

General

SIP trunk using Telnyx with Finland number: +358-3-XXXXXXXX

FreePBX on local machine in VirtualBox. FreePBX version: 15.0.23. Asterisk version: 16.24.1

Zoiper on the same machine as FreePBX.
Trunk:

Zrzut ekranu 2023-04-12 o 16.00.411842×888 157 KB

Outbound Route:
(Created using Dial patterns wizard and added some configuration for polish numbers but they probably incorrect.)

Zrzut ekranu 2023-04-12 o 16.02.142692×1112 252 KB

Extension:

Zrzut ekranu 2023-04-12 o 16.11.052624×1220 262 KB

This is how I do test call:

For example let’s take number of mobile and Internet provider T-mobile (t-mobile[.]pl/c/kontakt)

Regional: 224136996
Mobile: 602900000

When calling from Telnyx WebDialer utility I’m able to call those numbers normally.
When calling those number from using Zoiper I can hear following information: “All circuits are busy now, please try your call again later”. Error Service Unavailable (code: 503)

Zrzut ekranu 2023-04-12 o 21.37.35

PS. There is so many deleted comments because as a new user I could post images only in separate posts. Now I can do it in one and I’ve decided to make it one post.

dobrosavljevic · April 12, 2023, 9:02pm

Can you post any errors you get when trying to dial out from the asterisk console?

student_pl · April 12, 2023, 9:08pm

I was calling using just Zoiper client. I don’t know how to call from asterisk console.

dobrosavljevic · April 12, 2023, 9:12pm

Sorry, my wording was bad. Connect to the asterisk CLI run “pjsip set logger on” and then past the output from the full asterisk log after making a test call in zoiper.

student_pl · April 12, 2023, 9:28pm

No problem! I got the logs:

19743	Supported: replaces, norefersub, extended-refer, timer, sec-agree, outbound, path, X-cisco-serviceuri
19744	User-Agent: Z 5.5.15 v2.10.19.5
19745	Allow-Events: presence, kpml, talk, as-feature-event
19746	Content-Length: 348
19747
19748	v=0
19749	o=Z 0 3065721358 IN IP4 192.168.100.124
19750	s=Z
19751	c=IN IP4 192.168.100.124
19752	t=0 0
19753	m=audio 59320 RTP/AVP 106 9 98 101 0 8 3
19754	a=rtpmap:106 opus/48000/2
19755	a=fmtp:106 sprop-maxcapturerate=16000; minptime=20; useinbandfec=1
19756	a=rtpmap:98 telephone-event/48000
19757	a=fmtp:98 0-16
19758	a=rtpmap:101 telephone-event/8000
19759	a=fmtp:101 0-16
19760	a=sendrecv
19761	a=rtcp-mux
19762
19763	[2023-04-12 21:21:39] VERBOSE[7623] res_pjsip_logger.c: <— Transmitting SIP response (522 bytes) to UDP:192.168.100.124:64495 —>
19764	SIP/2.0 401 Unauthorized
19765	Via: SIP/2.0/UDP 192.168.100.124:64495;rport=64495;received=192.168.100.124;branch=z9hG4bK-524287-1—076db5049abbfb8d
19766	Call-ID: 9d-TyutYmmFmeQc1LiBwFQ…
19767	From: sip:[email protected];tag=de87144c
19768	To: sip:[email protected];tag=z9hG4bK-524287-1—076db5049abbfb8d
19769	CSeq: 1 INVITE
19770	WWW-Authenticate: Digest realm=asterisk,nonce=1681334499/7158e8acde38884f2596317a99ade817,opaque=161eba5a04f521e0,algorithm=md5,qop=auth
19771	Server: FPBX-15.0.23(16.24.1)
19772	Content-Length: 0
19773
19774
19775	[2023-04-12 21:21:39] VERBOSE[2783] res_pjsip_logger.c: <— Received SIP request (385 bytes) from UDP:192.168.100.124:64495 —>
19776	ACK sip:[email protected]:5060;transport=UDP SIP/2.0
19777	Via: SIP/2.0/UDP 192.168.100.124:64495;branch=z9hG4bK-524287-1—076db5049abbfb8d;rport
19778	Max-Forwards: 70
19779	To: sip:[email protected];tag=z9hG4bK-524287-1—076db5049abbfb8d
19780	From: sip:[email protected]:5060;transport=UDP;tag=de87144c
19781	Call-ID: 9d-TyutYmmFmeQc1LiBwFQ…
19782	CSeq: 1 ACK
19783	Content-Length: 0
19784
19785
19786	[2023-04-12 21:21:39] VERBOSE[2783] res_pjsip_logger.c: <— Received SIP request (1379 bytes) from UDP:192.168.100.124:64495 —>
19787	INVITE sip:[email protected]:5060;transport=UDP SIP/2.0
19788	Via: SIP/2.0/UDP 192.168.100.124:64495;branch=z9hG4bK-524287-1—f5e77fbb9e9b5115;rport
19789	Max-Forwards: 70
19790	Contact: sip:[email protected]:64495;transport=UDP
19791	To: sip:[email protected]:5060
19792	From: sip:[email protected]:5060;transport=UDP;tag=de87144c
19793	Call-ID: 9d-TyutYmmFmeQc1LiBwFQ…
19794	CSeq: 2 INVITE
19795	Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
19796	Content-Type: application/sdp
19797	Supported: replaces, norefersub, extended-refer, timer, sec-agree, outbound, path, X-cisco-serviceuri
19798	User-Agent: Z 5.5.15 v2.10.19.5
19799	Authorization: Digest username=2020,realm=asterisk,nonce=1681334499/7158e8acde38884f2596317a99ade817,uri=sip:[email protected]:5060;transport=UDP,response=aec61828a70026b66c3c747cd1abcfd1,cnonce=d1f7555e07f7b0fdda807eea9e28531b,nc=00000001,qop=auth,algorithm=md5,opaque=161eba5a04f521e0
19800	Allow-Events: presence, kpml, talk, as-feature-event
19801	Content-Length: 348
19802
19803	v=0
19804	o=Z 0 3065721358 IN IP4 192.168.100.124
19805	s=Z
19806	c=IN IP4 192.168.100.124
19807	t=0 0
19808	m=audio 59320 RTP/AVP 106 9 98 101 0 8 3
19809	a=rtpmap:106 opus/48000/2
19810	a=fmtp:106 sprop-maxcapturerate=16000; minptime=20; useinbandfec=1
19811	a=rtpmap:98 telephone-event/48000
19812	a=fmtp:98 0-16
19813	a=rtpmap:101 telephone-event/8000
19814	a=fmtp:101 0-16
19815	a=sendrecv
19816	a=rtcp-mux
19817
19818	[2023-04-12 21:21:39] VERBOSE[7623] res_pjsip_logger.c: <— Transmitting SIP response (330 bytes) to UDP:192.168.100.124:64495 —>
19819	SIP/2.0 100 Trying
19820	Via: SIP/2.0/UDP 192.168.100.124:64495;rport=64495;received=192.168.100.124;branch=z9hG4bK-524287-1—f5e77fbb9e9b5115
19821	Call-ID: 9d-TyutYmmFmeQc1LiBwFQ…
19822	From: sip:[email protected];tag=de87144c
19823	To: sip:[email protected]
19824	CSeq: 2 INVITE
19825	Server: FPBX-15.0.23(16.24.1)
19826	Content-Length: 0
19827
19828
19829	[2023-04-12 21:21:39] VERBOSE[7623] res_pjsip_logger.c: <— Transmitting SIP response (330 bytes) to UDP:192.168.100.124:64495 —>
19830	SIP/2.0 100 Trying
19831	Via: SIP/2.0/UDP 192.168.100.124:64495;rport=64495;received=192.168.100.124;branch=z9hG4bK-524287-1—f5e77fbb9e9b5115
19832	Call-ID: 9d-TyutYmmFmeQc1LiBwFQ…
19833	From: sip:[email protected];tag=de87144c
19834	To: sip:[email protected]
19835	CSeq: 2 INVITE
19836	Server: FPBX-15.0.23(16.24.1)
19837	Content-Length: 0
19838
19839
19840	[2023-04-12 21:21:39] VERBOSE[7623] netsock2.c: Using SIP RTP Audio TOS bits 184
19841	[2023-04-12 21:21:39] VERBOSE[7623] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
19842	[2023-04-12 21:21:39] VERBOSE[7623] netsock2.c: Using SIP RTP Audio CoS mark 5
19843	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [48224136996@from-internal:1] Macro(PJSIP/2020-00000038, user-callerid,LIMIT,EXTERNAL,) in new stack
19844	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:1] Set(PJSIP/2020-00000038, TOUCH_MONITOR=1681334499.56) in new stack
19845	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:2] Set(PJSIP/2020-00000038, CHANCONTEXT=) in new stack
19846	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:3] Set(PJSIP/2020-00000038, CHANCONTEXT=) in new stack
19847	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:4] Set(PJSIP/2020-00000038, CHANEXTENCONTEXT=2020-00000038) in new stack
19848	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:5] Set(PJSIP/2020-00000038, CHANEXTEN=2020-00000038) in new stack
19849	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:6] Set(PJSIP/2020-00000038, CALLERID(number)=2020) in new stack
19850	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:7] Set(PJSIP/2020-00000038, AMPUSER=2020) in new stack
19851	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:8] Set(PJSIP/2020-00000038, HOTDESCKCHAN=2020-00000038) in new stack
19852	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:9] Set(PJSIP/2020-00000038, HOTDESKEXTEN=2020) in new stack
19853	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:10] Set(PJSIP/2020-00000038, HOTDESKCALL=0) in new stack
19854	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:11] ExecIf(PJSIP/2020-00000038, 0?Set(HOTDESKCALL=1)) in new stack
19855	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:12] ExecIf(PJSIP/2020-00000038, 0?Set(CALLERID(name)=)) in new stack
19856	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:13] GotoIf(PJSIP/2020-00000038, 0?report) in new stack
19857	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:14] ExecIf(PJSIP/2020-00000038, 1?Set(REALCALLERIDNUM=2020)) in new stack
19858	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:15] Set(PJSIP/2020-00000038, AMPUSER=2020) in new stack
19859	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:16] GotoIf(PJSIP/2020-00000038, 0?limit) in new stack
19860	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:17] Set(PJSIP/2020-00000038, AMPUSERCIDNAME=2020) in new stack
19861	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:18] ExecIf(PJSIP/2020-00000038, 0?Set(__CIDMASQUERADING=TRUE)) in new stack
19862	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:19] GotoIf(PJSIP/2020-00000038, 0?report) in new stack
19863	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:20] Set(PJSIP/2020-00000038, AMPUSERCID=2020) in new stack
19864	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:21] Set(PJSIP/2020-00000038, __DIAL_OPTIONS=HhTtr) in new stack
19865	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:22] Set(PJSIP/2020-00000038, CALLERID(all)=2020 <2020>) in new stack
19866	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:23] ExecIf(PJSIP/2020-00000038, 0?Set(CUSDIAL=)) in new stack
19867	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:24] ExecIf(PJSIP/2020-00000038, 0?Set(CALLERID(all)=2020 <2020>)) in new stack
19868	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:25] GotoIf(PJSIP/2020-00000038, 0?limit) in new stack
19869	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:26] ExecIf(PJSIP/2020-00000038, 1?Set(GROUP(concurrency_limit)=2020)) in new stack
19870	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:27] ExecIf(PJSIP/2020-00000038, 0?Set(CHANNEL(language)=)) in new stack
19871	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:28] NoOp(PJSIP/2020-00000038, Macro Depth is 1) in new stack
19872	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:29] GotoIf(PJSIP/2020-00000038, 1?report2:macroerror) in new stack
19873	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx_builtins.c: Goto (macro-user-callerid,s,30)
19874	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:30] GotoIf(PJSIP/2020-00000038, 1?continue) in new stack
19875	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx_builtins.c: Goto (macro-user-callerid,s,49)
19876	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:49] Set(PJSIP/2020-00000038, CALLERID(number)=2020) in new stack
19877	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:50] Set(PJSIP/2020-00000038, CALLERID(name)=2020) in new stack
19878	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:51] GotoIf(PJSIP/2020-00000038, 0?cnum) in new stack
19879	[2023-04-12 21:21:39] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:52] Set(PJSIP/2020-00000038, CDR(cnam)=2020) in new stack
19880	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:53] Set(PJSIP/2020-00000038, CDR(cnum)=2020) in new stack
19881	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-user-callerid:54] Set(PJSIP/2020-00000038, CHANNEL(language)=en) in new stack
19882	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [48224136996@from-internal:2] Gosub(PJSIP/2020-00000038, sub-record-check,s,1(out,48224136996,dontcare)) in new stack
19883	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@sub-record-check:1] GotoIf(PJSIP/2020-00000038, 0?initialized) in new stack
19884	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@sub-record-check:2] Set(PJSIP/2020-00000038, __REC_STATUS=INITIALIZED) in new stack
19885	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@sub-record-check:3] Set(PJSIP/2020-00000038, NOW=1681334500) in new stack
19886	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@sub-record-check:4] Set(PJSIP/2020-00000038, __DAY=12) in new stack
19887	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@sub-record-check:5] Set(PJSIP/2020-00000038, __MONTH=04) in new stack
19888	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@sub-record-check:6] Set(PJSIP/2020-00000038, __YEAR=2023) in new stack
19889	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@sub-record-check:7] Set(PJSIP/2020-00000038, __TIMESTR=20230412-212140) in new stack
19890	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@sub-record-check:8] Set(PJSIP/2020-00000038, __FROMEXTEN=2020) in new stack
19891	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@sub-record-check:9] Set(PJSIP/2020-00000038, __MON_FMT=wav) in new stack
19892	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@sub-record-check:10] NoOp(PJSIP/2020-00000038, Recordings initialized) in new stack
19893	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@sub-record-check:11] ExecIf(PJSIP/2020-00000038, 0?Set(ARG3=dontcare)) in new stack
19894	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@sub-record-check:12] Set(PJSIP/2020-00000038, REC_POLICY_MODE_SAVE=) in new stack
19895	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@sub-record-check:13] ExecIf(PJSIP/2020-00000038, 0?Set(REC_STATUS=NO)) in new stack
19896	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@sub-record-check:14] GotoIf(PJSIP/2020-00000038, 3?checkaction) in new stack
19897	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx_builtins.c: Goto (sub-record-check,s,17)
19898	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@sub-record-check:17] GotoIf(PJSIP/2020-00000038, 1?sub-record-check,out,1) in new stack
19899	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx_builtins.c: Goto (sub-record-check,out,1)
19900	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [out@sub-record-check:1] NoOp(PJSIP/2020-00000038, Outbound Recording Check from 2020 to 48224136996) in new stack
19901	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [out@sub-record-check:2] Set(PJSIP/2020-00000038, RECMODE=dontcare) in new stack
19902	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [out@sub-record-check:3] ExecIf(PJSIP/2020-00000038, 1?Goto(routewins)) in new stack
19903	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx_builtins.c: Goto (sub-record-check,out,7)
19904	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [out@sub-record-check:7] Gosub(PJSIP/2020-00000038, recordcheck,1(dontcare,out,48224136996)) in new stack
19905	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(PJSIP/2020-00000038, Starting recording check against dontcare) in new stack
19906	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(PJSIP/2020-00000038, dontcare) in new stack
19907	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
19908	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [recordcheck@sub-record-check:3] Return(PJSIP/2020-00000038, ) in new stack
19909	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [out@sub-record-check:8] Return(PJSIP/2020-00000038, ) in new stack
19910	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [48224136996@from-internal:3] ExecIf(PJSIP/2020-00000038, 0 ?Set(CDR(accountcode)=)) in new stack
19911	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [48224136996@from-internal:4] Set(PJSIP/2020-00000038, _ROUTEID=3) in new stack
19912	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [48224136996@from-internal:5] Set(PJSIP/2020-00000038, _ROUTENAME=telnyx) in new stack
19913	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [48224136996@from-internal:6] Set(PJSIP/2020-00000038, MOHCLASS=default) in new stack
19914	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [48224136996@from-internal:7] Set(PJSIP/2020-00000038, _CALLERIDNAMEINTERNAL=2020) in new stack
19915	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [48224136996@from-internal:8] Set(PJSIP/2020-00000038, _CALLERIDNUMINTERNAL=2020) in new stack
19916	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [48224136996@from-internal:9] Set(PJSIP/2020-00000038, _EMAILNOTIFICATION=FALSE) in new stack
19917	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [48224136996@from-internal:10] Set(PJSIP/2020-00000038, _NODEST=) in new stack
19918	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [48224136996@from-internal:11] Macro(PJSIP/2020-00000038, dialout-trunk,2,48224136996,off) in new stack
19919	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:1] Set(PJSIP/2020-00000038, DIAL_TRUNK=2) in new stack
19920	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:2] ExecIf(PJSIP/2020-00000038, 0?Set(DIAL_OPTIONS=Hhtr)) in new stack
19921	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:3] GosubIf(PJSIP/2020-00000038, 0?sub-pincheck,s,1()) in new stack
19922	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:4] ExecIf(PJSIP/2020-00000038, 0?Set(CALLERID(num)=2020)) in new stack
19923	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:5] GotoIf(PJSIP/2020-00000038, 0?disabletrunk,1) in new stack
19924	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:6] Set(PJSIP/2020-00000038, DIAL_NUMBER=48224136996) in new stack
19925	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:7] Set(PJSIP/2020-00000038, DIAL_TRUNK_OPTIONS=HhTtr) in new stack
19926	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:8] Set(PJSIP/2020-00000038, OUTBOUND_GROUP=OUT_2) in new stack
19927	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:9] Set(PJSIP/2020-00000038, DIAL_TRUNK_OPTIONS=T) in new stack
19928	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:10] GotoIf(PJSIP/2020-00000038, 1?nomax) in new stack
19929	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx_builtins.c: Goto (macro-dialout-trunk,s,12)
19930	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:12] GotoIf(PJSIP/2020-00000038, 0?skipoutcid) in new stack
19931	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:13] Macro(PJSIP/2020-00000038, outbound-callerid,2) in new stack
19932	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:1] NoOp(PJSIP/2020-00000038, 2020) in new stack
19933	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:2] NoOp(PJSIP/2020-00000038, ) in new stack
19934	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:3] NoOp(PJSIP/2020-00000038, off) in new stack
19935	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:4] ExecIf(PJSIP/2020-00000038, 0?Set(CALLERPRES(name-pres)=)) in new stack
19936	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:5] ExecIf(PJSIP/2020-00000038, 0?Set(CALLERPRES(num-pres)=)) in new stack
19937	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:6] Set(PJSIP/2020-00000038, HOTDESCKCHAN=2020-00000038) in new stack
19938	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:7] Set(PJSIP/2020-00000038, HOTDESKEXTEN=2020) in new stack
19939	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:8] Set(PJSIP/2020-00000038, HOTDESKCALL=0) in new stack
19940	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:9] ExecIf(PJSIP/2020-00000038, 0?Set(HOTDESKCALL=1)) in new stack
19941	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:10] ExecIf(PJSIP/2020-00000038, 0?Set(CALLERID(name)=)) in new stack
19942	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:11] Set(PJSIP/2020-00000038, ALLOWTHISROUTE=NO) in new stack
19943	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:12] ExecIf(PJSIP/2020-00000038, 0?Set(ALLOWTHISROUTE=YES)) in new stack
19944	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:13] ExecIf(PJSIP/2020-00000038, 0?Hangup()) in new stack
19945	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:14] ExecIf(PJSIP/2020-00000038, 0?Set(REALCALLERIDNUM=2020)) in new stack
19946	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:15] ExecIf(PJSIP/2020-00000038, 0?Set(AMPUSER=2020)) in new stack
19947	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:16] GotoIf(PJSIP/2020-00000038, 1?normcid) in new stack
19948	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx_builtins.c: Goto (macro-outbound-callerid,s,20)
19949	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:20] Set(PJSIP/2020-00000038, USEROUTCID=358341093809) in new stack
19950	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:21] Set(PJSIP/2020-00000038, EMERGENCYCID=) in new stack
19951	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:22] ExecIf(PJSIP/2020-00000038, 0?Set(EMERGENCYCID=)) in new stack
19952	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:23] Set(PJSIP/2020-00000038, TRUNKOUTCID=358341093809) in new stack
19953	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:24] GotoIf(PJSIP/2020-00000038, 1?trunkcid) in new stack
19954	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx_builtins.c: Goto (macro-outbound-callerid,s,30)
19955	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:30] ExecIf(PJSIP/2020-00000038, 1?Set(CALLERID(all)=358341093809)) in new stack
19956	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:31] ExecIf(PJSIP/2020-00000038, 1?Set(CALLERID(all)=358341093809)) in new stack
19957	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:32] ExecIf(PJSIP/2020-00000038, 0?Set(CALLERID(all)=)) in new stack
19958	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:33] ExecIf(PJSIP/2020-00000038, 0?Set(CALLERID(all)=2020)) in new stack
19959	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:34] ExecIf(PJSIP/2020-00000038, 0?Set(CALLERID(all)=2020)) in new stack
19960	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:35] Set(PJSIP/2020-00000038, TIOHIDE=no) in new stack
19961	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:36] ExecIf(PJSIP/2020-00000038, 0?Set(CALLERPRES(name-pres)=prohib_passed_screen)) in new stack
19962	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:37] ExecIf(PJSIP/2020-00000038, 0?Set(CALLERPRES(num-pres)=prohib_passed_screen)) in new stack
19963	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:38] ExecIf(PJSIP/2020-00000038, 0?Set(CALLERPRES(name-pres)=prohib_passed_screen)) in new stack
19964	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:39] ExecIf(PJSIP/2020-00000038, 0?Set(CALLERPRES(num-pres)=prohib_passed_screen)) in new stack
19965	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:40] Set(PJSIP/2020-00000038, CDR(outbound_cnum)=358341093809) in new stack
19966	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-outbound-callerid:41] Set(PJSIP/2020-00000038, CDR(outbound_cnam)=) in new stack
19967	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:14] GosubIf(PJSIP/2020-00000038, 0?sub-flp-2,s,1()) in new stack
19968	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:15] Set(PJSIP/2020-00000038, OUTNUM=48224136996) in new stack
19969	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:16] Set(PJSIP/2020-00000038, custom=PJSIP) in new stack
19970	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:17] ExecIf(PJSIP/2020-00000038, 0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)) in new stack
19971	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:18] ExecIf(PJSIP/2020-00000038, 0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))) in new stack
19972	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:19] GotoIf(PJSIP/2020-00000038, 1?gocall) in new stack
19973	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx_builtins.c: Goto (macro-dialout-trunk,s,21)
19974	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:21] Macro(PJSIP/2020-00000038, dialout-trunk-predial-hook,) in new stack
19975	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(PJSIP/2020-00000038, ) in new stack
19976	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:22] GotoIf(PJSIP/2020-00000038, 0?skipcrm) in new stack
19977	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:23] Set(PJSIP/2020-00000038, __CRM_DIRECTION=OUTBOUND) in new stack
19978	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:24] Set(PJSIP/2020-00000038, __CRM_DESTINATION=48224136996) in new stack
19979	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:25] Set(PJSIP/2020-00000038, __CRM_SOURCE=2020) in new stack
19980	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:26] AGI(PJSIP/2020-00000038, agi://127.0.0.1/sangomacrm.agi) in new stack
19981	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] res_agi.c: <PJSIP/2020-00000038>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
19982	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:27] Set(PJSIP/2020-00000038, CHANNEL(hangup_handler_push)=crm-hangup,s,1) in new stack
19983	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:28] NoOp(PJSIP/2020-00000038, CRM Finished) in new stack
19984	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:29] GotoIf(PJSIP/2020-00000038, 0?bypass,1) in new stack
19985	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:30] ExecIf(PJSIP/2020-00000038, 1?Set(CONNECTEDLINE(num,i)=48224136996)) in new stack
19986	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:31] ExecIf(PJSIP/2020-00000038, 1?Set(CONNECTEDLINE(name,i)=CID:358341093809)) in new stack
19987	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:32] ExecIf(PJSIP/2020-00000038, 0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)358341093809)) in new stack
19988	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:33] GotoIf(PJSIP/2020-00000038, 0?customtrunk) in new stack
19989	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:34] ExecIf(PJSIP/2020-00000038, 0?Set(DIAL_TRUNK_OPTIONS=)) in new stack
19990	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:35] Set(PJSIP/2020-00000038, HASH(__SIPHEADERS,Alert-Info)=unset) in new stack
19991	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@macro-dialout-trunk:36] Dial(PJSIP/2020-00000038, PJSIP/48224136996@telnyx,300,Tb(func-apply-sipheaders^s^1,(2))U(sub-send-obroute-email^48224136996^48224136996^2^1681334500^^358341093809)) in new stack
19992	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] app_stack.c: PJSIP/telnyx-00000039 Internal Gosub(func-apply-sipheaders,s,1(2)) start
19993	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf(PJSIP/telnyx-00000039, 0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)) in new stack
19994	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp(PJSIP/telnyx-00000039, Applying SIP Headers to channel PJSIP/telnyx-00000039) in new stack
19995	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@func-apply-sipheaders:3] Set(PJSIP/telnyx-00000039, TECH=PJSIP) in new stack
19996	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@func-apply-sipheaders:4] Set(PJSIP/telnyx-00000039, SIPHEADERKEYS=Alert-Info) in new stack
19997	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@func-apply-sipheaders:5] While(PJSIP/telnyx-00000039, 1) in new stack
19998	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@func-apply-sipheaders:6] Set(PJSIP/telnyx-00000039, sipheader=unset) in new stack
19999	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@func-apply-sipheaders:7] ExecIf(PJSIP/telnyx-00000039, 0?SIPRemoveHeader(Alert-Info:)) in new stack
20000	[2023-04-12 21:21:40] VERBOSE[21377][C-0000002a] pbx.c: Executing [s@func-apply-sipheaders:8] ExecIf(PJSIP/telnyx-00000039, 1?Set(PJSIP_HEADER(remove,Alert-Info)=)) in new stack
20001	[2023-04-12 21:21:40] ERROR[7623] res_pjsip_header_funcs.c: No headers had been previously added to this session.

It seems that I can’t post for 22 hours because I’ve posted too many comments today my log is longer than that I posted.

Whole log is available here: asterisk logs - Pastebin.com

PitzKey · April 12, 2023, 9:58pm

Post your logs using pastebin.com

Stewart1 · April 12, 2023, 10:49pm

Line 20131 of the log:
20131 SIP/2.0 403 Caller Origination Number is Invalid D35
showing the call was rejected.

Try sending the caller ID starting with +358, set From Domain in the trunk to sip.telnyx.com and and retest. If it works, great. If you get a different error, paste a new log. If the same error, look at their INVITE on an incoming call and format, and format your outgoing call the same way. Also, look at your settings in the Mission Control Panel and confirm that formats for ANI and DNIS are correctly set.

If you still have trouble, can you get a log from the web dialer that shows the outbound INVITE? If so, you could try adjusting your trunk settings to match that.

student_pl · April 13, 2023, 8:01pm

Changing caller ID to be starting with +358 and setting From Domain to sip.telnyx.com solved the problem. I can now call to regional and mobile numbers using Zoiper and freePBX. Thank you very much all of you!

I tried calling from my mobile number to one starting with +358 but I see info that line is busy. Can you also help me with this one?