Inbound Calls Drop After 10 Seconds: Retransmission Error

luongjames · April 11, 2017, 3:34am

Just tried to add the match_auth_username bit into the SIP options.

That doesn’t seem to help with the call drops. And doesn’t seem to fix the issue where the second trunk is showing up as the first.

FWIW I also disabled one of the trunks to see whether it was affecting the call drops. Still the same problem.

astbox · April 11, 2017, 5:31pm

Post your sip trunks options.

luongjames · April 15, 2017, 2:54pm

Sorry it’s taken me so long to respond. I decided to tinker with it a bit some more. Since the only thing that I knew would work was to reinstall FreePBX, I did that to see what the logs would look like on a working installation.

Of course it works now again… But I’m not sure how long it will work since after awhile the previous instance did the same thing. Here are the logs. I don’t know that anything has changed. But, it’s working and I don’t have that strange private IP not responding.

[2017-04-15 19:48:48] VERBOSE[8839][C-00000000] netsock2.c: Using SIP RTP TOS bits 184
[2017-04-15 19:48:48] VERBOSE[8839][C-00000000] netsock2.c: Using SIP RTP CoS mark 5
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [800@from-trunk:1] GotoIf("SIP/pfingoHome-00000000", "1?ext-local,800,1:followme-check,800,1") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx_builtins.c: Goto (ext-local,800,1)
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [800@ext-local:1] Set("SIP/pfingoHome-00000000", "__RINGTIMER=15") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [800@ext-local:2] Macro("SIP/pfingoHome-00000000", "exten-vm,novm,800,0,0,0") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-exten-vm:1] Macro("SIP/pfingoHome-00000000", "user-callerid,") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-user-callerid:1] Set("SIP/pfingoHome-00000000", "TOUCH_MONITOR=1492267728.0") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-user-callerid:2] Set("SIP/pfingoHome-00000000", "AMPUSER=83860122") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-user-callerid:3] GotoIf("SIP/pfingoHome-00000000", "0?report") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-user-callerid:4] ExecIf("SIP/pfingoHome-00000000", "1?Set(REALCALLERIDNUM=83860122)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-user-callerid:5] Set("SIP/pfingoHome-00000000", "AMPUSER=") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-user-callerid:6] GotoIf("SIP/pfingoHome-00000000", "0?limit") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-user-callerid:7] Set("SIP/pfingoHome-00000000", "AMPUSERCIDNAME=") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("SIP/pfingoHome-00000000", "1?report") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx_builtins.c: Goto (macro-user-callerid,s,15)
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-user-callerid:15] GotoIf("SIP/pfingoHome-00000000", "0?continue") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-user-callerid:16] ExecIf("SIP/pfingoHome-00000000", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-user-callerid:17] Set("SIP/pfingoHome-00000000", "__TTL=64") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-user-callerid:18] GotoIf("SIP/pfingoHome-00000000", "1?continue") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx_builtins.c: Goto (macro-user-callerid,s,29)
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-user-callerid:29] Set("SIP/pfingoHome-00000000", "CALLERID(number)=83860122") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-user-callerid:30] Set("SIP/pfingoHome-00000000", "CALLERID(name)=83860122") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-user-callerid:31] GotoIf("SIP/pfingoHome-00000000", "0?cnum") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-user-callerid:32] Set("SIP/pfingoHome-00000000", "CDR(cnam)=83860122") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-user-callerid:33] Set("SIP/pfingoHome-00000000", "CDR(cnum)=83860122") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-user-callerid:34] Set("SIP/pfingoHome-00000000", "CHANNEL(language)=en") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-exten-vm:2] Set("SIP/pfingoHome-00000000", "RingGroupMethod=none") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-exten-vm:3] Set("SIP/pfingoHome-00000000", "__EXTTOCALL=800") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-exten-vm:4] Set("SIP/pfingoHome-00000000", "__PICKUPMARK=800") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-exten-vm:5] Set("SIP/pfingoHome-00000000", "RT=") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-exten-vm:6] ExecIf("SIP/pfingoHome-00000000", "0?Macro(vm,novm,DIRECTDIAL,)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-exten-vm:7] ExecIf("SIP/pfingoHome-00000000", "0?MacroExit()") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-exten-vm:8] Gosub("SIP/pfingoHome-00000000", "sub-record-check,s,1(exten,800,dontcare)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/pfingoHome-00000000", "0?initialized") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@sub-record-check:2] Set("SIP/pfingoHome-00000000", "__REC_STATUS=INITIALIZED") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@sub-record-check:3] Set("SIP/pfingoHome-00000000", "NOW=1492267728") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@sub-record-check:4] Set("SIP/pfingoHome-00000000", "__DAY=15") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@sub-record-check:5] Set("SIP/pfingoHome-00000000", "__MONTH=04") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@sub-record-check:6] Set("SIP/pfingoHome-00000000", "__YEAR=2017") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@sub-record-check:7] Set("SIP/pfingoHome-00000000", "__TIMESTR=20170415-194848") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@sub-record-check:8] Set("SIP/pfingoHome-00000000", "__FROMEXTEN=83860122") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@sub-record-check:9] Set("SIP/pfingoHome-00000000", "__MON_FMT=wav") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/pfingoHome-00000000", "Recordings initialized") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/pfingoHome-00000000", "0?Set(ARG3=dontcare)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@sub-record-check:12] Set("SIP/pfingoHome-00000000", "REC_POLICY_MODE_SAVE=") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/pfingoHome-00000000", "0?Set(REC_STATUS=NO)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/pfingoHome-00000000", "5?checkaction") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx_builtins.c: Goto (sub-record-check,s,17)
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/pfingoHome-00000000", "1?sub-record-check,exten,1") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx_builtins.c: Goto (sub-record-check,exten,1)
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [exten@sub-record-check:1] NoOp("SIP/pfingoHome-00000000", "Exten Recording Check between 83860122 and 800") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [exten@sub-record-check:2] Set("SIP/pfingoHome-00000000", "CALLTYPE=internal") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [exten@sub-record-check:3] ExecIf("SIP/pfingoHome-00000000", "0?Set(CALLTYPE=)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [exten@sub-record-check:4] Set("SIP/pfingoHome-00000000", "CALLEE=dontcare") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [exten@sub-record-check:5] ExecIf("SIP/pfingoHome-00000000", "0?Set(CALLEE=dontcare)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [exten@sub-record-check:6] GotoIf("SIP/pfingoHome-00000000", "0?callee") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [exten@sub-record-check:7] GotoIf("SIP/pfingoHome-00000000", "1?caller") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx_builtins.c: Goto (sub-record-check,exten,13)
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [exten@sub-record-check:13] Set("SIP/pfingoHome-00000000", "RECMODE=") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [exten@sub-record-check:14] ExecIf("SIP/pfingoHome-00000000", "1?Set(RECMODE=dontcare)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [exten@sub-record-check:15] ExecIf("SIP/pfingoHome-00000000", "1?Set(RECMODE=dontcare)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [exten@sub-record-check:16] Gosub("SIP/pfingoHome-00000000", "recordcheck,1(dontcare,internal,800)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/pfingoHome-00000000", "Starting recording check against dontcare") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/pfingoHome-00000000", "dontcare") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/pfingoHome-00000000", "") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [exten@sub-record-check:17] Return("SIP/pfingoHome-00000000", "") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-exten-vm:9] GotoIf("SIP/pfingoHome-00000000", "1?macrodial") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx_builtins.c: Goto (macro-exten-vm,s,15)
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-exten-vm:15] GosubIf("SIP/pfingoHome-00000000", "0?clrheader,1()") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-exten-vm:16] Macro("SIP/pfingoHome-00000000", "dial-one,,Ttr,800") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:1] Set("SIP/pfingoHome-00000000", "DEXTEN=800") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:2] ExecIf("SIP/pfingoHome-00000000", "0?Set(EXTTOCALL=800)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:3] Set("SIP/pfingoHome-00000000", "DIALSTATUS_CW=") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:4] GosubIf("SIP/pfingoHome-00000000", "0?screen,1()") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:5] GosubIf("SIP/pfingoHome-00000000", "0?cf,1()") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:6] GotoIf("SIP/pfingoHome-00000000", "1?skip1") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx_builtins.c: Goto (macro-dial-one,s,9)
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:9] GotoIf("SIP/pfingoHome-00000000", "0?nodial") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:10] GotoIf("SIP/pfingoHome-00000000", "0?continue") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:11] Set("SIP/pfingoHome-00000000", "EXTHASCW=ENABLED") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:12] GotoIf("SIP/pfingoHome-00000000", "0?next1:cwinusebusy") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx_builtins.c: Goto (macro-dial-one,s,24)
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:24] GotoIf("SIP/pfingoHome-00000000", "0?next3:continue") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx_builtins.c: Goto (macro-dial-one,s,26)
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:26] GotoIf("SIP/pfingoHome-00000000", "0?nodial") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:27] GosubIf("SIP/pfingoHome-00000000", "1?dstring,1():dlocal,1()") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [dstring@macro-dial-one:1] Set("SIP/pfingoHome-00000000", "DSTRING=") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [dstring@macro-dial-one:2] Set("SIP/pfingoHome-00000000", "DEVICES=800") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [dstring@macro-dial-one:3] ExecIf("SIP/pfingoHome-00000000", "0?Return()") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [dstring@macro-dial-one:4] ExecIf("SIP/pfingoHome-00000000", "0?Set(DEVICES=00)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [dstring@macro-dial-one:5] Set("SIP/pfingoHome-00000000", "LOOPCNT=1") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [dstring@macro-dial-one:6] Set("SIP/pfingoHome-00000000", "ITER=1") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [dstring@macro-dial-one:7] Set("SIP/pfingoHome-00000000", "THISDIAL=SIP/800") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [dstring@macro-dial-one:8] GosubIf("SIP/pfingoHome-00000000", "1?zap2dahdi,1()") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [zap2dahdi@macro-dial-one:1] ExecIf("SIP/pfingoHome-00000000", "0?Return()") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [zap2dahdi@macro-dial-one:2] Set("SIP/pfingoHome-00000000", "NEWDIAL=") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [zap2dahdi@macro-dial-one:3] Set("SIP/pfingoHome-00000000", "LOOPCNT2=1") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [zap2dahdi@macro-dial-one:4] Set("SIP/pfingoHome-00000000", "ITER2=1") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [zap2dahdi@macro-dial-one:5] Set("SIP/pfingoHome-00000000", "THISPART2=SIP/800") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [zap2dahdi@macro-dial-one:6] ExecIf("SIP/pfingoHome-00000000", "0?Set(THISPART2=DAHDI/800)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [zap2dahdi@macro-dial-one:7] Set("SIP/pfingoHome-00000000", "NEWDIAL=SIP/800&") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [zap2dahdi@macro-dial-one:8] Set("SIP/pfingoHome-00000000", "ITER2=2") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [zap2dahdi@macro-dial-one:9] GotoIf("SIP/pfingoHome-00000000", "0?begin2") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [zap2dahdi@macro-dial-one:10] Set("SIP/pfingoHome-00000000", "THISDIAL=SIP/800") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [zap2dahdi@macro-dial-one:11] Return("SIP/pfingoHome-00000000", "") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [dstring@macro-dial-one:9] GotoIf("SIP/pfingoHome-00000000", "1?docheck") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx_builtins.c: Goto (macro-dial-one,dstring,14)
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [dstring@macro-dial-one:14] GotoIf("SIP/pfingoHome-00000000", "0?skipset") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [dstring@macro-dial-one:15] Set("SIP/pfingoHome-00000000", "DSTRING=SIP/800&") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [dstring@macro-dial-one:16] Set("SIP/pfingoHome-00000000", "ITER=2") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [dstring@macro-dial-one:17] GotoIf("SIP/pfingoHome-00000000", "0?begin") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [dstring@macro-dial-one:18] ExecIf("SIP/pfingoHome-00000000", "0?Return()") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [dstring@macro-dial-one:19] Set("SIP/pfingoHome-00000000", "DSTRING=SIP/800") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [dstring@macro-dial-one:20] Return("SIP/pfingoHome-00000000", "") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:28] GotoIf("SIP/pfingoHome-00000000", "0?nodial") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:29] GotoIf("SIP/pfingoHome-00000000", "0?skiptrace") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:30] GosubIf("SIP/pfingoHome-00000000", "1?ctset,1():ctclear,1()") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [ctset@macro-dial-one:1] Set("SIP/pfingoHome-00000000", "DB(CALLTRACE/800)=83860122") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [ctset@macro-dial-one:2] Return("SIP/pfingoHome-00000000", "") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:31] Set("SIP/pfingoHome-00000000", "D_OPTIONS=Ttr") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:32] NoOp("SIP/pfingoHome-00000000", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:33] ExecIf("SIP/pfingoHome-00000000", "0?Set(ALERT_INFO=)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:34] ExecIf("SIP/pfingoHome-00000000", "0?Set(ALERT_INFO=)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:35] ExecIf("SIP/pfingoHome-00000000", "0?Set(ALERT_INFO=)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:36] ExecIf("SIP/pfingoHome-00000000", "0?Set(ALERT_INFO=;volume=)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:37] ExecIf("SIP/pfingoHome-00000000", "0?Set(ALERT_INFO=;volume=)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:38] GosubIf("SIP/pfingoHome-00000000", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:39] ExecIf("SIP/pfingoHome-00000000", "0?Set(CHANNEL(musicclass)=)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:40] GosubIf("SIP/pfingoHome-00000000", "0?qwait,1()") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:41] Set("SIP/pfingoHome-00000000", "__CWIGNORE=") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:42] Set("SIP/pfingoHome-00000000", "__KEEPCID=TRUE") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:43] GotoIf("SIP/pfingoHome-00000000", "0?usegoto,1") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:44] GotoIf("SIP/pfingoHome-00000000", "1?godial") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx_builtins.c: Goto (macro-dial-one,s,49)
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:49] Macro("SIP/pfingoHome-00000000", "dialout-one-predial-hook,") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dialout-one-predial-hook:1] MacroExit("SIP/pfingoHome-00000000", "") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:50] ExecIf("SIP/pfingoHome-00000000", "0?Set(D_OPTIONS=trI)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-dial-one:51] Dial("SIP/pfingoHome-00000000", "SIP/800,,Ttrb(func-apply-sipheaders^s^1)") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] netsock2.c: Using SIP RTP TOS bits 184
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] netsock2.c: Using SIP RTP CoS mark 5
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] app_stack.c: SIP/800-00000001 Internal Gosub(func-apply-sipheaders,s,1) start
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@func-apply-sipheaders:1] NoOp("SIP/800-00000001", "Applying SIP Headers to channel") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@func-apply-sipheaders:2] Set("SIP/800-00000001", "SIPHEADERKEYS=") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@func-apply-sipheaders:3] While("SIP/800-00000001", "0") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] app_while.c: Jumping to priority 7
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] pbx.c: Executing [s@func-apply-sipheaders:8] Return("SIP/800-00000001", "") in new stack
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] app_stack.c: Spawn extension (from-internal, 800, 1) exited non-zero on 'SIP/800-00000001'
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] app_stack.c: SIP/800-00000001 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] app_dial.c: Called SIP/800
[2017-04-15 19:48:48] VERBOSE[2650][C-00000000] app_dial.c: SIP/800-00000001 is ringing
[2017-04-15 19:48:52] VERBOSE[2650][C-00000000] app_dial.c: SIP/800-00000001 answered SIP/pfingoHome-00000000
[2017-04-15 19:48:52] VERBOSE[2653][C-00000000] bridge_channel.c: Channel SIP/800-00000001 joined 'simple_bridge' basic-bridge <eb9eed0a-52b6-4a43-a554-ca28ee224b50>
[2017-04-15 19:48:52] VERBOSE[2650][C-00000000] bridge_channel.c: Channel SIP/pfingoHome-00000000 joined 'simple_bridge' basic-bridge <eb9eed0a-52b6-4a43-a554-ca28ee224b50>
[2017-04-15 19:49:13] VERBOSE[2650][C-00000000] bridge_channel.c: Channel SIP/pfingoHome-00000000 left 'simple_bridge' basic-bridge <eb9eed0a-52b6-4a43-a554-ca28ee224b50>
[2017-04-15 19:49:13] VERBOSE[2653][C-00000000] bridge_channel.c: Channel SIP/800-00000001 left 'simple_bridge' basic-bridge <eb9eed0a-52b6-4a43-a554-ca28ee224b50>
[2017-04-15 19:49:13] VERBOSE[2650][C-00000000] app_macro.c: Spawn extension (macro-dial-one, s, 51) exited non-zero on 'SIP/pfingoHome-00000000' in macro 'dial-one'
[2017-04-15 19:49:13] VERBOSE[2650][C-00000000] app_macro.c: Spawn extension (macro-exten-vm, s, 16) exited non-zero on 'SIP/pfingoHome-00000000' in macro 'exten-vm'
[2017-04-15 19:49:13] VERBOSE[2650][C-00000000] pbx.c: Spawn extension (ext-local, 800, 2) exited non-zero on 'SIP/pfingoHome-00000000'
[2017-04-15 19:49:13] VERBOSE[2650][C-00000000] pbx.c: Executing [h@ext-local:1] Macro("SIP/pfingoHome-00000000", "hangupcall,") in new stack
[2017-04-15 19:49:13] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("SIP/pfingoHome-00000000", "1?theend") in new stack
[2017-04-15 19:49:13] VERBOSE[2650][C-00000000] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2017-04-15 19:49:13] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("SIP/pfingoHome-00000000", "0?Set(CDR(recordingfile)=)") in new stack
[2017-04-15 19:49:13] VERBOSE[2650][C-00000000] pbx.c: Executing [s@macro-hangupcall:4] Hangup("SIP/pfingoHome-00000000", "") in new stack
[2017-04-15 19:49:13] VERBOSE[2650][C-00000000] app_macro.c: Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'SIP/pfingoHome-00000000' in macro 'hangupcall'
[2017-04-15 19:49:13] VERBOSE[2650][C-00000000] pbx.c: Spawn extension (ext-local, h, 1) exited non-zero on 'SIP/pfingoHome-00000000'

luongjames · April 15, 2017, 2:57pm

When you say my sip trunk options are you referring to the following?

PEER DETAILS:
type=friend
host=sip.pfingo.com
fromdomain=sip.pfingo.com
username=userid
fromuser=userid
secret=password
insecure=port,invite
nat=yes
qualify=yes
dtmfmode=auto
disallow=all
allow=ulaw
context=from-trunk

Register String:
[email protected]:password:[email protected]:5060/the_extension_number_that_need_to ring