Hi,
My current FreePBX installation has been working fine for over a year now until today.
I can receive incoming external calls but I cannot make outgoing external calls.
Trunk settings:
username=***
type=peer
secret=***
qualify=no
port=5260
nat=yes
insecure=very
host=***
fromuser=***
fromdomain=***
dtmfmode=rfc2833
allow=all
Failed call log:
> == Setting global variable 'SIPDOMAIN' to '192.168.10.2' > -- Executing [[email protected]:1] Macro("PJSIP/01-00000043", "user-callerid,LIMIT,EXTERNAL,") in new stack > -- Executing [[email protected]:1] Set("PJSIP/01-00000043", "TOUCH_MONITOR=1558526866.114") in new stack > -- Executing [[email protected]:2] Set("PJSIP/01-00000043", "AMPUSER=01") in new stack > -- Executing [[email protected]:3] GotoIf("PJSIP/01-00000043", "0?report") in new stack > -- Executing [[email protected]:4] ExecIf("PJSIP/01-00000043", "1?Set(REALCALLERIDNUM=01)") in new stack > -- Executing [[email protected]:5] Set("PJSIP/01-00000043", "AMPUSER=01") in new stack > -- Executing [[email protected]:6] GotoIf("PJSIP/01-00000043", "0?limit") in new stack > -- Executing [[email protected]:7] Set("PJSIP/01-00000043", "AMPUSERCIDNAME=Sekretariat") in new stack > -- Executing [[email protected]:8] GotoIf("PJSIP/01-00000043", "0?report") in new stack > -- Executing [[email protected]:9] Set("PJSIP/01-00000043", "AMPUSERCID=01") in new stack > -- Executing [[email protected]:10] Set("PJSIP/01-00000043", "__DIAL_OPTIONS=Ttr") in new stack > -- Executing [[email protected]:11] Set("PJSIP/01-00000043", "CALLERID(all)="Sekretariat" <01>") in new stack > -- Executing [[email protected]:12] GotoIf("PJSIP/01-00000043", "0?limit") in new stack > -- Executing [[email protected]:13] ExecIf("PJSIP/01-00000043", "1?Set(GROUP(concurrency_limit)=01)") in new stack > -- Executing [[email protected]:14] ExecIf("PJSIP/01-00000043", "0?Set(CHANNEL(language)=)") in new stack > -- Executing [[email protected]:15] GotoIf("PJSIP/01-00000043", "1?continue") in new stack > -- Goto (macro-user-callerid,s,29) > -- Executing [[email protected]:29] Set("PJSIP/01-00000043", "CALLERID(number)=01") in new stack > -- Executing [[email protected]:30] Set("PJSIP/01-00000043", "CALLERID(name)=Sekretariat") in new stack > -- Executing [[email protected]:31] GotoIf("PJSIP/01-00000043", "0?cnum") in new stack > -- Executing [[email protected]:32] Set("PJSIP/01-00000043", "CDR(cnam)=Sekretariat") in new stack > -- Executing [[email protected]:33] Set("PJSIP/01-00000043", "CDR(cnum)=01") in new stack > -- Executing [[email protected]:34] Set("PJSIP/01-00000043", "CHANNEL(language)=pl") in new stack > -- Executing [[email protected]:2] Gosub("PJSIP/01-00000043", "sub-record-check,s,1(out,791279486,dontcare)") in new stack > -- Executing [[email protected]:1] GotoIf("PJSIP/01-00000043", "0?initialized") in new stack > -- Executing [[email protected]:2] Set("PJSIP/01-00000043", "__REC_STATUS=INITIALIZED") in new stack > -- Executing [[email protected]:3] Set("PJSIP/01-00000043", "NOW=1558526866") in new stack > -- Executing [[email protected]:4] Set("PJSIP/01-00000043", "__DAY=22") in new stack > -- Executing [[email protected]:5] Set("PJSIP/01-00000043", "__MONTH=05") in new stack > -- Executing [[email protected]:6] Set("PJSIP/01-00000043", "__YEAR=2019") in new stack > -- Executing [[email protected]:7] Set("PJSIP/01-00000043", "__TIMESTR=20190522-140746") in new stack > -- Executing [[email protected]:8] Set("PJSIP/01-00000043", "__FROMEXTEN=01") in new stack > -- Executing [[email protected]:9] Set("PJSIP/01-00000043", "__MON_FMT=wav") in new stack > -- Executing [[email protected]:10] NoOp("PJSIP/01-00000043", "Recordings initialized") in new stack > -- Executing [[email protected]:11] ExecIf("PJSIP/01-00000043", "0?Set(ARG3=dontcare)") in new stack > -- Executing [[email protected]:12] Set("PJSIP/01-00000043", "REC_POLICY_MODE_SAVE=") in new stack > -- Executing [[email protected]:13] ExecIf("PJSIP/01-00000043", "0?Set(REC_STATUS=NO)") in new stack > -- Executing [[email protected]:14] GotoIf("PJSIP/01-00000043", "3?checkaction") in new stack > -- Goto (sub-record-check,s,17) > -- Executing [[email protected]:17] GotoIf("PJSIP/01-00000043", "1?sub-record-check,out,1") in new stack > -- Goto (sub-record-check,out,1) > -- Executing [[email protected]:1] NoOp("PJSIP/01-00000043", "Outbound Recording Check from 01 to 791279486") in new stack > -- Executing [[email protected]:2] Set("PJSIP/01-00000043", "RECMODE=dontcare") in new stack > -- Executing [[email protected]:3] ExecIf("PJSIP/01-00000043", "1?Goto(routewins)") in new stack > -- Goto (sub-record-check,out,7) > -- Executing [[email protected]:7] Gosub("PJSIP/01-00000043", "recordcheck,1(dontcare,out,791279486)") in new stack > -- Executing [[email protected]:1] NoOp("PJSIP/01-00000043", "Starting recording check against dontcare") in new stack > -- Executing [[email protected]:2] Goto("PJSIP/01-00000043", "dontcare") in new stack > -- Goto (sub-record-check,recordcheck,3) > -- Executing [[email protected]:3] Return("PJSIP/01-00000043", "") in new stack > -- Executing [[email protected]:8] Return("PJSIP/01-00000043", "") in new stack > -- Executing [[email protected]:3] ExecIf("PJSIP/01-00000043", "0 ?Set(CDR(accountcode)=)") in new stack > -- Executing [[email protected]:4] Set("PJSIP/01-00000043", "MOHCLASS=default") in new stack > -- Executing [[email protected]:5] Set("PJSIP/01-00000043", "_NODEST=") in new stack > -- Executing [[email protected]:6] Macro("PJSIP/01-00000043", "dialout-trunk,1,791279486,,off") in new stack > -- Executing [[email protected]:1] Set("PJSIP/01-00000043", "DIAL_TRUNK=1") in new stack > -- Executing [[email protected]:2] GosubIf("PJSIP/01-00000043", "0?sub-pincheck,s,1()") in new stack > -- Executing [[email protected]:3] GotoIf("PJSIP/01-00000043", "0?disabletrunk,1") in new stack > -- Executing [[email protected]:4] Set("PJSIP/01-00000043", "DIAL_NUMBER=791279486") in new stack > -- Executing [[email protected]:5] Set("PJSIP/01-00000043", "DIAL_TRUNK_OPTIONS=Ttr") in new stack > -- Executing [[email protected]:6] Set("PJSIP/01-00000043", "OUTBOUND_GROUP=OUT_1") in new stack > -- Executing [[email protected]:7] GotoIf("PJSIP/01-00000043", "0?nomax") in new stack > -- Executing [[email protected]:8] GotoIf("PJSIP/01-00000043", "0?chanfull") in new stack > -- Executing [[email protected]:9] GotoIf("PJSIP/01-00000043", "0?skipoutcid") in new stack > -- Executing [[email protected]:10] Set("PJSIP/01-00000043", "DIAL_TRUNK_OPTIONS=T") in new stack > -- Executing [[email protected]:11] Macro("PJSIP/01-00000043", "outbound-callerid,1") in new stack > -- Executing [[email protected]:1] ExecIf("PJSIP/01-00000043", "0?Set(CALLERPRES(name-pres)=)") in new stack > -- Executing [[email protected]:2] ExecIf("PJSIP/01-00000043", "0?Set(CALLERPRES(num-pres)=)") in new stack > -- Executing [[email protected]:3] ExecIf("PJSIP/01-00000043", "0?Set(REALCALLERIDNUM=01)") in new stack > -- Executing [[email protected]:4] GotoIf("PJSIP/01-00000043", "1?normcid") in new stack > -- Goto (macro-outbound-callerid,s,7) > -- Executing [[email protected]:7] Set("PJSIP/01-00000043", "USEROUTCID=") in new stack > -- Executing [[email protected]:8] Set("PJSIP/01-00000043", "EMERGENCYCID=") in new stack > -- Executing [[email protected]:9] Set("PJSIP/01-00000043", "TRUNKOUTCID=146888149") in new stack > -- Executing [[email protected]:10] GotoIf("PJSIP/01-00000043", "1?trunkcid") in new stack > -- Goto (macro-outbound-callerid,s,15) > -- Executing [[email protected]d:15] ExecIf("PJSIP/01-00000043", "1?Set(CALLERID(all)=146888149)") in new stack > -- Executing [[email protected]:16] ExecIf("PJSIP/01-00000043", "0?Set(CALLERID(all)=)") in new stack > -- Executing [[email protected]:17] ExecIf("PJSIP/01-00000043", "0?Set(CALLERID(all)=)") in new stack > -- Executing [[email protected]:18] ExecIf("PJSIP/01-00000043", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack > -- Executing [[email protected]:19] ExecIf("PJSIP/01-00000043", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack > -- Executing [[email protected]:20] Set("PJSIP/01-00000043", "CDR(outbound_cnum)=146888149") in new stack > -- Executing [[email protected]:21] Set("PJSIP/01-00000043", "CDR(outbound_cnam)=") in new stack > [2019-05-22 14:07:46] WARNING[2364]: func_cdr.c:383 cdr_write_callback: CDR requires a value (CDR(variable)=value) > -- Executing [[email protected]:12] GosubIf("PJSIP/01-00000043", "1?sub-flp-1,s,1()") in new stack > -- Executing [[email protected]:1] ExecIf("PJSIP/01-00000043", "1?Return()") in new stack > -- Executing [[email protected]:13] Set("PJSIP/01-00000043", "OUTNUM=791279486") in new stack > -- Executing [[email protected]:14] Set("PJSIP/01-00000043", "custom=SIP/TOI") in new stack > -- Executing [[email protected]:15] ExecIf("PJSIP/01-00000043", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)") in new stack > -- Executing [[email protected]:16] ExecIf("PJSIP/01-00000043", "0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))") in new stack > -- Executing [[email protected]:17] Macro("PJSIP/01-00000043", "dialout-trunk-predial-hook,") in new stack > -- Executing [[email protected]:1] MacroExit("PJSIP/01-00000043", "") in new stack > -- Executing [[email protected]:18] GotoIf("PJSIP/01-00000043", "0?bypass,1") in new stack > -- Executing [[email protected]:19] ExecIf("PJSIP/01-00000043", "1?Set(CONNECTEDLINE(num,i)=791279486)") in new stack > -- Executing [[email protected]:20] ExecIf("PJSIP/01-00000043", "1?Set(CONNECTEDLINE(name,i)=CID:146888149)") in new stack > -- Executing [[email protected]:21] ExecIf("PJSIP/01-00000043", "0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)146888149)") in new stack > -- Executing [[email protected]:22] GotoIf("PJSIP/01-00000043", "0?customtrunk") in new stack > -- Executing [[email protected]:23] Dial("PJSIP/01-00000043", "SIP/TOI/791279486,300,T") in new stack > == Using SIP RTP TOS bits 184 > == Using SIP RTP CoS mark 5 > -- Called SIP/TOI/791279486 > [2019-05-22 14:07:46] WARNING[15408]: res_pjsip_pubsub.c:640 subscription_get_handler_from_rdata: No registered subscribe handler for event call-info > [2019-05-22 14:07:52] WARNING[15408]: res_pjsip_pubsub.c:640 subscription_get_handler_from_rdata: No registered subscribe handler for event call-info > [2019-05-22 14:07:56] WARNING[12754]: res_pjsip_pubsub.c:640 subscription_get_handler_from_rdata: No registered subscribe handler for event call-info > [2019-05-22 14:08:02] WARNING[15408]: res_pjsip_pubsub.c:640 subscription_get_handler_from_rdata: No registered subscribe handler for event call-info > [2019-05-22 14:08:06] WARNING[24199]: res_pjsip_pubsub.c:640 subscription_get_handler_from_rdata: No registered subscribe handler for event call-info > [2019-05-22 14:08:12] WARNING[15408]: res_pjsip_pubsub.c:640 subscription_get_handler_from_rdata: No registered subscribe handler for event call-info > [2019-05-22 14:08:16] WARNING[12754]: res_pjsip_pubsub.c:640 subscription_get_handler_from_rdata: No registered subscribe handler for event call-info > [2019-05-22 14:08:17] NOTICE[24199]: res_pjsip_exten_state.c:358 new_subscribe: Extension state subscription failed: Extension 20 does not exist in context 'from-internal' or has no associated hint > -- SIP/TOI-0000002f is circuit-busy > [2019-05-22 14:08:18] WARNING[2542]: chan_sip.c:4071 retrans_pkt: Retransmission timeout reached on transmission 4[email protected] for seqno 102 (Critical Request) -- See https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions > Packet timed out after 32000ms with no response > == Everyone is busy/congested at this time (1:0/1/0) > -- Executing [[email protected]:24] NoOp("PJSIP/01-00000043", "Dial failed for some reason with DIALSTATUS = CONGESTION and HANGUPCAUSE = 0") in new stack > -- Executing [[email protected]:25] GotoIf("PJSIP/01-00000043", "0?continue,1:s-CONGESTION,1") in new stack > -- Goto (macro-dialout-trunk,s-CONGESTION,1) > -- Executing [[email protected]:1] Set("PJSIP/01-00000043", "RC=0") in new stack > -- Executing [[email protected]:2] Goto("PJSIP/01-00000043", "0,1") in new stack > -- Goto (macro-dialout-trunk,0,1) > -- Executing [[email protected]:1] Goto("PJSIP/01-00000043", "continue,1") in new stack > -- Goto (macro-dialout-trunk,continue,1) > -- Executing [[email protected]:1] NoOp("PJSIP/01-00000043", "TRUNK Dial failed due to CONGESTION HANGUPCAUSE: 0 - failing through to other trunks") in new stack > -- Executing [[email protected]:2] ExecIf("PJSIP/01-00000043", "1?Set(CALLERID(number)=01)") in new stack > -- Executing [[email protected]:7] Macro("PJSIP/01-00000043", "outisbusy,") in new stack > -- Executing [[email protected]:1] Progress("PJSIP/01-00000043", "") in new stack > -- Executing [[email protected]:2] GotoIf("PJSIP/01-00000043", "0?emergency,1") in new stack > -- Executing [[email protected]:3] GotoIf("PJSIP/01-00000043", "0?intracompany,1") in new stack > -- Executing [[email protected]:4] Playback("PJSIP/01-00000043", "all-circuits-busy-now&pls-try-call-later, noanswer") in new stack > -- <PJSIP/01-00000043> Playing 'all-circuits-busy-now.ulaw' (language 'pl') > > 0x7ffb180f9890 -- Probation passed - setting RTP source address to 192.168.10.3:5004 > -- <PJSIP/01-00000043> Playing 'pls-try-call-later.ulaw' (language 'pl') > -- Executing [[email protected]:1] Macro("PJSIP/01-00000043", "hangupcall") in new stack > -- Executing [[email protected]:1] GotoIf("PJSIP/01-00000043", "1?theend") in new stack > -- Goto (macro-hangupcall,s,3) > -- Executing [[email protected]:3] ExecIf("PJSIP/01-00000043", "0?Set(CDR(recordingfile)=)") in new stack > -- Executing [[email protected]:4] Hangup("PJSIP/01-00000043", "") in new stack > == Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'PJSIP/01-00000043' in macro 'hangupcall' > == Spawn extension (from-internal, h, 1) exited non-zero on 'PJSIP/01-00000043' > [2019-05-22 14:08:21] NOTICE[12754]: res_pjsip_exten_state.c:358 new_subscribe: Extension state subscription failed: Extension 23 does not exist in context 'from-internal' or has no associated hint > [2019-05-22 14:08:22] WARNING[24199]: res_pjsip_pubsub.c:640 subscription_get_handler_from_rdata: No registered subscribe handler for event call-info > [2019-05-22 14:08:26] WARNING[15408]: res_pjsip_pubsub.c:640 subscription_get_handler_from_rdata: No registered subscribe handler for event call-info > [2019-05-22 14:08:32] WARNING[24199]: res_pjsip_pubsub.c:640 subscription_get_handler_from_rdata: No registered subscribe handler for event call-info
Anyone care to help me ?