История изменений [назад]

v=0 o=HuaweiSoftX3000 102511330 102511330 IN IP4 80.73.85.134 s=Sip Call c=IN IP4 80.73.85.134 t=0 0 m=audio 23818 RTP/AVP 8 0 18 4 97 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:18 G729/8000 a=rtpmap:4 G723/8000 a=rtpmap:97 telephone-event/8000 a=ptime:20 a=fmtp:97 0-15 a=fmtp:18 annexb=no <-------------> --- (14 headers 14 lines) --- Sending to 80.73.85.134:5081 (NAT) Sending to 80.73.85.134:5081 (NAT) Using INVITE request as basis request

1. Имеем FreePBX 13 Distro в Hyper-V;
2. Имеем trunk;
3. Extension 121;
4. Исходящие и входящие работают, все замечательно;
5. Настроил в Extension 121 - leb6zzenynkfgczhgudfgnyuncmfe5zu@SoftX3000 Found peer 'Rostelecom' for '9142759592' from 80.73.85.134:5081 == Using SIP RTP TOS bits 184 == Using SIP RTP CoS mark 5 Found RTP audio format 8 Found RTP audio format 0 Found RTP audio format 18 Found RTP audio format 4 Found RTP audio format 97 Found audio description format PCMA for ID 8 Found audio description format PCMU for ID 0 Found audio description format G729 for ID 18 Found audio description format G723 for ID 4 Found audio description format telephone-event for ID 97 Capabilities: us - (alaw|ulaw), peer - audio=(ulaw|g723|alaw|g729)/video=(nothing)/text=(nothing), combined - (alaw|ulaw) Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x1 (telephone-event|), combined - 0x1 (telephone-event|) Peer audio RTP is at port 80.73.85.134:23818 Looking for 460644 in from-trunk (domain fedorova) siproutedump: route/path hop: <sip:9142759592@80.73.85.134:5081;transport=udp> RDNIS for this call is 401111 (reason unconditional)
   Follow Me, чтобы после 10 сек. FBX отправлял вызов на сотовый номер оператора 8914ХХХХХХХ#, звонок не приходит, в консоли вижу что каждые 2 секунды происходит будто звонящий звонит и сбрасывается вызов, ни привета ни ответа на сотовом телефоне.
6. Настроил по данному совету http://asterisk-support.ru/question/51919/pereadresatsiia-na-vneshnii-nomer/ не помогло, звонящий звонит, срабатывает быстрый гудок 1 раз и сразу же сбрасывается.

<--- Transmitting (NAT) to 80.73.85.134:5081 ---> SIP/2.0 100 Trying Via: SIP/2.0/UDP 80.73.85.134:5081;branch=z9hG4bK950o5d20bgg0tg0at441.1;received=80.73.85.134;rport=5081 From: <sip:9142759592@80.73.85.134;user=phone;cpc-rus=1>;tag=6udm56hk-CC-23 To: <sip:401111@188.244.188.183;user=phone> Call-ID: leb6zzenynkfgczhgudfgnyuncmfe5zu@SoftX3000 CSeq: 1 INVITE Server: FPBX-13.0.190.11(13.12.1) Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE Supported: replaces, timer Contact: <sip:460644@188.244.188.183:5060> Content-Length: 0

7. Я не знаю что вам присылать чтоб было понятно Вам, напишите мне пожалуйста какая информация Вам нужна.

<------------> -- Executing [460644@from-trunk:1] Set("SIP/Rostelecom-0000013f", "DIRECTION=INBOUND") in new stack -- Executing [460644@from-trunk:2] Gosub("SIP/Rostelecom-0000013f", "sub-record-check,s,1(in,460644,dontcare)") in new stack -- Executing [s@sub-record-check:1] GotoIf("SIP/Rostelecom-0000013f", "0?initialized") in new stack -- Executing [s@sub-record-check:2] Set("SIP/Rostelecom-0000013f", "RECSTATUS=INITIALIZED") in new stack -- Executing [s@sub-record-check:3] Set("SIP/Rostelecom-0000013f", "NOW=1486543839") in new stack -- Executing [s@sub-record-check:4] Set("SIP/Rostelecom-0000013f", "DAY=08") in new stack -- Executing [s@sub-record-check:5] Set("SIP/Rostelecom-0000013f", "MONTH=02") in new stack -- Executing [s@sub-record-check:6] Set("SIP/Rostelecom-0000013f", "YEAR=2017") in new stack -- Executing [s@sub-record-check:7] Set("SIP/Rostelecom-0000013f", "TIMESTR=20170208-175039") in new stack -- Executing [s@sub-record-check:8] Set("SIP/Rostelecom-0000013f", "FROMEXTEN=unknown") in new stack -- Executing [s@sub-record-check:9] Set("SIP/Rostelecom-0000013f", "MONFMT=wav") in new stack -- Executing [s@sub-record-check:10] NoOp("SIP/Rostelecom-0000013f", "Recordings initialized") in new stack -- Executing [s@sub-record-check:11] ExecIf("SIP/Rostelecom-0000013f", "0?Set(ARG3=dontcare)") in new stack -- Executing [s@sub-record-check:12] Set("SIP/Rostelecom-0000013f", "RECPOLICYMODESAVE=") in new stack -- Executing [s@sub-record-check:13] ExecIf("SIP/Rostelecom-0000013f", "0?Set(RECSTATUS=NO)") in new stack -- Executing [s@sub-record-check:14] GotoIf("SIP/Rostelecom-0000013f", "2?checkaction") in new stack -- Goto (sub-record-check,s,17) -- Executing [s@sub-record-check:17] GotoIf("SIP/Rostelecom-0000013f", "1?sub-record-check,in,1") in new stack -- Goto (sub-record-check,in,1) -- Executing [in@sub-record-check:1] NoOp("SIP/Rostelecom-0000013f", "Inbound Recording Check to 460644") in new stack -- Executing [in@sub-record-check:2] Set("SIP/Rostelecom-0000013f", "FROMEXTEN=unknown") in new stack -- Executing [in@sub-record-check:3] ExecIf("SIP/Rostelecom-0000013f", "10?Set(FROMEXTEN=9142759592)") in new stack -- Executing [in@sub-record-check:4] Gosub("SIP/Rostelecom-0000013f", "recordcheck,1(dontcare,in,460644)") in new stack -- Executing [recordcheck@sub-record-check:1] NoOp("SIP/Rostelecom-0000013f", "Starting recording check against dontcare") in new stack -- Executing [recordcheck@sub-record-check:2] Goto("SIP/Rostelecom-0000013f", "dontcare") in new stack -- Goto (sub-record-check,recordcheck,3) -- Executing [recordcheck@sub-record-check:3] Return("SIP/Rostelecom-0000013f", "") in new stack -- Executing [in@sub-record-check:5] Return("SIP/Rostelecom-0000013f", "") in new stack -- Executing [460644@from-trunk:3] Gosub("SIP/Rostelecom-0000013f", "app-blacklist-check,s,1()") in new stack -- Executing [s@app-blacklist-check:1] GotoIf("SIP/Rostelecom-0000013f", "0?blacklisted") in new stack -- Executing [s@app-blacklist-check:2] Set("SIP/Rostelecom-0000013f", "CALLEDBLACKLIST=1") in new stack -- Executing [s@app-blacklist-check:3] Return("SIP/Rostelecom-0000013f", "") in new stack -- Executing [460644@from-trunk:4] Set("SIP/Rostelecom-0000013f", "FROMDID=460644") in new stack -- Executing [460644@from-trunk:5] Set("SIP/Rostelecom-0000013f", "CDR(did)=460644") in new stack -- Executing [460644@from-trunk:6] ExecIf("SIP/Rostelecom-0000013f", "1 ?Set(CALLERID(name)=9142759592)") in new stack -- Executing [460644@from-trunk:7] Set("SIP/Rostelecom-0000013f", "MOHCLASS=") in new stack -- Executing [460644@from-trunk:8] Set("SIP/Rostelecom-0000013f", "REVERSALREJECT=FALSE") in new stack -- Executing [460644@from-trunk:9] GotoIf("SIP/Rostelecom-0000013f", "1?post-reverse-charge") in new stack -- Goto (from-trunk,460644,11) -- Executing [460644@from-trunk:11] NoOp("SIP/Rostelecom-0000013f", "") in new stack -- Executing [460644@from-trunk:12] Set("SIP/Rostelecom-0000013f", "CALLINGNAMEPRESSV=allowednotscreened") in new stack -- Executing [460644@from-trunk:13] Set("SIP/Rostelecom-0000013f", "CALLINGNUMPRESSV=allowednotscreened") in new stack -- Executing [460644@from-trunk:14] Set("SIP/Rostelecom-0000013f", "CALLERID(name-pres)=allowednotscreened") in new stack -- Executing [460644@from-trunk:15] Set("SIP/Rostelecom-0000013f", "CALLERID(num-pres)=allowednotscreened") in new stack -- Executing [460644@from-trunk:16] NoOp("SIP/Rostelecom-0000013f", "CallerID Entry Point") in new stack -- Executing [460644@from-trunk:17] Goto("SIP/Rostelecom-0000013f", "ivr-1,s,1") in new stack -- Goto (ivr-1,s,1) -- Executing [s@ivr-1:1] Set("SIP/Rostelecom-0000013f", "INVALIDLOOPCOUNT=0") in new stack -- Executing [s@ivr-1:2] Set("SIP/Rostelecom-0000013f", "IVRCONTEXTivr-1=") in new stack -- Executing [s@ivr-1:3] Set("SIP/Rostelecom-0000013f", "IVRCONTEXT=ivr-1") in new stack -- Executing [s@ivr-1:4] Set("SIP/Rostelecom-0000013f", "IVRRETVM=") in new stack -- Executing [s@ivr-1:5] GotoIf("SIP/Rostelecom-0000013f", "0?skip") in new stack -- Executing [s@ivr-1:6] Answer("SIP/Rostelecom-0000013f", "") in new stack Audio is at 17492 Adding codec alaw to SDP Adding codec ulaw to SDP Adding non-codec 0x1 (telephone-event) to SDP

<--- Reliably Transmitting (NAT) to 80.73.85.134:5081 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP 80.73.85.134:5081;branch=z9hG4bK950o5d20bgg0tg0at441.1;received=80.73.85.134;rport=5081 From: <sip:9142759592@80.73.85.134;user=phone;cpc-rus=1>;tag=6udm56hk-CC-23 To: <sip:401111@188.244.188.183;user=phone>;tag=as58697ce0 Call-ID: leb6zzenynkfgczhgudfgnyuncmfe5zu@SoftX3000 CSeq: 1 INVITE Server: FPBX-13.0.190.11(13.12.1) Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE Supported: replaces, timer Contact: <sip:460644@188.244.188.183:5060> Content-Type: application/sdp Content-Length: 277

v=0 o=root 412634871 412634871 IN IP4 188.244.188.183 s=Asterisk PBX 13.12.1 c=IN IP4 188.244.188.183 t=0 0 m=audio 17492 RTP/AVP 8 0 97 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:97 telephone-event/8000 a=fmtp:97 0-16 a=ptime:20 a=maxptime:150 a=sendrecv

<------------> Retransmitting #1 (NAT) to 80.73.85.134:5081: SIP/2.0 200 OK Via: SIP/2.0/UDP 80.73.85.134:5081;branch=z9hG4bK950o5d20bgg0tg0at441.1;received=80.73.85.134;rport=5081 From: <sip:9142759592@80.73.85.134;user=phone;cpc-rus=1>;tag=6udm56hk-CC-23 To: <sip:401111@188.244.188.183;user=phone>;tag=as58697ce0 Call-ID: leb6zzenynkfgczhgudfgnyuncmfe5zu@SoftX3000 CSeq: 1 INVITE Server: FPBX-13.0.190.11(13.12.1) Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE Supported: replaces, timer Contact: <sip:460644@188.244.188.183:5060> Content-Type: application/sdp Content-Length: 277

v=0 o=root 412634871 412634871 IN IP4 188.244.188.183 s=Asterisk PBX 13.12.1 c=IN IP4 188.244.188.183 t=0 0 m=audio 17492 RTP/AVP 8 0 97 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:97 telephone-event/8000 a=fmtp:97 0-16 a=ptime:20 a=maxptime:150 a=sendrecv

---

   > 0x7f6988b58400 -- Probation passed - setting RTP source address to 80.73.85.134:23818
-- Executing [s@ivr-1:7] Wait("SIP/Rostelecom-0000013f", "1") in new stack

<--- SIP read from UDP:80.73.85.134:5081 ---> ACK sip:460644@188.244.188.183:5060 SIP/2.0 Via: SIP/2.0/UDP 80.73.85.134:5081;branch=z9hG4bKi52okk2030ag9hkem341.1 Call-ID: leb6zzenynkfgczhgudfgnyuncmfe5zu@SoftX3000 From: <sip:9142759592@80.73.85.134;user=phone;cpc-rus=1>;tag=6udm56hk-CC-23 To: <sip:401111@188.244.188.183;user=phone>;tag=as58697ce0 CSeq: 1 ACK Max-Forwards: 69 Content-Length: 0

<-------------> --- (8 headers 0 lines) ---

<--- SIP read from UDP:80.73.85.134:5081 ---> ACK sip:460644@188.244.188.183:5060 SIP/2.0 Via: SIP/2.0/UDP 80.73.85.134:5081;branch=z9hG4bKi52okk2030ag9hkem341.1 Call-ID: leb6zzenynkfgczhgudfgnyuncmfe5zu@SoftX3000 From: <sip:9142759592@80.73.85.134;user=phone;cpc-rus=1>;tag=6udm56hk-CC-23 To: <sip:401111@188.244.188.183;user=phone>;tag=as58697ce0 CSeq: 1 ACK Max-Forwards: 69 Content-Length: 0

<-------------> --- (8 headers 0 lines) --- -- Executing [s@ivr-1:8] Set("SIP/Rostelecom-0000013f", "IVR_MSG=custom/1") in new stack -- Executing [s@ivr-1:9] Set("SIP/Rostelecom-0000013f", "TIMEOUT(digit)=3") in new stack -- Digit timeout set to 3.000 -- Executing [s@ivr-1:10] ExecIf("SIP/Rostelecom-0000013f", "1?Background(custom/1)") in new stack -- <sip rostelecom-0000013f=""> Playing 'custom/1.slin' (language 'ru') Reliably Transmitting (NAT) to 80.73.85.134:5081: OPTIONS sip:80.73.85.134 SIP/2.0 Via: SIP/2.0/UDP 188.244.188.183:5060;branch=z9hG4bK01c9efee;rport Max-Forwards: 70 From: "Unknown" <sip:unknown@188.244.188.183>;tag=as0624c383 To: <sip:80.73.85.134> Contact: <sip:unknown@188.244.188.183:5060> Call-ID: 0f76ffbc79a6da762ed3c86243bb8b10@188.244.188.183:5060 CSeq: 102 OPTIONS User-Agent: FPBX-13.0.190.11(13.12.1) Date: Wed, 08 Feb 2017 08:50:42 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE Supported: replaces, timer Content-Length: 0

---

<--- SIP read from UDP:80.73.85.134:5081 ---> SIP/2.0 480 No Routes Found Via: SIP/2.0/UDP 188.244.188.183:5060;received=188.244.188.183;branch=z9hG4bK01c9efee;rport=5060 From: "Unknown" <sip:unknown@188.244.188.183>;tag=as0624c383 To: <sip:80.73.85.134>;tag=aprqngfrt-grhffl20000c6 Call-ID: 0f76ffbc79a6da762ed3c86243bb8b10@188.244.188.183:5060 CSeq: 102 OPTIONS

<-------------> --- (6 headers 0 lines) --- Really destroying SIP dialog '0f76ffbc79a6da762ed3c86243bb8b10@188.244.188.183:5060' Method: OPTIONS -- Executing [9@ivr-1:1] Goto("SIP/Rostelecom-0000013f", "from-did-direct,121,1") in new stack -- Goto (from-did-direct,121,1) -- Executing [121@from-did-direct:1] GotoIf("SIP/Rostelecom-0000013f", "0?ext-local,121,1:followme-check,121,1") in new stack -- Goto (followme-check,121,1) -- Executing [121@followme-check:1] Gosub("SIP/Rostelecom-0000013f", "followme-sub,121,1()") in new stack -- Executing [121@followme-sub:1] Macro("SIP/Rostelecom-0000013f", "user-callerid,") in new stack -- Executing [s@macro-user-callerid:1] Set("SIP/Rostelecom-0000013f", "TOUCHMONITOR=1486543839.533") in new stack -- Executing [s@macro-user-callerid:2] Set("SIP/Rostelecom-0000013f", "AMPUSER=9142759592") in new stack -- Executing [s@macro-user-callerid:3] GotoIf("SIP/Rostelecom-0000013f", "0?report") in new stack -- Executing [s@macro-user-callerid:4] ExecIf("SIP/Rostelecom-0000013f", "1?Set(REALCALLERIDNUM=9142759592)") in new stack -- Executing [s@macro-user-callerid:5] Set("SIP/Rostelecom-0000013f", "AMPUSER=") in new stack -- Executing [s@macro-user-callerid:6] GotoIf("SIP/Rostelecom-0000013f", "0?limit") in new stack -- Executing [s@macro-user-callerid:7] Set("SIP/Rostelecom-0000013f", "AMPUSERCIDNAME=") in new stack -- Executing [s@macro-user-callerid:8] GotoIf("SIP/Rostelecom-0000013f", "1?report") in new stack -- Goto (macro-user-callerid,s,15) -- Executing [s@macro-user-callerid:15] GotoIf("SIP/Rostelecom-0000013f", "0?continue") in new stack -- Executing [s@macro-user-callerid:16] ExecIf("SIP/Rostelecom-0000013f", "1?Set(CALLEEACCOUNCODE=)") in new stack -- Executing [s@macro-user-callerid:17] Set("SIP/Rostelecom-0000013f", "TTL=64") in new stack -- Executing [s@macro-user-callerid:18] GotoIf("SIP/Rostelecom-0000013f", "1?continue") in new stack -- Goto (macro-user-callerid,s,29) -- Executing [s@macro-user-callerid:29] Set("SIP/Rostelecom-0000013f", "CALLERID(number)=9142759592") in new stack -- Executing [s@macro-user-callerid:30] Set("SIP/Rostelecom-0000013f", "CALLERID(name)=9142759592") in new stack -- Executing [s@macro-user-callerid:31] GotoIf("SIP/Rostelecom-0000013f", "0?cnum") in new stack -- Executing [s@macro-user-callerid:32] Set("SIP/Rostelecom-0000013f", "CDR(cnam)=9142759592") in new stack -- Executing [s@macro-user-callerid:33] Set("SIP/Rostelecom-0000013f", "CDR(cnum)=9142759592") in new stack -- Executing [s@macro-user-callerid:34] Set("SIP/Rostelecom-0000013f", "CHANNEL(language)=ru") in new stack -- Executing [121@followme-sub:2] Set("SIP/Rostelecom-0000013f", "DIALOPTIONS=TtrI") in new stack -- Executing [121@followme-sub:3] Set("SIP/Rostelecom-0000013f", "CONNECTEDLINE(num,i)=121") in new stack -- Executing [121@followme-sub:4] Gosub("SIP/Rostelecom-0000013f", "sub-presencestate-display,s,1(121)") in new stack -- Executing [s@sub-presencestate-display:1] Goto("SIP/Rostelecom-0000013f", "state-notset,1") in new stack -- Goto (sub-presencestate-display,state-notset,1) -- Executing [state-notset@sub-presencestate-display:1] Set("SIP/Rostelecom-0000013f", "PRESENCESTATEDISPLAY=") in new stack -- Executing [state-notset@sub-presencestate-display:2] Return("SIP/Rostelecom-0000013f", "") in new stack -- Executing [121@followme-sub:5] Set("SIP/Rostelecom-0000013f", "CONNECTEDLINE(name)=1. ДК Автодорожная 7") in new stack -- Executing [121@followme-sub:6] Set("SIP/Rostelecom-0000013f", "FMDIALSTATUS=NOTINUSE") in new stack -- Executing [121@followme-sub:7] Set("SIP/Rostelecom-0000013f", "EXTTOCALL=121") in new stack -- Executing [121@followme-sub:8] Set("SIP/Rostelecom-0000013f", "PICKUPMARK=121") in new stack -- Executing [121@followme-sub:9] Macro("SIP/Rostelecom-0000013f", "blkvm-setifempty,") in new stack -- Executing [s@macro-blkvm-setifempty:1] GotoIf("SIP/Rostelecom-0000013f", "1?init") in new stack -- Goto (macro-blkvm-setifempty,s,4) -- Executing [s@macro-blkvm-setifempty:4] Set("SIP/Rostelecom-0000013f", "BLKVMCHANNEL=SIP/Rostelecom-0000013f") in new stack -- Executing [s@macro-blkvm-setifempty:5] Set("SIP/Rostelecom-0000013f", "SHARED(BLKVM,SIP/Rostelecom-0000013f)=TRUE") in new stack -- Executing [s@macro-blkvm-setifempty:6] Set("SIP/Rostelecom-0000013f", "GOSUBRETVAL=TRUE") in new stack -- Executing [s@macro-blkvm-setifempty:7] MacroExit("SIP/Rostelecom-0000013f", "") in new stack -- Executing [121@followme-sub:10] GotoIf("SIP/Rostelecom-0000013f", "1?skipov") in new stack -- Goto (followme-sub,121,13) -- Executing [121@followme-sub:13] Set("SIP/Rostelecom-0000013f", "RRNODEST=") in new stack -- Executing [121@followme-sub:14] Set("SIP/Rostelecom-0000013f", "NODEST=121") in new stack -- Executing [121@followme-sub:15] GosubIf("SIP/Rostelecom-0000013f", "1?sub-fmsetcid,s,1()") in new stack -- Executing [s@sub-fmsetcid:1] Goto("SIP/Rostelecom-0000013f", "s-did,1") in new stack -- Goto (sub-fmsetcid,s-did,1) -- Executing [s-did@sub-fmsetcid:1] ExecIf("SIP/Rostelecom-0000013f", "1?Set(REALCALLERIDNUM=460644)") in new stack -- Executing [s-did@sub-fmsetcid:2] Return("SIP/Rostelecom-0000013f", "") in new stack -- Executing [121@followme-sub:16] GotoIf("SIP/Rostelecom-0000013f", "1?skipprepend") in new stack -- Goto (followme-sub,121,18) -- Executing [121@followme-sub:18] Set("SIP/Rostelecom-0000013f", "RecordMethod=Group") in new stack -- Executing [121@followme-sub:19] Gosub("SIP/Rostelecom-0000013f", "sub-record-check,s,1(exten,121,)") in new stack -- Executing [s@sub-record-check:1] GotoIf("SIP/Rostelecom-0000013f", "10?initialized") in new stack -- Goto (sub-record-check,s,10) -- Executing [s@sub-record-check:10] NoOp("SIP/Rostelecom-0000013f", "Recordings initialized") in new stack -- Executing [s@sub-record-check:11] ExecIf("SIP/Rostelecom-0000013f", "1?Set(ARG3=dontcare)") in new stack -- Executing [s@sub-record-check:12] Set("SIP/Rostelecom-0000013f", "RECPOLICYMODESAVE=") in new stack -- Executing [s@sub-record-check:13] ExecIf("SIP/Rostelecom-0000013f", "0?Set(RECSTATUS=NO)") in new stack -- Executing [s@sub-record-check:14] GotoIf("SIP/Rostelecom-0000013f", "5?checkaction") in new stack -- Goto (sub-record-check,s,17) -- Executing [s@sub-record-check:17] GotoIf("SIP/Rostelecom-0000013f", "1?sub-record-check,exten,1") in new stack -- Goto (sub-record-check,exten,1) -- Executing [exten@sub-record-check:1] NoOp("SIP/Rostelecom-0000013f", "Exten Recording Check between 9142759592 and 121") in new stack -- Executing [exten@sub-record-check:2] Set("SIP/Rostelecom-0000013f", "CALLTYPE=external") in new stack -- Executing [exten@sub-record-check:3] ExecIf("SIP/Rostelecom-0000013f", "0?Set(CALLTYPE=)") in new stack -- Executing [exten@sub-record-check:4] Set("SIP/Rostelecom-0000013f", "CALLEE=dontcare") in new stack -- Executing [exten@sub-record-check:5] ExecIf("SIP/Rostelecom-0000013f", "0?Set(CALLEE=dontcare)") in new stack -- Executing [exten@sub-record-check:6] GotoIf("SIP/Rostelecom-0000013f", "1?callee") in new stack -- Goto (sub-record-check,exten,11) -- Executing [exten@sub-record-check:11] Gosub("SIP/Rostelecom-0000013f", "recordcheck,1(dontcare,external,121)") in new stack -- Executing [recordcheck@sub-record-check:1] NoOp("SIP/Rostelecom-0000013f", "Starting recording check against dontcare") in new stack -- Executing [recordcheck@sub-record-check:2] Goto("SIP/Rostelecom-0000013f", "dontcare") in new stack -- Goto (sub-record-check,recordcheck,3) -- Executing [recordcheck@sub-record-check:3] Return("SIP/Rostelecom-0000013f", "") in new stack -- Executing [exten@sub-record-check:12] Return("SIP/Rostelecom-0000013f", "") in new stack -- Executing [121@followme-sub:20] GotoIf("SIP/Rostelecom-0000013f", "1?skipdring") in new stack -- Goto (followme-sub,121,23) -- Executing [121@followme-sub:23] Set("SIP/Rostelecom-0000013f", "STRATEGY=hunt") in new stack -- Executing [121@followme-sub:24] Set("SIP/Rostelecom-0000013f", "RVOL=") in new stack -- Executing [121@followme-sub:25] GotoIf("SIP/Rostelecom-0000013f", "0?skipsimple") in new stack -- Executing [121@followme-sub:26] GotoIf("SIP/Rostelecom-0000013f", "0 ?skipsimple") in new stack -- Executing [121@followme-sub:27] Macro("SIP/Rostelecom-0000013f", "simple-dial,121,20") in new stack -- Executing [s@macro-simple-dial:1] Set("SIP/Rostelecom-0000013f", "EXTTOCALL=121") in new stack -- Executing [s@macro-simple-dial:2] Set("SIP/Rostelecom-0000013f", "RT=20") in new stack -- Executing [s@macro-simple-dial:3] Set("SIP/Rostelecom-0000013f", "CFUEXT=") in new stack -- Executing [s@macro-simple-dial:4] Set("SIP/Rostelecom-0000013f", "CFBEXT=") in new stack -- Executing [s@macro-simple-dial:5] Set("SIP/Rostelecom-0000013f", "CWITMP=") in new stack -- Executing [s@macro-simple-dial:6] Macro("SIP/Rostelecom-0000013f", "dial-one,20,TtrI,121") in new stack -- Executing [s@macro-dial-one:1] Set("SIP/Rostelecom-0000013f", "DEXTEN=121") in new stack -- Executing [s@macro-dial-one:2] ExecIf("SIP/Rostelecom-0000013f", "0?Set(EXTTOCALL=121)") in new stack -- Executing [s@macro-dial-one:3] Set("SIP/Rostelecom-0000013f", "DIALSTATUSCW=") in new stack -- Executing [s@macro-dial-one:4] GosubIf("SIP/Rostelecom-0000013f", "0?screen,1()") in new stack -- Executing [s@macro-dial-one:5] GosubIf("SIP/Rostelecom-0000013f", "0?cf,1()") in new stack -- Executing [s@macro-dial-one:6] GotoIf("SIP/Rostelecom-0000013f", "1?skip1") in new stack -- Goto (macro-dial-one,s,9) -- Executing [s@macro-dial-one:9] GotoIf("SIP/Rostelecom-0000013f", "0?nodial") in new stack -- Executing [s@macro-dial-one:10] GotoIf("SIP/Rostelecom-0000013f", "0?continue") in new stack -- Executing [s@macro-dial-one:11] Set("SIP/Rostelecom-0000013f", "EXTHASCW=ENABLED") in new stack -- Executing [s@macro-dial-one:12] GotoIf("SIP/Rostelecom-0000013f", "0?next1:cwinusebusy") in new stack -- Goto (macro-dial-one,s,24) -- Executing [s@macro-dial-one:24] GotoIf("SIP/Rostelecom-0000013f", "0?next3:continue") in new stack -- Goto (macro-dial-one,s,26) -- Executing [s@macro-dial-one:26] GotoIf("SIP/Rostelecom-0000013f", "0?nodial") in new stack -- Executing [s@macro-dial-one:27] GosubIf("SIP/Rostelecom-0000013f", "1?dstring,1():dlocal,1()") in new stack -- Executing [dstring@macro-dial-one:1] Set("SIP/Rostelecom-0000013f", "DSTRING=") in new stack -- Executing [dstring@macro-dial-one:2] Set("SIP/Rostelecom-0000013f", "DEVICES=121") in new stack -- Executing [dstring@macro-dial-one:3] ExecIf("SIP/Rostelecom-0000013f", "0?Return()") in new stack -- Executing [dstring@macro-dial-one:4] ExecIf("SIP/Rostelecom-0000013f", "0?Set(DEVICES=21)") in new stack -- Executing [dstring@macro-dial-one:5] Set("SIP/Rostelecom-0000013f", "LOOPCNT=1") in new stack -- Executing [dstring@macro-dial-one:6] Set("SIP/Rostelecom-0000013f", "ITER=1") in new stack -- Executing [dstring@macro-dial-one:7] Set("SIP/Rostelecom-0000013f", "THISDIAL=SIP/Rostelecom/450179") in new stack -- Executing [dstring@macro-dial-one:8] GosubIf("SIP/Rostelecom-0000013f", "1?zap2dahdi,1()") in new stack -- Executing [zap2dahdi@macro-dial-one:1] ExecIf("SIP/Rostelecom-0000013f", "0?Return()") in new stack -- Executing [zap2dahdi@macro-dial-one:2] Set("SIP/Rostelecom-0000013f", "NEWDIAL=") in new stack -- Executing [zap2dahdi@macro-dial-one:3] Set("SIP/Rostelecom-0000013f", "LOOPCNT2=1") in new stack -- Executing [zap2dahdi@macro-dial-one:4] Set("SIP/Rostelecom-0000013f", "ITER2=1") in new stack -- Executing [zap2dahdi@macro-dial-one:5] Set("SIP/Rostelecom-0000013f", "THISPART2=SIP/Rostelecom/450179") in new stack -- Executing [zap2dahdi@macro-dial-one:6] ExecIf("SIP/Rostelecom-0000013f", "0?Set(THISPART2=DAHDI/Rostelecom/450179)") in new stack -- Executing [zap2dahdi@macro-dial-one:7] Set("SIP/Rostelecom-0000013f", "NEWDIAL=SIP/Rostelecom/450179&") in new stack -- Executing [zap2dahdi@macro-dial-one:8] Set("SIP/Rostelecom-0000013f", "ITER2=2") in new stack -- Executing [zap2dahdi@macro-dial-one:9] GotoIf("SIP/Rostelecom-0000013f", "0?begin2") in new stack -- Executing [zap2dahdi@macro-dial-one:10] Set("SIP/Rostelecom-0000013f", "THISDIAL=SIP/Rostelecom/450179") in new stack -- Executing [zap2dahdi@macro-dial-one:11] Return("SIP/Rostelecom-0000013f", "") in new stack -- Executing [dstring@macro-dial-one:9] GotoIf("SIP/Rostelecom-0000013f", "1?docheck") in new stack -- Goto (macro-dial-one,dstring,14) -- Executing [dstring@macro-dial-one:14] GotoIf("SIP/Rostelecom-0000013f", "0?skipset") in new stack -- Executing [dstring@macro-dial-one:15] Set("SIP/Rostelecom-0000013f", "DSTRING=SIP/Rostelecom/450179&") in new stack -- Executing [dstring@macro-dial-one:16] Set("SIP/Rostelecom-0000013f", "ITER=2") in new stack -- Executing [dstring@macro-dial-one:17] GotoIf("SIP/Rostelecom-0000013f", "0?begin") in new stack -- Executing [dstring@macro-dial-one:18] ExecIf("SIP/Rostelecom-0000013f", "0?Return()") in new stack -- Executing [dstring@macro-dial-one:19] Set("SIP/Rostelecom-0000013f", "DSTRING=SIP/Rostelecom/450179") in new stack -- Executing [dstring@macro-dial-one:20] Return("SIP/Rostelecom-0000013f", "") in new stack -- Executing [s@macro-dial-one:28] GotoIf("SIP/Rostelecom-0000013f", "0?nodial") in new stack -- Executing [s@macro-dial-one:29] GotoIf("SIP/Rostelecom-0000013f", "0?skiptrace") in new stack -- Executing [s@macro-dial-one:30] GosubIf("SIP/Rostelecom-0000013f", "1?ctset,1():ctclear,1()") in new stack -- Executing [ctset@macro-dial-one:1] Set("SIP/Rostelecom-0000013f", "DB(CALLTRACE/121)=9142759592") in new stack -- Executing [ctset@macro-dial-one:2] Return("SIP/Rostelecom-0000013f", "") in new stack -- Executing [s@macro-dial-one:31] Set("SIP/Rostelecom-0000013f", "DOPTIONS=TtrIM(auto-blkvm)") in new stack -- Executing [s@macro-dial-one:32] NoOp("SIP/Rostelecom-0000013f", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack -- Executing [s@macro-dial-one:33] ExecIf("SIP/Rostelecom-0000013f", "0?Set(ALERTINFO=)") in new stack -- Executing [s@macro-dial-one:34] ExecIf("SIP/Rostelecom-0000013f", "0?Set(ALERTINFO=)") in new stack -- Executing [s@macro-dial-one:35] ExecIf("SIP/Rostelecom-0000013f", "0?Set(ALERTINFO=)") in new stack -- Executing [s@macro-dial-one:36] ExecIf("SIP/Rostelecom-0000013f", "0?Set(ALERTINFO=;volume=)") in new stack -- Executing [s@macro-dial-one:37] ExecIf("SIP/Rostelecom-0000013f", "0?Set(ALERTINFO=;volume=)") in new stack -- Executing [s@macro-dial-one:38] GosubIf("SIP/Rostelecom-0000013f", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack -- Executing [s@macro-dial-one:39] ExecIf("SIP/Rostelecom-0000013f", "0?Set(CHANNEL(musicclass)=)") in new stack -- Executing [s@macro-dial-one:40] GosubIf("SIP/Rostelecom-0000013f", "0?qwait,1()") in new stack -- Executing [s@macro-dial-one:41] Set("SIP/Rostelecom-0000013f", "CWIGNORE=") in new stack -- Executing [s@macro-dial-one:42] Set("SIP/Rostelecom-0000013f", "KEEPCID=TRUE") in new stack -- Executing [s@macro-dial-one:43] GotoIf("SIP/Rostelecom-0000013f", "0?usegoto,1") in new stack -- Executing [s@macro-dial-one:44] GotoIf("SIP/Rostelecom-0000013f", "1?godial") in new stack -- Goto (macro-dial-one,s,49) -- Executing [s@macro-dial-one:49] Macro("SIP/Rostelecom-0000013f", "dialout-one-predial-hook,") in new stack -- Executing [s@macro-dialout-one-predial-hook:1] MacroExit("SIP/Rostelecom-0000013f", "") in new stack -- Executing [s@macro-dial-one:50] ExecIf("SIP/Rostelecom-0000013f", "1?Set(DOPTIONS=trIM(auto-blkvm)I)") in new stack -- Executing [s@macro-dial-one:51] Dial("SIP/Rostelecom-0000013f", "SIP/Rostelecom/450179,20,trIM(auto-blkvm)Ib(func-apply-sipheaders^s^1)") in new stack == Using SIP RTP TOS bits 184 == Using SIP RTP CoS mark 5 -- SIP/Rostelecom-00000140 Internal Gosub(func-apply-sipheaders,s,1) start -- Executing [s@func-apply-sipheaders:1] NoOp("SIP/Rostelecom-00000140", "Applying SIP Headers to channel") in new stack -- Executing [s@func-apply-sipheaders:2] Set("SIP/Rostelecom-00000140", "SIPHEADERKEYS=") in new stack -- Executing [s@func-apply-sipheaders:3] While("SIP/Rostelecom-00000140", "0") in new stack -- Jumping to priority 7 -- Executing [s@func-apply-sipheaders:8] Return("SIP/Rostelecom-00000140", "") in new stack == Spawn extension (from-trunk, 121, 1) exited non-zero on 'SIP/Rostelecom-00000140' -- SIP/Rostelecom-00000140 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUBRETVAL= Audio is at 10830 Adding codec alaw to SDP Adding codec ulaw to SDP Adding non-codec 0x1 (telephone-event) to SDP Reliably Transmitting (NAT) to 80.73.85.134:5081: INVITE sip:450179@80.73.85.134:5081 SIP/2.0 Via: SIP/2.0/UDP 188.244.188.183:5060;branch=z9hG4bK3eb13442;rport Max-Forwards: 70 From: "9142759592" <sip:9142759592@188.244.188.183>;tag=as274cd934 To: <sip:450179@80.73.85.134:5081> Contact: <sip:9142759592@188.244.188.183:5060> Call-ID: 147b2230281aed6a0262b42e2950bc7c@188.244.188.183:5060 CSeq: 102 INVITE User-Agent: FPBX-13.0.190.11(13.12.1) Date: Wed, 08 Feb 2017 08:50:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE Supported: replaces, timer Diversion: <sip:401111@188.244.188.183>;reason=unconditional Content-Type: application/sdp Content-Length: 280

v=0 o=root 351539843 351539843 IN IP4 188.244.188.183 s=Asterisk PBX 13.12.1 c=IN IP4 188.244.188.183 t=0 0 m=audio 10830 RTP/AVP 8 0 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=maxptime:150 a=sendrecv

---

-- Called SIP/Rostelecom/450179

Retransmitting #1 (NAT) to 80.73.85.134:5081: INVITE sip:450179@80.73.85.134:5081 SIP/2.0 Via: SIP/2.0/UDP 188.244.188.183:5060;branch=z9hG4bK3eb13442;rport Max-Forwards: 70 From: "9142759592" <sip:9142759592@188.244.188.183>;tag=as274cd934 To: <sip:450179@80.73.85.134:5081> Contact: <sip:9142759592@188.244.188.183:5060> Call-ID: 147b2230281aed6a0262b42e2950bc7c@188.244.188.183:5060 CSeq: 102 INVITE User-Agent: FPBX-13.0.190.11(13.12.1) Date: Wed, 08 Feb 2017 08:50:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE Supported: replaces, timer Diversion: <sip:401111@188.244.188.183>;reason=unconditional Content-Type: application/sdp Content-Length: 280

v=0 o=root 351539843 351539843 IN IP4 188.244.188.183 s=Asterisk PBX 13.12.1 c=IN IP4 188.244.188.183 t=0 0 m=audio 10830 RTP/AVP 8 0 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=maxptime:150 a=sendrecv

---

<--- SIP read from UDP:80.73.85.134:5081 ---> SIP/2.0 100 Trying Via: SIP/2.0/UDP 188.244.188.183:5060;received=188.244.188.183;branch=z9hG4bK3eb13442;rport=5060 From: "9142759592" <sip:9142759592@188.244.188.183>;tag=as274cd934 To: <sip:450179@80.73.85.134:5081> Call-ID: 147b2230281aed6a0262b42e2950bc7c@188.244.188.183:5060 CSeq: 102 INVITE

<-------------> --- (6 headers 0 lines) ---

<--- SIP read from UDP:80.73.85.134:5081 ---> SIP/2.0 480 No Routes Found Via: SIP/2.0/UDP 188.244.188.183:5060;received=188.244.188.183;branch=z9hG4bK3eb13442;rport=5060 From: "9142759592" <sip:9142759592@188.244.188.183>;tag=as274cd934 To: <sip:450179@80.73.85.134:5081>;tag=aprqngfrt-1be2jl00000c6 Call-ID: 147b2230281aed6a0262b42e2950bc7c@188.244.188.183:5060 CSeq: 102 INVITE

<-------------> --- (6 headers 0 lines) --- Transmitting (NAT) to 80.73.85.134:5081: ACK sip:450179@80.73.85.134:5081 SIP/2.0 Via: SIP/2.0/UDP 188.244.188.183:5060;branch=z9hG4bK3eb13442;rport Max-Forwards: 70 From: "9142759592" <sip:9142759592@188.244.188.183>;tag=as274cd934 To: <sip:450179@80.73.85.134:5081>;tag=aprqngfrt-1be2jl00000c6 Contact: <sip:9142759592@188.244.188.183:5060> Call-ID: 147b2230281aed6a0262b42e2950bc7c@188.244.188.183:5060 CSeq: 102 ACK User-Agent: FPBX-13.0.190.11(13.12.1) Content-Length: 0

---

-- Redirecting update to SIP/Rostelecom-0000013f prevented.
-- SIP/Rostelecom-00000140 is busy

Scheduling destruction of SIP dialog '147b2230281aed6a0262b42e2950bc7c@188.244.188.183:5060' in 13120 ms (Method: INVITE) == Everyone is busy/congested at this time (1:1/0/0) -- Executing [s@macro-dial-one:52] ExecIf("SIP/Rostelecom-0000013f", "0?MacroExit()") in new stack -- Executing [s@macro-dial-one:53] ExecIf("SIP/Rostelecom-0000013f", "0?Set(DIALSTATUS=)") in new stack -- Executing [s@macro-dial-one:54] GosubIf("SIP/Rostelecom-0000013f", "0?s-BUSY,1()") in new stack -- Executing [s@macro-dial-one:55] MacroExit("SIP/Rostelecom-0000013f", "") in new stack -- Executing [s@macro-simple-dial:7] Set("SIP/Rostelecom-0000013f", "_CWIGNORE=") in new stack -- Executing [s@macro-simple-dial:8] Set("SIP/Rostelecom-0000013f", "PRDIALSTATUS=BUSY") in new stack -- Executing [s@macro-simple-dial:9] GosubIf("SIP/Rostelecom-0000013f", "0?docfu,1()") in new stack -- Executing [s@macro-simple-dial:10] GosubIf("SIP/Rostelecom-0000013f", "0?docfb,1()") in new stack -- Executing [s@macro-simple-dial:11] Set("SIP/Rostelecom-0000013f", "DIALSTATUS=BUSY") in new stack -- Executing [s@macro-simple-dial:12] Goto("SIP/Rostelecom-0000013f", "s-BUSY,1") in new stack -- Goto (macro-simple-dial,s-BUSY,1) -- Executing [s-BUSY@macro-simple-dial:1] NoOp("SIP/Rostelecom-0000013f", "Extension is reporting s-BUSY") in new stack -- Executing [121@followme-sub:28] Set("SIP/Rostelecom-0000013f", "RingGroupMethod=hunt") in new stack -- Executing [121@followme-sub:29] Set("SIP/Rostelecom-0000013f", "FMGRP=121") in new stack -- Executing [121@followme-sub:30] GotoIf("SIP/Rostelecom-0000013f", "1?DIALGRP") in new stack -- Goto (followme-sub,121,34) -- Executing [121@followme-sub:34] ExecIf("SIP/Rostelecom-0000013f", "1?Set(DOPTS=TtrI):Set(DOPTS=m(Ring)TtI)") in new stack -- Executing [121@followme-sub:35] GotoIf("SIP/Rostelecom-0000013f", "0?doconfirm") in new stack -- Executing [121@followme-sub:36] GotoIf("SIP/Rostelecom-0000013f", "0?ringallv21") in new stack -- Executing [121@followme-sub:37] Macro("SIP/Rostelecom-0000013f", "dial,30,TtrI,89679100900#") in new stack -- Executing [s@macro-dial:1] NoOp("SIP/Rostelecom-0000013f", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack -- Executing [s@macro-dial:2] ExecIf("SIP/Rostelecom-0000013f", "0?Set(ALERTINFO=)") in new stack -- Executing [s@macro-dial:3] ExecIf("SIP/Rostelecom-0000013f", "0?Set(ALERTINFO=)") in new stack -- Executing [s@macro-dial:4] ExecIf("SIP/Rostelecom-0000013f", "0?Set(ALERTINFO=)") in new stack -- Executing [s@macro-dial:5] ExecIf("SIP/Rostelecom-0000013f", "0?Set(CHANNEL(musicclass)=)") in new stack -- Executing [s@macro-dial:6] AGI("SIP/Rostelecom-0000013f", "dialparties.agi") in new stack -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi dialparties.agi: Starting New Dialparties.agi dialparties.agi: Caller ID name is '9142759592' number is '9142759592'

dialparties.agi: USECONFIRMATION: 'FALSE' dialparties.agi: RINGGROUPINDEX: '' dialparties.agi: Methodology of ring is 'hunt' -- dialparties.agi: Added extension 89679100900# to extension map -- dialparties.agi: Extension 89679100900# cf is disabled dialparties.agi: extnum 89679100900# has: cw: 0; hascfb: 0 [] hascfu: 0 [] dialparties.agi: Built External dialstring component for 89679100900: Local/89679100900@from-internal/n -- dialparties.agi: Filtered ARG3: 89679100900 dialparties.agi: NODEST: 121 adding M(auto-blkvm) to dialopts: TtrIM(auto-blkvm) dialparties.agi: NODEST: 121 blkvm enabled macro already in dialopts: TtrIM(auto-blkvm) -- <sip rostelecom-0000013f="">AGI Script dialparties.agi completed, returning 0 -- Executing [s@macro-dial:24] NoOp("SIP/Rostelecom-0000013f", "Returned from dialparties with hunt groups to dial") in new stack -- Executing [s@macro-dial:25] Set("SIP/Rostelecom-0000013f", "HuntLoop=0") in new stack -- Executing [s@macro-dial:26] ExecIf("SIP/Rostelecom-0000013f", "0?Set(HuntMembers=0)") in new stack -- Executing [s@macro-dial:27] GotoIf("SIP/Rostelecom-0000013f", "1?a30") in new stack -- Goto (macro-dial,s,30) -- Executing [s@macro-dial:30] Set("SIP/Rostelecom-0000013f", "HuntMember=HuntMember0") in new stack -- Executing [s@macro-dial:31] GotoIf("SIP/Rostelecom-0000013f", "1?a32:a35") in new stack -- Goto (macro-dial,s,32) -- Executing [s@macro-dial:32] Set("SIP/Rostelecom-0000013f", "CTEXTEN=89679100900") in new stack -- Executing [s@macro-dial:33] Set("SIP/Rostelecom-0000013f", "EXTTOCALL=89679100900") in new stack -- Executing [s@macro-dial:34] Set("SIP/Rostelecom-0000013f", "DB(CALLTRACE/89679100900)=9142759592") in new stack -- Executing [s@macro-dial:35] Goto("SIP/Rostelecom-0000013f", "s,huntstart") in new stack -- Goto (macro-dial,s,44) -- Executing [s@macro-dial:44] NoOp("SIP/Rostelecom-0000013f", "Hunt Dial Start") in new stack -- Executing [s@macro-dial:45] ExecIf("SIP/Rostelecom-0000013f", "0?Set(HASH(SIPHEADERS,Alert-Info)=;volume=)") in new stack -- Executing [s@macro-dial:46] ExecIf("SIP/Rostelecom-0000013f", "0?Set(HASH(SIPHEADERS,Alert-Info)=;volume=)") in new stack -- Executing [s@macro-dial:47] Macro("SIP/Rostelecom-0000013f", "dial-hunt-predial-hook,") in new stack -- Executing [s@macro-dial-hunt-predial-hook:1] MacroExit("SIP/Rostelecom-0000013f", "") in new stack -- Executing [s@macro-dial:48] Dial("SIP/Rostelecom-0000013f", "Local/89679100900@from-internal/n,30,trIM(auto-blkvm)b(func-apply-sipheaders^s^1),") in new stack -- Local/89679100900@from-internal-0000006b;1 Internal Gosub(func-apply-sipheaders,s,1) start -- Executing [s@func-apply-sipheaders:1] NoOp("Local/89679100900@from-internal-0000006b;1", "Applying SIP Headers to channel") in new stack -- Executing [s@func-apply-sipheaders:2] Set("Local/89679100900@from-internal-0000006b;1", "SIPHEADERKEYS=") in new stack -- Executing [s@func-apply-sipheaders:3] While("Local/89679100900@from-internal-0000006b;1", "0") in new stack -- Jumping to priority 7 -- Executing [s@func-apply-sipheaders:8] Return("Local/89679100900@from-internal-0000006b;1", "") in new stack == Spawn extension (from-internal, 121, 1) exited non-zero on 'Local/89679100900@from-internal-0000006b;1' -- Local/89679100900@from-internal-0000006b;1 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUBRETVAL= -- Called Local/89679100900@from-internal/n -- Executing [89679100900@from-internal:1] Macro("Local/89679100900@from-internal-0000006b;2", "user-callerid,LIMIT,EXTERNAL,") in new stack -- Executing [s@macro-user-callerid:1] Set("Local/89679100900@from-internal-0000006b;2", "TOUCHMONITOR=1486543850.536") in new stack -- Executing [s@macro-user-callerid:2] Set("Local/89679100900@from-internal-0000006b;2", "AMPUSER=9142759592") in new stack -- Executing [s@macro-user-callerid:3] GotoIf("Local/89679100900@from-internal-0000006b;2", "0?report") in new stack -- Executing [s@macro-user-callerid:4] ExecIf("Local/89679100900@from-internal-0000006b;2", "0?Set(REALCALLERIDNUM=9142759592)") in new stack -- Executing [s@macro-user-callerid:5] Set("Local/89679100900@from-internal-0000006b;2", "AMPUSER=") in new stack -- Executing [s@macro-user-callerid:6] GotoIf("Local/89679100900@from-internal-0000006b;2", "0?limit") in new stack -- Executing [s@macro-user-callerid:7] Set("Local/89679100900@from-internal-0000006b;2", "AMPUSERCIDNAME=") in new stack -- Executing [s@macro-user-callerid:8] GotoIf("Local/89679100900@from-internal-0000006b;2", "1?report") in new stack -- Goto (macro-user-callerid,s,15) -- Executing [s@macro-user-callerid:15] GotoIf("Local/89679100900@from-internal-0000006b;2", "1?continue") in new stack -- Goto (macro-user-callerid,s,29) -- Executing [s@macro-user-callerid:29] Set("Local/89679100900@from-internal-0000006b;2", "CALLERID(number)=9142759592") in new stack -- Executing [s@macro-user-callerid:30] Set("Local/89679100900@from-internal-0000006b;2", "CALLERID(name)=9142759592") in new stack -- Executing [s@macro-user-callerid:31] GotoIf("Local/89679100900@from-internal-0000006b;2", "0?cnum") in new stack -- Executing [s@macro-user-callerid:32] Set("Local/89679100900@from-internal-0000006b;2", "CDR(cnam)=9142759592") in new stack -- Executing [s@macro-user-callerid:33] Set("Local/89679100900@from-internal-0000006b;2", "CDR(cnum)=9142759592") in new stack -- Executing [s@macro-user-callerid:34] Set("Local/89679100900@from-internal-0000006b;2", "CHANNEL(language)=ru") in new stack -- Executing [89679100900@from-internal:2] Gosub("Local/89679100900@from-internal-0000006b;2", "sub-record-check,s,1(out,89679100900,dontcare)") in new stack -- Executing [s@sub-record-check:1] GotoIf("Local/89679100900@from-internal-0000006b;2", "0?initialized") in new stack -- Executing [s@sub-record-check:2] Set("Local/89679100900@from-internal-0000006b;2", "RECSTATUS=INITIALIZED") in new stack -- Executing [s@sub-record-check:3] Set("Local/89679100900@from-internal-0000006b;2", "NOW=1486543850") in new stack -- Executing [s@sub-record-check:4] Set("Local/89679100900@from-internal-0000006b;2", "DAY=08") in new stack -- Executing [s@sub-record-check:5] Set("Local/89679100900@from-internal-0000006b;2", "MONTH=02") in new stack -- Executing [s@sub-record-check:6] Set("Local/89679100900@from-internal-0000006b;2", "YEAR=2017") in new stack -- Executing [s@sub-record-check:7] Set("Local/89679100900@from-internal-0000006b;2", "TIMESTR=20170208-175050") in new stack -- Executing [s@sub-record-check:8] Set("Local/89679100900@from-internal-0000006b;2", "FROMEXTEN=460644") in new stack -- Executing [s@sub-record-check:9] Set("Local/89679100900@from-internal-0000006b;2", "_MONFMT=wav") in new stack -- Executing [s@sub-record-check:10] NoOp("Local/89679100900@from-internal-0000006b;2", "Recordings initialized") in new stack -- Executing [s@sub-record-check:11] ExecIf("Local/89679100900@from-internal-0000006b;2", "0?Set(ARG3=dontcare)") in new stack -- Executing [s@sub-record-check:12] Set("Local/89679100900@from-internal-0000006b;2", "RECPOLICYMODESAVE=") in new stack -- Executing [s@sub-record-check:13] ExecIf("Local/89679100900@from-internal-0000006b;2", "0?Set(RECSTATUS=NO)") in new stack -- Executing [s@sub-record-check:14] GotoIf("Local/89679100900@from-internal-0000006b;2", "3?checkaction") in new stack -- Goto (sub-record-check,s,17) -- Executing [s@sub-record-check:17] GotoIf("Local/89679100900@from-internal-0000006b;2", "1?sub-record-check,out,1") in new stack -- Goto (sub-record-check,out,1) -- Executing [out@sub-record-check:1] NoOp("Local/89679100900@from-internal-0000006b;2", "Outbound Recording Check from 460644 to 89679100900") in new stack -- Executing [out@sub-record-check:2] Set("Local/89679100900@from-internal-0000006b;2", "RECMODE=") in new stack -- Executing [out@sub-record-check:3] ExecIf("Local/89679100900@from-internal-0000006b;2", "1?Goto(routewins)") in new stack -- Goto (sub-record-check,out,7) -- Executing [out@sub-record-check:7] Gosub("Local/89679100900@from-internal-0000006b;2", "recordcheck,1(dontcare,out,89679100900)") in new stack -- Executing [recordcheck@sub-record-check:1] NoOp("Local/89679100900@from-internal-0000006b;2", "Starting recording check against dontcare") in new stack -- Executing [recordcheck@sub-record-check:2] Goto("Local/89679100900@from-internal-0000006b;2", "dontcare") in new stack -- Goto (sub-record-check,recordcheck,3) -- Executing [recordcheck@sub-record-check:3] Return("Local/89679100900@from-internal-0000006b;2", "") in new stack -- Executing [out@sub-record-check:8] Return("Local/89679100900@from-internal-0000006b;2", "") in new stack -- Executing [89679100900@from-internal:3] ExecIf("Local/89679100900@from-internal-0000006b;2", "0 ?Set(CDR(accountcode)=)") in new stack -- Executing [89679100900@from-internal:4] Set("Local/89679100900@from-internal-0000006b;2", "MOHCLASS=default") in new stack -- Executing [89679100900@from-internal:5] Set("Local/89679100900@from-internal-0000006b;2", "NODEST=") in new stack -- Executing [89679100900@from-internal:6] Macro("Local/89679100900@from-internal-0000006b;2", "dialout-trunk,2,9679100900,,off") in new stack -- Executing [s@macro-dialout-trunk:1] Set("Local/89679100900@from-internal-0000006b;2", "DIALTRUNK=2") in new stack -- Executing [s@macro-dialout-trunk:2] GosubIf("Local/89679100900@from-internal-0000006b;2", "0?sub-pincheck,s,1()") in new stack -- Executing [s@macro-dialout-trunk:3] GotoIf("Local/89679100900@from-internal-0000006b;2", "0?disabletrunk,1") in new stack -- Executing [s@macro-dialout-trunk:4] Set("Local/89679100900@from-internal-0000006b;2", "DIALNUMBER=9679100900") in new stack -- Executing [s@macro-dialout-trunk:5] Set("Local/89679100900@from-internal-0000006b;2", "DIALTRUNKOPTIONS=Ttr") in new stack -- Executing [s@macro-dialout-trunk:6] Set("Local/89679100900@from-internal-0000006b;2", "OUTBOUNDGROUP=OUT2") in new stack -- Executing [s@macro-dialout-trunk:7] GotoIf("Local/89679100900@from-internal-0000006b;2", "0?nomax") in new stack -- Executing [s@macro-dialout-trunk:8] GotoIf("Local/89679100900@from-internal-0000006b;2", "0?chanfull") in new stack -- Executing [s@macro-dialout-trunk:9] GotoIf("Local/89679100900@from-internal-0000006b;2", "0?skipoutcid") in new stack -- Executing [s@macro-dialout-trunk:10] Set("Local/89679100900@from-internal-0000006b;2", "DIALTRUNKOPTIONS=T") in new stack -- Executing [s@macro-dialout-trunk:11] Macro("Local/89679100900@from-internal-0000006b;2", "outbound-callerid,2") in new stack -- Executing [s@macro-outbound-callerid:1] ExecIf("Local/89679100900@from-internal-0000006b;2", "1?Set(CALLERPRES(name-pres)=allowednotscreened)") in new stack -- Executing [s@macro-outbound-callerid:2] ExecIf("Local/89679100900@from-internal-0000006b;2", "1?Set(CALLERPRES(num-pres)=allowednotscreened)") in new stack -- Executing [s@macro-outbound-callerid:3] ExecIf("Local/89679100900@from-internal-0000006b;2", "0?Set(REALCALLERIDNUM=9142759592)") in new stack -- Executing [s@macro-outbound-callerid:4] GotoIf("Local/89679100900@from-internal-0000006b;2", "0?normcid") in new stack -- Executing [s@macro-outbound-callerid:5] Set("Local/89679100900@from-internal-0000006b;2", "USEROUTCID=460644") in new stack -- Executing [s@macro-outbound-callerid:6] GotoIf("Local/89679100900@from-internal-0000006b;2", "1?bypass") in new stack -- Goto (macro-outbound-callerid,s,8) -- Executing [s@macro-outbound-callerid:8] Set("Local/89679100900@from-internal-0000006b;2", "EMERGENCYCID=") in new stack -- Executing [s@macro-outbound-callerid:9] Set("Local/89679100900@from-internal-0000006b;2", "TRUNKOUTCID=14112460644") in new stack -- Executing [s@macro-outbound-callerid:10] GotoIf("Local/89679100900@from-internal-0000006b;2", "1?trunkcid") in new stack -- Goto (macro-outbound-callerid,s,15) -- Executing [s@macro-outbound-callerid:15] ExecIf("Local/89679100900@from-internal-0000006b;2", "1?Set(CALLERID(all)=14112460644)") in new stack -- Executing [s@macro-outbound-callerid:16] ExecIf("Local/89679100900@from-internal-0000006b;2", "1?Set(CALLERID(all)=460644)") in new stack -- Executing [s@macro-outbound-callerid:17] ExecIf("Local/89679100900@from-internal-0000006b;2", "0?Set(CALLERID(all)=)") in new stack -- Executing [s@macro-outbound-callerid:18] ExecIf("Local/89679100900@from-internal-0000006b;2", "0?Set(CALLERPRES(name-pres)=prohibpassedscreen)") in new stack -- Executing [s@macro-outbound-callerid:19] ExecIf("Local/89679100900@from-internal-0000006b;2", "0?Set(CALLERPRES(num-pres)=prohibpassedscreen)") in new stack -- Executing [s@macro-outbound-callerid:20] Set("Local/89679100900@from-internal-0000006b;2", "CDR(outboundcnum)=460644") in new stack -- Executing [s@macro-outbound-callerid:21] Set("Local/89679100900@from-internal-0000006b;2", "CDR(outboundcnam)=") in new stack [2017-02-08 17:50:50] WARNING[1680]: funccdr.c:383 cdrwritecallback: CDR requires a value (CDR(variable)=value) -- Executing [s@macro-dialout-trunk:12] GosubIf("Local/89679100900@from-internal-0000006b;2", "0?sub-flp-2,s,1()") in new stack -- Executing [s@macro-dialout-trunk:13] Set("Local/89679100900@from-internal-0000006b;2", "OUTNUM=9679100900") in new stack -- Executing [s@macro-dialout-trunk:14] Set("Local/89679100900@from-internal-0000006b;2", "custom=SIP/Rostelecom") in new stack -- Executing [s@macro-dialout-trunk:15] ExecIf("Local/89679100900@from-internal-0000006b;2", "0?Set(DIALTRUNKOPTIONS=M(setmusic^default)T)") in new stack -- Executing [s@macro-dialout-trunk:16] ExecIf("Local/89679100900@from-internal-0000006b;2", "0?Set(DIALTRUNKOPTIONS=TM(confirm))") in new stack -- Executing [s@macro-dialout-trunk:17] Macro("Local/89679100900@from-internal-0000006b;2", "dialout-trunk-predial-hook,") in new stack -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("Local/89679100900@from-internal-0000006b;2", "") in new stack -- Executing [s@macro-dialout-trunk:18] GotoIf("Local/89679100900@from-internal-0000006b;2", "0?bypass,1") in new stack -- Executing [s@macro-dialout-trunk:19] ExecIf("Local/89679100900@from-internal-0000006b;2", "0?Set(CONNECTEDLINE(num,i)=9679100900)") in new stack -- Executing [s@macro-dialout-trunk:20] ExecIf("Local/89679100900@from-internal-0000006b;2", "0?Set(CONNECTEDLINE(name,i)=CID:460644)") in new stack -- Executing [s@macro-dialout-trunk:21] ExecIf("Local/89679100900@from-internal-0000006b;2", "0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)460644)") in new stack -- Executing [s@macro-dialout-trunk:22] GotoIf("Local/89679100900@from-internal-0000006b;2", "0?customtrunk") in new stack -- Executing [s@macro-dialout-trunk:23] Dial("Local/89679100900@from-internal-0000006b;2", "SIP/Rostelecom/9679100900,300,T") in new stack == Using SIP RTP TOS bits 184 == Using SIP RTP CoS mark 5 Audio is at 17192 Adding codec alaw to SDP Adding codec ulaw to SDP

<--- SIP read from UDP:80.73.85.134:5081 ---> SIP/2.0 480 No Routes Found Via: SIP/2.0/UDP 188.244.188.183:5060;received=188.244.188.183;branch=z9hG4bK3eb13442;rport=5060 From: "9142759592" <sip:9142759592@188.244.188.183>;tag=as274cd934 To: <sip:450179@80.73.85.134:5081>;tag=aprqngfrt-1be2jl00000c6 Call-ID: 147b2230281aed6a0262b42e2950bc7c@188.244.188.183:5060 CSeq: 102 INVITE

<-------------> --- (6 headers 0 lines) --- Transmitting (NAT) to 80.73.85.134:5081: ACK sip:450179@80.73.85.134:5081 SIP/2.0 Via: SIP/2.0/UDP 188.244.188.183:5060;branch=z9hG4bK3eb13442;rport Max-Forwards: 70 From: "9142759592" <sip:9142759592@188.244.188.183>;tag=as274cd934 To: <sip:450179@80.73.85.134:5081>;tag=aprqngfrt-1be2jl00000c6 Contact: <sip:9142759592@188.244.188.183:5060> Call-ID: 147b2230281aed6a0262b42e2950bc7c@188.244.188.183:5060 CSeq: 102 ACK User-Agent: FPBX-13.0.190.11(13.12.1) Content-Length: 0

---

Adding non-codec 0x1 (telephone-event) to SDP Reliably Transmitting (NAT) to 80.73.85.134:5081: INVITE sip:9679100900@80.73.85.134:5081 SIP/2.0 Via: SIP/2.0/UDP 188.244.188.183:5060;branch=z9hG4bK258a7851;rport Max-Forwards: 70 From: <sip:460644@188.244.188.183>;tag=as6f6c2406 To: <sip:9679100900@80.73.85.134:5081> Contact: <sip:460644@188.244.188.183:5060> Call-ID: 12ed895e017da11568529f6644244703@188.244.188.183:5060 CSeq: 102 INVITE User-Agent: FPBX-13.0.190.11(13.12.1) Date: Wed, 08 Feb 2017 08:50:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE Supported: replaces, timer Diversion: <sip:401111@188.244.188.183>;reason=unconditional Content-Type: application/sdp Content-Length: 280

v=0 o=root 958314494 958314494 IN IP4 188.244.188.183 s=Asterisk PBX 13.12.1 c=IN IP4 188.244.188.183 t=0 0 m=audio 17192 RTP/AVP 8 0 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=maxptime:150 a=sendrecv

---

-- Called SIP/Rostelecom/9679100900

Retransmitting #1 (NAT) to 80.73.85.134:5081: INVITE sip:9679100900@80.73.85.134:5081 SIP/2.0 Via: SIP/2.0/UDP 188.244.188.183:5060;branch=z9hG4bK258a7851;rport Max-Forwards: 70 From: <sip:460644@188.244.188.183>;tag=as6f6c2406 To: <sip:9679100900@80.73.85.134:5081> Contact: <sip:460644@188.244.188.183:5060> Call-ID: 12ed895e017da11568529f6644244703@188.244.188.183:5060 CSeq: 102 INVITE User-Agent: FPBX-13.0.190.11(13.12.1) Date: Wed, 08 Feb 2017 08:50:50 GMT Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE Supported: replaces, timer Diversion: <sip:401111@188.244.188.183>;reason=unconditional Content-Type: application/sdp Content-Length: 280

v=0 o=root 958314494 958314494 IN IP4 188.244.188.183 s=Asterisk PBX 13.12.1 c=IN IP4 188.244.188.183 t=0 0 m=audio 17192 RTP/AVP 8 0 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=maxptime:150 a=sendrecv

---

<--- SIP read from UDP:80.73.85.134:5081 ---> SIP/2.0 100 Trying Via: SIP/2.0/UDP 188.244.188.183:5060;received=188.244.188.183;branch=z9hG4bK258a7851;rport=5060 From: <sip:460644@188.244.188.183>;tag=as6f6c2406 To: <sip:9679100900@80.73.85.134:5081> Call-ID: 12ed895e017da11568529f6644244703@188.244.188.183:5060 CSeq: 102 INVITE

<-------------> --- (6 headers 0 lines) ---

<--- SIP read from UDP:80.73.85.134:5081 ---> SIP/2.0 480 No Routes Found Via: SIP/2.0/UDP 188.244.188.183:5060;received=188.244.188.183;branch=z9hG4bK258a7851;rport=5060 From: <sip:460644@188.244.188.183>;tag=as6f6c2406 To: <sip:9679100900@80.73.85.134:5081>;tag=aprqngfrt-4fdi5g30000c6 Call-ID: 12ed895e017da11568529f6644244703@188.244.188.183:5060 CSeq: 102 INVITE

<-------------> --- (6 headers 0 lines) --- Transmitting (NAT) to 80.73.85.134:5081: ACK sip:9679100900@80.73.85.134:5081 SIP/2.0 Via: SIP/2.0/UDP 188.244.188.183:5060;branch=z9hG4bK258a7851;rport Max-Forwards: 70 From: <sip:460644@188.244.188.183>;tag=as6f6c2406 To: <sip:9679100900@80.73.85.134:5081>;tag=aprqngfrt-4fdi5g30000c6 Contact: <sip:460644@188.244.188.183:5060> Call-ID: 12ed895e017da11568529f6644244703@188.244.188.183:5060 CSeq: 102 ACK User-Agent: FPBX-13.0.190.11(13.12.1) Content-Length: 0

---

-- SIP/Rostelecom-00000141 redirecting info has changed, passing it to Local/89679100900@from-internal-0000006b;2
-- SIP/Rostelecom-00000141 is busy

Scheduling destruction of SIP dialog '12ed895e017da11568529f6644244703@188.244.188.183:5060' in 13120 ms (Method: INVITE) == Everyone is busy/congested at this time (1:1/0/0) -- Executing [s@macro-dialout-trunk:24] NoOp("Local/89679100900@from-internal-0000006b;2", "Dial failed for some reason with DIALSTATUS = BUSY and HANGUPCAUSE = 19") in new stack -- Executing [s@macro-dialout-trunk:25] GotoIf("Local/89679100900@from-internal-0000006b;2", "0?continue,1:s-BUSY,1") in new stack -- Goto (macro-dialout-trunk,s-BUSY,1) -- Executing [s-BUSY@macro-dialout-trunk:1] NoOp("Local/89679100900@from-internal-0000006b;2", "Dial failed due to trunk reporting BUSY - giving up") in new stack -- Executing [s-BUSY@macro-dialout-trunk:2] PlayTones("Local/89679100900@from-internal-0000006b;2", "busy") in new stack -- Executing [s-BUSY@macro-dialout-trunk:3] Busy("Local/89679100900@from-internal-0000006b;2", "20") in new stack -- Redirecting update to SIP/Rostelecom-0000013f prevented. -- Local/89679100900@from-internal-0000006b;1 is busy == Everyone is busy/congested at this time (1:1/0/0) -- Executing [s@macro-dial:49] GotoIf("SIP/Rostelecom-0000013f", "0?ANSWER,1") in new stack -- Executing [s@macro-dial:50] Set("SIP/Rostelecom-0000013f", "HuntLoop=1") in new stack -- Executing [s@macro-dial:51] GotoIf("SIP/Rostelecom-0000013f", "1?a46") in new stack -- Goto (macro-dial,s,53) -- Executing [s@macro-dial:53] Set("SIP/Rostelecom-0000013f", "HuntMembers=0") in new stack == Spawn extension (macro-dialout-trunk, s-BUSY, 3) exited non-zero on 'Local/89679100900@from-internal-0000006b;2' in macro 'dialout-trunk' == Spawn extension (from-internal, 89679100900, 6) exited non-zero on 'Local/89679100900@from-internal-0000006b;2' -- Executing [h@from-internal:1] Macro("Local/89679100900@from-internal-0000006b;2", "hangupcall") in new stack -- Executing [s@macro-hangupcall:1] GotoIf("Local/89679100900@from-internal-0000006b;2", "1?theend") in new stack -- Goto (macro-hangupcall,s,3) -- Executing [s@macro-dial:54] Goto("SIP/Rostelecom-0000013f", "s,a22") in new stack -- Executing [s@macro-hangupcall:3] ExecIf("Local/89679100900@from-internal-0000006b;2", "0?Set(CDR(recordingfile)=)") in new stack -- Executing [s@macro-hangupcall:4] Hangup("Local/89679100900@from-internal-0000006b;2", "") in new stack == Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'Local/89679100900@from-internal-0000006b;2' in macro 'hangupcall' == Spawn extension (from-internal, h, 1) exited non-zero on 'Local/89679100900@from-internal-0000006b;2' -- Goto (macro-dial,s,27) -- Executing [s@macro-dial:27] GotoIf("SIP/Rostelecom-0000013f", "0?a30") in new stack -- Executing [s@macro-dial:28] NoOp("SIP/Rostelecom-0000013f", "Returning as there are no members left in the hunt group to ring") in new stack -- Executing [s@macro-dial:29] MacroExit("SIP/Rostelecom-0000013f", "") in new stack -- Executing [121@followme-sub:38] Goto("SIP/Rostelecom-0000013f", "nextstep") in new stack -- Goto (followme-sub,121,45) -- Executing [121@followme-sub:45] Set("SIP/Rostelecom-0000013f", "RingGroupMethod=") in new stack -- Executing [121@followme-sub:46] GotoIf("SIP/Rostelecom-0000013f", "0?nodest") in new stack -- Executing [121@followme-sub:47] Set("SIP/Rostelecom-0000013f", "NODEST=") in new stack -- Executing [121@followme-sub:48] Set("SIP/Rostelecom-0000013f", "PICKUPMARK=") in new stack -- Executing [121@followme-sub:49] Macro("SIP/Rostelecom-0000013f", "blkvm-clr,") in new stack -- Executing [s@macro-blkvm-clr:1] Set("SIP/Rostelecom-0000013f", "SHARED(BLKVM,SIP/Rostelecom-0000013f)=") in new stack -- Executing [s@macro-blkvm-clr:2] Set("SIP/Rostelecom-0000013f", "GOSUBRETVAL=") in new stack -- Executing [s@macro-blkvm-clr:3] MacroExit("SIP/Rostelecom-0000013f", "") in new stack -- Executing [121@followme-sub:50] Set("SIP/Rostelecom-0000013f", "DIALSTATUS=NOANSWER") in new stack -- Executing [121@followme-sub:51] GotoIf("SIP/Rostelecom-0000013f", "0?dohangup") in new stack -- Executing [121@followme-sub:52] Goto("SIP/Rostelecom-0000013f", "ivr-2,s,1") in new stack -- Goto (ivr-2,s,1) -- Executing [s@ivr-2:1] Set("SIP/Rostelecom-0000013f", "TIMEOUTLOOPCOUNT=0") in new stack -- Executing [s@ivr-2:2] Set("SIP/Rostelecom-0000013f", "INVALIDLOOPCOUNT=0") in new stack -- Executing [s@ivr-2:3] Set("SIP/Rostelecom-0000013f", "IVRCONTEXTivr-2=ivr-1") in new stack -- Executing [s@ivr-2:4] Set("SIP/Rostelecom-0000013f", "IVRCONTEXT=ivr-2") in new stack -- Executing [s@ivr-2:5] Set("SIP/Rostelecom-0000013f", "_IVRRETVM=") in new stack -- Executing [s@ivr-2:6] GotoIf("SIP/Rostelecom-0000013f", "1?skip") in new stack -- Goto (ivr-2,s,9) -- Executing [s@ivr-2:9] Set("SIP/Rostelecom-0000013f", "IVR_MSG=custom/akcii-menu") in new stack -- Executing [s@ivr-2:10] Set("SIP/Rostelecom-0000013f", "TIMEOUT(digit)=3") in new stack -- Digit timeout set to 3.000 -- Executing [s@ivr-2:11] ExecIf("SIP/Rostelecom-0000013f", "1?Background(custom/akcii-menu)") in new stack -- <sip rostelecom-0000013f=""> Playing 'custom/akcii-menu.slin' (language 'ru')

<--- SIP read from UDP:80.73.85.134:5081 ---> SIP/2.0 480 No Routes Found Via: SIP/2.0/UDP 188.244.188.183:5060;received=188.244.188.183;branch=z9hG4bK258a7851;rport=5060 From: <sip:460644@188.244.188.183>;tag=as6f6c2406 To: <sip:9679100900@80.73.85.134:5081>;tag=aprqngfrt-4fdi5g30000c6 Call-ID: 12ed895e017da11568529f6644244703@188.244.188.183:5060 CSeq: 102 INVITE

<-------------> --- (6 headers 0 lines) --- Transmitting (NAT) to 80.73.85.134:5081: ACK sip:9679100900@80.73.85.134:5081 SIP/2.0 Via: SIP/2.0/UDP 188.244.188.183:5060;branch=z9hG4bK258a7851;rport Max-Forwards: 70 From: <sip:460644@188.244.188.183>;tag=as6f6c2406 To: <sip:9679100900@80.73.85.134:5081>;tag=aprqngfrt-4fdi5g30000c6 Contact: <sip:460644@188.244.188.183:5060> Call-ID: 12ed895e017da11568529f6644244703@188.244.188.183:5060 CSeq: 102 ACK User-Agent: FPBX-13.0.190.11(13.12.1) Content-Length: 0

---

-- Executing [s@ivr-2:12] WaitExten("SIP/Rostelecom-0000013f", "3,") in new stack

<--- SIP read from UDP:80.73.85.134:5081 ---> BYE sip:460644@188.244.188.183:5060 SIP/2.0 Via: SIP/2.0/UDP 80.73.85.134:5081;branch=z9hG4bKi52okk2030ag9hkem341cd0000010.1 Call-ID: leb6zzenynkfgczhgudfgnyuncmfe5zu@SoftX3000 From: <sip:9142759592@80.73.85.134;user=phone;cpc-rus=1>;tag=6udm56hk-CC-23 To: <sip:401111@188.244.188.183;user=phone>;tag=as58697ce0 CSeq: 2 BYE Reason: Q.850;cause=16;text="normal call clearing" Max-Forwards: 69 Content-Length: 0

<-------------> --- (9 headers 0 lines) --- Sending to 80.73.85.134:5081 (NAT) Scheduling destruction of SIP dialog 'leb6zzenynkfgczhgudfgnyuncmfe5zu@SoftX3000' in 13120 ms (Method: BYE)

<--- Transmitting (NAT) to 80.73.85.134:5081 ---> SIP/2.0 200 OK Via: SIP/2.0/UDP 80.73.85.134:5081;branch=z9hG4bKi52okk2030ag9hkem341cd0000010.1;received=80.73.85.134;rport=5081 From: <sip:9142759592@80.73.85.134;user=phone;cpc-rus=1>;tag=6udm56hk-CC-23 To: <sip:401111@188.244.188.183;user=phone>;tag=as58697ce0 Call-ID: leb6zzenynkfgczhgudfgnyuncmfe5zu@SoftX3000 CSeq: 2 BYE Server: FPBX-13.0.190.11(13.12.1) Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE Supported: replaces, timer Content-Length: 0

<------------> == Spawn extension (ivr-2, s, 12) exited non-zero on 'SIP/Rostelecom-0000013f' -- Executing [h@ivr-2:1] Hangup("SIP/Rostelecom-0000013f", "") in new stack == Spawn extension (ivr-2, h, 1) exited non-zero on 'SIP/Rostelecom-0000013f' Really destroying SIP dialog '147b2230281aed6a0262b42e2950bc7c@188.244.188.183:5060' Method: INVITE Really destroying SIP dialog '12ed895e017da11568529f6644244703@188.244.188.183:5060' Method: INVITE Really destroying SIP dialog 'leb6zzenynkfgczhgudfgnyuncmfe5zu@SoftX3000' Method: BYE