freepbx*CLI> <--- Received SIP request (810 bytes) from UDP:172.16.1.39:5060 ---> INVITE sip:1@172.16.1.78:5060 SIP/2.0 Via: SIP/2.0/UDP 172.16.1.39:5060;branch=z9hG4bK4012ef21;rport Max-Forwards: 70 From: "+994504471790" ;tag=as4209b103 To: Contact: Call-ID: 15b135d16188821a765525e810d43beb@172.16.1.39 CSeq: 102 INVITE Date: Fri, 03 May 2019 14:46:11 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO Supported: replaces, timer Content-Type: application/sdp Content-Length: 281 v=0 o=root 1404113139 1404113139 IN IP4 172.16.1.39 s=Asterisk PBX 1.6.2.6 c=IN IP4 172.16.1.39 t=0 0 m=audio 10994 RTP/AVP 0 8 3 101 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:3 GSM/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv == Setting global variable 'SIPDOMAIN' to '172.16.1.78' <--- Transmitting SIP response (331 bytes) to UDP:172.16.1.39:5060 ---> SIP/2.0 100 Trying Via: SIP/2.0/UDP 172.16.1.39:5060;rport=5060;received=172.16.1.39;branch=z9hG4bK4012ef21 Call-ID: 15b135d16188821a765525e810d43beb@172.16.1.39 From: "+994504471790" ;tag=as4209b103 To: CSeq: 102 INVITE Server: FPBX-14.0.8.4(15.4.0) Content-Length: 0 -- Executing [1@from-pstn:1] NoOp("PJSIP/hbguven-00000003", "Catch-All DID Match - Found 1 - You probably want a DID for this.") in new stack -- Executing [1@from-pstn:2] Set("PJSIP/hbguven-00000003", "__FROM_DID=1") in new stack -- Executing [1@from-pstn:3] Goto("PJSIP/hbguven-00000003", "ext-did,s,1") in new stack -- Goto (ext-did,s,1) -- Executing [s@ext-did:1] Set("PJSIP/hbguven-00000003", "__DIRECTION=INBOUND") in new stack -- Executing [s@ext-did:2] Gosub("PJSIP/hbguven-00000003", "sub-record-check,s,1(in,s,dontcare)") in new stack -- Executing [s@sub-record-check:1] GotoIf("PJSIP/hbguven-00000003", "0?initialized") in new stack -- Executing [s@sub-record-check:2] Set("PJSIP/hbguven-00000003", "__REC_STATUS=INITIALIZED") in new stack -- Executing [s@sub-record-check:3] Set("PJSIP/hbguven-00000003", "NOW=1556894814") in new stack -- Executing [s@sub-record-check:4] Set("PJSIP/hbguven-00000003", "__DAY=03") in new stack -- Executing [s@sub-record-check:5] Set("PJSIP/hbguven-00000003", "__MONTH=05") in new stack -- Executing [s@sub-record-check:6] Set("PJSIP/hbguven-00000003", "__YEAR=2019") in new stack -- Executing [s@sub-record-check:7] Set("PJSIP/hbguven-00000003", "__TIMESTR=20190503-144654") in new stack -- Executing [s@sub-record-check:8] Set("PJSIP/hbguven-00000003", "__FROMEXTEN=unknown") in new stack -- Executing [s@sub-record-check:9] Set("PJSIP/hbguven-00000003", "__MON_FMT=wav") in new stack -- Executing [s@sub-record-check:10] NoOp("PJSIP/hbguven-00000003", "Recordings initialized") in new stack -- Executing [s@sub-record-check:11] ExecIf("PJSIP/hbguven-00000003", "0?Set(ARG3=dontcare)") in new stack -- Executing [s@sub-record-check:12] Set("PJSIP/hbguven-00000003", "REC_POLICY_MODE_SAVE=") in new stack -- Executing [s@sub-record-check:13] ExecIf("PJSIP/hbguven-00000003", "0?Set(REC_STATUS=NO)") in new stack -- Executing [s@sub-record-check:14] GotoIf("PJSIP/hbguven-00000003", "2?checkaction") in new stack -- Goto (sub-record-check,s,17) -- Executing [s@sub-record-check:17] GotoIf("PJSIP/hbguven-00000003", "1?sub-record-check,in,1") in new stack -- Goto (sub-record-check,in,1) -- Executing [in@sub-record-check:1] NoOp("PJSIP/hbguven-00000003", "Inbound Recording Check to s") in new stack -- Executing [in@sub-record-check:2] Set("PJSIP/hbguven-00000003", "FROMEXTEN=unknown") in new stack -- Executing [in@sub-record-check:3] ExecIf("PJSIP/hbguven-00000003", "13?Set(FROMEXTEN=+994504471790)") in new stack -- Executing [in@sub-record-check:4] Gosub("PJSIP/hbguven-00000003", "recordcheck,1(dontcare,in,s)") in new stack -- Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/hbguven-00000003", "Starting recording check against dontcare") in new stack -- Executing [recordcheck@sub-record-check:2] Goto("PJSIP/hbguven-00000003", "dontcare") in new stack -- Goto (sub-record-check,recordcheck,3) -- Executing [recordcheck@sub-record-check:3] Return("PJSIP/hbguven-00000003", "") in new stack -- Executing [in@sub-record-check:5] Return("PJSIP/hbguven-00000003", "") in new stack -- Executing [s@ext-did:3] Gosub("PJSIP/hbguven-00000003", "app-blacklist-check,s,1()") in new stack -- Executing [s@app-blacklist-check:1] GotoIf("PJSIP/hbguven-00000003", "0?blacklisted") in new stack -- Executing [s@app-blacklist-check:2] Set("PJSIP/hbguven-00000003", "CALLED_BLACKLIST=1") in new stack -- Executing [s@app-blacklist-check:3] Return("PJSIP/hbguven-00000003", "") in new stack -- Executing [s@ext-did:4] Set("PJSIP/hbguven-00000003", "CHANNEL(tonezone)=us") in new stack -- Executing [s@ext-did:5] ExecIf("PJSIP/hbguven-00000003", "0?Set(__FROM_DID=s)") in new stack -- Executing [s@ext-did:6] Set("PJSIP/hbguven-00000003", "CDR(did)=1") in new stack -- Executing [s@ext-did:7] ExecIf("PJSIP/hbguven-00000003", "0 ?Set(CALLERID(name)=+994504471790)") in new stack -- Executing [s@ext-did:8] Set("PJSIP/hbguven-00000003", "__MOHCLASS=") in new stack -- Executing [s@ext-did:9] Set("PJSIP/hbguven-00000003", "__REVERSAL_REJECT=FALSE") in new stack -- Executing [s@ext-did:10] GotoIf("PJSIP/hbguven-00000003", "1?post-reverse-charge") in new stack -- Goto (ext-did,s,12) -- Executing [s@ext-did:12] NoOp("PJSIP/hbguven-00000003", "") in new stack -- Executing [s@ext-did:13] Set("PJSIP/hbguven-00000003", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack -- Executing [s@ext-did:14] Set("PJSIP/hbguven-00000003", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack -- Executing [s@ext-did:15] Set("PJSIP/hbguven-00000003", "CALLERID(name-pres)=allowed_not_screened") in new stack -- Executing [s@ext-did:16] Set("PJSIP/hbguven-00000003", "CALLERID(num-pres)=allowed_not_screened") in new stack -- Executing [s@ext-did:17] NoOp("PJSIP/hbguven-00000003", "CallerID Entry Point") in new stack -- Executing [s@ext-did:18] Set("PJSIP/hbguven-00000003", "__CRM_DIRECTION=INBOUND") in new stack -- Executing [s@ext-did:19] Set("PJSIP/hbguven-00000003", "__CRM_SOURCE=+994504471790") in new stack -- Executing [s@ext-did:20] Set("PJSIP/hbguven-00000003", "__CRM_LINKEDID=1556894814.3") in new stack -- Executing [s@ext-did:21] ExecIf("PJSIP/hbguven-00000003", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack -- Executing [s@ext-did:22] Goto("PJSIP/hbguven-00000003", "ivr-8,s,1") in new stack -- Goto (ivr-8,s,1) -- Executing [s@ivr-8:1] Set("PJSIP/hbguven-00000003", "TIMEOUT_LOOPCOUNT=0") in new stack -- Executing [s@ivr-8:2] Set("PJSIP/hbguven-00000003", "INVALID_LOOPCOUNT=0") in new stack -- Executing [s@ivr-8:3] Set("PJSIP/hbguven-00000003", "_IVR_CONTEXT_ivr-8=") in new stack -- Executing [s@ivr-8:4] Set("PJSIP/hbguven-00000003", "_IVR_CONTEXT=ivr-8") in new stack -- Executing [s@ivr-8:5] Set("PJSIP/hbguven-00000003", "__IVR_RETVM=") in new stack -- Executing [s@ivr-8:6] GotoIf("PJSIP/hbguven-00000003", "0?skip") in new stack -- Executing [s@ivr-8:7] Answer("PJSIP/hbguven-00000003", "") in new stack > 0x7f0014016f70 -- Strict RTP learning after remote address set to: 172.16.1.39:10994 <--- Transmitting SIP response (876 bytes) to UDP:172.16.1.39:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP 172.16.1.39:5060;rport=5060;received=172.16.1.39;branch=z9hG4bK4012ef21 Call-ID: 15b135d16188821a765525e810d43beb@172.16.1.39 From: "+994504471790" ;tag=as4209b103 To: ;tag=4aa355ca-879a-470c-8f6a-2065653000c2 CSeq: 102 INVITE Server: FPBX-14.0.8.4(15.4.0) Contact: Allow: OPTIONS, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, REGISTER, MESSAGE, REFER Supported: 100rel, timer, replaces, norefersub Content-Type: application/sdp Content-Length: 282 v=0 o=- 1404113139 1404113141 IN IP4 172.16.1.78 s=Asterisk c=IN IP4 172.16.1.78 t=0 0 m=audio 18200 RTP/AVP 0 8 3 101 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:3 GSM/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=maxptime:150 a=sendrecv <--- Received SIP request (390 bytes) from UDP:172.16.1.39:5060 ---> ACK sip:172.16.1.78:5060 SIP/2.0 Via: SIP/2.0/UDP 172.16.1.39:5060;branch=z9hG4bK31232d5d;rport Max-Forwards: 70 From: "+994504471790" ;tag=as4209b103 To: ;tag=4aa355ca-879a-470c-8f6a-2065653000c2 Contact: Call-ID: 15b135d16188821a765525e810d43beb@172.16.1.39 CSeq: 102 ACK Content-Length: 0 > 0x7f0014016f70 -- Strict RTP switching to RTP target address 172.16.1.39:10994 as source -- Executing [s@ivr-8:8] Wait("PJSIP/hbguven-00000003", "1") in new stack -- Executing [s@ivr-8:9] Set("PJSIP/hbguven-00000003", "IVR_MSG=custom/1") in new stack -- Executing [s@ivr-8:10] Set("PJSIP/hbguven-00000003", "TIMEOUT(digit)=3") in new stack -- Digit timeout set to 3.000 -- Executing [s@ivr-8:11] ExecIf("PJSIP/hbguven-00000003", "1?Background(custom/1)") in new stack -- Playing 'custom/1.slin' (language 'en') > 0x7f0014016f70 -- Strict RTP learning complete - Locking on source address 172.16.1.39:10994 -- Executing [1@ivr-8:1] Set("PJSIP/hbguven-00000003", "IVRSELECTION=1|ivr-8") in new stack -- Executing [1@ivr-8:2] QueueLog("PJSIP/hbguven-00000003", "NONE,1556894814.3,NONE,INFO,IVRAPPEND|1|ivr-8") in new stack -- Executing [1@ivr-8:3] Goto("PJSIP/hbguven-00000003", "ivr-9,s,1") in new stack -- Goto (ivr-9,s,1) -- Executing [s@ivr-9:1] Set("PJSIP/hbguven-00000003", "TIMEOUT_LOOPCOUNT=0") in new stack -- Executing [s@ivr-9:2] Set("PJSIP/hbguven-00000003", "INVALID_LOOPCOUNT=0") in new stack -- Executing [s@ivr-9:3] Set("PJSIP/hbguven-00000003", "_IVR_CONTEXT_ivr-9=ivr-8") in new stack -- Executing [s@ivr-9:4] Set("PJSIP/hbguven-00000003", "_IVR_CONTEXT=ivr-9") in new stack -- Executing [s@ivr-9:5] Set("PJSIP/hbguven-00000003", "__IVR_RETVM=") in new stack -- Executing [s@ivr-9:6] GotoIf("PJSIP/hbguven-00000003", "1?skip") in new stack -- Goto (ivr-9,s,9) -- Executing [s@ivr-9:9] Set("PJSIP/hbguven-00000003", "IVR_MSG=custom/2") in new stack -- Executing [s@ivr-9:10] Set("PJSIP/hbguven-00000003", "TIMEOUT(digit)=3") in new stack -- Digit timeout set to 3.000 -- Executing [s@ivr-9:11] ExecIf("PJSIP/hbguven-00000003", "1?Background(custom/2)") in new stack -- Playing 'custom/2.slin' (language 'en') -- Executing [2@ivr-9:1] Set("PJSIP/hbguven-00000003", "IVRSELECTION=2|ivr-9") in new stack -- Executing [2@ivr-9:2] QueueLog("PJSIP/hbguven-00000003", "NONE,1556894814.3,NONE,INFO,IVRAPPEND|2|ivr-9") in new stack -- Executing [2@ivr-9:3] Goto("PJSIP/hbguven-00000003", "ext-miscdests,4,1") in new stack -- Goto (ext-miscdests,4,1) -- Executing [4@ext-miscdests:1] NoOp("PJSIP/hbguven-00000003", "MiscDest: filial_HBGuven") in new stack -- Executing [4@ext-miscdests:2] Goto("PJSIP/hbguven-00000003", "from-internal,0552260112,1") in new stack -- Goto (from-internal,0552260112,1) -- Executing [0552260112@from-internal:1] Set("PJSIP/hbguven-00000003", "CURL_RESULT= -- Response: Success -- Message: Commit successfully!") in new stack -- Executing [0552260112@from-internal:2] Gosub("PJSIP/hbguven-00000003", "sub-record-check,s,1(out,0552260112,dontcare)") in new stack -- Executing [s@sub-record-check:1] GotoIf("PJSIP/hbguven-00000003", "13?initialized") in new stack -- Goto (sub-record-check,s,10) -- Executing [s@sub-record-check:10] NoOp("PJSIP/hbguven-00000003", "Recordings initialized") in new stack -- Executing [s@sub-record-check:11] ExecIf("PJSIP/hbguven-00000003", "0?Set(ARG3=dontcare)") in new stack -- Executing [s@sub-record-check:12] Set("PJSIP/hbguven-00000003", "REC_POLICY_MODE_SAVE=") in new stack -- Executing [s@sub-record-check:13] ExecIf("PJSIP/hbguven-00000003", "0?Set(REC_STATUS=NO)") in new stack -- Executing [s@sub-record-check:14] GotoIf("PJSIP/hbguven-00000003", "3?checkaction") in new stack -- Goto (sub-record-check,s,17) -- Executing [s@sub-record-check:17] GotoIf("PJSIP/hbguven-00000003", "1?sub-record-check,out,1") in new stack -- Goto (sub-record-check,out,1) -- Executing [out@sub-record-check:1] NoOp("PJSIP/hbguven-00000003", "Outbound Recording Check from +994504471790 to 0552260112") in new stack -- Executing [out@sub-record-check:2] Set("PJSIP/hbguven-00000003", "RECMODE=") in new stack -- Executing [out@sub-record-check:3] ExecIf("PJSIP/hbguven-00000003", "1?Goto(routewins)") in new stack -- Goto (sub-record-check,out,7) -- Executing [out@sub-record-check:7] Gosub("PJSIP/hbguven-00000003", "recordcheck,1(dontcare,out,0552260112)") in new stack -- Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/hbguven-00000003", "Starting recording check against dontcare") in new stack -- Executing [recordcheck@sub-record-check:2] Goto("PJSIP/hbguven-00000003", "dontcare") in new stack -- Goto (sub-record-check,recordcheck,3) -- Executing [recordcheck@sub-record-check:3] Return("PJSIP/hbguven-00000003", "") in new stack -- Executing [out@sub-record-check:8] Return("PJSIP/hbguven-00000003", "") in new stack -- Executing [0552260112@from-internal:3] ExecIf("PJSIP/hbguven-00000003", "0 ?Set(CDR(accountcode)=)") in new stack -- Executing [0552260112@from-internal:4] Set("PJSIP/hbguven-00000003", "MOHCLASS=default") in new stack -- Executing [0552260112@from-internal:5] Set("PJSIP/hbguven-00000003", "_NODEST=") in new stack -- Executing [0552260112@from-internal:6] Macro("PJSIP/hbguven-00000003", "dialout-trunk,2,0552260112,,off") in new stack -- Executing [s@macro-dialout-trunk:1] Set("PJSIP/hbguven-00000003", "DIAL_TRUNK=2") in new stack -- Executing [s@macro-dialout-trunk:2] ExecIf("PJSIP/hbguven-00000003", "1?Set(DIAL_OPTIONS=Hhtr)") in new stack -- Executing [s@macro-dialout-trunk:3] GosubIf("PJSIP/hbguven-00000003", "0?sub-pincheck,s,1()") in new stack -- Executing [s@macro-dialout-trunk:4] ExecIf("PJSIP/hbguven-00000003", "0?Set(CALLERID(num)=)") in new stack -- Executing [s@macro-dialout-trunk:5] GotoIf("PJSIP/hbguven-00000003", "0?disabletrunk,1") in new stack -- Executing [s@macro-dialout-trunk:6] Set("PJSIP/hbguven-00000003", "DIAL_NUMBER=0552260112") in new stack -- Executing [s@macro-dialout-trunk:7] Set("PJSIP/hbguven-00000003", "DIAL_TRUNK_OPTIONS=Hhtr") in new stack -- Executing [s@macro-dialout-trunk:8] Set("PJSIP/hbguven-00000003", "OUTBOUND_GROUP=OUT_2") in new stack -- Executing [s@macro-dialout-trunk:9] Set("PJSIP/hbguven-00000003", "DIAL_TRUNK_OPTIONS=T") in new stack -- Executing [s@macro-dialout-trunk:10] GotoIf("PJSIP/hbguven-00000003", "1?nomax") in new stack -- Goto (macro-dialout-trunk,s,12) -- Executing [s@macro-dialout-trunk:12] GotoIf("PJSIP/hbguven-00000003", "0?skipoutcid") in new stack -- Executing [s@macro-dialout-trunk:13] Macro("PJSIP/hbguven-00000003", "outbound-callerid,2") in new stack -- Executing [s@macro-outbound-callerid:1] NoOp("PJSIP/hbguven-00000003", "") in new stack -- Executing [s@macro-outbound-callerid:2] NoOp("PJSIP/hbguven-00000003", "") in new stack -- Executing [s@macro-outbound-callerid:3] NoOp("PJSIP/hbguven-00000003", "off") in new stack -- Executing [s@macro-outbound-callerid:4] ExecIf("PJSIP/hbguven-00000003", "1?Set(CALLERPRES(name-pres)=allowed_not_screened)") in new stack -- Executing [s@macro-outbound-callerid:5] ExecIf("PJSIP/hbguven-00000003", "1?Set(CALLERPRES(num-pres)=allowed_not_screened)") in new stack -- Executing [s@macro-outbound-callerid:6] ExecIf("PJSIP/hbguven-00000003", "1?Set(REALCALLERIDNUM=+994504471790)") in new stack -- Executing [s@macro-outbound-callerid:7] ExecIf("PJSIP/hbguven-00000003", "0?Set(AMPUSER=+994504471790)") in new stack -- Executing [s@macro-outbound-callerid:8] GotoIf("PJSIP/hbguven-00000003", "1?normcid") in new stack -- Goto (macro-outbound-callerid,s,12) -- Executing [s@macro-outbound-callerid:12] Set("PJSIP/hbguven-00000003", "USEROUTCID=") in new stack -- Executing [s@macro-outbound-callerid:13] Set("PJSIP/hbguven-00000003", "EMERGENCYCID=") in new stack -- Executing [s@macro-outbound-callerid:14] Set("PJSIP/hbguven-00000003", "TRUNKOUTCID=") in new stack -- Executing [s@macro-outbound-callerid:15] GotoIf("PJSIP/hbguven-00000003", "1?trunkcid") in new stack -- Goto (macro-outbound-callerid,s,21) -- Executing [s@macro-outbound-callerid:21] ExecIf("PJSIP/hbguven-00000003", "0?Set(CALLERID(all)=)") in new stack -- Executing [s@macro-outbound-callerid:22] ExecIf("PJSIP/hbguven-00000003", "0?Set(CALLERID(all)=)") in new stack -- Executing [s@macro-outbound-callerid:23] ExecIf("PJSIP/hbguven-00000003", "0?Set(CALLERID(all)=)") in new stack -- Executing [s@macro-outbound-callerid:24] ExecIf("PJSIP/hbguven-00000003", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack -- Executing [s@macro-outbound-callerid:25] ExecIf("PJSIP/hbguven-00000003", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack -- Executing [s@macro-outbound-callerid:26] Set("PJSIP/hbguven-00000003", "CDR(outbound_cnum)=+994504471790") in new stack -- Executing [s@macro-outbound-callerid:27] Set("PJSIP/hbguven-00000003", "CDR(outbound_cnam)=+994504471790") in new stack -- Executing [s@macro-dialout-trunk:14] GosubIf("PJSIP/hbguven-00000003", "1?sub-flp-2,s,1()") in new stack -- Executing [s@sub-flp-2:1] ExecIf("PJSIP/hbguven-00000003", "0?Set(TARGET_FLP_2=+9942260112)") in new stack -- Executing [s@sub-flp-2:2] GotoIf("PJSIP/hbguven-00000003", "0?match") in new stack -- Executing [s@sub-flp-2:3] Return("PJSIP/hbguven-00000003", "") in new stack -- Executing [s@macro-dialout-trunk:15] Set("PJSIP/hbguven-00000003", "OUTNUM=0552260112") in new stack -- Executing [s@macro-dialout-trunk:16] Set("PJSIP/hbguven-00000003", "custom=PJSIP") in new stack -- Executing [s@macro-dialout-trunk:17] ExecIf("PJSIP/hbguven-00000003", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)") in new stack -- Executing [s@macro-dialout-trunk:18] ExecIf("PJSIP/hbguven-00000003", "0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))") in new stack -- Executing [s@macro-dialout-trunk:19] Macro("PJSIP/hbguven-00000003", "dialout-trunk-predial-hook,") in new stack -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("PJSIP/hbguven-00000003", "") in new stack -- Executing [s@macro-dialout-trunk:20] GotoIf("PJSIP/hbguven-00000003", "1?skipcrm") in new stack -- Goto (macro-dialout-trunk,s,26) -- Executing [s@macro-dialout-trunk:26] NoOp("PJSIP/hbguven-00000003", "CRM Finished") in new stack -- Executing [s@macro-dialout-trunk:27] GotoIf("PJSIP/hbguven-00000003", "0?bypass,1") in new stack -- Executing [s@macro-dialout-trunk:28] ExecIf("PJSIP/hbguven-00000003", "0?Set(CONNECTEDLINE(num,i)=0552260112)") in new stack -- Executing [s@macro-dialout-trunk:29] ExecIf("PJSIP/hbguven-00000003", "0?Set(CONNECTEDLINE(name,i)=CID:+994504471790)") in new stack -- Executing [s@macro-dialout-trunk:30] ExecIf("PJSIP/hbguven-00000003", "0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)+994504471790)") in new stack -- Executing [s@macro-dialout-trunk:31] GotoIf("PJSIP/hbguven-00000003", "0?customtrunk") in new stack -- Executing [s@macro-dialout-trunk:32] Dial("PJSIP/hbguven-00000003", "PJSIP/0552260112@hbguven,300,Tb(func-apply-sipheaders^s^1,(2))") in new stack -- PJSIP/hbguven-00000004 Internal Gosub(func-apply-sipheaders,s,1(2)) start -- Executing [s@func-apply-sipheaders:1] ExecIf("PJSIP/hbguven-00000004", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack -- Executing [s@func-apply-sipheaders:2] NoOp("PJSIP/hbguven-00000004", "Applying SIP Headers to channel PJSIP/hbguven-00000004") in new stack -- Executing [s@func-apply-sipheaders:3] Set("PJSIP/hbguven-00000004", "TECH=PJSIP") in new stack -- Executing [s@func-apply-sipheaders:4] Set("PJSIP/hbguven-00000004", "SIPHEADERKEYS=") in new stack -- Executing [s@func-apply-sipheaders:5] While("PJSIP/hbguven-00000004", "0") in new stack -- Jumping to priority 12 -- Executing [s@func-apply-sipheaders:13] Return("PJSIP/hbguven-00000004", "") in new stack == Spawn extension (from-pstn, 0552260112, 1) exited non-zero on 'PJSIP/hbguven-00000004' -- PJSIP/hbguven-00000004 Internal Gosub(func-apply-sipheaders,s,1(2)) complete GOSUB_RETVAL= -- Called PJSIP/0552260112@hbguven <--- Transmitting SIP request (1020 bytes) to UDP:172.16.1.39:5060 ---> INVITE sip:0552260112@172.16.1.39:5060 SIP/2.0 Via: SIP/2.0/UDP 172.16.1.78:5060;rport;branch=z9hG4bKPjc4b71a22-6413-4cf7-8858-4cbe0cd619d6 From: "+994504471790" ;tag=73c4ad13-c6cb-4898-b9cb-843a7a0a6dca To: Contact: Call-ID: 53e1abb0-6df0-4083-b969-3ec9ecef928c CSeq: 8423 INVITE Allow: OPTIONS, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, REGISTER, MESSAGE, REFER Supported: 100rel, timer, replaces, norefersub Session-Expires: 1800 Min-SE: 90 Max-Forwards: 70 User-Agent: FPBX-14.0.8.4(15.4.0) Content-Type: application/sdp Content-Length: 337 v=0 o=- 1335456058 1335456058 IN IP4 172.16.1.78 s=Asterisk c=IN IP4 172.16.1.78 t=0 0 m=audio 11476 RTP/AVP 0 8 3 111 9 101 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:3 GSM/8000 a=rtpmap:111 G726-32/8000 a=rtpmap:9 G722/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=maxptime:150 a=sendrecv <--- Received SIP response (551 bytes) from UDP:172.16.1.39:5060 ---> SIP/2.0 100 Trying Via: SIP/2.0/UDP 172.16.1.78:5060;branch=z9hG4bKPjc4b71a22-6413-4cf7-8858-4cbe0cd619d6;received=172.16.1.78;rport=5060 From: "+994504471790" ;tag=73c4ad13-c6cb-4898-b9cb-843a7a0a6dca To: Call-ID: 53e1abb0-6df0-4083-b969-3ec9ecef928c CSeq: 8423 INVITE Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO Supported: replaces, timer Require: timer Session-Expires: 1800;refresher=uas Contact: Content-Length: 0 <--- Received SIP response (551 bytes) from UDP:172.16.1.39:5060 ---> SIP/2.0 100 Trying Via: SIP/2.0/UDP 172.16.1.78:5060;branch=z9hG4bKPjc4b71a22-6413-4cf7-8858-4cbe0cd619d6;received=172.16.1.78;rport=5060 From: "+994504471790" ;tag=73c4ad13-c6cb-4898-b9cb-843a7a0a6dca To: Call-ID: 53e1abb0-6df0-4083-b969-3ec9ecef928c CSeq: 8423 INVITE Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO Supported: replaces, timer Require: timer Session-Expires: 1800;refresher=uas Contact: Content-Length: 0 <--- Received SIP response (890 bytes) from UDP:172.16.1.39:5060 ---> SIP/2.0 183 Session Progress Via: SIP/2.0/UDP 172.16.1.78:5060;branch=z9hG4bKPjc4b71a22-6413-4cf7-8858-4cbe0cd619d6;received=172.16.1.78;rport=5060 From: "+994504471790" ;tag=73c4ad13-c6cb-4898-b9cb-843a7a0a6dca To: ;tag=as4cda1434 Call-ID: 53e1abb0-6df0-4083-b969-3ec9ecef928c CSeq: 8423 INVITE Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO Supported: replaces, timer Require: timer Session-Expires: 1800;refresher=uas Contact: Content-Type: application/sdp Content-Length: 281 v=0 o=root 1302155482 1302155482 IN IP4 172.16.1.39 s=Asterisk PBX 1.6.2.6 c=IN IP4 172.16.1.39 t=0 0 m=audio 11050 RTP/AVP 8 0 3 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:3 GSM/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv > 0x7f001400db70 -- Strict RTP learning after remote address set to: 172.16.1.39:11050 -- PJSIP/hbguven-00000004 is making progress passing it to PJSIP/hbguven-00000003 > 0x7f001400db70 -- Strict RTP switching to RTP target address 172.16.1.39:11050 as source <--- Transmitting SIP request (413 bytes) to UDP:172.16.1.39:5060 ---> OPTIONS sip:172.16.1.39:5060 SIP/2.0 Via: SIP/2.0/UDP 172.16.1.78:5060;rport;branch=z9hG4bKPj16f98325-d3af-4147-94f3-c0d6f783c826 From: ;tag=231fc339-36e1-494b-bb30-7faa29c57e1c To: Contact: Call-ID: ad9dc128-0e8d-41b9-a3a9-f2234ffdc854 CSeq: 57951 OPTIONS Max-Forwards: 70 User-Agent: FPBX-14.0.8.4(15.4.0) Content-Length: 0 <--- Received SIP response (492 bytes) from UDP:172.16.1.39:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP 172.16.1.78:5060;branch=z9hG4bKPj16f98325-d3af-4147-94f3-c0d6f783c826;received=172.16.1.78;rport=5060 From: ;tag=231fc339-36e1-494b-bb30-7faa29c57e1c To: ;tag=as12d55d26 Call-ID: ad9dc128-0e8d-41b9-a3a9-f2234ffdc854 CSeq: 57951 OPTIONS Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO Supported: replaces, timer Contact: Accept: application/sdp Content-Length: 0 > 0x7f001400db70 -- Strict RTP learning complete - Locking on source address 172.16.1.39:11050 <--- Received SIP request (421 bytes) from UDP:172.16.1.39:5060 ---> BYE sip:172.16.1.78:5060 SIP/2.0 Via: SIP/2.0/UDP 172.16.1.39:5060;branch=z9hG4bK625751ea;rport Max-Forwards: 70 From: "+994504471790" ;tag=as4209b103 To: ;tag=4aa355ca-879a-470c-8f6a-2065653000c2 Call-ID: 15b135d16188821a765525e810d43beb@172.16.1.39 CSeq: 103 BYE X-Asterisk-HangupCause: Normal Clearing X-Asterisk-HangupCauseCode: 16 Content-Length: 0 <--- Transmitting SIP response (365 bytes) to UDP:172.16.1.39:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP 172.16.1.39:5060;rport=5060;received=172.16.1.39;branch=z9hG4bK625751ea Call-ID: 15b135d16188821a765525e810d43beb@172.16.1.39 From: "+994504471790" ;tag=as4209b103 To: ;tag=4aa355ca-879a-470c-8f6a-2065653000c2 CSeq: 103 BYE Server: FPBX-14.0.8.4(15.4.0) Content-Length: 0 -- PJSIP/hbguven-00000004 Internal Gosub(crm-hangup,s,1) start -- Executing [s@crm-hangup:1] NoOp("PJSIP/hbguven-00000004", "Sending Hangup to CRM") in new stack -- Executing [s@crm-hangup:2] NoOp("PJSIP/hbguven-00000004", "HANGUP CAUSE: 0") in new stack -- Executing [s@crm-hangup:3] ExecIf("PJSIP/hbguven-00000004", "0?Set(__CRM_VOICEMAIL=)") in new stack -- Executing [s@crm-hangup:4] NoOp("PJSIP/hbguven-00000004", "MASTER CHANNEL: 1556894832.4 = 1556894814.3") in new stack -- Executing [s@crm-hangup:5] GotoIf("PJSIP/hbguven-00000004", "1?return") in new stack -- Goto (crm-hangup,s,8) -- Executing [s@crm-hangup:8] Return("PJSIP/hbguven-00000004", "") in new stack == Spawn extension (from-pstn, 0552260112, 1) exited non-zero on 'PJSIP/hbguven-00000004' -- PJSIP/hbguven-00000004 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL= == Spawn extension (macro-dialout-trunk, s, 32) exited non-zero on 'PJSIP/hbguven-00000003' in macro 'dialout-trunk' == Spawn extension (from-internal, 0552260112, 6) exited non-zero on 'PJSIP/hbguven-00000003' -- Executing [h@from-internal:1] Macro("PJSIP/hbguven-00000003", "hangupcall") in new stack -- Executing [s@macro-hangupcall:1] GotoIf("PJSIP/hbguven-00000003", "1?theend") in new stack -- Goto (macro-hangupcall,s,3) -- Executing [s@macro-hangupcall:3] ExecIf("PJSIP/hbguven-00000003", "0?Set(CDR(recordingfile)=)") in new stack <--- Transmitting SIP request (436 bytes) to UDP:172.16.1.39:5060 ---> CANCEL sip:0552260112@172.16.1.39:5060 SIP/2.0 Via: SIP/2.0/UDP 172.16.1.78:5060;rport;branch=z9hG4bKPjc4b71a22-6413-4cf7-8858-4cbe0cd619d6 From: "+994504471790" ;tag=73c4ad13-c6cb-4898-b9cb-843a7a0a6dca To: Call-ID: 53e1abb0-6df0-4083-b969-3ec9ecef928c CSeq: 8423 CANCEL Reason: Q.850;cause=0 Max-Forwards: 70 User-Agent: FPBX-14.0.8.4(15.4.0) Content-Length: 0 <--- Received SIP response (486 bytes) from UDP:172.16.1.39:5060 ---> SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP 172.16.1.78:5060;branch=z9hG4bKPjc4b71a22-6413-4cf7-8858-4cbe0cd619d6;received=172.16.1.78;rport=5060 From: "+994504471790" ;tag=73c4ad13-c6cb-4898-b9cb-843a7a0a6dca To: ;tag=as4cda1434 Call-ID: 53e1abb0-6df0-4083-b969-3ec9ecef928c CSeq: 8423 INVITE Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO Supported: replaces, timer Content-Length: 0 <--- Received SIP response (470 bytes) from UDP:172.16.1.39:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP 172.16.1.78:5060;branch=z9hG4bKPjc4b71a22-6413-4cf7-8858-4cbe0cd619d6;received=172.16.1.78;rport=5060 From: "+994504471790" ;tag=73c4ad13-c6cb-4898-b9cb-843a7a0a6dca To: ;tag=as4cda1434 Call-ID: 53e1abb0-6df0-4083-b969-3ec9ecef928c CSeq: 8423 CANCEL Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO Supported: replaces, timer Content-Length: 0 -- Executing [s@macro-hangupcall:4] NoOp("PJSIP/hbguven-00000003", "PJSIP/hbguven-00000004 montior file= ") in new stack -- Executing [s@macro-hangupcall:5] GotoIf("PJSIP/hbguven-00000003", "1?skipagi") in new stack -- Goto (macro-hangupcall,s,7) -- Executing [s@macro-hangupcall:7] Hangup("PJSIP/hbguven-00000003", "") in new stack <--- Transmitting SIP request (422 bytes) to UDP:172.16.1.39:5060 ---> ACK sip:0552260112@172.16.1.39:5060 SIP/2.0 Via: SIP/2.0/UDP 172.16.1.78:5060;rport;branch=z9hG4bKPjc4b71a22-6413-4cf7-8858-4cbe0cd619d6 From: "+994504471790" ;tag=73c4ad13-c6cb-4898-b9cb-843a7a0a6dca To: ;tag=as4cda1434 Call-ID: 53e1abb0-6df0-4083-b969-3ec9ecef928c CSeq: 8423 ACK Max-Forwards: 70 User-Agent: FPBX-14.0.8.4(15.4.0) Content-Length: 0 == Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'PJSIP/hbguven-00000003' in macro 'hangupcall' == Spawn extension (from-internal, h, 1) exited non-zero on 'PJSIP/hbguven-00000003' -- PJSIP/hbguven-00000003 Internal Gosub(crm-hangup,s,1) start -- Executing [s@crm-hangup:1] NoOp("PJSIP/hbguven-00000003", "Sending Hangup to CRM") in new stack -- Executing [s@crm-hangup:2] NoOp("PJSIP/hbguven-00000003", "HANGUP CAUSE: 16") in new stack -- Executing [s@crm-hangup:3] ExecIf("PJSIP/hbguven-00000003", "0?Set(__CRM_VOICEMAIL=)") in new stack -- Executing [s@crm-hangup:4] NoOp("PJSIP/hbguven-00000003", "MASTER CHANNEL: 1556894814.3 = 1556894814.3") in new stack -- Executing [s@crm-hangup:5] GotoIf("PJSIP/hbguven-00000003", "0?return") in new stack -- Executing [s@crm-hangup:6] Set("PJSIP/hbguven-00000003", "__CRM_HANGUP=1") in new stack -- Executing [s@crm-hangup:7] AGI("PJSIP/hbguven-00000003", "sangomacrm.agi") in new stack -- Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi -- AGI Script sangomacrm.agi completed, returning 0 -- Executing [s@crm-hangup:8] Return("PJSIP/hbguven-00000003", "") in new stack == Spawn extension (from-internal, h, 1) exited non-zero on 'PJSIP/hbguven-00000003' -- PJSIP/hbguven-00000003 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL= <--- Received SIP request (466 bytes) from UDP:172.16.1.39:5060 ---> OPTIONS sip:172.16.1.78 SIP/2.0 Via: SIP/2.0/UDP 172.16.1.39:5060;branch=z9hG4bK7b51f379;rport Max-Forwards: 70 From: "Unknown" ;tag=as51f7cbf8 To: Contact: Call-ID: 41c6f95c342d691712b8217d3e6b1383@172.16.1.39 CSeq: 102 OPTIONS Date: Fri, 03 May 2019 14:46:41 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO Supported: replaces, timer Content-Length: 0 <--- Transmitting SIP response (821 bytes) to UDP:172.16.1.39:5060 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP 172.16.1.39:5060;rport=5060;received=172.16.1.39;branch=z9hG4bK7b51f379 Call-ID: 41c6f95c342d691712b8217d3e6b1383@172.16.1.39 From: "Unknown" ;tag=as51f7cbf8 To: ;tag=z9hG4bK7b51f379 CSeq: 102 OPTIONS Accept: application/sdp, application/dialog-info+xml, application/xpidf+xml, application/cpim-pidf+xml, application/simple-message-summary, application/pidf+xml, application/pidf+xml, application/dialog-info+xml, application/simple-message-summary, message/sipfrag;version=2.0 Allow: OPTIONS, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, REGISTER, MESSAGE, REFER Supported: 100rel, timer, replaces, norefersub Accept-Encoding: text/plain Accept-Language: en Server: FPBX-14.0.8.4(15.4.0) Content-Length: 0