CID not flowing through pstn. Assistance required please

I’ve set what I believe are the various CID areas and looking at the Call Detail Record for a test call I see thats the CallerID is assigned.

On the call event log I also see the test CID flowing through as below, but on the dialed phone I don’t get 12345678900, I get Unknown. I would greatly appreciate some assistance please. Thank you.

Time Event Type UniqueID LinkedID Cid num Extension Context Channel Name
Wed, Nov 27, 2019 8:09 AM CHAN_START 1574842151.14 1574842151.14 105 9447342052XXX from-internal PJSIP/105-0000000a
Wed, Nov 27, 2019 8:09 AM CHAN_START 1574842151.15 1574842151.14 s from-trunk-sip-didlogic SIP/didlogic-00000000
Wed, Nov 27, 2019 8:09 AM ANSWER 1574842151.15 1574842151.14 9447342052XXX 9447342052XXX from-trunk-sip-didlogic SIP/didlogic-00000000
Wed, Nov 27, 2019 8:09 AM ANSWER 1574842151.14 1574842151.14 12345678900 s macro-dialout-trunk PJSIP/105-0000000a
Wed, Nov 27, 2019 8:09 AM BRIDGE_ENTER 1574842151.15 1574842151.14 9447342052XXX from-trunk-sip-didlogic SIP/didlogic-00000000
Wed, Nov 27, 2019 8:09 AM BRIDGE_ENTER 1574842151.14 1574842151.14 12345678900 s macro-dialout-trunk PJSIP/105-0000000a
Wed, Nov 27, 2019 8:09 AM BRIDGE_EXIT 1574842151.14 1574842151.14 12345678900 s macro-dialout-trunk PJSIP/105-0000000a
Wed, Nov 27, 2019 8:09 AM BRIDGE_EXIT 1574842151.15 1574842151.14 9447342052XXX from-trunk-sip-didlogic SIP/didlogic-00000000
Wed, Nov 27, 2019 8:09 AM HANGUP 1574842151.15 1574842151.14 9447342052XXX from-trunk-sip-didlogic SIP/didlogic-00000000
Wed, Nov 27, 2019 8:09 AM CHAN_END 1574842151.15 1574842151.14 9447342052XXX from-trunk-sip-didlogic SIP/didlogic-00000000

image

I’d start with a sip debug to see what’s going on with this. Also, the /var/log/asterisk/full log will have the steps that the system undertook to get to where you got. To be honest, the CDR is the least useful way to troubleshoot this.

Thanks for your reply.

Given the log trace below I can see that my test CID (12345678900) makes it most the way through, but I don’t know why it doesn’t get through to the outside SIP provider and onto the pstn.

Perhaps it is making it outside my network correctly but I don’t have the knowledge to determine that. Can someone please confirm?

[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-user-callerid:10] Set(“PJSIP/105-00000003”, “AMPUSERCID=105”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-user-callerid:11] Set(“PJSIP/105-00000003”, “__DIAL_OPTIONS=HhTtr”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-user-callerid:12] Set(“PJSIP/105-00000003”, “CALLERID(all)=“Sean #2” <105>”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-user-callerid:13] ExecIf(“PJSIP/105-00000003”, “0?Set(CALLERID(all)=EXTERNAL)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-user-callerid:14] GotoIf(“PJSIP/105-00000003”, “0?limit”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-user-callerid:15] ExecIf(“PJSIP/105-00000003”, “1?Set(GROUP(concurrency_limit)=105)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-user-callerid:16] ExecIf(“PJSIP/105-00000003”, “0?Set(CHANNEL(language)=)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-user-callerid:17] NoOp(“PJSIP/105-00000003”, “Macro Depth is 1”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-user-callerid:18] GotoIf(“PJSIP/105-00000003”, “1?report2:macroerror”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx_builtins.c: Goto (macro-user-callerid,s,19)
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-user-callerid:19] GotoIf(“PJSIP/105-00000003”, “1?continue”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx_builtins.c: Goto (macro-user-callerid,s,38)
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-user-callerid:38] Set(“PJSIP/105-00000003”, “CALLERID(number)=105”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-user-callerid:39] Set(“PJSIP/105-00000003”, “CALLERID(name)=Sean #2”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-user-callerid:40] GotoIf(“PJSIP/105-00000003”, “0?cnum”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-user-callerid:41] Set(“PJSIP/105-00000003”, “CDR(cnam)=Sean #2”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-user-callerid:42] Set(“PJSIP/105-00000003”, “CDR(cnum)=105”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-user-callerid:43] Set(“PJSIP/105-00000003”, “CHANNEL(language)=en_GB”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [9447342052440@from-internal:2] Gosub(“PJSIP/105-00000003”, “sub-record-check,s,1(out,9447342052440,dontcare)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-record-check:1] GotoIf(“PJSIP/105-00000003”, “0?initialized”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-record-check:2] Set(“PJSIP/105-00000003”, “__REC_STATUS=INITIALIZED”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-record-check:3] Set(“PJSIP/105-00000003”, “NOW=1574936703”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-record-check:4] Set(“PJSIP/105-00000003”, “__DAY=28”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-record-check:5] Set(“PJSIP/105-00000003”, “__MONTH=11”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-record-check:6] Set(“PJSIP/105-00000003”, “__YEAR=2019”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-record-check:7] Set(“PJSIP/105-00000003”, “__TIMESTR=20191128-102503”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-record-check:8] Set(“PJSIP/105-00000003”, “__FROMEXTEN=105”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-record-check:9] Set(“PJSIP/105-00000003”, “__MON_FMT=wav”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-record-check:10] NoOp(“PJSIP/105-00000003”, “Recordings initialized”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-record-check:11] ExecIf(“PJSIP/105-00000003”, “0?Set(ARG3=dontcare)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-record-check:12] Set(“PJSIP/105-00000003”, “REC_POLICY_MODE_SAVE=”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-record-check:13] ExecIf(“PJSIP/105-00000003”, “0?Set(REC_STATUS=NO)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-record-check:14] GotoIf(“PJSIP/105-00000003”, “3?checkaction”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx_builtins.c: Goto (sub-record-check,s,17)
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-record-check:17] GotoIf(“PJSIP/105-00000003”, “1?sub-record-check,out,1”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx_builtins.c: Goto (sub-record-check,out,1)
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [out@sub-record-check:1] NoOp(“PJSIP/105-00000003”, “Outbound Recording Check from 105 to 9447342052440”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [out@sub-record-check:2] Set(“PJSIP/105-00000003”, “RECMODE=dontcare”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [out@sub-record-check:3] ExecIf(“PJSIP/105-00000003”, “1?Goto(routewins)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx_builtins.c: Goto (sub-record-check,out,7)
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [out@sub-record-check:7] Gosub(“PJSIP/105-00000003”, “recordcheck,1(dontcare,out,9447342052440)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“PJSIP/105-00000003”, “Starting recording check against dontcare”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“PJSIP/105-00000003”, “dontcare”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“PJSIP/105-00000003”, “”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [out@sub-record-check:8] Return(“PJSIP/105-00000003”, “”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [9447342052440@from-internal:3] ExecIf(“PJSIP/105-00000003”, “0 ?Set(CDR(accountcode)=)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [9447342052440@from-internal:4] Set(“PJSIP/105-00000003”, “ROUTE_CIDSAVE=“Sean #2” <105>”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [9447342052440@from-internal:5] Set(“PJSIP/105-00000003”, “MOHCLASS=default”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [9447342052440@from-internal:6] Set(“PJSIP/105-00000003”, “_NODEST=”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [9447342052440@from-internal:7] Macro(“PJSIP/105-00000003”, “dialout-trunk,1,447342052440,off”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:1] Set(“PJSIP/105-00000003”, “DIAL_TRUNK=1”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:2] ExecIf(“PJSIP/105-00000003”, “0?Set(DIAL_OPTIONS=Hhtr)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:3] GosubIf(“PJSIP/105-00000003”, “0?sub-pincheck,s,1()”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:4] ExecIf(“PJSIP/105-00000003”, “0?Set(CALLERID(num)=105)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:5] GotoIf(“PJSIP/105-00000003”, “0?disabletrunk,1”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:6] Set(“PJSIP/105-00000003”, “DIAL_NUMBER=447342052440”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:7] Set(“PJSIP/105-00000003”, “DIAL_TRUNK_OPTIONS=HhTtr”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:8] Set(“PJSIP/105-00000003”, “OUTBOUND_GROUP=OUT_1”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:9] Set(“PJSIP/105-00000003”, “DIAL_TRUNK_OPTIONS=T”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:10] GotoIf(“PJSIP/105-00000003”, “1?nomax”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx_builtins.c: Goto (macro-dialout-trunk,s,12)
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:12] GotoIf(“PJSIP/105-00000003”, “0?skipoutcid”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:13] Macro(“PJSIP/105-00000003”, “outbound-callerid,1”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:1] NoOp(“PJSIP/105-00000003”, “105”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:2] NoOp(“PJSIP/105-00000003”, “”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:3] NoOp(“PJSIP/105-00000003”, “off”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:4] ExecIf(“PJSIP/105-00000003”, “0?Set(CALLERPRES(name-pres)=)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:5] ExecIf(“PJSIP/105-00000003”, “0?Set(CALLERPRES(num-pres)=)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:6] ExecIf(“PJSIP/105-00000003”, “0?Set(REALCALLERIDNUM=105)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:7] ExecIf(“PJSIP/105-00000003”, “0?Set(AMPUSER=105)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:8] GotoIf(“PJSIP/105-00000003”, “1?normcid”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx_builtins.c: Goto (macro-outbound-callerid,s,12)
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:12] Set(“PJSIP/105-00000003”, “USEROUTCID=<12345678900>”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:13] Set(“PJSIP/105-00000003”, “EMERGENCYCID=”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:14] Set(“PJSIP/105-00000003”, “TRUNKOUTCID=01157351119”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:15] GotoIf(“PJSIP/105-00000003”, “1?trunkcid”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx_builtins.c: Goto (macro-outbound-callerid,s,21)
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:21] ExecIf(“PJSIP/105-00000003”, “1?Set(CALLERID(all)=01157351119)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:22] ExecIf(“PJSIP/105-00000003”, “1?Set(CALLERID(all)=<12345678900>)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:23] ExecIf(“PJSIP/105-00000003”, “0?Set(CALLERID(all)=)”) in new stack
[2019-11-28 10:25:03] WARNING[16082][C-00000003] ast_expr2.fl: ast_yyerror(): syntax error: syntax error, unexpected ‘=’, expecting $end; Input:
= 1 & 0 = 0
^
[2019-11-28 10:25:03] WARNING[16082][C-00000003] ast_expr2.fl: If you have questions, please refer to https://wiki.asterisk.org/wiki/display/AST/Channel+Variables
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:24] ExecIf(“PJSIP/105-00000003”, “?Set(CALLERID(all)=105)”) in new stack
[2019-11-28 10:25:03] WARNING[16082][C-00000003] ast_expr2.fl: ast_yyerror(): syntax error: syntax error, unexpected ‘=’, expecting $end; Input:
= 1 & 0 = 0
^
[2019-11-28 10:25:03] WARNING[16082][C-00000003] ast_expr2.fl: If you have questions, please refer to https://wiki.asterisk.org/wiki/display/AST/Channel+Variables
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:25] ExecIf(“PJSIP/105-00000003”, “0?Set(CALLERPRES(name-pres)=prohib_passed_screen)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:26] ExecIf(“PJSIP/105-00000003”, “0?Set(CALLERPRES(num-pres)=prohib_passed_screen)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:27] Set(“PJSIP/105-00000003”, “CDR(outbound_cnum)=12345678900”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-outbound-callerid:28] Set(“PJSIP/105-00000003”, “CDR(outbound_cnam)=”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:14] GosubIf(“PJSIP/105-00000003”, “1?sub-flp-1,s,1()”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-flp-1:1] ExecIf(“PJSIP/105-00000003”, “0?Set(TARGET_FLP_1=44447342052440)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-flp-1:2] GotoIf(“PJSIP/105-00000003”, “0?match”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-flp-1:3] ExecIf(“PJSIP/105-00000003”, “0?Return()”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@sub-flp-1:4] Return(“PJSIP/105-00000003”, “”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:15] Set(“PJSIP/105-00000003”, “OUTNUM=447342052440”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:16] Set(“PJSIP/105-00000003”, “custom=SIP/didlogic”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:17] ExecIf(“PJSIP/105-00000003”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:18] ExecIf(“PJSIP/105-00000003”, “0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:19] Macro(“PJSIP/105-00000003”, “dialout-trunk-predial-hook,”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“PJSIP/105-00000003”, “”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:20] GotoIf(“PJSIP/105-00000003”, “0?skipcrm”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:21] Set(“PJSIP/105-00000003”, “__CRM_DIRECTION=OUTBOUND”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:22] Set(“PJSIP/105-00000003”, “__CRM_DESTINATION=447342052440”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:23] Set(“PJSIP/105-00000003”, “__CRM_SOURCE=105”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:24] AGI(“PJSIP/105-00000003”, “sangomacrm.agi”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] res_agi.c: <PJSIP/105-00000003>AGI Script sangomacrm.agi completed, returning 0
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:25] Set(“PJSIP/105-00000003”, “CHANNEL(hangup_handler_push)=crm-hangup,s,1”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:26] NoOp(“PJSIP/105-00000003”, “CRM Finished”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:27] GotoIf(“PJSIP/105-00000003”, “0?bypass,1”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:28] ExecIf(“PJSIP/105-00000003”, “1?Set(CONNECTEDLINE(num,i)=447342052440)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:29] ExecIf(“PJSIP/105-00000003”, “1?Set(CONNECTEDLINE(name,i)=CID:12345678900)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:30] ExecIf(“PJSIP/105-00000003”, “0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)12345678900)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:31] GotoIf(“PJSIP/105-00000003”, “0?customtrunk”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:32] ExecIf(“PJSIP/105-00000003”, “0?Set(DIAL_TRUNK_OPTIONS=)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@macro-dialout-trunk:33] Dial(“PJSIP/105-00000003”, “SIP/didlogic/447342052440,300,Tb(func-apply-sipheaders^s^1,(1))”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] netsock2.c: Using SIP RTP TOS bits 184
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] netsock2.c: Using SIP RTP CoS mark 5
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] app_stack.c: SIP/didlogic-00000003 Internal Gosub(func-apply-sipheaders,s,1(1)) start
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf(“SIP/didlogic-00000003”, “0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp(“SIP/didlogic-00000003”, “Applying SIP Headers to channel SIP/didlogic-00000003”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:3] Set(“SIP/didlogic-00000003”, “TECH=SIP”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:4] Set(“SIP/didlogic-00000003”, “SIPHEADERKEYS=”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:5] While(“SIP/didlogic-00000003”, “0”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] app_while.c: Jumping to priority 13
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] pbx.c: Executing [s@func-apply-sipheaders:14] Return(“SIP/didlogic-00000003”, “”) in new stack
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] app_stack.c: Spawn extension (from-trunk-sip-didlogic, 9447342052440, 1) exited non-zero on ‘SIP/didlogic-00000003’
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] app_stack.c: SIP/didlogic-00000003 Internal Gosub(func-apply-sipheaders,s,1(1)) complete GOSUB_RETVAL=
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] chan_sip.c: Audio is at 16242
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] chan_sip.c: Adding codec ulaw to SDP
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] chan_sip.c: Adding non-codec 0x1 (telephone-event) to SDP
[2019-11-28 10:25:03] VERBOSE[16082][C-00000003] chan_sip.c: Reliably Transmitting (NAT) to 83.222.249.39:5060:
INVITE sip:[email protected] SIP/2.0
Via: SIP/2.0/UDP 172.xx.31.196:5160;branch=z9hG4bK3fdc3fc2;rport
Max-Forwards: 70
From: <sip:[email protected]:5160>;tag=as4fc98a18
To: <sip:[email protected]>
Contact: <sip:[email protected]:5160>
Call-ID: [email protected]:5160
CSeq: 102 INVITE
User-Agent: FPBX-14.0.13.12(13.29.2)
Date: Thu, 28 Nov 2019 10:25:03 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
P-Asserted-Identity: “12345678900” <sip:[email protected]>
Content-Type: application/sdp
Content-Length: 240

Have you considered that the sip/pstn provider won’t pass a spoofed CLI and/or expect it in e164 format?

Yes, thanks, it’s something I’m querying separately. I’ve sent the same trace to them with a similar question. However, they previously confirmed they opened the route for me to pass my own CID through, but what validation remains their end I don’t know and have queried.

Does it appear from the information I’ve provided that the CID is making it out correctly my end?

Thanks again.

If we tried to spoof 12345678900 as the CLI it wouldn’t go over any of our providers. That’s probably the answer as you can’t do that in the UK. I wouldn’t over complicate this and first try a genuine CLI from the same extension and see if that works ok. Unless I’m misunderstanding what you’re trying to do and, if so, my apologies.

Thanks, yes I changed the CID to comply with E.164 and set it to 447538345678. The SIP/DID provider say they don’t restrict (as mentioned) and today they responded and state they have not received any calls with the CID I mentioned (12345678900).

However, they do say they have received calls with the CID as 52781. That is on the payload of the test connection and is the test account name.

Does that match with what I am sending in the below trace? I of course see 52781, but not in the CID, but my knowledge is limited.

2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx_builtins.c: Goto (macro-outbound-callerid,s,21)
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-outbound-callerid:21] ExecIf(“PJSIP/105-00000005”, “1?Set(CALLERID(all)=<447538345678>)”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-outbound-callerid:22] ExecIf(“PJSIP/105-00000005”, “1?Set(CALLERID(all)=<447538345678>)”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-outbound-callerid:23] ExecIf(“PJSIP/105-00000005”, “0?Set(CALLERID(all)=)”) in new stack
[2019-11-28 11:10:07] WARNING[24863][C-00000005] ast_expr2.fl: ast_yyerror(): syntax error: syntax error, unexpected ‘=’, expecting $end; Input:
= 1 & 0 = 0
^
[2019-11-28 11:10:07] WARNING[24863][C-00000005] ast_expr2.fl: If you have questions, please refer to https://wiki.asterisk.org/wiki/display/AST/Channel+Variables
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-outbound-callerid:24] ExecIf(“PJSIP/105-00000005”, “?Set(CALLERID(all)=105)”) in new stack
[2019-11-28 11:10:07] WARNING[24863][C-00000005] ast_expr2.fl: ast_yyerror(): syntax error: syntax error, unexpected ‘=’, expecting $end; Input:
= 1 & 0 = 0
^
[2019-11-28 11:10:07] WARNING[24863][C-00000005] ast_expr2.fl: If you have questions, please refer to https://wiki.asterisk.org/wiki/display/AST/Channel+Variables
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-outbound-callerid:25] ExecIf(“PJSIP/105-00000005”, “0?Set(CALLERPRES(name-pres)=prohib_passed_screen)”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-outbound-callerid:26] ExecIf(“PJSIP/105-00000005”, “0?Set(CALLERPRES(num-pres)=prohib_passed_screen)”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-outbound-callerid:27] Set(“PJSIP/105-00000005”, “CDR(outbound_cnum)=447538345678”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-outbound-callerid:28] Set(“PJSIP/105-00000005”, “CDR(outbound_cnam)=”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:14] GosubIf(“PJSIP/105-00000005”, “1?sub-flp-1,s,1()”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@sub-flp-1:1] ExecIf(“PJSIP/105-00000005”, “0?Set(TARGET_FLP_1=44447342052440)”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@sub-flp-1:2] GotoIf(“PJSIP/105-00000005”, “0?match”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@sub-flp-1:3] ExecIf(“PJSIP/105-00000005”, “0?Return()”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@sub-flp-1:4] Return(“PJSIP/105-00000005”, “”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:15] Set(“PJSIP/105-00000005”, “OUTNUM=447342052440”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:16] Set(“PJSIP/105-00000005”, “custom=SIP/didlogic”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:17] ExecIf(“PJSIP/105-00000005”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:18] ExecIf(“PJSIP/105-00000005”, “0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:19] Macro(“PJSIP/105-00000005”, “dialout-trunk-predial-hook,”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“PJSIP/105-00000005”, “”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:20] GotoIf(“PJSIP/105-00000005”, “0?skipcrm”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:21] Set(“PJSIP/105-00000005”, “__CRM_DIRECTION=OUTBOUND”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:22] Set(“PJSIP/105-00000005”, “__CRM_DESTINATION=447342052440”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:23] Set(“PJSIP/105-00000005”, “__CRM_SOURCE=105”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:24] AGI(“PJSIP/105-00000005”, “sangomacrm.agi”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] res_agi.c: <PJSIP/105-00000005>AGI Script sangomacrm.agi completed, returning 0
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:25] Set(“PJSIP/105-00000005”, “CHANNEL(hangup_handler_push)=crm-hangup,s,1”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:26] NoOp(“PJSIP/105-00000005”, “CRM Finished”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:27] GotoIf(“PJSIP/105-00000005”, “0?bypass,1”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:28] ExecIf(“PJSIP/105-00000005”, “1?Set(CONNECTEDLINE(num,i)=447342052440)”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:29] ExecIf(“PJSIP/105-00000005”, “1?Set(CONNECTEDLINE(name,i)=CID:447538345678)”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:30] ExecIf(“PJSIP/105-00000005”, “0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)447538345678)”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:31] GotoIf(“PJSIP/105-00000005”, “0?customtrunk”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:32] ExecIf(“PJSIP/105-00000005”, “0?Set(DIAL_TRUNK_OPTIONS=)”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@macro-dialout-trunk:33] Dial(“PJSIP/105-00000005”, “SIP/didlogic/447342052440,300,Tb(func-apply-sipheaders^s^1,(1))”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] netsock2.c: Using SIP RTP TOS bits 184
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] netsock2.c: Using SIP RTP CoS mark 5
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] app_stack.c: SIP/didlogic-00000005 Internal Gosub(func-apply-sipheaders,s,1(1)) start
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf(“SIP/didlogic-00000005”, “0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp(“SIP/didlogic-00000005”, “Applying SIP Headers to channel SIP/didlogic-00000005”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@func-apply-sipheaders:3] Set(“SIP/didlogic-00000005”, “TECH=SIP”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@func-apply-sipheaders:4] Set(“SIP/didlogic-00000005”, “SIPHEADERKEYS=”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@func-apply-sipheaders:5] While(“SIP/didlogic-00000005”, “0”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] app_while.c: Jumping to priority 13
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] pbx.c: Executing [s@func-apply-sipheaders:14] Return(“SIP/didlogic-00000005”, “”) in new stack
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] app_stack.c: Spawn extension (from-trunk-sip-didlogic, 9447342052440, 1) exited non-zero on ‘SIP/didlogic-00000005’
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] app_stack.c: SIP/didlogic-00000005 Internal Gosub(func-apply-sipheaders,s,1(1)) complete GOSUB_RETVAL=
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] chan_sip.c: Audio is at 19622
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] chan_sip.c: Adding codec ulaw to SDP
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] chan_sip.c: Adding non-codec 0x1 (telephone-event) to SDP
[2019-11-28 11:10:07] VERBOSE[24863][C-00000005] chan_sip.c: Reliably Transmitting (NAT) to 83.222.249.39:5060:
INVITE sip:[email protected] SIP/2.0
Via: SIP/2.0/UDP 172.XX31.196:5160;branch=z9hG4bK43463e08;rport
Max-Forwards: 70
From: <sip:[email protected]:5160>;tag=as4ad48aa4
To: <sip:[email protected]>
Contact: <sip:[email protected]:5160>
Call-ID: [email protected]:5160
CSeq: 102 INVITE
User-Agent: FPBX-14.0.13.12(13.29.2)
Date: Thu, 28 Nov 2019 11:10:07 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
P-Asserted-Identity: “447538345678” <sip:[email protected]>
Content-Type: application/sdp
Content-Length: 240

v=0
o=root 220787419 220787419 IN IP4 172.XX.31.196
s=Asterisk PBX 13.29.2
c=IN IP4 172.XX.31.196
t=0 0
m=audio 19622 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=maxptime:150
a=sendrecv

You’ll need to take this up with your sip provider but first and foremost I would only use a genuine CID for your testing. Is that …345678 mobile number even genuine? You are not allowed to spoof CLIs. There is no point using 12345678900 or 9447… or anything else that doesn’t comply with the required e164 format. You can set the CID on the trunk and the extension from the FreePBX GUI. Good luck with it.

Thanks. I have no intention of spoofing it outside a test, I just want to pass through legit DID per extension via the same channel.

Thanks for your time.

Kind regards,

Can anyone else assist me in why the CID is not flowing through. The logs are listed in this thread.

Thanks in advance.

Is your caller ID of the format

"the name" <the number>

?

Many thanks for coming back to me dicko.

The caller ID is set as “<44115735xxxx>”. Without the quotes and without any preceding text such as “the name”.

Regards,

Try adding “YOUR WHATEVER” best is 15 or less uppercase ASCII characters.

Thanks for your assistance. I’ve added as suggested but still “Unknown” on receiving phone.

Please find a section of the log entries from SIP debug. I can provide further logs if necessary:

<— SIP read from UDP:83.XX2.249.39:5060 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.XX.XX.196:5160;received=52.XX.188.93;branch=z9hG4bK263790ec;rport=5160
Record-Route: <sip:83.XX.249.39;lr=on;ftag=as18249890;nat=yes>
From: “YOUR WHATEVER” <sip:[email protected]:5160>;tag=as18249890
To: <sip:[email protected]>;tag=as5d1e2a06
Call-ID: [email protected]:5160
CSeq: 103 INVITE
Server: DID Logic MGW
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces
Contact: <sip:[email protected]:5080>
Content-Type: application/sdp
Content-Length: 227

v=0
o=didlogic 83027473 83027473 IN IP4 5.XX.74.245
s=DID Logic MGW
c=IN IP4 5.XX.74.245
t=0 0
m=audio 18894 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

Are the ast_yyerrors still there?

Who or what is 53781 because that is the CallerID(num) you are using.

I don’t see any ast errors in the log file. Where are these likely to be?

The SIP provider is also saying they are receiving 52781 as the CID, but I can’t see why?

The 52781 is the test id on the SIP account I’m testing with and assigned to the Trunk in Freepbx.

Outgoing
Peer Details:
host=sip.uk.didlogic.net
user=52781
username=52781
fromuser=52781
authname=52781
secret=xxxxx
insecure=port,invite
type=peer
sendrpid=pai
qualify=yes
disallow=all
allow=ulaw
trustrpid=yes

Incoming
Register String: 52781:[email protected]

This shouldn’t that difficult. Why don’t you simply find another SIP provider, buy ONE trunk from them for testing and plug it into your system? If it also fails you know the problem is your configuration if it works you can tell your existing SIP provider you have a competitor who works and you don’t understand why they don’t - or just tell them to pound sand. They don’t appear to have been much help so why are you so loyal to them? If I was selling SIP trunks and a customer called me with a problem like this in 5 minutes I would have insisted on webexing into their system and making sure they had configured it properly.

JUST SAYIN’ !!!

I’ve tried a few providers with varying levels of configuration ease but with the couple I’ve put more time in with the CID problem persists. I think the issue is my end, especially now that dicko has pointed out that I’m sending the CID as 52781 given my logs

Working back from this I hope I can find the config setting I need to change in freepbx to pass the required CID.

The outgoing CID is recorded for all outbound calls in the CDR. Also you might get more people to look at call traces if you make a bit of effort. Share them via pastebin instead of endless unformatted dumps here.

Yes. The CID report lists the CID correctly:
image

dicko seems to have seen something that may explain the issue?