Добрый день, уважаемые гуру. Поменял работу и вместе с ней с меди пришлось пересесть на FREE PBX. Не сочтите мой вопрос тупым. FreePBX 2.10.1.9 Задача: при входящем внешнем звонке, если секр не берет трубку переадресовать ей на мобильный. Попробовал: follow me добавить номер сотового# и соотв правило. не заработало. Каким то чудом в транк уходил CID звонящего. Ессно пров это отбивал. Перепробовал прописывать его везде результата-0. Плюнул. СОздал misc. destination с ее номером. Поставил его в follow me и на внутреннем при неответе.
Получил: Входящий звонок- 10 секунд звонит офисный. потом звонит сотовый ровно 5 секунд, потом звонок опять возвращается на сотовый. Подскажите пожалуйста где увеличить время ожидания попытки дозвониться до сотового?
решил приложить лог происходящего при звонке 893XXXXX655 звонящий 210 внутренний номер секр 893XXXXX615 сотовый секр.
[2017-10-27 13:14:52] VERBOSE[27563] pbx.c: -- Executing [s@macro-hangupcall :1] GotoIf("SIP/GOC-00008306", "1?theend") in new stack
[2017-10-27 13:14:52] VERBOSE[27563] pbx.c: -- Goto (macro-hangupcall,s,3)
[2017-10-27 13:14:52] VERBOSE[27563] pbx.c: -- Executing [s@macro-hangupcall :3] ExecIf("SIP/GOC-00008306",
"0?Set(CDR(recordingfile)=)") in new stack
[2017-10-27 13:14:52] VERBOSE[27563] pbx.c: -- Executing [s@macro-hangupcall :4] Hangup("SIP/GOC-00008306", "") in new stack
[2017-10-27 13:14:52] VERBOSE[27563] app_macro.c: == Spawn extension (macro-ha ngupcall, s, 4) exited non-zero on 'SIP/GOC-00008306' in macro 'hangupcall'
[2017-10-27 13:14:52] VERBOSE[27563] features.c: == Spawn extension (macro-dia lout-trunk, h, 1) exited non-zero on 'SIP/GOC-00008306'
[2017-10-27 13:14:52] VERBOSE[27563] app_macro.c: == Spawn extension (macro-di alout-trunk, s, 22) exited non-zero on 'SIP/GOC-00008306' in macro 'dialout-trun k'
[2017-10-27 13:14:52] VERBOSE[27563] pbx.c: == Spawn extension (from-internal, 893XXXXX615, 6) exited non-zero on 'SIP/GOC-00008306'
[2017-10-27 13:15:25] NOTICE[3538] chan_sip.c: Peer '120' is now Lagged. (2016ms / 2000ms)
[2017-10-27 13:15:47] NOTICE[3538] chan_sip.c: Peer '120' is now Reachable. (27m s / 2000ms)
[2017-10-27 13:17:15] VERBOSE[3538] netsock2.c: == Using SIP RTP TOS bits 184
[2017-10-27 13:17:15] VERBOSE[3538] netsock2.c: == Using SIP RTP CoS mark 5
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [10024@from-trunk-s ip-GOC:1] Set("SIP/GOC-00008308", "GROUP()=OUT_5") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [10024@from-trunk-s ip-GOC:2] Goto("SIP/GOC-00008308", "from-trunk,10024,1") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Goto (from-trunk,10024,1)
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [10024@from-trunk:1 ] Set("SIP/GOC-00008308", "__FROM_DID=10024") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [10024@from-trunk:2 ] Set("SIP/GOC-00008308", "CDR(did)=10024") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [10024@from-trunk:3 ] ExecIf("SIP/GOC-00008308", "0 ?Set(CALLERID(name)=893XXXXX655)") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [10024@from-trunk:4 ] Set("SIP/GOC-00008308", "__CALLINGPRES_SV=allowed_not_screened") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [10024@from-trunk:5 ] Set("SIP/GOC-00008308", "CALLERPRES()=allowed_not_screened") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [10024@from-trunk:6 ] Goto("SIP/GOC-00008308", "from-did-direct,201,1") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Goto (from-did-direct,201,1)
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:1] GotoIf("SIP/GOC-00008308", "0?ext-local,201,1") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:2] Macro("SIP/GOC-00008308", "user-callerid,") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-user-calle rid:1] Set("SIP/GOC-00008308", "AMPUSER=893XXXXX655") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-user-calle rid:2] GotoIf("SIP/GOC-00008308", "0?report") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-user-calle rid:3] ExecIf("SIP/GOC-00008308", "1?Set(REALCALLERIDNUM=893XXXXX655)") in new s tack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-user-calle rid:4] Set("SIP/GOC-00008308", "AMPUSER=") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-user-calle rid:5] Set("SIP/GOC-00008308", "AMPUSERCIDNAME=") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-user-calle rid:6] GotoIf("SIP/GOC-00008308", "1?report") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Goto (macro-user-callerid,s,1 1)
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-user-calle rid:11] GotoIf("SIP/GOC-00008308", "0?continue") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-user-calle rid:12] Set("SIP/GOC-00008308", "__TTL=64") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-user-calle rid:13] GotoIf("SIP/GOC-00008308", "1?continue") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Goto (macro-user-callerid,s,2 4)
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-user-calle rid:24] Set("SIP/GOC-00008308", "CALLERID(number)=893XXXXX655") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-user-calle rid:25] Set("SIP/GOC-00008308", "CALLERID(name)=893XXXXX655") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-user-calle rid:26] Set("SIP/GOC-00008308", "CHANNEL(language)=en") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:3] Set("SIP/GOC-00008308", "DIAL_OPTIONS=trI") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:4] Set("SIP/GOC-00008308", "CONNECTEDLINE(num)=201") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:5] Set("SIP/GOC-00008308", "CONNECTEDLINE(name,i)=Ekaterina Leontyeva") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:6] Set("SIP/GOC-00008308", "FM_DIALSTATUS=NOT_INUSE") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:7] Set("SIP/GOC-00008308", "__EXTTOCALL=201") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:8] Set("SIP/GOC-00008308", "__PICKUPMARK=201") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:9] Macro("SIP/GOC-00008308", "blkvm-setifempty,") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-blkvm-seti fempty:1] GotoIf("SIP/GOC-00008308", "1?init") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Goto (macro-blkvm-setifempty, s,4)
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-blkvm-seti fempty:4] Set("SIP/GOC-00008308", "__BLKVM_CHANNEL=SIP/GOC-00008308") in new sta ck
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-blkvm-seti fempty:5] Set("SIP/GOC-00008308", "SHARED(BLKVM,SIP/GOC-00008308)=TRUE") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-blkvm-seti fempty:6] Set("SIP/GOC-00008308", "GOSUB_RETVAL=TRUE") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-blkvm-seti fempty:7] MacroExit("SIP/GOC-00008308", "") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:10] GotoIf("SIP/GOC-00008308", "1?skipov") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Goto (from-did-direct,201,13)
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:13] Set("SIP/GOC-00008308", "RRNODEST=") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:14] Set("SIP/GOC-00008308", "__NODEST=201") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:15] GosubIf("SIP/GOC-00008308", "1?sub-fmsetcid,s,1()") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@sub-fmsetcid:1] Goto("SIP/GOC-00008308", "s-did,1") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Goto (sub-fmsetcid,s-did,1)
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s-did@sub-fmsetcid :1] ExecIf("SIP/GOC-00008308", "1?Set(__REALCALLERIDNUM=10024)") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s-did@sub-fmsetcid :2] Return("SIP/GOC-00008308", "") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:16] Set("SIP/GOC-00008308", "RecordMethod=Group") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:17] Gosub("SIP/GOC-00008308", "sub-record-check,s,1(exten,201,)") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@sub-record-check :1] GotoIf("SIP/GOC-00008308", "1?check") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Goto (sub-record-check,s,6)
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@sub-record-check :6] Set("SIP/GOC-00008308", "__MON_FMT=wav") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@sub-record-check :7] GotoIf("SIP/GOC-00008308", "1?next") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Goto (sub-record-check,s,10)
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@sub-record-check :10] ExecIf("SIP/GOC-00008308", "0?Return()") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@sub-record-check :11] GotoIf("SIP/GOC-00008308", "0?exten,1") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@sub-record-check :12] Set("SIP/GOC-00008308", "__REC_STATUS=INITIALIZED") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@sub-record-check :13] ExecIf("SIP/GOC-00008308", "0?Set(__REC_POLICY_MODE=)") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@sub-record-check :14] Set("SIP/GOC-00008308", "NOW=1509095835") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@sub-record-check :15] Set("SIP/GOC-00008308", "__DAY=27") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@sub-record-check :16] Set("SIP/GOC-00008308", "__MONTH=10") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@sub-record-check :17] Set("SIP/GOC-00008308", "__YEAR=2017") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@sub-record-check :18] Set("SIP/GOC-00008308", "__TIMESTR=20171027-131715") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@sub-record-check :19] Set("SIP/GOC-00008308", "__FROMEXTEN=10024") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@sub-record-check :20] Set("SIP/GOC-00008308", "__CALLFILENAME=exten-201-10024-20171027-131715-150 9095835.38367") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@sub-record-check :21] Goto("SIP/GOC-00008308", "exten,1") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Goto (sub-record-check,exten, 1)
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [exten@sub-record-c heck:1] GotoIf("SIP/GOC-00008308", "0?callee") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [exten@sub-record-c heck:2] Set("SIP/GOC-00008308", "__REC_POLICY_MODE=dontcare") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [exten@sub-record-c heck:3] GotoIf("SIP/GOC-00008308", "1?caller") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Goto (sub-record-check,exten, 10)
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [exten@sub-record-c heck:10] Set("SIP/GOC-00008308", "__REC_POLICY_MODE=") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [exten@sub-record-c heck:11] GosubIf("SIP/GOC-00008308", "0?record,1(exten,201,10024)") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [exten@sub-record-c heck:12] Return("SIP/GOC-00008308", "") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:18] Set("SIP/GOC-00008308", "RingGroupMethod=ringallv2") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:19] Set("SIP/GOC-00008308", "_FMGRP=201") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:20] GotoIf("SIP/GOC-00008308", "0?doconfirm") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [201@from-did-direc t:21] Macro("SIP/GOC-00008308", "dial,20,trI,201") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-dial:1] Go toIf("SIP/GOC-00008308", "1?dial") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Goto (macro-dial,s,3)
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-dial:3] AG I("SIP/GOC-00008308", "dialparties.agi") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] res_agi.c: -- Launched AGI Script /var/ lib/asterisk/agi-bin/dialparties.agi
[2017-10-27 13:17:15] VERBOSE[27599] res_agi.c: dialparties.agi: Starting New D ialparties.agi
[2017-10-27 13:17:15] VERBOSE[27599] res_agi.c: dialparties.agi: Caller ID name is '893XXXXX655' number is '893XXXXX655'
[2017-10-27 13:17:15] VERBOSE[27599] res_agi.c: dialparties.agi: Methodology of ring is 'ringallv2'
[2017-10-27 13:17:15] VERBOSE[27599] res_agi.c: -- dialparties.agi: Added ex tension 201 to extension map
[2017-10-27 13:17:15] VERBOSE[27599] res_agi.c: -- dialparties.agi: Extensio n 201 cf is disabled
[2017-10-27 13:17:15] VERBOSE[27599] res_agi.c: -- dialparties.agi: Extensio n 201 do not disturb is disabled
[2017-10-27 13:17:15] VERBOSE[27599] res_agi.c: -- dialparties.agi: dbset CA LLTRACE/201 to 893XXXXX655
[2017-10-27 13:17:15] VERBOSE[27599] res_agi.c: -- dialparties.agi: Filtered ARG3: 201
[2017-10-27 13:17:15] VERBOSE[27599] res_agi.c: -- <SIP/GOC-00008308>AGI Scr ipt dialparties.agi completed, returning 0
[2017-10-27 13:17:15] VERBOSE[27599] pbx.c: -- Executing [s@macro-dial:7] Di al("SIP/GOC-00008308", "SIP/201,20,trIM(auto-blkvm)") in new stack
[2017-10-27 13:17:15] VERBOSE[27599] netsock2.c: == Using SIP RTP TOS bits 184
[2017-10-27 13:17:15] VERBOSE[27599] netsock2.c: == Using SIP RTP CoS mark 5
[2017-10-27 13:17:15] VERBOSE[27599] app_dial.c: -- Called SIP/201
[2017-10-27 13:17:15] VERBOSE[27599] app_dial.c: -- Connected line update to SIP/GOC-00008308 prevented.
[2017-10-27 13:17:16] VERBOSE[27599] app_dial.c: -- SIP/201-00008309 is ring ing
[2017-10-27 13:17:25] VERBOSE[27599] app_macro.c: == Spawn extension (macro-dial, s, 7) exited non-zero on 'SIP/GOC-00008308' in macro 'dial'
[2017-10-27 13:17:25] VERBOSE[27599] pbx.c: == Spawn extension (from-did-direct, 201, 21) exited non-zero on 'SIP/GOC-00008308'
[2017-10-27 13:17:25] VERBOSE[27599] pbx.c: -- Executing [h@from-did-direct:1] Macro("SIP/GOC-00008308", "hangupcall,") in new stack
[2017-10-27 13:17:25] VERBOSE[27599] pbx.c: -- Executing [s@macro-hangupcall:1] GotoIf("SIP/GOC-00008308", "1?theend") in new stack
[2017-10-27 13:17:25] VERBOSE[27599] pbx.c: -- Goto (macro-hangupcall,s,3)
[2017-10-27 13:17:25] VERBOSE[27599] pbx.c: -- Executing [s@macro-hangupcall:3] ExecIf("SIP/GOC-00008308", "0?Set(CDR(recordingfile)=)") in new stack
[2017-10-27 13:17:25] VERBOSE[27599] pbx.c: -- Executing [s@macro-hangupcall:4] Hangup("SIP/GOC-00008308", "") in new stack
[2017-10-27 13:17:25] VERBOSE[27599] app_macro.c: == Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'SIP/GOC-00008308' in macro 'hangupcall'
[2017-10-27 13:17:25] VERBOSE[27599] pbx.c: == Spawn extension (from-did-direct, h, 1) exited non-zero on 'SIP/GOC-00008308'
[2017-10-27 13:17:25] VERBOSE[3538] netsock2.c: == Using SIP RTP TOS bits 184
[2017-10-27 13:17:25] VERBOSE[3538] netsock2.c: == Using SIP RTP CoS mark 5
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [10025@from-trunk-sip-GOC:1] Set("SIP/GOC-0000830a", "GROUP()=OUT_5") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [10025@from-trunk-sip-GOC:2] Goto("SIP/GOC-0000830a", "from-trunk,10025,1") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Goto (from-trunk,10025,1)
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [10025@from-trunk:1] Set("SIP/GOC-0000830a", "__FROM_DID=10025") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [10025@from-trunk:2] Set("SIP/GOC-0000830a", "CDR(did)=10025") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [10025@from-trunk:3] ExecIf("SIP/GOC-0000830a", "0 ?Set(CALLERID(name)=893XXXXX655)") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [10025@from-trunk:4] Set("SIP/GOC-0000830a", "__CALLINGPRES_SV=allowed_not_screened") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [10025@from-trunk:5] Set("SIP/GOC-0000830a", "CALLERPRES()=allowed_not_screened") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [10025@from-trunk:6] Goto("SIP/GOC-0000830a", "from-did-direct,201,1") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Goto (from-did-direct,201,1)
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:1] GotoIf("SIP/GOC-0000830a", "0?ext-local,201,1") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:2] Macro("SIP/GOC-0000830a", "user-callerid,") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-user-callerid:1] Set("SIP/GOC-0000830a", "AMPUSER=893XXXXX655") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-user-callerid:2] GotoIf("SIP/GOC-0000830a", "0?report") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-user-callerid:3] ExecIf("SIP/GOC-0000830a", "1?Set(REALCALLERIDNUM=893XXXXX655)") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-user-callerid:4] Set("SIP/GOC-0000830a", "AMPUSER=") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-user-callerid:5] Set("SIP/GOC-0000830a", "AMPUSERCIDNAME=") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-user-callerid:6] GotoIf("SIP/GOC-0000830a", "1?report") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Goto (macro-user-callerid,s,11)
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-user-callerid:11] GotoIf("SIP/GOC-0000830a", "0?continue") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-user-callerid:12] Set("SIP/GOC-0000830a", "__TTL=64") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-user-callerid:13] GotoIf("SIP/GOC-0000830a", "1?continue") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Goto (macro-user-callerid,s,24)
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-user-callerid:24] Set("SIP/GOC-0000830a", "CALLERID(number)=893XXXXX655") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-user-callerid:25] Set("SIP/GOC-0000830a", "CALLERID(name)=893XXXXX655") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-user-callerid:26] Set("SIP/GOC-0000830a", "CHANNEL(language)=en") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:3] Set("SIP/GOC-0000830a", "DIAL_OPTIONS=trI") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:4] Set("SIP/GOC-0000830a", "CONNECTEDLINE(num)=201") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:5] Set("SIP/GOC-0000830a", "CONNECTEDLINE(name,i)=Ekaterina Leontyeva") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:6] Set("SIP/GOC-0000830a", "FM_DIALSTATUS=NOT_INUSE") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:7] Set("SIP/GOC-0000830a", "__EXTTOCALL=201") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:8] Set("SIP/GOC-0000830a", "__PICKUPMARK=201") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:9] Macro("SIP/GOC-0000830a", "blkvm-setifempty,") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-blkvm-setifempty:1] GotoIf("SIP/GOC-0000830a", "1?init") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Goto (macro-blkvm-setifempty,s,4)
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-blkvm-setifempty:4] Set("SIP/GOC-0000830a", "__BLKVM_CHANNEL=SIP/GOC-0000830a") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-blkvm-setifempty:5] Set("SIP/GOC-0000830a", "SHARED(BLKVM,SIP/GOC-0000830a)=TRUE") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-blkvm-setifempty:6] Set("SIP/GOC-0000830a", "GOSUB_RETVAL=TRUE") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-blkvm-setifempty:7] MacroExit("SIP/GOC-0000830a", "") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:10] GotoIf("SIP/GOC-0000830a", "1?skipov") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Goto (from-did-direct,201,13)
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:13] Set("SIP/GOC-0000830a", "RRNODEST=") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:14] Set("SIP/GOC-0000830a", "__NODEST=201") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:15] GosubIf("SIP/GOC-0000830a", "1?sub-fmsetcid,s,1()") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@sub-fmsetcid:1] Goto("SIP/GOC-0000830a", "s-did,1") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Goto (sub-fmsetcid,s-did,1)
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s-did@sub-fmsetcid:1] ExecIf("SIP/GOC-0000830a", "1?Set(__REALCALLERIDNUM=10025)") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s-did@sub-fmsetcid:2] Return("SIP/GOC-0000830a", "") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:16] Set("SIP/GOC-0000830a", "RecordMethod=Group") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:17] Gosub("SIP/GOC-0000830a", "sub-record-check,s,1(exten,201,)") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@sub-record-check:1] GotoIf("SIP/GOC-0000830a", "1?check") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Goto (sub-record-check,s,6)
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@sub-record-check:6] Set("SIP/GOC-0000830a", "__MON_FMT=wav") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@sub-record-check:7] GotoIf("SIP/GOC-0000830a", "1?next") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Goto (sub-record-check,s,10)
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@sub-record-check:10] ExecIf("SIP/GOC-0000830a", "0?Return()") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@sub-record-check:11] GotoIf("SIP/GOC-0000830a", "0?exten,1") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@sub-record-check:12] Set("SIP/GOC-0000830a", "__REC_STATUS=INITIALIZED") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@sub-record-check:13] ExecIf("SIP/GOC-0000830a", "0?Set(__REC_POLICY_MODE=)") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@sub-record-check:14] Set("SIP/GOC-0000830a", "NOW=1509095845") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@sub-record-check:15] Set("SIP/GOC-0000830a", "__DAY=27") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@sub-record-check:16] Set("SIP/GOC-0000830a", "__MONTH=10") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@sub-record-check:17] Set("SIP/GOC-0000830a", "__YEAR=2017") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@sub-record-check:18] Set("SIP/GOC-0000830a", "__TIMESTR=20171027-131725") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@sub-record-check:19] Set("SIP/GOC-0000830a", "__FROMEXTEN=10025") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@sub-record-check:20] Set("SIP/GOC-0000830a", "__CALLFILENAME=exten-201-10025-20171027-131725-1509095845.38369") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@sub-record-check:21] Goto("SIP/GOC-0000830a", "exten,1") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Goto (sub-record-check,exten,1)
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [exten@sub-record-check:1] GotoIf("SIP/GOC-0000830a", "0?callee") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [exten@sub-record-check:2] Set("SIP/GOC-0000830a", "__REC_POLICY_MODE=dontcare") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [exten@sub-record-check:3] GotoIf("SIP/GOC-0000830a", "1?caller") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Goto (sub-record-check,exten,10)
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [exten@sub-record-check:10] Set("SIP/GOC-0000830a", "__REC_POLICY_MODE=") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [exten@sub-record-check:11] GosubIf("SIP/GOC-0000830a", "0?record,1(exten,201,10025)") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [exten@sub-record-check:12] Return("SIP/GOC-0000830a", "") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:18] Set("SIP/GOC-0000830a", "RingGroupMethod=ringallv2") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:19] Set("SIP/GOC-0000830a", "_FMGRP=201") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:20] GotoIf("SIP/GOC-0000830a", "0?doconfirm") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [201@from-did-direct:21] Macro("SIP/GOC-0000830a", "dial,20,trI,201") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-dial:1] GotoIf("SIP/GOC-0000830a", "1?dial") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Goto (macro-dial,s,3)
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-dial:3] AGI("SIP/GOC-0000830a", "dialparties.agi") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] res_agi.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
[2017-10-27 13:17:25] VERBOSE[27601] res_agi.c: dialparties.agi: Starting New Dialparties.agi
[2017-10-27 13:17:25] VERBOSE[27601] res_agi.c: dialparties.agi: Caller ID name is '893XXXXX655' number is '893XXXXX655'
[2017-10-27 13:17:25] VERBOSE[27601] res_agi.c: dialparties.agi: Methodology of ring is 'ringallv2'
[2017-10-27 13:17:25] VERBOSE[27601] res_agi.c: -- dialparties.agi: Added extension 201 to extension map
[2017-10-27 13:17:25] VERBOSE[27601] res_agi.c: -- dialparties.agi: Extension 201 cf is disabled
[2017-10-27 13:17:25] VERBOSE[27601] res_agi.c: -- dialparties.agi: Extension 201 do not disturb is disabled
[2017-10-27 13:17:25] VERBOSE[27601] res_agi.c: -- dialparties.agi: dbset CALLTRACE/201 to 893XXXXX655
[2017-10-27 13:17:25] VERBOSE[27601] res_agi.c: -- dialparties.agi: Filtered ARG3: 201
[2017-10-27 13:17:25] VERBOSE[27601] res_agi.c: -- <SIP/GOC-0000830a>AGI Script dialparties.agi completed, returning 0
[2017-10-27 13:17:25] VERBOSE[27601] pbx.c: -- Executing [s@macro-dial:7] Dial("SIP/GOC-0000830a", "SIP/201,20,trIM(auto-blkvm)") in new stack
[2017-10-27 13:17:25] VERBOSE[27601] netsock2.c: == Using SIP RTP TOS bits 184
[2017-10-27 13:17:25] VERBOSE[27601] netsock2.c: == Using SIP RTP CoS mark 5
[2017-10-27 13:17:25] VERBOSE[27601] app_dial.c: -- Called SIP/201
[2017-10-27 13:17:25] VERBOSE[27601] app_dial.c: -- Connected line update to SIP/GOC-0000830a prevented.
[2017-10-27 13:17:26] VERBOSE[27601] app_dial.c: -- SIP/201-0000830b is ringing
[2017-10-27 13:17:35] VERBOSE[27601] app_macro.c: == Spawn extension (macro-dial, s, 7) exited non-zero on 'SIP/GOC-0000830a' in macro 'dial'
[2017-10-27 13:17:35] VERBOSE[27601] pbx.c: == Spawn extension (from-did-direct, 201, 21) exited non-zero on 'SIP/GOC-0000830a'
[2017-10-27 13:17:35] VERBOSE[27601] pbx.c: -- Executing [h@from-did-direct:1] Macro("SIP/GOC-0000830a", "hangupcall,") in new stack
[2017-10-27 13:17:35] VERBOSE[27601] pbx.c: -- Executing [s@macro-hangupcall:1] GotoIf("SIP/GOC-0000830a", "1?theend") in new stack
[2017-10-27 13:17:35] VERBOSE[27601] pbx.c: -- Goto (macro-hangupcall,s,3)
[2017-10-27 13:17:35] VERBOSE[27601] pbx.c: -- Executing [s@macro-hangupcall:3] ExecIf("SIP/GOC-0000830a", "0?Set(CDR(recordingfile)=)") in new stack
[2017-10-27 13:17:35] VERBOSE[27601] pbx.c: -- Executing [s@macro-hangupcall:4] Hangup("SIP/GOC-0000830a", "") in new stack
[2017-10-27 13:17:35] VERBOSE[27601] app_macro.c: == Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'SIP/GOC-0000830a' in macro 'hangupcall'
[2017-10-27 13:17:35] VERBOSE[27601] pbx.c: == Spawn extension (from-did-direct, h, 1) exited non-zero on 'SIP/GOC-0000830a'
[2017-10-27 13:17:36] VERBOSE[3538] netsock2.c: == Using SIP RTP TOS bits 184
[2017-10-27 13:17:36] VERBOSE[3538] netsock2.c: == Using SIP RTP CoS mark 5
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [10026@from-trunk-sip-GOC:1] Set("SIP/GOC-0000830c", "GROUP()=OUT_5") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [10026@from-trunk-sip-GOC:2] Goto("SIP/GOC-0000830c", "from-trunk,10026,1") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Goto (from-trunk,10026,1)
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [10026@from-trunk:1] Set("SIP/GOC-0000830c", "__FROM_DID=10026") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [10026@from-trunk:2] Set("SIP/GOC-0000830c", "CDR(did)=10026") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [10026@from-trunk:3] ExecIf("SIP/GOC-0000830c", "0 ?Set(CALLERID(name)=893XXXXX655)") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [10026@from-trunk:4] Set("SIP/GOC-0000830c", "__CALLINGPRES_SV=allowed_not_screened") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [10026@from-trunk:5] Set("SIP/GOC-0000830c", "CALLERPRES()=allowed_not_screened") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [10026@from-trunk:6] Goto("SIP/GOC-0000830c", "ext-miscdests,1,1") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Goto (ext-miscdests,1,1)
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [1@ext-miscdests:1] NoOp("SIP/GOC-0000830c", "MiscDest: Kate") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [1@ext-miscdests:2] Goto("SIP/GOC-0000830c", "from-internal,893XXXXX615,1") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Goto (from-internal,893XXXXX615,1)
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [893XXXXX615@from-internal:1] Macro("SIP/GOC-0000830c", "user-callerid,LIMIT,") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-user-callerid:1] Set("SIP/GOC-0000830c", "AMPUSER=893XXXXX655") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-user-callerid:2] GotoIf("SIP/GOC-0000830c", "0?report") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-user-callerid:3] ExecIf("SIP/GOC-0000830c", "1?Set(REALCALLERIDNUM=893XXXXX655)") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-user-callerid:4] Set("SIP/GOC-0000830c", "AMPUSER=") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-user-callerid:5] Set("SIP/GOC-0000830c", "AMPUSERCIDNAME=") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-user-callerid:6] GotoIf("SIP/GOC-0000830c", "1?report") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Goto (macro-user-callerid,s,11)
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-user-callerid:11] GotoIf("SIP/GOC-0000830c", "1?continue") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Goto (macro-user-callerid,s,24)
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-user-callerid:24] Set("SIP/GOC-0000830c", "CALLERID(number)=893XXXXX655") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-user-callerid:25] Set("SIP/GOC-0000830c", "CALLERID(name)=893XXXXX655") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-user-callerid:26] Set("SIP/GOC-0000830c", "CHANNEL(language)=en") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [893XXXXX615@from-internal:2] Set("SIP/GOC-0000830c", "MOHCLASS=default") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [893XXXXX615@from-internal:3] ExecIf("SIP/GOC-0000830c", "1?Set(TRUNKCIDOVERRIDE=759020)") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [893XXXXX615@from-internal:4] Set("SIP/GOC-0000830c", "_NODEST=") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [893XXXXX615@from-internal:5] Gosub("SIP/GOC-0000830c", "sub-record-check,s,1(out,893XXXXX615,)") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@sub-record-check:1] GotoIf("SIP/GOC-0000830c", "1?check") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Goto (sub-record-check,s,6)
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@sub-record-check:6] Set("SIP/GOC-0000830c", "__MON_FMT=wav") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@sub-record-check:7] GotoIf("SIP/GOC-0000830c", "1?next") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Goto (sub-record-check,s,10)
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@sub-record-check:10] ExecIf("SIP/GOC-0000830c", "0?Return()") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@sub-record-check:11] GotoIf("SIP/GOC-0000830c", "0?out,1") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@sub-record-check:12] Set("SIP/GOC-0000830c", "__REC_STATUS=INITIALIZED") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@sub-record-check:13] ExecIf("SIP/GOC-0000830c", "0?Set(__REC_POLICY_MODE=)") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@sub-record-check:14] Set("SIP/GOC-0000830c", "NOW=1509095856") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@sub-record-check:15] Set("SIP/GOC-0000830c", "__DAY=27") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@sub-record-check:16] Set("SIP/GOC-0000830c", "__MONTH=10") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@sub-record-check:17] Set("SIP/GOC-0000830c", "__YEAR=2017") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@sub-record-check:18] Set("SIP/GOC-0000830c", "__TIMESTR=20171027-131736") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@sub-record-check:19] Set("SIP/GOC-0000830c", "__FROMEXTEN=893XXXXX655") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@sub-record-check:20] Set("SIP/GOC-0000830c", "__CALLFILENAME=out-893XXXXX615-893XXXXX655-20171027-131736-1509095856.38371") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@sub-record-check:21] Goto("SIP/GOC-0000830c", "out,1") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Goto (sub-record-check,out,1)
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [out@sub-record-check:1] ExecIf("SIP/GOC-0000830c", "1?Set(__REC_POLICY_MODE=)") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [out@sub-record-check:2] GosubIf("SIP/GOC-0000830c", "0?record,1(exten,893XXXXX615,893XXXXX655)") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [out@sub-record-check:3] Return("SIP/GOC-0000830c", "") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [893XXXXX615@from-internal:6] Macro("SIP/GOC-0000830c", "dialout-trunk,2,893XXXXX615,") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:1] Set("SIP/GOC-0000830c", "DIAL_TRUNK=2") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:2] GosubIf("SIP/GOC-0000830c", "0?sub-pincheck,s,1()") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:3] GotoIf("SIP/GOC-0000830c", "0?disabletrunk,1") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:4] Set("SIP/GOC-0000830c", "DIAL_NUMBER=893XXXXX615") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:5] Set("SIP/GOC-0000830c", "DIAL_TRUNK_OPTIONS=tr") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:6] Set("SIP/GOC-0000830c", "OUTBOUND_GROUP=OUT_2") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:7] GotoIf("SIP/GOC-0000830c", "1?nomax") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Goto (macro-dialout-trunk,s,9)
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:9] GotoIf("SIP/GOC-0000830c", "0?skipoutcid") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:10] Set("SIP/GOC-0000830c", "DIAL_TRUNK_OPTIONS=") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:11] Macro("SIP/GOC-0000830c", "outbound-callerid,2") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-outbound-callerid:1] ExecIf("SIP/GOC-0000830c", "1?Set(CALLERPRES()=allowed_not_screened)") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-outbound-callerid:2] ExecIf("SIP/GOC-0000830c", "0?Set(REALCALLERIDNUM=893XXXXX655)") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-outbound-callerid:3] GotoIf("SIP/GOC-0000830c", "1?normcid") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Goto (macro-outbound-callerid,s,6)
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-outbound-callerid:6] Set("SIP/GOC-0000830c", "USEROUTCID=") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-outbound-callerid:7] Set("SIP/GOC-0000830c", "EMERGENCYCID=") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-outbound-callerid:8] Set("SIP/GOC-0000830c", "TRUNKOUTCID=<78422759020>") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-outbound-callerid:9] GotoIf("SIP/GOC-0000830c", "1?trunkcid") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Goto (macro-outbound-callerid,s,12)
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-outbound-callerid:12] ExecIf("SIP/GOC-0000830c", "1?Set(CALLERID(all)=<78422759020>)") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-outbound-callerid:13] ExecIf("SIP/GOC-0000830c", "0?Set(CALLERID(all)=)") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-outbound-callerid:14] ExecIf("SIP/GOC-0000830c", "1?Set(CALLERID(all)=759020)") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-outbound-callerid:15] ExecIf("SIP/GOC-0000830c", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:12] GosubIf("SIP/GOC-0000830c", "0?sub-flp-2,s,1()") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:13] Set("SIP/GOC-0000830c", "OUTNUM=893XXXXX615") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:14] Set("SIP/GOC-0000830c", "custom=SIP/QW") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:15] ExecIf("SIP/GOC-0000830c", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:16] ExecIf("SIP/GOC-0000830c", "0?Set(DIAL_TRUNK_OPTIONS=M(confirm))") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:17] Macro("SIP/GOC-0000830c", "dialout-trunk-predial-hook,") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("SIP/GOC-0000830c", "") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:18] GotoIf("SIP/GOC-0000830c", "0?bypass,1") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:19] ExecIf("SIP/GOC-0000830c", "0?Set(CONNECTEDLINE(num,i)=893XXXXX615)") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:20] ExecIf("SIP/GOC-0000830c", "0?Set(CONNECTEDLINE(name,i)=CID:759020)") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:21] GotoIf("SIP/GOC-0000830c", "0?customtrunk") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] pbx.c: -- Executing [s@macro-dialout-trunk:22] Dial("SIP/GOC-0000830c", "SIP/QW/893XXXXX615,300,") in new stack
[2017-10-27 13:17:36] VERBOSE[27603] netsock2.c: == Using SIP RTP TOS bits 184
[2017-10-27 13:17:36] VERBOSE[27603] netsock2.c: == Using SIP RTP CoS mark 5
[2017-10-27 13:17:36] VERBOSE[27603] app_dial.c: -- Called SIP/QW/893XXXXX615
[2017-10-27 13:17:36] VERBOSE[27603] app_dial.c: -- SIP/QW-0000830d is ringing
[2017-10-27 13:17:40] VERBOSE[27603] app_dial.c: -- SIP/QW-0000830d is ringing
[2017-10-27 13:17:46] VERBOSE[27603] app_macro.c: == Spawn extension (macro-dialout-trunk, s, 22) exited non-zero on 'SIP/GOC-0000830c' in macro 'dialout-trunk'
[2017-10-27 13:17:46] VERBOSE[27603] pbx.c: == Spawn extension (from-internal, 893XXXXX615, 6) exited non-zero on 'SIP/GOC-0000830c'
[2017-10-27 13:17:46] VERBOSE[27603] pbx.c: -- Executing [h@from-internal:1] Hangup("SIP/GOC-0000830c", "") in new stack
[2017-10-27 13:17:46] VERBOSE[27603] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/GOC-0000830c'
[2017-10-27 13:17:46] VERBOSE[3538] netsock2.c: == Using SIP RTP TOS bits 184
[2017-10-27 13:17:46] VERBOSE[3538] netsock2.c: == Using SIP RTP CoS mark 5
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [759020@from-trunk-sip-GOC:1] Set("SIP/GOC-0000830e", "GROUP()=OUT_5") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [759020@from-trunk-sip-GOC:2] Goto("SIP/GOC-0000830e", "from-trunk,759020,1") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Goto (from-trunk,759020,1)
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [759020@from-trunk:1] Set("SIP/GOC-0000830e", "__FROM_DID=759020") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [759020@from-trunk:2] Set("SIP/GOC-0000830e", "CDR(did)=759020") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [759020@from-trunk:3] ExecIf("SIP/GOC-0000830e", "0 ?Set(CALLERID(name)=893XXXXX655)") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [759020@from-trunk:4] Set("SIP/GOC-0000830e", "__CALLINGPRES_SV=allowed_not_screened") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [759020@from-trunk:5] Set("SIP/GOC-0000830e", "CALLERPRES()=allowed_not_screened") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [759020@from-trunk:6] Goto("SIP/GOC-0000830e", "from-did-direct,201,1") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Goto (from-did-direct,201,1)
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:1] GotoIf("SIP/GOC-0000830e", "0?ext-local,201,1") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:2] Macro("SIP/GOC-0000830e", "user-callerid,") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-user-callerid:1] Set("SIP/GOC-0000830e", "AMPUSER=893XXXXX655") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-user-callerid:2] GotoIf("SIP/GOC-0000830e", "0?report") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-user-callerid:3] ExecIf("SIP/GOC-0000830e", "1?Set(REALCALLERIDNUM=893XXXXX655)") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-user-callerid:4] Set("SIP/GOC-0000830e", "AMPUSER=") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-user-callerid:5] Set("SIP/GOC-0000830e", "AMPUSERCIDNAME=") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-user-callerid:6] GotoIf("SIP/GOC-0000830e", "1?report") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Goto (macro-user-callerid,s,11)
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-user-callerid:11] GotoIf("SIP/GOC-0000830e", "0?continue") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-user-callerid:12] Set("SIP/GOC-0000830e", "__TTL=64") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-user-callerid:13] GotoIf("SIP/GOC-0000830e", "1?continue") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Goto (macro-user-callerid,s,24)
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-user-callerid:24] Set("SIP/GOC-0000830e", "CALLERID(number)=893XXXXX655") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-user-callerid:25] Set("SIP/GOC-0000830e", "CALLERID(name)=893XXXXX655") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-user-callerid:26] Set("SIP/GOC-0000830e", "CHANNEL(language)=en") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:3] Set("SIP/GOC-0000830e", "DIAL_OPTIONS=trI") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:4] Set("SIP/GOC-0000830e", "CONNECTEDLINE(num)=201") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:5] Set("SIP/GOC-0000830e", "CONNECTEDLINE(name,i)=Ekaterina Leontyeva") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:6] Set("SIP/GOC-0000830e", "FM_DIALSTATUS=NOT_INUSE") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:7] Set("SIP/GOC-0000830e", "__EXTTOCALL=201") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:8] Set("SIP/GOC-0000830e", "__PICKUPMARK=201") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:9] Macro("SIP/GOC-0000830e", "blkvm-setifempty,") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-blkvm-setifempty:1] GotoIf("SIP/GOC-0000830e", "1?init") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Goto (macro-blkvm-setifempty,s,4)
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-blkvm-setifempty:4] Set("SIP/GOC-0000830e", "__BLKVM_CHANNEL=SIP/GOC-0000830e") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-blkvm-setifempty:5] Set("SIP/GOC-0000830e", "SHARED(BLKVM,SIP/GOC-0000830e)=TRUE") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-blkvm-setifempty:6] Set("SIP/GOC-0000830e", "GOSUB_RETVAL=TRUE") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-blkvm-setifempty:7] MacroExit("SIP/GOC-0000830e", "") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:10] GotoIf("SIP/GOC-0000830e", "1?skipov") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Goto (from-did-direct,201,13)
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:13] Set("SIP/GOC-0000830e", "RRNODEST=") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:14] Set("SIP/GOC-0000830e", "__NODEST=201") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:15] GosubIf("SIP/GOC-0000830e", "1?sub-fmsetcid,s,1()") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@sub-fmsetcid:1] Goto("SIP/GOC-0000830e", "s-did,1") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Goto (sub-fmsetcid,s-did,1)
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s-did@sub-fmsetcid:1] ExecIf("SIP/GOC-0000830e", "1?Set(__REALCALLERIDNUM=759020)") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s-did@sub-fmsetcid:2] Return("SIP/GOC-0000830e", "") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:16] Set("SIP/GOC-0000830e", "RecordMethod=Group") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:17] Gosub("SIP/GOC-0000830e", "sub-record-check,s,1(exten,201,)") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@sub-record-check:1] GotoIf("SIP/GOC-0000830e", "1?check") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Goto (sub-record-check,s,6)
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@sub-record-check:6] Set("SIP/GOC-0000830e", "__MON_FMT=wav") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@sub-record-check:7] GotoIf("SIP/GOC-0000830e", "1?next") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Goto (sub-record-check,s,10)
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@sub-record-check:10] ExecIf("SIP/GOC-0000830e", "0?Return()") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@sub-record-check:11] GotoIf("SIP/GOC-0000830e", "0?exten,1") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@sub-record-check:12] Set("SIP/GOC-0000830e", "__REC_STATUS=INITIALIZED") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@sub-record-check:13] ExecIf("SIP/GOC-0000830e", "0?Set(__REC_POLICY_MODE=)") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@sub-record-check:14] Set("SIP/GOC-0000830e", "NOW=1509095866") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@sub-record-check:15] Set("SIP/GOC-0000830e", "__DAY=27") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@sub-record-check:16] Set("SIP/GOC-0000830e", "__MONTH=10") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@sub-record-check:17] Set("SIP/GOC-0000830e", "__YEAR=2017") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@sub-record-check:18] Set("SIP/GOC-0000830e", "__TIMESTR=20171027-131746") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@sub-record-check:19] Set("SIP/GOC-0000830e", "__FROMEXTEN=759020") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@sub-record-check:20] Set("SIP/GOC-0000830e", "__CALLFILENAME=exten-201-759020-20171027-131746-1509095866.38373") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@sub-record-check:21] Goto("SIP/GOC-0000830e", "exten,1") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Goto (sub-record-check,exten,1)
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [exten@sub-record-check:1] GotoIf("SIP/GOC-0000830e", "0?callee") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [exten@sub-record-check:2] Set("SIP/GOC-0000830e", "__REC_POLICY_MODE=dontcare") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [exten@sub-record-check:3] GotoIf("SIP/GOC-0000830e", "1?caller") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Goto (sub-record-check,exten,10)
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [exten@sub-record-check:10] Set("SIP/GOC-0000830e", "__REC_POLICY_MODE=") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [exten@sub-record-check:11] GosubIf("SIP/GOC-0000830e", "0?record,1(exten,201,759020)") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [exten@sub-record-check:12] Return("SIP/GOC-0000830e", "") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:18] Set("SIP/GOC-0000830e", "RingGroupMethod=ringallv2") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:19] Set("SIP/GOC-0000830e", "_FMGRP=201") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:20] GotoIf("SIP/GOC-0000830e", "0?doconfirm") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [201@from-did-direct:21] Macro("SIP/GOC-0000830e", "dial,20,trI,201") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-dial:1] GotoIf("SIP/GOC-0000830e", "1?dial") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Goto (macro-dial,s,3)
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-dial:3] AGI("SIP/GOC-0000830e", "dialparties.agi") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] res_agi.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
[2017-10-27 13:17:46] VERBOSE[27604] res_agi.c: dialparties.agi: Starting New Dialparties.agi
[2017-10-27 13:17:46] VERBOSE[27604] res_agi.c: dialparties.agi: Caller ID name is '893XXXXX655' number is '893XXXXX655'
[2017-10-27 13:17:46] VERBOSE[27604] res_agi.c: dialparties.agi: Methodology of ring is 'ringallv2'
[2017-10-27 13:17:46] VERBOSE[27604] res_agi.c: -- dialparties.agi: Added extension 201 to extension map
[2017-10-27 13:17:46] VERBOSE[27604] res_agi.c: -- dialparties.agi: Extension 201 cf is disabled
[2017-10-27 13:17:46] VERBOSE[27604] res_agi.c: -- dialparties.agi: Extension 201 do not disturb is disabled
[2017-10-27 13:17:46] VERBOSE[27604] res_agi.c: -- dialparties.agi: dbset CALLTRACE/201 to 893XXXXX655
[2017-10-27 13:17:46] VERBOSE[27604] res_agi.c: -- dialparties.agi: Filtered ARG3: 201
[2017-10-27 13:17:46] VERBOSE[27604] res_agi.c: -- <SIP/GOC-0000830e>AGI Script dialparties.agi completed, returning 0
[2017-10-27 13:17:46] VERBOSE[27604] pbx.c: -- Executing [s@macro-dial:7] Dial("SIP/GOC-0000830e", "SIP/201,20,trIM(auto-blkvm)") in new stack
[2017-10-27 13:17:46] VERBOSE[27604] netsock2.c: == Using SIP RTP TOS bits 184
[2017-10-27 13:17:46] VERBOSE[27604] netsock2.c: == Using SIP RTP CoS mark 5
[2017-10-27 13:17:46] VERBOSE[27604] app_dial.c: -- Called SIP/201
[2017-10-27 13:17:46] VERBOSE[27604] app_dial.c: -- Connected line update to SIP/GOC-0000830e prevented.
[2017-10-27 13:17:46] VERBOSE[27604] app_dial.c: -- SIP/201-0000830f is ringing
[2017-10-27 13:17:48] VERBOSE[27604] app_macro.c: == Spawn extension (macro-dial, s, 7) exited non-zero on 'SIP/GOC-0000830e' in macro 'dial'
[2017-10-27 13:17:48] VERBOSE[27604] pbx.c: == Spawn extension (from-did-direct, 201, 21) exited non-zero on 'SIP/GOC-0000830e'
[2017-10-27 13:17:48] VERBOSE[27604] pbx.c: -- Executing [h@from-did-direct:1] Macro("SIP/GOC-0000830e", "hangupcall,") in new stack
[2017-10-27 13:17:48] VERBOSE[27604] pbx.c: -- Executing [s@macro-hangupcall:1] GotoIf("SIP/GOC-0000830e", "1?theend") in new stack
[2017-10-27 13:17:48] VERBOSE[27604] pbx.c: -- Goto (macro-hangupcall,s,3)
[2017-10-27 13:17:48] VERBOSE[27604] pbx.c: -- Executing [s@macro-hangupcall:3] ExecIf("SIP/GOC-0000830e", "0?Set(CDR(recordingfile)=)") in new stack
[2017-10-27 13:17:48] VERBOSE[27604] pbx.c: -- Executing [s@macro-hangupcall:4] Hangup("SIP/GOC-0000830e", "") in new stack
[2017-10-27 13:17:48] VERBOSE[27604] app_macro.c: == Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'SIP/GOC-0000830e' in macro 'hangupcall'
[2017-10-27 13:17:48] VERBOSE[27604] pbx.c: == Spawn extension (from-did-direct, h, 1) exited non-zero on 'SIP/GOC-0000830e'
в записях о звонках смотрите вот это
SIP/QW/893XXXXX615
если там cancel - то это глюк вашего диалплана. если там answer, busy что угодно - то ваш провайдер отбивает звонок.
вот так вот взять и ответить - нереально
Задан: 2017-10-27 13:58:30 +0400
Просмотрен: 212 раз
Обновлен: Oct 28 '17
Проект компании "АТС Дизайн"
Asterisk® и Digium® являются зарегистрированными торговыми марками компании
Digium, Inc., США.
IP АТС Asterisk распространяется под лицензией
GNU GPL.
Нахрена в follow me, у абонента есть "по не ответу"? Сразу Misc destination... вставьте.
Out ( 2017-10-27 14:55:50 +0400 )редактироватьпри выключении folow me переадресация не рабоатет((( Пляски были уже всяческие
khu.yam@mail.ru ( 2017-10-27 15:41:25 +0400 )редактироватьработайте с контекстами, проблема тогда в них. Ежели впихнуть транк в from-internal или from-pstn, то обычно проблем меньше.
Out ( 2017-10-27 16:01:20 +0400 )редактироватьЕсли можно для новичка совсем хотя бы ссылку с направлением?
khu.yam@mail.ru ( 2017-10-27 16:16:10 +0400 )редактироватьНамек: если нужный контекст не разрешает выполнять что то, вам в помощь asterisk -rvvvvvvvvvvvvvvv там идет описание чего не хватает...
Каждый контекст имеет свой диапазон разрешаемого.
Out ( 2017-10-27 16:42:08 +0400 )редактироватьв features - есть время возврата звонка при не ответе - 15 секунд и стоит по умолчанию
awsswa ( 2017-10-29 16:58:49 +0400 )редактировать