Calls dropping at 31 seconds

Hi all. I’m having the dreaded 30 second call drop issue that everyone says is either a misconfiguration on my part or a router/NAT issue. I’ve been through all of the troubleshooting ideas I’ve come across in multiple forums on the subject to no avail. Tens of hours later, I’m stuck.

I’m using Free PBX distro, PBX Firmware 10.13.66-11 with all of the default ports. My router has the server in its virtual DMZ. I’ve tried NAT SIP passthrough as enabled and enabled+assisted in Merlin-flavored AsusWRT. Can someone please take a look and hopefully send me in the right direction?

Asterisk Log
[2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [1212425----@from-internal:1] Macro("PJSIP/0905-0000006c", "user-callerid,LIMIT") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/0905-0000006c", "TOUCH_MONITOR=1465347804.120") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/0905-0000006c", "AMPUSER=0905") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:3] GotoIf("PJSIP/0905-0000006c", "0?report") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:4] ExecIf("PJSIP/0905-0000006c", "1?Set(REALCALLERIDNUM=0905)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/0905-0000006c", "AMPUSER=0905") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:6] GotoIf("PJSIP/0905-0000006c", "0?limit") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:7] Set("PJSIP/0905-0000006c", "AMPUSERCIDNAME=9E") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("PJSIP/0905-0000006c", "0?report") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:9] Set("PJSIP/0905-0000006c", "AMPUSERCID=0905") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/0905-0000006c", "__DIAL_OPTIONS=Ttr") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:11] Set("PJSIP/0905-0000006c", "CALLERID(all)="9E" <0905>") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:12] GotoIf("PJSIP/0905-0000006c", "0?limit") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("PJSIP/0905-0000006c", "1?Set(GROUP(concurrency_limit)=0905)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:14] ExecIf("PJSIP/0905-0000006c", "0?Set(CHANNEL(language)=)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:15] GotoIf("PJSIP/0905-0000006c", "1?continue") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Goto (macro-user-callerid,s,29) [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:29] Set("PJSIP/0905-0000006c", "CALLERID(number)=0905") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:30] Set("PJSIP/0905-0000006c", "CALLERID(name)=9E") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:31] Set("PJSIP/0905-0000006c", "CDR(cnum)=0905") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:32] Set("PJSIP/0905-0000006c", "CDR(cnam)=9E") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-user-callerid:33] Set("PJSIP/0905-0000006c", "CHANNEL(language)=en") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [1212425----@from-internal:2] Set("PJSIP/0905-0000006c", "ROUTEUSER=0905") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [1212425----@from-internal:3] GotoIf("PJSIP/0905-0000006c", "1?notblind") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Goto (from-internal,1212425----,6) [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [1212425----@from-internal:6] GotoIf("PJSIP/0905-0000006c", "1?restrictedroute-b0d649c6c324952c5c8ca0196139a4f3,1212425----,2:outbound-allroutes,1212425----,2") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Goto (restrictedroute-b0d649c6c324952c5c8ca0196139a4f3,1212425----,2) [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [1212425----@restrictedroute-b0d649c6c324952c5c8ca0196139a4f3:2] Gosub("PJSIP/0905-0000006c", "sub-record-check,s,1(out,1212425----,dontcare)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/0905-0000006c", "0?initialized") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/0905-0000006c", "__REC_STATUS=INITIALIZED") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/0905-0000006c", "NOW=1465347804") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/0905-0000006c", "__DAY=07") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/0905-0000006c", "__MONTH=06") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/0905-0000006c", "__YEAR=2016") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/0905-0000006c", "__TIMESTR=20160607-210324") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/0905-0000006c", "__FROMEXTEN=0905") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/0905-0000006c", "__MON_FMT=wav") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/0905-0000006c", "Recordings initialized") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/0905-0000006c", "0?Set(ARG3=dontcare)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/0905-0000006c", "REC_POLICY_MODE_SAVE=") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/0905-0000006c", "0?Set(REC_STATUS=NO)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/0905-0000006c", "3?checkaction") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Goto (sub-record-check,s,17) [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/0905-0000006c", "1?sub-record-check,out,1") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Goto (sub-record-check,out,1) [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [out@sub-record-check:1] NoOp("PJSIP/0905-0000006c", "Outbound Recording Check from 0905 to 1212425----") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [out@sub-record-check:2] Set("PJSIP/0905-0000006c", "RECMODE=dontcare") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [out@sub-record-check:3] ExecIf("PJSIP/0905-0000006c", "1?Goto(routewins)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Goto (sub-record-check,out,7) [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [out@sub-record-check:7] Gosub("PJSIP/0905-0000006c", "recordcheck,1(dontcare,out,1212425----)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/0905-0000006c", "Starting recording check against dontcare") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/0905-0000006c", "dontcare") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Goto (sub-record-check,recordcheck,3) [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/0905-0000006c", "") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [out@sub-record-check:8] Return("PJSIP/0905-0000006c", "") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [1212425----@restrictedroute-b0d649c6c324952c5c8ca0196139a4f3:3] ExecIf("PJSIP/0905-0000006c", "0 ?Set(CDR(accountcode)=)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [1212425----@restrictedroute-b0d649c6c324952c5c8ca0196139a4f3:4] Set("PJSIP/0905-0000006c", "MOHCLASS=none") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [1212425----@restrictedroute-b0d649c6c324952c5c8ca0196139a4f3:5] Set("PJSIP/0905-0000006c", "_NODEST=") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [1212425----@restrictedroute-b0d649c6c324952c5c8ca0196139a4f3:6] Macro("PJSIP/0905-0000006c", "dialout-trunk,1,212425----,,off") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:1] Set("PJSIP/0905-0000006c", "DIAL_TRUNK=1") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:2] GosubIf("PJSIP/0905-0000006c", "0?sub-pincheck,s,1()") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:3] GotoIf("PJSIP/0905-0000006c", "0?disabletrunk,1") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:4] Set("PJSIP/0905-0000006c", "DIAL_NUMBER=212425----") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:5] Set("PJSIP/0905-0000006c", "DIAL_TRUNK_OPTIONS=Ttr") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:6] Set("PJSIP/0905-0000006c", "OUTBOUND_GROUP=OUT_1") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:7] GotoIf("PJSIP/0905-0000006c", "1?nomax") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Goto (macro-dialout-trunk,s,9) [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:9] GotoIf("PJSIP/0905-0000006c", "0?skipoutcid") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:10] Set("PJSIP/0905-0000006c", "DIAL_TRUNK_OPTIONS=Tt") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:11] Macro("PJSIP/0905-0000006c", "outbound-callerid,1") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-outbound-callerid:1] ExecIf("PJSIP/0905-0000006c", "0?Set(CALLERPRES(name-pres)=)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-outbound-callerid:2] ExecIf("PJSIP/0905-0000006c", "0?Set(CALLERPRES(num-pres)=)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-outbound-callerid:3] ExecIf("PJSIP/0905-0000006c", "0?Set(REALCALLERIDNUM=0905)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-outbound-callerid:4] GotoIf("PJSIP/0905-0000006c", "1?normcid") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Goto (macro-outbound-callerid,s,7) [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-outbound-callerid:7] Set("PJSIP/0905-0000006c", "USEROUTCID="Eric Einstein" <212425---->") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-outbound-callerid:8] Set("PJSIP/0905-0000006c", "EMERGENCYCID=") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-outbound-callerid:9] Set("PJSIP/0905-0000006c", "TRUNKOUTCID=") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-outbound-callerid:10] GotoIf("PJSIP/0905-0000006c", "1?trunkcid") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Goto (macro-outbound-callerid,s,15) [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-outbound-callerid:15] ExecIf("PJSIP/0905-0000006c", "0?Set(CALLERID(all)=)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-outbound-callerid:16] ExecIf("PJSIP/0905-0000006c", "1?Set(CALLERID(all)="Eric Einstein" <212425---->)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-outbound-callerid:17] ExecIf("PJSIP/0905-0000006c", "0?Set(CALLERID(all)=)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-outbound-callerid:18] ExecIf("PJSIP/0905-0000006c", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-outbound-callerid:19] ExecIf("PJSIP/0905-0000006c", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-outbound-callerid:20] Set("PJSIP/0905-0000006c", "CDR(outbound_cnum)=212425----") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-outbound-callerid:21] Set("PJSIP/0905-0000006c", "CDR(outbound_cnam)=Eric Einstein") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:12] GosubIf("PJSIP/0905-0000006c", "1?sub-flp-1,s,1()") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-flp-1:1] ExecIf("PJSIP/0905-0000006c", "1?Set(TARGET_FLP_1=1212425----)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-flp-1:2] GotoIf("PJSIP/0905-0000006c", "1?match") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Goto (sub-flp-1,s,4) [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-flp-1:4] Set("PJSIP/0905-0000006c", "DIAL_NUMBER=1212425----") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@sub-flp-1:5] Return("PJSIP/0905-0000006c", "") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:13] Set("PJSIP/0905-0000006c", "OUTNUM=1212425----") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:14] Set("PJSIP/0905-0000006c", "custom=PJSIP") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:15] ExecIf("PJSIP/0905-0000006c", "1?Set(DIAL_TRUNK_OPTIONS=M(setmusic^none)Tt)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:16] ExecIf("PJSIP/0905-0000006c", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^none)TtM(confirm))") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:17] Macro("PJSIP/0905-0000006c", "dialout-trunk-predial-hook,") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("PJSIP/0905-0000006c", "") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:18] GotoIf("PJSIP/0905-0000006c", "0?bypass,1") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:19] ExecIf("PJSIP/0905-0000006c", "1?Set(CONNECTEDLINE(num,i)=1212425----)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:20] ExecIf("PJSIP/0905-0000006c", "1?Set(CONNECTEDLINE(name,i)=CID:212425----)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:21] ExecIf("PJSIP/0905-0000006c", "0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)212425----)") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:22] GotoIf("PJSIP/0905-0000006c", "0?customtrunk") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-dialout-trunk:23] Dial("PJSIP/0905-0000006c", "PJSIP/1212425----@VitelityOut,300,M(setmusic^none)Tt") in new stack [2016-06-07 21:03:24] VERBOSE[25914][C-00000037] app_dial.c: Called PJSIP/1212425----@VitelityOut [2016-06-07 21:03:26] VERBOSE[25914][C-00000037] app_dial.c: PJSIP/VitelityOut-0000006d is making progress passing it to PJSIP/0905-0000006c [2016-06-07 21:03:31] VERBOSE[25914][C-00000037] app_dial.c: PJSIP/VitelityOut-0000006d requested media update control 26, passing it to PJSIP/0905-0000006c [2016-06-07 21:03:31] VERBOSE[25914][C-00000037] app_dial.c: PJSIP/VitelityOut-0000006d answered PJSIP/0905-0000006c [2016-06-07 21:03:31] VERBOSE[25914][C-00000037] pbx.c: Executing [s@macro-setmusic:1] Set("PJSIP/VitelityOut-0000006d", "CHANNEL(musicclass)=none") in new stack [2016-06-07 21:03:31] VERBOSE[25915][C-00000037] bridge_channel.c: Channel PJSIP/VitelityOut-0000006d joined 'simple_bridge' basic-bridge <fcf7f596-a25a-471d-a96e-a25a5564d0e9> [2016-06-07 21:03:31] VERBOSE[25914][C-00000037] bridge_channel.c: Channel PJSIP/0905-0000006c joined 'simple_bridge' basic-bridge <fcf7f596-a25a-471d-a96e-a25a5564d0e9> [2016-06-07 21:04:03] VERBOSE[25914][C-00000037] bridge_channel.c: Channel PJSIP/0905-0000006c left 'simple_bridge' basic-bridge <fcf7f596-a25a-471d-a96e-a25a5564d0e9> [2016-06-07 21:04:03] VERBOSE[25915][C-00000037] bridge_channel.c: Channel PJSIP/VitelityOut-0000006d left 'simple_bridge' basic-bridge <fcf7f596-a25a-471d-a96e-a25a5564d0e9> [2016-06-07 21:04:03] VERBOSE[25914][C-00000037] app_macro.c: Spawn extension (macro-dialout-trunk, s, 23) exited non-zero on 'PJSIP/0905-0000006c' in macro 'dialout-trunk' [2016-06-07 21:04:03] VERBOSE[25914][C-00000037] pbx.c: Spawn extension (restrictedroute-b0d649c6c324952c5c8ca0196139a4f3, 1212425----, 6) exited non-zero on 'PJSIP/0905-0000006c' [2016-06-07 21:04:03] VERBOSE[25914][C-00000037] pbx.c: Executing [h@restrictedroute-b0d649c6c324952c5c8ca0196139a4f3:1] Hangup("PJSIP/0905-0000006c", "") in new stack [2016-06-07 21:04:03] VERBOSE[25914][C-00000037] pbx.c: Spawn extension (restrictedroute-b0d649c6c324952c5c8ca0196139a4f3, h, 1) exited non-zero on 'PJSIP/0905-0000006c'

SIP Call Flow

sip_general_additional.conf
accept_outofcall_message=yes auth_message_requests=no outofcall_message_context=dpma_message_context faxdetect=no vmexten=*97 context=from-sip-external callerid=Unknown notifyringing=yes notifyhold=yes tos_sip=cs3 tos_audio=ef tos_video=af41 alwaysauthreject=yes useragent=FPBX-13.0.124(13.7.1) disallow=all allow=ulaw allow=alaw allow=gsm allow=g726 rtpend=20000 rtpstart=10000 callevents=yes bindport=5061 jbenable=no allowguest=yes tlsbindaddr=[::]:5061 tlsclientmethod=sslv2 tlsenable=no srvlookup=no defaultexpiry=120 minexpiry=60 g726nonstandard=no videosupport=no maxcallbitrate=384 canreinvite=no rtptimeout=30 rtpholdtimeout=300 rtpkeepalive=0 maxexpiry=3600 registerattempts=0 registertimeout=20 notifyhold=yes notifyringing=yes checkmwi=10 nat=force_rport,comedia externhost=internationaltailoring.us.to externrefresh=120 ALLOW_SIP_ANON=no localnet=192.168.0.0/16 language=en

Vitelity is telling you that it’s changed its IP address. You’ll need to do a pjsip set logger on and then paste the traffic from vitelity to see what’s going on.

1 Like

Hi Eric:

I had this issue often late last year with a particular SIP trunk provider at several client sites. UDP Session Timeout settings in the router was the culprit. Default was 9 seconds. After increasing it to 180 seconds most sites started working correctly. I was also getting lots of randomly dropped calls until making the above change.

1 Like

This is almost always the problem in these situations, by the way.,

Had The Same Problem
Go to (Setting>Asterisk Sip Setting) check your “Local Networks” I leave this blank, It interfere with my trunks Go to (> Chan PJSip Settings) on the bottom you’ll fined "External IP Address " and “Local network” set your nat setting here. Work for me

Well after much playing around with the router, I finally got it. For anyone with a dynamic IP address and this router, here goes:

FreePBX FreePBX 13.0.131
Asterisk SIP Settings-General SIP Settings leave external network blank since this may change.
Confusingly the NAT settings aren’t on this page but on the Asterisk SIP Settings-Chan SIP Settings page. There, choose NAT “yes”, “Dynamic IP”, and Dynamic Host to your domain name.

Asus RT-AC68U 380.59 Merlin
WAN-NAT Passthrough
SIP Passthrough “Enabled” but not “Enabled + NAT helper”.

The other thing that needs to happen is power cycling and not just rebooting the machines. I think that was why my adjustments weren’t originally taking hold, though through this many iterations and attempts, I’m not 100% sure.

Thanks all for the input and help with this. Hopefully this thread will help someone else in turn.