No audio on internal or external calls

Hello,

I’m new to Asterisk/FreePBX… I setup a server running FreePBX 14 and Asterisk 13.

I setup the SIP trunks properly (I believe) and created two test extensions. I have connected to the two test extensions via X-Lite on two different computers. The extensions can call each other no problem, but when they connect there’s no audio at all from either end.

I can also successfully make an external call and receive a call from external parties, but again no audio at all.

I have tried to disable the firewall in FreePBX, but that does not help - and I have tried to increase the port range for RTP which does not help. I have also ensured that the “Local Networks” under “NAT Settings” is set appropriate with our private address scheme.

Any suggestions for how I can get this working properly?

Thanks in advance!

https://wiki.freepbx.org/display/SUP/Providing+Great+Debug#ProvidingGreatDebug-AsteriskLogs

If your phones and freepbx servers are all on your local lan, most probably you have a codec mismatch.

If freepbx is hosted on the cloud, most probably you have a NAT issue.

In any case, you should provide more info about your specific setup so we can provide useful help.

Here’s the output from the log as requested (produced by calling from one local extension to another local extension). X-Lite shows that the microphone is picking up sound, but it never comes through on the other end.

[2018-09-17 12:57:32] VERBOSE[56453][C-00000018] pbx.c: Executing [[email protected]:3] ExecIf(“PJSIP/233-0000002a”, “0?Set(CDR(recordingfile)=)”) in new stack
[2018-09-17 12:57:32] VERBOSE[56453][C-00000018] pbx.c: Executing [[email protected]:4] NoOp(“PJSIP/233-0000002a”, "PJSIP/234-0000002b monior file= ") in new stack
[2018-09-17 12:57:32] VERBOSE[56453][C-00000018] pbx.c: Executing [[email protected]:5] AGI(“PJSIP/233-0000002a”, “attendedtransfer-rec-restart.php,PJSIP/234-0000002b,”) in new stack
[2018-09-17 12:57:32] VERBOSE[56453][C-00000018] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/attendedtransfer-rec-restart.php
[2018-09-17 12:57:32] VERBOSE[56453][C-00000018] res_agi.c: <PJSIP/233-0000002a>AGI Script attendedtransfer-rec-restart.php completed, returning 0
[2018-09-17 12:57:32] VERBOSE[56453][C-00000018] pbx.c: Executing [[email protected]:6] Hangup(“PJSIP/233-0000002a”, “”) in new stack
[2018-09-17 12:57:32] VERBOSE[56453][C-00000018] app_macro.c: Spawn extension (macro-hangupcall, s, 6) exited non-zero on ‘PJSIP/233-0000002a’ in macro ‘hangupcall’
[2018-09-17 12:57:32] VERBOSE[56453][C-00000018] pbx.c: Spawn extension (ext-local, h, 1) exited non-zero on ‘PJSIP/233-0000002a’
[2018-09-17 12:58:27] VERBOSE[52754] pbx_variables.c: Setting global variable ‘SIPDOMAIN’ to ‘10.42.0.23’
[2018-09-17 12:58:27] VERBOSE[52754] netsock2.c: Using SIP RTP Audio TOS bits 184
[2018-09-17 12:58:27] VERBOSE[52754] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
[2018-09-17 12:58:27] VERBOSE[52754] netsock2.c: Using SIP RTP Audio CoS mark 5
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:1] GotoIf(“PJSIP/233-0000002c”, “1?ext-local,234,1:followme-check,234,1”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx_builtins.c: Goto (ext-local,234,1)
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:1] Set(“PJSIP/233-0000002c”, “__RINGTIMER=15”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:2] Macro(“PJSIP/233-0000002c”, “exten-vm,novm,234,0,0,0”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:1] Macro(“PJSIP/233-0000002c”, “user-callerid,”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:1] Set(“PJSIP/233-0000002c”, “TOUCH_MONITOR=1537203507.44”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:2] Set(“PJSIP/233-0000002c”, “AMPUSER=233”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:3] GotoIf(“PJSIP/233-0000002c”, “0?report”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:4] ExecIf(“PJSIP/233-0000002c”, “1?Set(REALCALLERIDNUM=233)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:5] Set(“PJSIP/233-0000002c”, “AMPUSER=233”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:6] GotoIf(“PJSIP/233-0000002c”, “0?limit”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:7] Set(“PJSIP/233-0000002c”, “AMPUSERCIDNAME=User 1”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:8] ExecIf(“PJSIP/233-0000002c”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:9] GotoIf(“PJSIP/233-0000002c”, “0?report”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:10] Set(“PJSIP/233-0000002c”, “AMPUSERCID=233”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:11] Set(“PJSIP/233-0000002c”, “__DIAL_OPTIONS=HhTtr”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:12] Set(“PJSIP/233-0000002c”, “CALLERID(all)=“User 1” <233>”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:13] GotoIf(“PJSIP/233-0000002c”, “0?limit”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:14] ExecIf(“PJSIP/233-0000002c”, “0?Set(GROUP(concurrency_limit)=233)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:15] ExecIf(“PJSIP/233-0000002c”, “0?Set(CHANNEL(language)=)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:16] NoOp(“PJSIP/233-0000002c”, “Macro Depth is 2”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:17] GotoIf(“PJSIP/233-0000002c”, “1?report2:macroerror”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx_builtins.c: Goto (macro-user-callerid,s,18)
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:18] GotoIf(“PJSIP/233-0000002c”, “0?continue”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:19] ExecIf(“PJSIP/233-0000002c”, “1?Set(__CALLEE_ACCOUNCODE=)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:20] Set(“PJSIP/233-0000002c”, “__TTL=64”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:21] GotoIf(“PJSIP/233-0000002c”, “1?continue”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx_builtins.c: Goto (macro-user-callerid,s,37)
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:37] Set(“PJSIP/233-0000002c”, “CALLERID(number)=233”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:38] Set(“PJSIP/233-0000002c”, “CALLERID(name)=User 1”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:39] GotoIf(“PJSIP/233-0000002c”, “0?cnum”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:40] Set(“PJSIP/233-0000002c”, “CDR(cnam)=User 1”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:41] Set(“PJSIP/233-0000002c”, “CDR(cnum)=233”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:42] Set(“PJSIP/233-0000002c”, “CHANNEL(language)=en”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:2] Set(“PJSIP/233-0000002c”, “RingGroupMethod=none”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:3] Set(“PJSIP/233-0000002c”, “__EXTTOCALL=234”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:4] Set(“PJSIP/233-0000002c”, “__PICKUPMARK=234”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:5] Set(“PJSIP/233-0000002c”, “RT=”) in new stack
[2018-09-17 12:58:27] WARNING[56727][C-00000019] chan_sip.c: This function can only be used on SIP channels.
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:6] ExecIf(“PJSIP/233-0000002c”, “0?Macro(vm,novm,DIRECTDIAL,)”) in new stack
[2018-09-17 12:58:27] WARNING[56727][C-00000019] chan_sip.c: This function can only be used on SIP channels.
[2018-09-17 12:58:27] WARNING[56727][C-00000019] chan_sip.c: This function can only be used on SIP channels.
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:7] ExecIf(“PJSIP/233-0000002c”, “0?MacroExit()”) in new stack
[2018-09-17 12:58:27] WARNING[56727][C-00000019] chan_sip.c: This function can only be used on SIP channels.
[2018-09-17 12:58:27] WARNING[56727][C-00000019] chan_sip.c: This function can only be used on SIP channels.
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:8] ExecIf(“PJSIP/233-0000002c”, “0?Gosub(ext-intercom,*80234,1())”) in new stack
[2018-09-17 12:58:27] WARNING[56727][C-00000019] chan_sip.c: This function can only be used on SIP channels.
[2018-09-17 12:58:27] WARNING[56727][C-00000019] chan_sip.c: This function can only be used on SIP channels.
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:9] ExecIf(“PJSIP/233-0000002c”, “0?MacroExit()”) in new stack
[2018-09-17 12:58:27] WARNING[56727][C-00000019] chan_sip.c: This function can only be used on SIP channels.
[2018-09-17 12:58:27] WARNING[56727][C-00000019] chan_sip.c: This function can only be used on SIP channels.
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:10] ExecIf(“PJSIP/233-0000002c”, “0?ChanSpy(PJSIP/234,q)”) in new stack
[2018-09-17 12:58:27] WARNING[56727][C-00000019] chan_sip.c: This function can only be used on SIP channels.
[2018-09-17 12:58:27] WARNING[56727][C-00000019] chan_sip.c: This function can only be used on SIP channels.
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:11] ExecIf(“PJSIP/233-0000002c”, “0?MacroExit()”) in new stack
[2018-09-17 12:58:27] WARNING[56727][C-00000019] chan_sip.c: This function can only be used on SIP channels.
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:12] ExecIf(“PJSIP/233-0000002c”, “0?Macro(vm,novm,DIRECTDIAL,)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:13] ExecIf(“PJSIP/233-0000002c”, “0?MacroExit()”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:14] ExecIf(“PJSIP/233-0000002c”, “0?Gosub(ext-intercom,*80234,1())”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:15] ExecIf(“PJSIP/233-0000002c”, “0?MacroExit()”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:16] ExecIf(“PJSIP/233-0000002c”, “0?ChanSpy(PJSIP/234,q)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:17] ExecIf(“PJSIP/233-0000002c”, “0?MacroExit()”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:18] Gosub(“PJSIP/233-0000002c”, “sub-record-check,s,1(exten,234,dontcare)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:1] GotoIf(“PJSIP/233-0000002c”, “0?initialized”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:2] Set(“PJSIP/233-0000002c”, “__REC_STATUS=INITIALIZED”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:3] Set(“PJSIP/233-0000002c”, “NOW=1537203507”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:4] Set(“PJSIP/233-0000002c”, “__DAY=17”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:5] Set(“PJSIP/233-0000002c”, “__MONTH=09”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:6] Set(“PJSIP/233-0000002c”, “__YEAR=2018”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:7] Set(“PJSIP/233-0000002c”, “__TIMESTR=20180917-125827”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:8] Set(“PJSIP/233-0000002c”, “__FROMEXTEN=233”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:9] Set(“PJSIP/233-0000002c”, “__MON_FMT=wav”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:10] NoOp(“PJSIP/233-0000002c”, “Recordings initialized”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:11] ExecIf(“PJSIP/233-0000002c”, “0?Set(ARG3=dontcare)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:12] Set(“PJSIP/233-0000002c”, “REC_POLICY_MODE_SAVE=”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:13] ExecIf(“PJSIP/233-0000002c”, “0?Set(REC_STATUS=NO)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:14] GotoIf(“PJSIP/233-0000002c”, “5?checkaction”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx_builtins.c: Goto (sub-record-check,s,17)
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:17] GotoIf(“PJSIP/233-0000002c”, “1?sub-record-check,exten,1”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx_builtins.c: Goto (sub-record-check,exten,1)
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:1] NoOp(“PJSIP/233-0000002c”, “Exten Recording Check between 233 and 234”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:2] Set(“PJSIP/233-0000002c”, “CALLTYPE=internal”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:3] ExecIf(“PJSIP/233-0000002c”, “0?Set(CALLTYPE=)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:4] Set(“PJSIP/233-0000002c”, “CALLEE=dontcare”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:5] ExecIf(“PJSIP/233-0000002c”, “0?Set(CALLEE=dontcare)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:6] GotoIf(“PJSIP/233-0000002c”, “0?callee”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:7] GotoIf(“PJSIP/233-0000002c”, “1?caller”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx_builtins.c: Goto (sub-record-check,exten,13)
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:13] Set(“PJSIP/233-0000002c”, “RECMODE=dontcare”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:14] ExecIf(“PJSIP/233-0000002c”, “0?Set(RECMODE=dontcare)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:15] ExecIf(“PJSIP/233-0000002c”, “1?Set(RECMODE=dontcare)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:16] Gosub(“PJSIP/233-0000002c”, “recordcheck,1(dontcare,internal,234)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:1] NoOp(“PJSIP/233-0000002c”, “Starting recording check against dontcare”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:2] Goto(“PJSIP/233-0000002c”, “dontcare”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:3] Return(“PJSIP/233-0000002c”, “”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:17] Return(“PJSIP/233-0000002c”, “”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:19] GotoIf(“PJSIP/233-0000002c”, “1?macrodial”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx_builtins.c: Goto (macro-exten-vm,s,25)
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:25] GosubIf(“PJSIP/233-0000002c”, “0?clrheader,1()”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:26] Macro(“PJSIP/233-0000002c”, “dial-one,HhTtr,234”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:1] Set(“PJSIP/233-0000002c”, “DEXTEN=234”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:2] Set(“PJSIP/233-0000002c”, “__CRM_SOURCE=233”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:3] ExecIf(“PJSIP/233-0000002c”, “0?Set(__EXTTOCALL=234)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:4] Set(“PJSIP/233-0000002c”, “DIALSTATUS_CW=”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:5] GosubIf(“PJSIP/233-0000002c”, “0?screen,1()”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:6] GosubIf(“PJSIP/233-0000002c”, “0?cf,1()”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:7] GotoIf(“PJSIP/233-0000002c”, “1?skip1”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx_builtins.c: Goto (macro-dial-one,s,10)
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:10] GotoIf(“PJSIP/233-0000002c”, “0?nodial”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:11] GotoIf(“PJSIP/233-0000002c”, “0?continue”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:12] Set(“PJSIP/233-0000002c”, “EXTHASCW=ENABLED”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:13] GotoIf(“PJSIP/233-0000002c”, “0?next1:cwinusebusy”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx_builtins.c: Goto (macro-dial-one,s,25)
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:25] GotoIf(“PJSIP/233-0000002c”, “0?next3:continue”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx_builtins.c: Goto (macro-dial-one,s,27)
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:27] GotoIf(“PJSIP/233-0000002c”, “0?nodial”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:28] GosubIf(“PJSIP/233-0000002c”, “1?dstring,1():dlocal,1()”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:1] Set(“PJSIP/233-0000002c”, “DSTRING=”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:2] Set(“PJSIP/233-0000002c”, “DEVICES=234”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:3] ExecIf(“PJSIP/233-0000002c”, “0?Return()”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:4] ExecIf(“PJSIP/233-0000002c”, “0?Set(DEVICES=34)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:5] Set(“PJSIP/233-0000002c”, “LOOPCNT=1”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:6] Set(“PJSIP/233-0000002c”, “ITER=1”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:7] Set(“PJSIP/233-0000002c”, “THISDIAL=PJSIP/234”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:8] GosubIf(“PJSIP/233-0000002c”, “1?zap2dahdi,1()”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:1] ExecIf(“PJSIP/233-0000002c”, “0?Return()”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:2] Set(“PJSIP/233-0000002c”, “NEWDIAL=”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:3] Set(“PJSIP/233-0000002c”, “LOOPCNT2=1”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:4] Set(“PJSIP/233-0000002c”, “ITER2=1”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:5] Set(“PJSIP/233-0000002c”, “THISPART2=PJSIP/234”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:6] ExecIf(“PJSIP/233-0000002c”, “0?Set(THISPART2=DAHDIIP/234)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:7] Set(“PJSIP/233-0000002c”, “NEWDIAL=PJSIP/234&”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:8] Set(“PJSIP/233-0000002c”, “ITER2=2”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:9] GotoIf(“PJSIP/233-0000002c”, “0?begin2”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:10] Set(“PJSIP/233-0000002c”, “THISDIAL=PJSIP/234”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:11] Return(“PJSIP/233-0000002c”, “”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:9] GotoIf(“PJSIP/233-0000002c”, “0?docheck”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:10] NoOp(“PJSIP/233-0000002c”, “Debug: Found PJSIP Destination PJSIP/234”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:11] GotoIf(“PJSIP/233-0000002c”, “0?doset”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:12] NoOp(“PJSIP/233-0000002c”, “Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:13] Set(“PJSIP/233-0000002c”, “THISDIAL=PJSIP/234/sip:[email protected]:49262;rinstance=812c27609c7cbfae”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:14] ExecIf(“PJSIP/233-0000002c”, “0?Set(DIALSTATUS=CHANUNAVAIL)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:15] GotoIf(“PJSIP/233-0000002c”, “0?skipset”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:16] Set(“PJSIP/233-0000002c”, “DSTRING=PJSIP/234/sip:[email protected]:49262;rinstance=812c27609c7cbfae&”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:17] Set(“PJSIP/233-0000002c”, “ITER=2”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:18] GotoIf(“PJSIP/233-0000002c”, “0?begin”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:19] ExecIf(“PJSIP/233-0000002c”, “0?Return()”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:20] Set(“PJSIP/233-0000002c”, “DSTRING=PJSIP/234/sip:[email protected]:49262;rinstance=812c27609c7cbfae”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:21] Return(“PJSIP/233-0000002c”, “”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:29] GotoIf(“PJSIP/233-0000002c”, “0?nodial”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:30] GotoIf(“PJSIP/233-0000002c”, “0?skiptrace”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:31] GosubIf(“PJSIP/233-0000002c”, “1?ctset,1():ctclear,1()”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:1] Set(“PJSIP/233-0000002c”, “DB(CALLTRACE/234)=233”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:2] Return(“PJSIP/233-0000002c”, “”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:32] Set(“PJSIP/233-0000002c”, “D_OPTIONS=HhTtr”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:33] GosubIf(“PJSIP/233-0000002c”, “0?func-set-sipheader,s,1(Alert-Info,)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:34] NoOp(“PJSIP/233-0000002c”, "Blind Transfer: , Attended Transfer: , User: 233, Alert Info: ") in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:35] ExecIf(“PJSIP/233-0000002c”, “1?Set(ALERT_INFO=)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:36] ExecIf(“PJSIP/233-0000002c”, “0?Set(ALERT_INFO=)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:37] ExecIf(“PJSIP/233-0000002c”, “0?Set(ALERT_INFO=)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:38] ExecIf(“PJSIP/233-0000002c”, “0?Set(ALERT_INFO=Normal;volume=)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:39] ExecIf(“PJSIP/233-0000002c”, “0?Set(ALERT_INFO=Normal;volume=)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:40] GosubIf(“PJSIP/233-0000002c”, “0?func-set-sipheader,s,1(Alert-Info,)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:41] ExecIf(“PJSIP/233-0000002c”, “0?Set(CHANNEL(musicclass)=)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:42] GosubIf(“PJSIP/233-0000002c”, “0?qwait,1()”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:43] Set(“PJSIP/233-0000002c”, “__CWIGNORE=”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:44] Set(“PJSIP/233-0000002c”, “__KEEPCID=TRUE”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:45] GotoIf(“PJSIP/233-0000002c”, “0?usegoto,1”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:46] GotoIf(“PJSIP/233-0000002c”, “0?godial”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:47] Gosub(“PJSIP/233-0000002c”, “sub-presencestate-display,s,1(234)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:1] Goto(“PJSIP/233-0000002c”, “state-not_set,1”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx_builtins.c: Goto (sub-presencestate-display,state-not_set,1)
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:1] Set(“PJSIP/233-0000002c”, “PRESENCESTATE_DISPLAY=”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:2] Return(“PJSIP/233-0000002c”, “”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:48] Set(“PJSIP/233-0000002c”, “CONNECTEDLINE(name,i)=User 2”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:49] Set(“PJSIP/233-0000002c”, “CONNECTEDLINE(num)=234”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:50] Set(“PJSIP/233-0000002c”, “D_OPTIONS=HhTtrI”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:51] Macro(“PJSIP/233-0000002c”, “dialout-one-predial-hook,”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:1] MacroExit(“PJSIP/233-0000002c”, “”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:52] ExecIf(“PJSIP/233-0000002c”, “0?Set(D_OPTIONS=HhtrII)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:53] NoOp(“PJSIP/233-0000002c”, “”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:54] ExecIf(“PJSIP/233-0000002c”, “0?Set(D_OPTIONS=HhTtrIg)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:55] Dial(“PJSIP/233-0000002c”, “PJSIP/234/sip:[email protected]:49262;rinstance=812c27609c7cbfae,HhTtrIb(func-apply-sipheaders^s^1)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] app_stack.c: PJSIP/234-0000002d Internal Gosub(func-apply-sipheaders,s,1) start
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:1] ExecIf(“PJSIP/234-0000002d”, “0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:2] NoOp(“PJSIP/234-0000002d”, “Applying SIP Headers to channel”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:3] Set(“PJSIP/234-0000002d”, “SIPHEADERKEYS=”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:4] ExecIf(“PJSIP/234-0000002d”, “0?Set(Rheader=1)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:5] While(“PJSIP/234-0000002d”, “0”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] app_while.c: Jumping to priority 9
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:10] ExecIf(“PJSIP/234-0000002d”, “0?SIPRemoveHeader(Alert-Info:)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:11] ExecIf(“PJSIP/234-0000002d”, “0?Set(PJSIP_HEADER(remove,Alert-Info)=)”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] pbx.c: Executing [[email protected]:12] Return(“PJSIP/234-0000002d”, “”) in new stack
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] app_stack.c: Spawn extension (from-internal, 234, 1) exited non-zero on ‘PJSIP/234-0000002d’
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] app_stack.c: PJSIP/234-0000002d Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] app_dial.c: Called PJSIP/234/sip:[email protected]:49262;rinstance=812c27609c7cbfae
[2018-09-17 12:58:27] VERBOSE[52754] netsock2.c: Using SIP RTP Audio TOS bits 184
[2018-09-17 12:58:27] VERBOSE[52754] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
[2018-09-17 12:58:27] VERBOSE[52754] netsock2.c: Using SIP RTP Audio CoS mark 5
[2018-09-17 12:58:27] VERBOSE[56727][C-00000019] app_dial.c: Connected line update to PJSIP/233-0000002c prevented.
[2018-09-17 12:58:28] VERBOSE[56727][C-00000019] app_dial.c: PJSIP/234-0000002d is ringing
[2018-09-17 12:58:28] VERBOSE[56727][C-00000019] app_dial.c: PJSIP/234-0000002d is ringing
[2018-09-17 12:58:31] VERBOSE[56727][C-00000019] app_dial.c: PJSIP/234-0000002d answered PJSIP/233-0000002c
[2018-09-17 12:58:31] VERBOSE[56751][C-00000019] bridge_channel.c: Channel PJSIP/234-0000002d joined ‘simple_bridge’ basic-bridge <38c2c912-90f2-4cb9-be0d-a91f5b8f99b9>
[2018-09-17 12:58:31] VERBOSE[56727][C-00000019] bridge_channel.c: Channel PJSIP/233-0000002c joined ‘simple_bridge’ basic-bridge <38c2c912-90f2-4cb9-be0d-a91f5b8f99b9>

Yes, the phones and server are all of the local LAN. Initially I just had ulaw enabled in FreePBX and on the X-Lite installations. I then tried enabling all codecs in X-Lite and the corresponding codecs in FreePBX, but still no luck.

Please let me know whatever other info I can provide to help out.

If they are all local to the same network, you should not be having one-way sound issues, at least not related to NAT.
What is the output of command core show channels while the call is in progress?

Here is the output of that command during a local to local call:

Channel Location State Application(Data)
PJSIP/233-00000032 [email protected]:55 Up Dial(PJSIP/234/sip:[email protected]
PJSIP/234-00000033 (None) Up AppDial((Outgoing Line))
2 active channels
1 active call
29 calls processed

I seem to have got it working… looks like it was a mix of incorrect firewall settings within the FreePBX firewall.

One thing I still don’t understand though - I tried to connect an X-Lite softphone to the server and the extension kept not registering. The firewall had 10.42.10.0/24 added to the trusted zone and the workstation had the IP of 10.42.10.59, so it should have matched and been allowed through the firewall, correct?

In actuality, I had to manually add 10.42.10.59/32 to the firewall as trusted and then X-Lite finally registered. Is there a known bug with the firewall and CIDR?

This topic was automatically closed 365 days after the last reply. New replies are no longer allowed.