VIDEOCHAT  ::   FAQ  ::   Поиск  ::   Регистрация  ::   Вход

FreePBX+DV6004S рвет соединение.

Обо всем касательно FreePBX, MetPBX, TrixBox, Elastix, AstPBX и всех других дистрибутивов

Модераторы: april22, Zavr2008

kirush
Сообщения: 23
Зарегистрирован: 13 май 2012, 14:05

FreePBX+DV6004S рвет соединение.

Сообщение kirush »

Добрый день!
Помогите установить причину

PBX Firmware: 6.12.65-24
PBX Service Pack: 1.0.0.0
с транка 4967340666 рвет беспорядочно рвет соединение.
В качестве шлюза на этом транке Dlink DVG6004S.
лог FreePBX:
PRIME_BBCODE_SPOILER_SHOW PRIME_BBCODE_SPOILER:
-- Executing [4967340666@from-trunk-sip-702:1] Set("SIP/702-000000c9", "GROUP()=OUT_7") in new stack
-- Executing [4967340666@from-trunk-sip-702:2] Goto("SIP/702-000000c9", "from-trunk,4967340666,1") in new stack
-- Goto (from-trunk,4967340666,1)
-- Executing [4967340666@from-trunk:1] Set("SIP/702-000000c9", "__FROM_DID=4967340666") in new stack
-- Executing [4967340666@from-trunk:2] Set("SIP/702-000000c9", "CHANNEL(language)=ru") in new stack
-- Executing [4967340666@from-trunk:3] Gosub("SIP/702-000000c9", "sub-record-check,s,1(in,4967340666,dontcare)") in new stack
-- Executing [s@sub-record-check:1] GotoIf("SIP/702-000000c9", "0?initialized") in new stack
-- Executing [s@sub-record-check:2] Set("SIP/702-000000c9", "__REC_STATUS=INITIALIZED") in new stack
-- Executing [s@sub-record-check:3] Set("SIP/702-000000c9", "NOW=1423229234") in new stack
-- Executing [s@sub-record-check:4] Set("SIP/702-000000c9", "__DAY=06") in new stack
-- Executing [s@sub-record-check:5] Set("SIP/702-000000c9", "__MONTH=02") in new stack
-- Executing [s@sub-record-check:6] Set("SIP/702-000000c9", "__YEAR=2015") in new stack
-- Executing [s@sub-record-check:7] Set("SIP/702-000000c9", "__TIMESTR=20150206-162714") in new stack
-- Executing [s@sub-record-check:8] Set("SIP/702-000000c9", "__FROMEXTEN=unknown") in new stack
-- Executing [s@sub-record-check:9] Set("SIP/702-000000c9", "__MON_FMT=wav") in new stack
-- Executing [s@sub-record-check:10] NoOp("SIP/702-000000c9", "Recordings initialized") in new stack
-- Executing [s@sub-record-check:11] ExecIf("SIP/702-000000c9", "0?Set(ARG3=dontcare)") in new stack
-- Executing [s@sub-record-check:12] Set("SIP/702-000000c9", "REC_POLICY_MODE_SAVE=") in new stack
-- Executing [s@sub-record-check:13] ExecIf("SIP/702-000000c9", "0?Set(REC_STATUS=NO)") in new stack
-- Executing [s@sub-record-check:14] GotoIf("SIP/702-000000c9", "2?checkaction") in new stack
-- Goto (sub-record-check,s,17)
-- Executing [s@sub-record-check:17] GotoIf("SIP/702-000000c9", "1?sub-record-check,in,1") in new stack
-- Goto (sub-record-check,in,1)
-- Executing [in@sub-record-check:1] NoOp("SIP/702-000000c9", "Inbound Recording Check to 4967340666") in new stack
-- Executing [in@sub-record-check:2] Set("SIP/702-000000c9", "FROMEXTEN=unknown") in new stack
-- Executing [in@sub-record-check:3] ExecIf("SIP/702-000000c9", "11?Set(FROMEXTEN=84967741839)") in new stack
-- Executing [in@sub-record-check:4] Gosub("SIP/702-000000c9", "recordcheck,1(dontcare,in,4967340666)") in new stack
-- Executing [recordcheck@sub-record-check:1] NoOp("SIP/702-000000c9", "Starting recording check against dontcare") in new stack
-- Executing [recordcheck@sub-record-check:2] Goto("SIP/702-000000c9", "dontcare") in new stack
-- Goto (sub-record-check,recordcheck,3)
-- Executing [recordcheck@sub-record-check:3] Return("SIP/702-000000c9", "") in new stack
-- Executing [in@sub-record-check:5] Return("SIP/702-000000c9", "") in new stack
-- Executing [4967340666@from-trunk:4] Gosub("SIP/702-000000c9", "app-blacklist-check,s,1()") in new stack
-- Executing [s@app-blacklist-check:1] GotoIf("SIP/702-000000c9", "0?blacklisted") in new stack
-- Executing [s@app-blacklist-check:2] Set("SIP/702-000000c9", "CALLED_BLACKLIST=1") in new stack
-- Executing [s@app-blacklist-check:3] Return("SIP/702-000000c9", "") in new stack
-- Executing [4967340666@from-trunk:5] Set("SIP/702-000000c9", "CDR(did)=4967340666") in new stack
-- Executing [4967340666@from-trunk:6] ExecIf("SIP/702-000000c9", "1 ?Set(CALLERID(name)=84967741839)") in new stack
-- Executing [4967340666@from-trunk:7] Set("SIP/702-000000c9", "CHANNEL(musicclass)=default") in new stack
-- Executing [4967340666@from-trunk:8] Set("SIP/702-000000c9", "__MOHCLASS=default") in new stack
[2015-02-06 16:27:14] WARNING[3184][C-0000085b]: func_channel.c:538 func_channel_read: Unknown or unavailable item requested: 'reversecharge'
-- Executing [4967340666@from-trunk:9] GotoIf("SIP/702-000000c9", "0?macro-hangupcall") in new stack
-- Executing [4967340666@from-trunk:10] Set("SIP/702-000000c9", "__CALLINGPRES_SV=allowed_not_screened") in new stack
-- Executing [4967340666@from-trunk:11] Set("SIP/702-000000c9", "CALLERPRES()=allowed_not_screened") in new stack
-- Executing [4967340666@from-trunk:12] Goto("SIP/702-000000c9", "timeconditions,2,1") in new stack
-- Goto (timeconditions,2,1)
-- Executing [2@timeconditions:1] Set("SIP/702-000000c9", "DB(TC/2/INUSESTATE)=INUSE") in new stack
-- Executing [2@timeconditions:2] Set("SIP/702-000000c9", "DB(TC/2/NOT_INUSESTATE)=NOT_INUSE") in new stack
-- Executing [2@timeconditions:3] GotoIfTime("SIP/702-000000c9", "10:00-18:00,sat-sun,*,*?truestate") in new stack
-- Executing [2@timeconditions:4] GotoIfTime("SIP/702-000000c9", "09:00-21:00,mon-fri,*,*?truestate") in new stack
-- Goto (timeconditions,2,12)
-- Executing [2@timeconditions:12] GotoIf("SIP/702-000000c9", "0?falsegoto") in new stack
-- Executing [2@timeconditions:13] ExecIf("SIP/702-000000c9", "0?Set(DB(TC/2)=)") in new stack
-- Executing [2@timeconditions:14] Set("SIP/702-000000c9", "DEVICE_STATE(Custom:TC2)=NOT_INUSE") in new stack
-- Executing [2@timeconditions:15] ExecIf("SIP/702-000000c9", "0?Set(NOT_INUSE)") in new stack
-- Executing [2@timeconditions:16] GotoIf("SIP/702-000000c9", "1?ivr-1,s,1") in new stack
-- Goto (ivr-1,s,1)
-- Executing [s@ivr-1:1] Set("SIP/702-000000c9", "_IVR_CONTEXT_ivr-1=") in new stack
-- Executing [s@ivr-1:2] Set("SIP/702-000000c9", "_IVR_CONTEXT=ivr-1") in new stack
-- Executing [s@ivr-1:3] Set("SIP/702-000000c9", "__IVR_RETVM=") in new stack
-- Executing [s@ivr-1:4] GotoIf("SIP/702-000000c9", "0?skip") in new stack
-- Executing [s@ivr-1:5] Answer("SIP/702-000000c9", "") in new stack
> 0x7fe8f0021d20 -- Probation passed - setting RTP source address to 91.207.114.6:10002
-- Executing [s@ivr-1:6] Wait("SIP/702-000000c9", "1") in new stack
-- Executing [s@ivr-1:7] Set("SIP/702-000000c9", "IVR_MSG=custom/work") in new stack
-- Executing [s@ivr-1:8] Set("SIP/702-000000c9", "TIMEOUT(digit)=3") in new stack
-- Digit timeout set to 3.000
-- Executing [s@ivr-1:9] ExecIf("SIP/702-000000c9", "1?Background(custom/work)") in new stack
-- <SIP/702-000000c9> Playing 'custom/work.slin' (language 'ru')
-- Executing [8@ivr-1:1] Goto("SIP/702-000000c9", "from-did-direct,08,1") in new stack
-- Goto (from-did-direct,08,1)
-- Executing [08@from-did-direct:1] GotoIf("SIP/702-000000c9", "1?ext-local,08,1") in new stack
-- Goto (ext-local,08,1)
-- Executing [08@ext-local:1] Set("SIP/702-000000c9", "__RINGTIMER=60") in new stack
-- Executing [08@ext-local:2] Macro("SIP/702-000000c9", "exten-vm,novm,08,0,0,0") in new stack
-- Executing [s@macro-exten-vm:1] Macro("SIP/702-000000c9", "user-callerid,") in new stack
-- Executing [s@macro-user-callerid:1] Set("SIP/702-000000c9", "TOUCH_MONITOR=1423229234.841") in new stack
-- Executing [s@macro-user-callerid:2] Set("SIP/702-000000c9", "AMPUSER=84967741839") in new stack
-- Executing [s@macro-user-callerid:3] GotoIf("SIP/702-000000c9", "0?report") in new stack
-- Executing [s@macro-user-callerid:4] ExecIf("SIP/702-000000c9", "1?Set(REALCALLERIDNUM=84967741839)") in new stack
-- Executing [s@macro-user-callerid:5] Set("SIP/702-000000c9", "AMPUSER=") in new stack
-- Executing [s@macro-user-callerid:6] GotoIf("SIP/702-000000c9", "0?limit") in new stack
-- Executing [s@macro-user-callerid:7] Set("SIP/702-000000c9", "AMPUSERCIDNAME=") in new stack
-- Executing [s@macro-user-callerid:8] GotoIf("SIP/702-000000c9", "1?report") in new stack
-- Goto (macro-user-callerid,s,16)
-- Executing [s@macro-user-callerid:16] GotoIf("SIP/702-000000c9", "0?continue") in new stack
-- Executing [s@macro-user-callerid:17] ExecIf("SIP/702-000000c9", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
-- Executing [s@macro-user-callerid:18] Set("SIP/702-000000c9", "__TTL=64") in new stack
-- Executing [s@macro-user-callerid:19] GotoIf("SIP/702-000000c9", "1?continue") in new stack
-- Goto (macro-user-callerid,s,30)
-- Executing [s@macro-user-callerid:30] Set("SIP/702-000000c9", "CALLERID(number)=84967741839") in new stack
-- Executing [s@macro-user-callerid:31] Set("SIP/702-000000c9", "CALLERID(name)=84967741839") in new stack
-- Executing [s@macro-user-callerid:32] Set("SIP/702-000000c9", "CDR(cnum)=84967741839") in new stack
-- Executing [s@macro-user-callerid:33] Set("SIP/702-000000c9", "CDR(cnam)=84967741839") in new stack
-- Executing [s@macro-user-callerid:34] Set("SIP/702-000000c9", "CHANNEL(language)=ru") in new stack
-- Executing [s@macro-exten-vm:2] Set("SIP/702-000000c9", "RingGroupMethod=none") in new stack
-- Executing [s@macro-exten-vm:3] Set("SIP/702-000000c9", "__EXTTOCALL=08") in new stack
-- Executing [s@macro-exten-vm:4] Set("SIP/702-000000c9", "__PICKUPMARK=08") in new stack
-- Executing [s@macro-exten-vm:5] Set("SIP/702-000000c9", "RT=") in new stack
-- Executing [s@macro-exten-vm:6] ExecIf("SIP/702-000000c9", "0?Macro(vm,novm,DIRECTDIAL,)") in new stack
-- Executing [s@macro-exten-vm:7] ExecIf("SIP/702-000000c9", "0?MacroExit()") in new stack
-- Executing [s@macro-exten-vm:8] Gosub("SIP/702-000000c9", "sub-record-check,s,1(exten,08,)") in new stack
-- Executing [s@sub-record-check:1] GotoIf("SIP/702-000000c9", "11?initialized") in new stack
-- Goto (sub-record-check,s,10)
-- Executing [s@sub-record-check:10] NoOp("SIP/702-000000c9", "Recordings initialized") in new stack
-- Executing [s@sub-record-check:11] ExecIf("SIP/702-000000c9", "0?Set(ARG3=dontcare)") in new stack
-- Executing [s@sub-record-check:12] Set("SIP/702-000000c9", "REC_POLICY_MODE_SAVE=") in new stack
-- Executing [s@sub-record-check:13] ExecIf("SIP/702-000000c9", "0?Set(REC_STATUS=NO)") in new stack
-- Executing [s@sub-record-check:14] GotoIf("SIP/702-000000c9", "5?checkaction") in new stack
-- Goto (sub-record-check,s,17)
-- Executing [s@sub-record-check:17] GotoIf("SIP/702-000000c9", "1?sub-record-check,exten,1") in new stack
-- Goto (sub-record-check,exten,1)
-- Executing [exten@sub-record-check:1] NoOp("SIP/702-000000c9", "Exten Recording Check between 84967741839 and 08") in new stack
-- Executing [exten@sub-record-check:2] Set("SIP/702-000000c9", "CALLTYPE=external") in new stack
-- Executing [exten@sub-record-check:3] ExecIf("SIP/702-000000c9", "0?Set(CALLTYPE=)") in new stack
-- Executing [exten@sub-record-check:4] Set("SIP/702-000000c9", "CALLEE=yes") in new stack
-- Executing [exten@sub-record-check:5] ExecIf("SIP/702-000000c9", "0?Set(CALLEE=dontcare)") in new stack
-- Executing [exten@sub-record-check:6] GotoIf("SIP/702-000000c9", "1?callee") in new stack
-- Goto (sub-record-check,exten,11)
-- Executing [exten@sub-record-check:11] Gosub("SIP/702-000000c9", "recordcheck,1(yes,external,08)") in new stack
-- Executing [recordcheck@sub-record-check:1] NoOp("SIP/702-000000c9", "Starting recording check against yes") in new stack
-- Executing [recordcheck@sub-record-check:2] Goto("SIP/702-000000c9", "yes") in new stack
-- Goto (sub-record-check,recordcheck,9)
-- Executing [recordcheck@sub-record-check:9] ExecIf("SIP/702-000000c9", "0?Return()") in new stack
-- Executing [recordcheck@sub-record-check:10] Set("SIP/702-000000c9", "__REC_POLICY_MODE=YES") in new stack
-- Executing [recordcheck@sub-record-check:11] Goto("SIP/702-000000c9", "startrec") in new stack
-- Goto (sub-record-check,recordcheck,16)
-- Executing [recordcheck@sub-record-check:16] NoOp("SIP/702-000000c9", "Starting recording: external, 08") in new stack
-- Executing [recordcheck@sub-record-check:17] Set("SIP/702-000000c9", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack
-- Executing [recordcheck@sub-record-check:18] Set("SIP/702-000000c9", "__CALLFILENAME=external-08-84967741839-20150206-162714-1423229234.841") in new stack
-- Executing [recordcheck@sub-record-check:19] MixMonitor("SIP/702-000000c9", "2015/02/06/external-08-84967741839-20150206-162714-1423229234.841.wav,ai(LOCAL_MIXMON_ID),") in new stack
-- Executing [recordcheck@sub-record-check:20] Set("SIP/702-000000c9", "__MIXMON_ID=0x7fe934300b30") in new stack
== Begin MixMonitor Recording SIP/702-000000c9
-- Executing [recordcheck@sub-record-check:21] Set("SIP/702-000000c9", "__RECORD_ID=SIP/702-000000c9") in new stack
-- Executing [recordcheck@sub-record-check:22] Set("SIP/702-000000c9", "__REC_STATUS=RECORDING") in new stack
-- Executing [recordcheck@sub-record-check:23] Set("SIP/702-000000c9", "CDR(recordingfile)=external-08-84967741839-20150206-162714-1423229234.841.wav") in new stack
-- Executing [recordcheck@sub-record-check:24] Return("SIP/702-000000c9", "") in new stack
-- Executing [exten@sub-record-check:12] Return("SIP/702-000000c9", "") in new stack
-- Executing [s@macro-exten-vm:9] GotoIf("SIP/702-000000c9", "1?macrodial") in new stack
-- Goto (macro-exten-vm,s,15)
-- Executing [s@macro-exten-vm:15] GosubIf("SIP/702-000000c9", "0?clrheader,1()") in new stack
-- Executing [s@macro-exten-vm:16] Macro("SIP/702-000000c9", "dial-one,,Ttr,08") in new stack
-- Executing [s@macro-dial-one:1] Set("SIP/702-000000c9", "DEXTEN=08") in new stack
-- Executing [s@macro-dial-one:2] Set("SIP/702-000000c9", "DIALSTATUS_CW=") in new stack
-- Executing [s@macro-dial-one:3] GosubIf("SIP/702-000000c9", "0?screen,1()") in new stack
-- Executing [s@macro-dial-one:4] GosubIf("SIP/702-000000c9", "0?cf,1()") in new stack
-- Executing [s@macro-dial-one:5] GotoIf("SIP/702-000000c9", "1?skip1") in new stack
-- Goto (macro-dial-one,s,8)
-- Executing [s@macro-dial-one:8] GotoIf("SIP/702-000000c9", "0?nodial") in new stack
-- Executing [s@macro-dial-one:9] GotoIf("SIP/702-000000c9", "0?continue") in new stack
-- Executing [s@macro-dial-one:10] Set("SIP/702-000000c9", "EXTHASCW=ENABLED") in new stack
-- Executing [s@macro-dial-one:11] GotoIf("SIP/702-000000c9", "0?next1:cwinusebusy") in new stack
-- Goto (macro-dial-one,s,23)
-- Executing [s@macro-dial-one:23] GotoIf("SIP/702-000000c9", "1?next3:continue") in new stack
-- Goto (macro-dial-one,s,24)
-- Executing [s@macro-dial-one:24] ExecIf("SIP/702-000000c9", "0?Set(DIALSTATUS_CW=BUSY)") in new stack
-- Executing [s@macro-dial-one:25] GotoIf("SIP/702-000000c9", "0?nodial") in new stack
-- Executing [s@macro-dial-one:26] GosubIf("SIP/702-000000c9", "1?dstring,1():dlocal,1()") in new stack
-- Executing [dstring@macro-dial-one:1] Set("SIP/702-000000c9", "DSTRING=") in new stack
-- Executing [dstring@macro-dial-one:2] Set("SIP/702-000000c9", "DEVICES=08") in new stack
-- Executing [dstring@macro-dial-one:3] ExecIf("SIP/702-000000c9", "0?Return()") in new stack
-- Executing [dstring@macro-dial-one:4] ExecIf("SIP/702-000000c9", "0?Set(DEVICES=8)") in new stack
-- Executing [dstring@macro-dial-one:5] Set("SIP/702-000000c9", "LOOPCNT=1") in new stack
-- Executing [dstring@macro-dial-one:6] Set("SIP/702-000000c9", "ITER=1") in new stack
-- Executing [dstring@macro-dial-one:7] Set("SIP/702-000000c9", "THISDIAL=SIP/08") in new stack
-- Executing [dstring@macro-dial-one:8] GosubIf("SIP/702-000000c9", "1?zap2dahdi,1()") in new stack
-- Executing [zap2dahdi@macro-dial-one:1] ExecIf("SIP/702-000000c9", "0?Return()") in new stack
-- Executing [zap2dahdi@macro-dial-one:2] Set("SIP/702-000000c9", "NEWDIAL=") in new stack
-- Executing [zap2dahdi@macro-dial-one:3] Set("SIP/702-000000c9", "LOOPCNT2=1") in new stack
-- Executing [zap2dahdi@macro-dial-one:4] Set("SIP/702-000000c9", "ITER2=1") in new stack
-- Executing [zap2dahdi@macro-dial-one:5] Set("SIP/702-000000c9", "THISPART2=SIP/08") in new stack
-- Executing [zap2dahdi@macro-dial-one:6] ExecIf("SIP/702-000000c9", "0?Set(THISPART2=DAHDI/08)") in new stack
-- Executing [zap2dahdi@macro-dial-one:7] Set("SIP/702-000000c9", "NEWDIAL=SIP/08&") in new stack
-- Executing [zap2dahdi@macro-dial-one:8] Set("SIP/702-000000c9", "ITER2=2") in new stack
-- Executing [zap2dahdi@macro-dial-one:9] GotoIf("SIP/702-000000c9", "0?begin2") in new stack
-- Executing [zap2dahdi@macro-dial-one:10] Set("SIP/702-000000c9", "THISDIAL=SIP/08") in new stack
-- Executing [zap2dahdi@macro-dial-one:11] Return("SIP/702-000000c9", "") in new stack
-- Executing [dstring@macro-dial-one:9] GotoIf("SIP/702-000000c9", "1?doset") in new stack
-- Goto (macro-dial-one,dstring,12)
-- Executing [dstring@macro-dial-one:12] Set("SIP/702-000000c9", "DSTRING=SIP/08&") in new stack
-- Executing [dstring@macro-dial-one:13] Set("SIP/702-000000c9", "ITER=2") in new stack
-- Executing [dstring@macro-dial-one:14] GotoIf("SIP/702-000000c9", "0?begin") in new stack
-- Executing [dstring@macro-dial-one:15] Set("SIP/702-000000c9", "DSTRING=SIP/08") in new stack
-- Executing [dstring@macro-dial-one:16] Return("SIP/702-000000c9", "") in new stack
-- Executing [s@macro-dial-one:27] GotoIf("SIP/702-000000c9", "0?nodial") in new stack
-- Executing [s@macro-dial-one:28] GotoIf("SIP/702-000000c9", "0?skiptrace") in new stack
-- Executing [s@macro-dial-one:29] GosubIf("SIP/702-000000c9", "1?ctset,1():ctclear,1()") in new stack
-- Executing [ctset@macro-dial-one:1] Set("SIP/702-000000c9", "DB(CALLTRACE/08)=84967741839") in new stack
-- Executing [ctset@macro-dial-one:2] Return("SIP/702-000000c9", "") in new stack
-- Executing [s@macro-dial-one:30] Set("SIP/702-000000c9", "D_OPTIONS=Ttr") in new stack
-- Executing [s@macro-dial-one:31] ExecIf("SIP/702-000000c9", "0?SIPAddHeader(Alert-Info: )") in new stack
-- Executing [s@macro-dial-one:32] ExecIf("SIP/702-000000c9", "0?SIPAddHeader()") in new stack
-- Executing [s@macro-dial-one:33] ExecIf("SIP/702-000000c9", "1?Set(CHANNEL(musicclass)=default)") in new stack
-- Executing [s@macro-dial-one:34] GosubIf("SIP/702-000000c9", "0?qwait,1()") in new stack
-- Executing [s@macro-dial-one:35] Set("SIP/702-000000c9", "__CWIGNORE=") in new stack
-- Executing [s@macro-dial-one:36] Set("SIP/702-000000c9", "__KEEPCID=TRUE") in new stack
-- Executing [s@macro-dial-one:37] GotoIf("SIP/702-000000c9", "0?usegoto,1") in new stack
-- Executing [s@macro-dial-one:38] GotoIf("SIP/702-000000c9", "1?godial") in new stack
-- Goto (macro-dial-one,s,43)
-- Executing [s@macro-dial-one:43] Macro("SIP/702-000000c9", "dialout-one-predial-hook,") in new stack
-- Executing [s@macro-dialout-one-predial-hook:1] MacroExit("SIP/702-000000c9", "") in new stack
-- Executing [s@macro-dial-one:44] Dial("SIP/702-000000c9", "SIP/08,,Ttr") in new stack
Настройки шлюза:
Telephony settings: https://yadi.sk/i/SD8Qh4XReWKPp
SIP settings: https://yadi.sk/i/lqDuiLm9eWKRZ
Advanced Setiings: https://yadi.sk/i/DW8SUNaneWKVZ

Склоняюсь к проблеме на стороне тел. шлюза.
april22
Сообщения: 2187
Зарегистрирован: 09 июл 2012, 09:47

Re: FreePBX+DV6004S рвет соединение.

Сообщение april22 »

Executing [s@macro-dial-one:44] Dial("SIP/702-000000c9", "SIP/08,,Ttr") in new stack
а это кто такой 08 ?
Своими вопросами , вы загоняете меня в ГУГЛЬ.
kirush
Сообщения: 23
Зарегистрирован: 13 май 2012, 14:05

Re: FreePBX+DV6004S рвет соединение.

Сообщение kirush »

Звонок пришел с 84967741839 на 4967340666, включился IVR, далее звонящий набрал 8, и его перевело ко мне на 08.
После нескольких минут - разрыв.
ded
Сообщения: 15625
Зарегистрирован: 26 авг 2010, 19:00

Re: FreePBX+DV6004S рвет соединение.

Сообщение ded »

ко мне на 08 - это разрыв (шаблона).
Ожидается перевод на 01 - пожар! Поджог! В млицию звонить? превод на 02, есть ли жертвы, раненые? Есть , перевод на 03, скорая? Срочно выезжайте на пожар! и т. д.
kirush
Сообщения: 23
Зарегистрирован: 13 май 2012, 14:05

Re: FreePBX+DV6004S рвет соединение.

Сообщение kirush »

Внутренних номеров в пределах 10 шт, не увидел смысла в трехзначных номерах.
В чем разрыв шаблона? Нарушает какие то RFC? Дайте ссылку плз
Но хотелось бы услышать что нибудь по проблеме.
ded
Сообщения: 15625
Зарегистрирован: 26 авг 2010, 19:00

Re: FreePBX+DV6004S рвет соединение.

Сообщение ded »

Если номеров в пределах 10 шт, то хватает однозначных номеров. Ноль - лишний.
Ноль впереди во всём мире - признак национального звонка, два нуля, они же плюcик - признак интернационального.
Игнорировать накопленый мировым сообществом порядок - неразумно.
Чтобы понять причину разрыва надо увидеть и проанализировать всю сессию установления вызова, включив
CLI> sip set debug peer 08 (справочная?)
При необходимости можно даже исследовать черезWireshark.
kirush
Сообщения: 23
Зарегистрирован: 13 май 2012, 14:05

Re: FreePBX+DV6004S рвет соединение.

Сообщение kirush »

Справочная у нас 09 :)
попробую снять дебаг.
kirush
Сообщения: 23
Зарегистрирован: 13 май 2012, 14:05

Re: FreePBX+DV6004S рвет соединение.

Сообщение kirush »

Портянка
Звонок был на линию 702 с номера 340529, он встал в очередь (1000), а потом на него ответил 05.
PRIME_BBCODE_SPOILER_SHOW PRIME_BBCODE_SPOILER:
<------------->
--- (8 headers 0 lines) ---
Really destroying SIP dialog '142571639030873-31153207985149@10.1.16.208' Method: ACK
-- Executing [s@ivr-1:10] WaitExten("SIP/702-0000014b", "1,") in new stack
-- Timeout on SIP/702-0000014b, going to 't'
-- Executing [t@ivr-1:1] Goto("SIP/702-0000014b", "ext-queues,1000,1") in new stack
-- Goto (ext-queues,1000,1)
-- Executing [1000@ext-queues:1] Macro("SIP/702-0000014b", "user-callerid,") in new stack
-- Executing [s@macro-user-callerid:1] Set("SIP/702-0000014b", "TOUCH_MONITOR=1423475263.1035") in new stack
-- Executing [s@macro-user-callerid:2] Set("SIP/702-0000014b", "AMPUSER=340529") in new stack
-- Executing [s@macro-user-callerid:3] GotoIf("SIP/702-0000014b", "0?report") in new stack
-- Executing [s@macro-user-callerid:4] ExecIf("SIP/702-0000014b", "1?Set(REALCALLERIDNUM=340529)") in new stack
-- Executing [s@macro-user-callerid:5] Set("SIP/702-0000014b", "AMPUSER=") in new stack
-- Executing [s@macro-user-callerid:6] GotoIf("SIP/702-0000014b", "0?limit") in new stack
-- Executing [s@macro-user-callerid:7] Set("SIP/702-0000014b", "AMPUSERCIDNAME=") in new stack
-- Executing [s@macro-user-callerid:8] GotoIf("SIP/702-0000014b", "1?report") in new stack
-- Goto (macro-user-callerid,s,16)
-- Executing [s@macro-user-callerid:16] GotoIf("SIP/702-0000014b", "0?continue") in new stack
-- Executing [s@macro-user-callerid:17] ExecIf("SIP/702-0000014b", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
-- Executing [s@macro-user-callerid:18] Set("SIP/702-0000014b", "__TTL=64") in new stack
-- Executing [s@macro-user-callerid:19] GotoIf("SIP/702-0000014b", "1?continue") in new stack
-- Goto (macro-user-callerid,s,30)
-- Executing [s@macro-user-callerid:30] Set("SIP/702-0000014b", "CALLERID(number)=340529") in new stack
-- Executing [s@macro-user-callerid:31] Set("SIP/702-0000014b", "CALLERID(name)=340529") in new stack
-- Executing [s@macro-user-callerid:32] Set("SIP/702-0000014b", "CDR(cnum)=340529") in new stack
-- Executing [s@macro-user-callerid:33] Set("SIP/702-0000014b", "CDR(cnam)=340529") in new stack
-- Executing [s@macro-user-callerid:34] Set("SIP/702-0000014b", "CHANNEL(language)=ru") in new stack
-- Executing [1000@ext-queues:2] Answer("SIP/702-0000014b", "") in new stack
-- Executing [1000@ext-queues:3] Macro("SIP/702-0000014b", "blkvm-set,reset") in new stack
-- Executing [s@macro-blkvm-set:1] ExecIf("SIP/702-0000014b", "1?Set(__BLKVM_CHANNEL=SIP/702-0000014b)") in new stack
-- Executing [s@macro-blkvm-set:2] Set("SIP/702-0000014b", "SHARED(BLKVM,SIP/702-0000014b)=TRUE") in new stack
-- Executing [s@macro-blkvm-set:3] Set("SIP/702-0000014b", "GOSUB_RETVAL=TRUE") in new stack
-- Executing [s@macro-blkvm-set:4] MacroExit("SIP/702-0000014b", "") in new stack
-- Executing [1000@ext-queues:4] ExecIf("SIP/702-0000014b", "1?Set(_DIAL_OPTIONS=TtrM(auto-blkvm))") in new stack
-- Executing [1000@ext-queues:5] Set("SIP/702-0000014b", "__NODEST=1000") in new stack
-- Executing [1000@ext-queues:6] Set("SIP/702-0000014b", "QCIDPP=") in new stack
-- Executing [1000@ext-queues:7] Set("SIP/702-0000014b", "VQ_CIDPP=") in new stack
-- Executing [1000@ext-queues:8] ExecIf("SIP/702-0000014b", "0?Macro(prepend-cid,)") in new stack
-- Executing [1000@ext-queues:9] Set("SIP/702-0000014b", "QAINFO=") in new stack
-- Executing [1000@ext-queues:10] Set("SIP/702-0000014b", "VQ_AINFO=") in new stack
-- Executing [1000@ext-queues:11] ExecIf("SIP/702-0000014b", "0?Set(__ALERT_INFO=)") in new stack
-- Executing [1000@ext-queues:12] Set("SIP/702-0000014b", "QJOINMSG=ru/queue-periodic-announce") in new stack
-- Executing [1000@ext-queues:13] Set("SIP/702-0000014b", "VQ_JOINMSG=") in new stack
-- Executing [1000@ext-queues:14] Set("SIP/702-0000014b", "QRETRY=n") in new stack
-- Executing [1000@ext-queues:15] Set("SIP/702-0000014b", "VQ_RETRY=") in new stack
-- Executing [1000@ext-queues:16] Set("SIP/702-0000014b", "QOPTIONS=tn") in new stack
-- Executing [1000@ext-queues:17] Set("SIP/702-0000014b", "VQ_OPTIONS=") in new stack
-- Executing [1000@ext-queues:18] Set("SIP/702-0000014b", "QGOSUB=") in new stack
-- Executing [1000@ext-queues:19] Set("SIP/702-0000014b", "VQ_GOSUB=") in new stack
-- Executing [1000@ext-queues:20] Set("SIP/702-0000014b", "QAGI=") in new stack
-- Executing [1000@ext-queues:21] Set("SIP/702-0000014b", "VQ_AGI=") in new stack
-- Executing [1000@ext-queues:22] Set("SIP/702-0000014b", "QRULE=") in new stack
-- Executing [1000@ext-queues:23] Set("SIP/702-0000014b", "VQ_RULE=") in new stack
-- Executing [1000@ext-queues:24] Set("SIP/702-0000014b", "QPOSITION=") in new stack
-- Executing [1000@ext-queues:25] Set("SIP/702-0000014b", "VQ_POSITION=") in new stack
-- Executing [1000@ext-queues:26] Gosub("SIP/702-0000014b", "sub-record-check,s,1(q,1000,never)") in new stack
-- Executing [s@sub-record-check:1] GotoIf("SIP/702-0000014b", "6?initialized") in new stack
-- Goto (sub-record-check,s,10)
-- Executing [s@sub-record-check:10] NoOp("SIP/702-0000014b", "Recordings initialized") in new stack
-- Executing [s@sub-record-check:11] ExecIf("SIP/702-0000014b", "0?Set(ARG3=dontcare)") in new stack
-- Executing [s@sub-record-check:12] Set("SIP/702-0000014b", "REC_POLICY_MODE_SAVE=") in new stack
-- Executing [s@sub-record-check:13] ExecIf("SIP/702-0000014b", "0?Set(REC_STATUS=NO)") in new stack
-- Executing [s@sub-record-check:14] GotoIf("SIP/702-0000014b", "1?checkaction") in new stack
-- Goto (sub-record-check,s,17)
-- Executing [s@sub-record-check:17] GotoIf("SIP/702-0000014b", "0?sub-record-check,q,1") in new stack
-- Executing [s@sub-record-check:18] NoOp("SIP/702-0000014b", "Generic q Recording Check - 340529 1000") in new stack
-- Executing [s@sub-record-check:19] Gosub("SIP/702-0000014b", "recordcheck,1(never,q,1000)") in new stack
-- Executing [recordcheck@sub-record-check:1] NoOp("SIP/702-0000014b", "Starting recording check against never") in new stack
-- Executing [recordcheck@sub-record-check:2] Goto("SIP/702-0000014b", "never") in new stack
-- Goto (sub-record-check,recordcheck,14)
-- Executing [recordcheck@sub-record-check:14] Set("SIP/702-0000014b", "__REC_POLICY_MODE=NEVER") in new stack
-- Executing [recordcheck@sub-record-check:15] Goto("SIP/702-0000014b", "stoprec") in new stack
-- Goto (sub-record-check,recordcheck,25)
-- Executing [recordcheck@sub-record-check:25] NoOp("SIP/702-0000014b", "Stopping recording: q, 1000") in new stack
-- Executing [recordcheck@sub-record-check:26] Set("SIP/702-0000014b", "__REC_STATUS=STOPPED") in new stack
-- Executing [recordcheck@sub-record-check:27] System("SIP/702-0000014b", "/var/lib/asterisk/bin/stoprecording.php "SIP/702-0000014b"") in new stack
-- Executing [recordcheck@sub-record-check:28] Return("SIP/702-0000014b", "") in new stack
-- Executing [s@sub-record-check:20] Return("SIP/702-0000014b", "") in new stack
-- Executing [1000@ext-queues:27] ExecIf("SIP/702-0000014b", "0?Playback(ru/queue-periodic-announce, )") in new stack
-- Executing [1000@ext-queues:28] QueueLog("SIP/702-0000014b", "1000,1423475263.1035,NONE,DID,4967340666") in new stack
-- Executing [1000@ext-queues:29] Set("SIP/702-0000014b", "QAANNOUNCE=") in new stack
-- Executing [1000@ext-queues:30] Set("SIP/702-0000014b", "VQ_AANNOUNCE=") in new stack
-- Executing [1000@ext-queues:31] Set("SIP/702-0000014b", "QMOH=") in new stack
-- Executing [1000@ext-queues:32] Set("SIP/702-0000014b", "VQ_MOH=") in new stack
-- Executing [1000@ext-queues:33] ExecIf("SIP/702-0000014b", "0?Set(__MOHCLASS=)") in new stack
-- Executing [1000@ext-queues:34] ExecIf("SIP/702-0000014b", "1?Set(CHANNEL(musicclass)=default)") in new stack
-- Executing [1000@ext-queues:35] Set("SIP/702-0000014b", "QMAXWAIT=") in new stack
-- Executing [1000@ext-queues:36] Set("SIP/702-0000014b", "VQ_MAXWAIT=") in new stack
-- Executing [1000@ext-queues:37] Set("SIP/702-0000014b", "QUEUENUM=1000") in new stack
-- Executing [1000@ext-queues:38] Set("SIP/702-0000014b", "QUEUEJOINTIME=1423475284") in new stack
-- Executing [1000@ext-queues:39] Queue("SIP/702-0000014b", "1000,tn,,,,,,,,") in new stack
-- Started music on hold, class 'default', on SIP/702-0000014b
-- LazyMembers debugging - Numbusies: 0, Nummems: 1
-- Executing [05@from-queue:1] Set("Local/05@from-queue-00000160;2", "QAGENT=05") in new stack
-- Executing [05@from-queue:2] Goto("Local/05@from-queue-00000160;2", "1000,1") in new stack
-- Goto (from-queue,1000,1)
-- Executing [1000@from-queue:1] Goto("Local/05@from-queue-00000160;2", "from-internal,05,1") in new stack
-- Goto (from-internal,05,1)
-- Executing [05@from-internal:1] GotoIf("Local/05@from-queue-00000160;2", "1?ext-local,05,1") in new stack
-- Goto (ext-local,05,1)
-- Executing [05@ext-local:1] Set("Local/05@from-queue-00000160;2", "__RINGTIMER=60") in new stack
-- Executing [05@ext-local:2] Macro("Local/05@from-queue-00000160;2", "exten-vm,novm,05,0,0,0") in new stack
-- Executing [s@macro-exten-vm:1] Macro("Local/05@from-queue-00000160;2", "user-callerid,") in new stack
-- Executing [s@macro-user-callerid:1] Set("Local/05@from-queue-00000160;2", "TOUCH_MONITOR=1423475284.1039") in new stack
-- Executing [s@macro-user-callerid:2] Set("Local/05@from-queue-00000160;2", "AMPUSER=340529") in new stack
-- Executing [s@macro-user-callerid:3] GotoIf("Local/05@from-queue-00000160;2", "1?report") in new stack
-- Goto (macro-user-callerid,s,16)
-- Executing [s@macro-user-callerid:16] GotoIf("Local/05@from-queue-00000160;2", "0?continue") in new stack
-- Executing [s@macro-user-callerid:17] ExecIf("Local/05@from-queue-00000160;2", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
-- Executing [s@macro-user-callerid:18] Set("Local/05@from-queue-00000160;2", "__TTL=63") in new stack
-- Executing [s@macro-user-callerid:19] GotoIf("Local/05@from-queue-00000160;2", "1?continue") in new stack
-- Goto (macro-user-callerid,s,30)
-- Executing [s@macro-user-callerid:30] Set("Local/05@from-queue-00000160;2", "CALLERID(number)=340529") in new stack
-- Executing [s@macro-user-callerid:31] Set("Local/05@from-queue-00000160;2", "CALLERID(name)=340529") in new stack
-- Executing [s@macro-user-callerid:32] Set("Local/05@from-queue-00000160;2", "CDR(cnum)=340529") in new stack
-- Executing [s@macro-user-callerid:33] Set("Local/05@from-queue-00000160;2", "CDR(cnam)=340529") in new stack
-- Executing [s@macro-user-callerid:34] Set("Local/05@from-queue-00000160;2", "CHANNEL(language)=ru") in new stack
-- Executing [s@macro-exten-vm:2] Set("Local/05@from-queue-00000160;2", "RingGroupMethod=none") in new stack
-- Executing [s@macro-exten-vm:3] Set("Local/05@from-queue-00000160;2", "__EXTTOCALL=05") in new stack
-- Executing [s@macro-exten-vm:4] Set("Local/05@from-queue-00000160;2", "__PICKUPMARK=05") in new stack
-- Executing [s@macro-exten-vm:5] Set("Local/05@from-queue-00000160;2", "RT=") in new stack
[2015-02-09 12:48:04] WARNING[26568][C-0000127b]: chan_sip.c:21976 func_header_read: This function can only be used on SIP channels.
-- Executing [s@macro-exten-vm:6] ExecIf("Local/05@from-queue-00000160;2", "0?Macro(vm,novm,DIRECTDIAL,)") in new stack
[2015-02-09 12:48:04] WARNING[26568][C-0000127b]: chan_sip.c:21976 func_header_read: This function can only be used on SIP channels.
[2015-02-09 12:48:04] WARNING[26568][C-0000127b]: chan_sip.c:21976 func_header_read: This function can only be used on SIP channels.
-- Executing [s@macro-exten-vm:7] ExecIf("Local/05@from-queue-00000160;2", "0?MacroExit()") in new stack
[2015-02-09 12:48:04] WARNING[26568][C-0000127b]: chan_sip.c:21976 func_header_read: This function can only be used on SIP channels.
-- Executing [s@macro-exten-vm:8] Gosub("Local/05@from-queue-00000160;2", "sub-record-check,s,1(exten,05,)") in new stack
-- Executing [s@sub-record-check:1] GotoIf("Local/05@from-queue-00000160;2", "0?initialized") in new stack
-- Executing [s@sub-record-check:2] Set("Local/05@from-queue-00000160;2", "__REC_STATUS=INITIALIZED") in new stack
-- Executing [s@sub-record-check:3] Set("Local/05@from-queue-00000160;2", "NOW=1423475284") in new stack
-- Executing [s@sub-record-check:4] Set("Local/05@from-queue-00000160;2", "__DAY=09") in new stack
-- Executing [s@sub-record-check:5] Set("Local/05@from-queue-00000160;2", "__MONTH=02") in new stack
-- Executing [s@sub-record-check:6] Set("Local/05@from-queue-00000160;2", "__YEAR=2015") in new stack
-- Executing [s@sub-record-check:7] Set("Local/05@from-queue-00000160;2", "__TIMESTR=20150209-124804") in new stack
-- Executing [s@sub-record-check:8] Set("Local/05@from-queue-00000160;2", "__FROMEXTEN=340529") in new stack
-- Executing [s@sub-record-check:9] Set("Local/05@from-queue-00000160;2", "__MON_FMT=wav") in new stack
-- Executing [s@sub-record-check:10] NoOp("Local/05@from-queue-00000160;2", "Recordings initialized") in new stack
-- Executing [s@sub-record-check:11] ExecIf("Local/05@from-queue-00000160;2", "0?Set(ARG3=dontcare)") in new stack
-- Executing [s@sub-record-check:12] Set("Local/05@from-queue-00000160;2", "REC_POLICY_MODE_SAVE=NEVER") in new stack
-- Executing [s@sub-record-check:13] ExecIf("Local/05@from-queue-00000160;2", "0?Set(REC_STATUS=NO)") in new stack
-- Executing [s@sub-record-check:14] GotoIf("Local/05@from-queue-00000160;2", "5?checkaction") in new stack
-- Goto (sub-record-check,s,17)
-- Executing [s@sub-record-check:17] GotoIf("Local/05@from-queue-00000160;2", "1?sub-record-check,exten,1") in new stack
-- Goto (sub-record-check,exten,1)
-- Executing [exten@sub-record-check:1] NoOp("Local/05@from-queue-00000160;2", "Exten Recording Check between 340529 and 05") in new stack
-- Executing [exten@sub-record-check:2] Set("Local/05@from-queue-00000160;2", "CALLTYPE=external") in new stack
-- Executing [exten@sub-record-check:3] ExecIf("Local/05@from-queue-00000160;2", "0?Set(CALLTYPE=)") in new stack
-- Executing [exten@sub-record-check:4] Set("Local/05@from-queue-00000160;2", "CALLEE=yes") in new stack
-- Executing [exten@sub-record-check:5] ExecIf("Local/05@from-queue-00000160;2", "0?Set(CALLEE=dontcare)") in new stack
-- Executing [exten@sub-record-check:6] GotoIf("Local/05@from-queue-00000160;2", "1?callee") in new stack
-- Goto (sub-record-check,exten,11)
-- Executing [exten@sub-record-check:11] Gosub("Local/05@from-queue-00000160;2", "recordcheck,1(yes,external,05)") in new stack
-- Executing [recordcheck@sub-record-check:1] NoOp("Local/05@from-queue-00000160;2", "Starting recording check against yes") in new stack
-- Executing [recordcheck@sub-record-check:2] Goto("Local/05@from-queue-00000160;2", "yes") in new stack
-- Goto (sub-record-check,recordcheck,9)
-- Executing [recordcheck@sub-record-check:9] ExecIf("Local/05@from-queue-00000160;2", "1?Return()") in new stack
-- Executing [exten@sub-record-check:12] Return("Local/05@from-queue-00000160;2", "") in new stack
-- Executing [s@macro-exten-vm:9] GotoIf("Local/05@from-queue-00000160;2", "10?macrodial") in new stack
-- Goto (macro-exten-vm,s,15)
-- Executing [s@macro-exten-vm:15] GosubIf("Local/05@from-queue-00000160;2", "0?clrheader,1()") in new stack
-- Executing [s@macro-exten-vm:16] Macro("Local/05@from-queue-00000160;2", "dial-one,,TtrM(auto-blkvm),05") in new stack
-- Executing [s@macro-dial-one:1] Set("Local/05@from-queue-00000160;2", "DEXTEN=05") in new stack
-- Executing [s@macro-dial-one:2] Set("Local/05@from-queue-00000160;2", "DIALSTATUS_CW=") in new stack
-- Executing [s@macro-dial-one:3] GosubIf("Local/05@from-queue-00000160;2", "0?screen,1()") in new stack
-- Executing [s@macro-dial-one:4] GosubIf("Local/05@from-queue-00000160;2", "0?cf,1()") in new stack
-- Executing [s@macro-dial-one:5] GotoIf("Local/05@from-queue-00000160;2", "1?skip1") in new stack
-- Goto (macro-dial-one,s,8)
-- Executing [s@macro-dial-one:8] GotoIf("Local/05@from-queue-00000160;2", "0?nodial") in new stack
-- Executing [s@macro-dial-one:9] GotoIf("Local/05@from-queue-00000160;2", "0?continue") in new stack
-- Executing [s@macro-dial-one:10] Set("Local/05@from-queue-00000160;2", "EXTHASCW=ENABLED") in new stack
-- Executing [s@macro-dial-one:11] GotoIf("Local/05@from-queue-00000160;2", "0?next1:cwinusebusy") in new stack
-- Goto (macro-dial-one,s,23)
-- Executing [s@macro-dial-one:23] GotoIf("Local/05@from-queue-00000160;2", "1?next3:continue") in new stack
-- Goto (macro-dial-one,s,24)
-- Executing [s@macro-dial-one:24] ExecIf("Local/05@from-queue-00000160;2", "0?Set(DIALSTATUS_CW=BUSY)") in new stack
-- Executing [s@macro-dial-one:25] GotoIf("Local/05@from-queue-00000160;2", "0?nodial") in new stack
-- Executing [s@macro-dial-one:26] GosubIf("Local/05@from-queue-00000160;2", "1?dstring,1():dlocal,1()") in new stack
-- Executing [dstring@macro-dial-one:1] Set("Local/05@from-queue-00000160;2", "DSTRING=") in new stack
-- Executing [dstring@macro-dial-one:2] Set("Local/05@from-queue-00000160;2", "DEVICES=05") in new stack
-- Executing [dstring@macro-dial-one:3] ExecIf("Local/05@from-queue-00000160;2", "0?Return()") in new stack
-- Executing [dstring@macro-dial-one:4] ExecIf("Local/05@from-queue-00000160;2", "0?Set(DEVICES=5)") in new stack
-- Executing [dstring@macro-dial-one:5] Set("Local/05@from-queue-00000160;2", "LOOPCNT=1") in new stack
-- Executing [dstring@macro-dial-one:6] Set("Local/05@from-queue-00000160;2", "ITER=1") in new stack
-- Executing [dstring@macro-dial-one:7] Set("Local/05@from-queue-00000160;2", "THISDIAL=SIP/05") in new stack
-- Executing [dstring@macro-dial-one:8] GosubIf("Local/05@from-queue-00000160;2", "1?zap2dahdi,1()") in new stack
-- Executing [zap2dahdi@macro-dial-one:1] ExecIf("Local/05@from-queue-00000160;2", "0?Return()") in new stack
-- Executing [zap2dahdi@macro-dial-one:2] Set("Local/05@from-queue-00000160;2", "NEWDIAL=") in new stack
-- Executing [zap2dahdi@macro-dial-one:3] Set("Local/05@from-queue-00000160;2", "LOOPCNT2=1") in new stack
-- Executing [zap2dahdi@macro-dial-one:4] Set("Local/05@from-queue-00000160;2", "ITER2=1") in new stack
-- Executing [zap2dahdi@macro-dial-one:5] Set("Local/05@from-queue-00000160;2", "THISPART2=SIP/05") in new stack
-- Executing [zap2dahdi@macro-dial-one:6] ExecIf("Local/05@from-queue-00000160;2", "0?Set(THISPART2=DAHDI/05)") in new stack
-- Executing [zap2dahdi@macro-dial-one:7] Set("Local/05@from-queue-00000160;2", "NEWDIAL=SIP/05&") in new stack
-- Executing [zap2dahdi@macro-dial-one:8] Set("Local/05@from-queue-00000160;2", "ITER2=2") in new stack
-- Executing [zap2dahdi@macro-dial-one:9] GotoIf("Local/05@from-queue-00000160;2", "0?begin2") in new stack
-- Executing [zap2dahdi@macro-dial-one:10] Set("Local/05@from-queue-00000160;2", "THISDIAL=SIP/05") in new stack
-- Executing [zap2dahdi@macro-dial-one:11] Return("Local/05@from-queue-00000160;2", "") in new stack
-- Executing [dstring@macro-dial-one:9] GotoIf("Local/05@from-queue-00000160;2", "1?doset") in new stack
-- Goto (macro-dial-one,dstring,12)
-- Executing [dstring@macro-dial-one:12] Set("Local/05@from-queue-00000160;2", "DSTRING=SIP/05&") in new stack
-- Executing [dstring@macro-dial-one:13] Set("Local/05@from-queue-00000160;2", "ITER=2") in new stack
-- Executing [dstring@macro-dial-one:14] GotoIf("Local/05@from-queue-00000160;2", "0?begin") in new stack
-- Executing [dstring@macro-dial-one:15] Set("Local/05@from-queue-00000160;2", "DSTRING=SIP/05") in new stack
-- Executing [dstring@macro-dial-one:16] Return("Local/05@from-queue-00000160;2", "") in new stack
-- Executing [s@macro-dial-one:27] GotoIf("Local/05@from-queue-00000160;2", "0?nodial") in new stack
-- Executing [s@macro-dial-one:28] GotoIf("Local/05@from-queue-00000160;2", "0?skiptrace") in new stack
-- Executing [s@macro-dial-one:29] GosubIf("Local/05@from-queue-00000160;2", "1?ctset,1():ctclear,1()") in new stack
-- Executing [ctset@macro-dial-one:1] Set("Local/05@from-queue-00000160;2", "DB(CALLTRACE/05)=340529") in new stack
-- Executing [ctset@macro-dial-one:2] Return("Local/05@from-queue-00000160;2", "") in new stack
-- Executing [s@macro-dial-one:30] Set("Local/05@from-queue-00000160;2", "D_OPTIONS=TtrM(auto-blkvm)") in new stack
-- Executing [s@macro-dial-one:31] ExecIf("Local/05@from-queue-00000160;2", "0?SIPAddHeader(Alert-Info: )") in new stack
-- Executing [s@macro-dial-one:32] ExecIf("Local/05@from-queue-00000160;2", "0?SIPAddHeader()") in new stack
-- Executing [s@macro-dial-one:33] ExecIf("Local/05@from-queue-00000160;2", "1?Set(CHANNEL(musicclass)=default)") in new stack
-- Executing [s@macro-dial-one:34] GosubIf("Local/05@from-queue-00000160;2", "0?qwait,1()") in new stack
-- Executing [s@macro-dial-one:35] Set("Local/05@from-queue-00000160;2", "__CWIGNORE=") in new stack
-- Executing [s@macro-dial-one:36] Set("Local/05@from-queue-00000160;2", "__KEEPCID=TRUE") in new stack
-- Executing [s@macro-dial-one:37] GotoIf("Local/05@from-queue-00000160;2", "0?usegoto,1") in new stack

<--- SIP read from UDP:10.1.16.208:5060 --->
REGISTER sip:91.207.114.4 SIP/2.0
Via: SIP/2.0/UDP 10.1.16.208:5060;branch=z9hG4bK10532160823121918434;rport
From: 05 <sip:05@91.207.114.4:5060>;tag=2906022732
To: 05 <sip:05@91.207.114.4:5060>
Call-ID: 31802130493701-166481871114673@10.1.16.208
CSeq: 26567 REGISTER
Contact: <sip:05@10.1.16.208:5060>
Max-Forwards: 70
Expires: 60
Supported: path
User-Agent: Voip Phone 1.0
Content-Length: 0

<------------->
--- (12 headers 0 lines) ---
Sending to 10.1.16.208:5060 (NAT)

<--- Transmitting (NAT) to 10.1.16.208:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 10.1.16.208:5060;branch=z9hG4bK10532160823121918434;received=10.1.16.208;rport=5060
From: 05 <sip:05@91.207.114.4:5060>;tag=2906022732
To: 05 <sip:05@91.207.114.4:5060>;tag=as5da3baf6
Call-ID: 31802130493701-166481871114673@10.1.16.208
CSeq: 26567 REGISTER
Server: FPBX-12.0.36(11.15.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="7ba82c4b"
Content-Length: 0


<------------>
Scheduling destruction of SIP dialog '31802130493701-166481871114673@10.1.16.208' in 32000 ms (Method: REGISTER)

<--- SIP read from UDP:10.1.16.208:5060 --->
REGISTER sip:91.207.114.4 SIP/2.0
Via: SIP/2.0/UDP 10.1.16.208:5060;branch=z9hG4bK28270760549693870;rport
From: 05 <sip:05@91.207.114.4:5060>;tag=2906022732
To: 05 <sip:05@91.207.114.4:5060>
Call-ID: 31802130493701-166481871114673@10.1.16.208
CSeq: 26568 REGISTER
Contact: <sip:05@10.1.16.208:5060>
Authorization: Digest username="05", realm="asterisk", nonce="7ba82c4b", uri="sip:91.207.114.4", response="31efa7a873ab8bc07e39a825f5f586b9", algorithm=MD5
Max-Forwards: 70
Expires: 60
Supported: path
User-Agent: Voip Phone 1.0
Content-Length: 0

<------------->
--- (13 headers 0 lines) ---
Sending to 10.1.16.208:5060 (NAT)
-- Executing [s@macro-dial-one:38] GotoIf("Local/05@from-queue-00000160;2", "1?godial") in new stack
-- Goto (macro-dial-one,s,43)
Reliably Transmitting (NAT) to 10.1.16.208:5060:
OPTIONS sip:05@10.1.16.208:5060 SIP/2.0
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK695ac476;rport
Max-Forwards: 70
From: "Unknown" <sip:Unknown@91.207.114.4>;tag=as699c84b7
To: <sip:05@10.1.16.208:5060>
Contact: <sip:Unknown@91.207.114.4:5060>
Call-ID: 2e9953cf2dc99a1266eacdd70d998ffe@91.207.114.4:5060
CSeq: 102 OPTIONS
User-Agent: FPBX-12.0.36(11.15.0)
Date: Mon, 09 Feb 2015 09:48:05 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Content-Length: 0


---

<--- Transmitting (NAT) to 10.1.16.208:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.1.16.208:5060;branch=z9hG4bK28270760549693870;received=10.1.16.208;rport=5060
From: 05 <sip:05@91.207.114.4:5060>;tag=2906022732
To: 05 <sip:05@91.207.114.4:5060>;tag=as5da3baf6
Call-ID: 31802130493701-166481871114673@10.1.16.208
CSeq: 26568 REGISTER
Server: FPBX-12.0.36(11.15.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Expires: 60
Contact: <sip:05@10.1.16.208:5060>;expires=60
Date: Mon, 09 Feb 2015 09:48:05 GMT
Content-Length: 0


<------------>
-- Executing [s@macro-dial-one:43] Macro("Local/05@from-queue-00000160;2", "dialout-one-predial-hook,") in new stack
Scheduling destruction of SIP dialog '62eefc377efb5e6a774339da2ee9b097@91.207.114.4:5060' in 6400 ms (Method: NOTIFY)
Reliably Transmitting (NAT) to 10.1.16.208:5060:
NOTIFY sip:05@10.1.16.208:5060 SIP/2.0
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK249411a0;rport
Max-Forwards: 70
From: "Unknown" <sip:Unknown@91.207.114.4>;tag=as55057662
To: <sip:05@10.1.16.208:5060>
Contact: <sip:Unknown@91.207.114.4:5060>
Call-ID: 62eefc377efb5e6a774339da2ee9b097@91.207.114.4:5060
CSeq: 102 NOTIFY
User-Agent: FPBX-12.0.36(11.15.0)
Event: message-summary
Content-Type: application/simple-message-summary
Content-Length: 87

Messages-Waiting: no
Message-Account: sip:*97@91.207.114.4
Voice-Message: 0/0 (0/0)

---
Scheduling destruction of SIP dialog '31802130493701-166481871114673@10.1.16.208' in 32000 ms (Method: REGISTER)
-- Executing [s@macro-dialout-one-predial-hook:1] MacroExit("Local/05@from-queue-00000160;2", "") in new stack
-- Executing [s@macro-dial-one:44] Dial("Local/05@from-queue-00000160;2", "SIP/05,,TtrM(auto-blkvm)") in new stack
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
Audio is at 12858
Adding codec 100004 (alaw) to SDP
Adding codec 100003 (ulaw) to SDP
Adding codec 100002 (gsm) to SDP
Adding codec 100011 (g726) to SDP
Adding non-codec 0x1 (telephone-event) to SDP
Reliably Transmitting (NAT) to 10.1.16.208:5060:
INVITE sip:05@10.1.16.208:5060 SIP/2.0
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK4a4bfa1f;rport
Max-Forwards: 70
From: "340529" <sip:340529@91.207.114.4>;tag=as3ec6464f
To: <sip:05@10.1.16.208:5060>
Contact: <sip:340529@91.207.114.4:5060>
Call-ID: 2ccf3826620134f16282a8eb02732b97@91.207.114.4:5060
CSeq: 102 INVITE
User-Agent: FPBX-12.0.36(11.15.0)
Date: Mon, 09 Feb 2015 09:48:05 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
P-Asserted-Identity: "340529" <sip:340529@91.207.114.4>
Content-Type: application/sdp
Content-Length: 314

v=0
o=root 1668199369 1668199369 IN IP4 91.207.114.4
s=Asterisk PBX 11.15.0
c=IN IP4 91.207.114.4
t=0 0
m=audio 12858 RTP/AVP 8 0 3 111 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:3 GSM/8000
a=rtpmap:111 G726-32/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

---
-- Called SIP/05
-- Local/05@from-queue-00000160;1 is ringing
-- Local/05@from-queue-00000160;1 connected line has changed. Saving it until answer for SIP/702-0000014b
-- Local/05@from-queue-00000160;1 connected line has changed. Saving it until answer for SIP/702-0000014b

<--- SIP read from UDP:10.1.16.208:5060 --->
REGISTER sip:91.207.114.4 SIP/2.0
Via: SIP/2.0/UDP 10.1.16.208:5060;branch=z9hG4bK28270760549693870;rport
From: 05 <sip:05@91.207.114.4:5060>;tag=2906022732
To: 05 <sip:05@91.207.114.4:5060>
Call-ID: 31802130493701-166481871114673@10.1.16.208
CSeq: 26568 REGISTER
Contact: <sip:05@10.1.16.208:5060>
Authorization: Digest username="05", realm="asterisk", nonce="7ba82c4b", uri="sip:91.207.114.4", response="31efa7a873ab8bc07e39a825f5f586b9", algorithm=MD5
Max-Forwards: 70
Expires: 60
Supported: path
User-Agent: Voip Phone 1.0
Content-Length: 0

<------------->
--- (13 headers 0 lines) ---
Sending to 10.1.16.208:5060 (NAT)
[2015-02-09 12:48:06] NOTICE[19448]: chan_sip.c:16436 check_auth: Correct auth, but based on stale nonce received from '05 <sip:05@91.207.114.4:5060>;tag=2906022732'

<--- Transmitting (NAT) to 10.1.16.208:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 10.1.16.208:5060;branch=z9hG4bK28270760549693870;received=10.1.16.208;rport=5060
From: 05 <sip:05@91.207.114.4:5060>;tag=2906022732
To: 05 <sip:05@91.207.114.4:5060>;tag=as5da3baf6
Call-ID: 31802130493701-166481871114673@10.1.16.208
CSeq: 26568 REGISTER
Server: FPBX-12.0.36(11.15.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="1b07ae75", stale=true
Content-Length: 0


<------------>
Scheduling destruction of SIP dialog '31802130493701-166481871114673@10.1.16.208' in 32000 ms (Method: REGISTER)

<--- SIP read from UDP:10.1.16.208:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK695ac476;rport
From: "Unknown" <sip:Unknown@91.207.114.4>;tag=as699c84b7
To: <sip:05@10.1.16.208:5060>
Call-ID: 2e9953cf2dc99a1266eacdd70d998ffe@91.207.114.4:5060
CSeq: 102 OPTIONS
Contact: <sip:05@10.1.16.208:5060>
Supported: 100rel, replaces, timer
Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REFER, NOTIFY, INFO, PRACK, UPDATE, MESSAGE
Accept: application/sdp, message/sipfrag, application/dtmf-relay
Content-Length: 0

<------------->
--- (11 headers 0 lines) ---
Really destroying SIP dialog '2e9953cf2dc99a1266eacdd70d998ffe@91.207.114.4:5060' Method: OPTIONS

<--- SIP read from UDP:10.1.16.208:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK249411a0;rport
From: "Unknown" <sip:Unknown@91.207.114.4>;tag=as55057662
To: <sip:05@10.1.16.208:5060>
Call-ID: 62eefc377efb5e6a774339da2ee9b097@91.207.114.4:5060
CSeq: 102 NOTIFY
Content-Length: 0

<------------->
--- (7 headers 0 lines) ---
Really destroying SIP dialog '62eefc377efb5e6a774339da2ee9b097@91.207.114.4:5060' Method: NOTIFY

<--- SIP read from UDP:10.1.16.208:5060 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK4a4bfa1f;rport
From: "340529" <sip:340529@91.207.114.4>;tag=as3ec6464f
To: <sip:05@10.1.16.208:5060>
Call-ID: 2ccf3826620134f16282a8eb02732b97@91.207.114.4:5060
CSeq: 102 INVITE
Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REFER, NOTIFY, INFO, PRACK, UPDATE, MESSAGE
Content-Length: 0

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

<--- SIP read from UDP:10.1.16.208:5060 --->
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK4a4bfa1f;rport
From: "340529" <sip:340529@91.207.114.4>;tag=as3ec6464f
To: <sip:05@10.1.16.208:5060>;tag=2142215481
Call-ID: 2ccf3826620134f16282a8eb02732b97@91.207.114.4:5060
CSeq: 102 INVITE
Contact: <sip:05@10.1.16.208:5060>
Server: Voip Phone 1.0
Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REFER, NOTIFY, INFO, PRACK, UPDATE, MESSAGE
Content-Length: 0

<------------->
--- (10 headers 0 lines) ---
list_route: hop: <sip:05@10.1.16.208:5060>
-- SIP/05-0000014e is ringing
-- Local/05@from-queue-00000160;1 is ringing
[2015-02-09 12:48:07] WARNING[19448]: chan_sip.c:4020 retrans_pkt: Retransmission timeout reached on transmission d83274d44d6176540a2876663dc8bf00 for seqno 1 (Non-critical Response) -- See https://wiki.asterisk.org/wiki/display/ ... nsmissions
Packet timed out after 31999ms with no response
[2015-02-09 12:48:07] WARNING[19448]: chan_sip.c:4082 retrans_pkt: Timeout on d83274d44d6176540a2876663dc8bf00 on non-critical invite transaction.

<--- SIP read from UDP:10.1.16.208:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK4a4bfa1f;rport
From: "340529" <sip:340529@91.207.114.4>;tag=as3ec6464f
To: <sip:05@10.1.16.208:5060>;tag=2142215481
Call-ID: 2ccf3826620134f16282a8eb02732b97@91.207.114.4:5060
CSeq: 102 INVITE
Contact: <sip:05@10.1.16.208:5060>
Supported: 100rel, replaces, timer
Server: Voip Phone 1.0
Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REFER, NOTIFY, INFO, PRACK, UPDATE, MESSAGE
Content-Type: application/sdp
Content-Length: 234

v=0
o=05 29434981 15859294 IN IP4 10.1.16.208
s=A conversation
c=IN IP4 10.1.16.208
t=0 0
m=audio 10154 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-15
a=sendrecv
<------------->
--- (12 headers 11 lines) ---
Found RTP audio format 8
Found RTP audio format 0
Found RTP audio format 101
Found audio description format PCMA for ID 8
Found audio description format PCMU for ID 0
Found audio description format telephone-event for ID 101
Capabilities: us - (gsm|ulaw|alaw|g726), peer - audio=(ulaw|alaw)/video=(nothing)/text=(nothing), combined - (ulaw|alaw)
Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x1 (telephone-event|), combined - 0x1 (telephone-event|)
Peer audio RTP is at port 10.1.16.208:10154
list_route: hop: <sip:05@10.1.16.208:5060>
set_destination: Parsing <sip:05@10.1.16.208:5060> for address/port to send to
set_destination: set destination to 10.1.16.208:5060
Transmitting (NAT) to 10.1.16.208:5060:
ACK sip:05@10.1.16.208:5060 SIP/2.0
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK6fd55f3b;rport
Max-Forwards: 70
From: "340529" <sip:340529@91.207.114.4>;tag=as3ec6464f
To: <sip:05@10.1.16.208:5060>;tag=2142215481
Contact: <sip:340529@91.207.114.4:5060>
Call-ID: 2ccf3826620134f16282a8eb02732b97@91.207.114.4:5060
CSeq: 102 ACK
User-Agent: FPBX-12.0.36(11.15.0)
Content-Length: 0


---
-- Local/05@from-queue-00000160;1 connected line has changed. Saving it until answer for SIP/702-0000014b
-- SIP/05-0000014e answered Local/05@from-queue-00000160;2
-- Executing [s@macro-auto-blkvm:1] Set("SIP/05-0000014e", "__MACRO_RESULT=") in new stack
-- Executing [s@macro-auto-blkvm:2] Set("SIP/05-0000014e", "CFIGNORE=") in new stack
-- Executing [s@macro-auto-blkvm:3] Set("SIP/05-0000014e", "MASTER_CHANNEL(CFIGNORE)=") in new stack
-- Executing [s@macro-auto-blkvm:4] Set("SIP/05-0000014e", "FORWARD_CONTEXT=from-internal") in new stack
-- Executing [s@macro-auto-blkvm:5] Set("SIP/05-0000014e", "MASTER_CHANNEL(FORWARD_CONTEXT)=from-internal") in new stack
-- Executing [s@macro-auto-blkvm:6] Macro("SIP/05-0000014e", "blkvm-clr,") in new stack
-- Executing [s@macro-blkvm-clr:1] Set("SIP/05-0000014e", "SHARED(BLKVM,SIP/702-0000014b)=") in new stack
-- Executing [s@macro-blkvm-clr:2] Set("SIP/05-0000014e", "GOSUB_RETVAL=") in new stack
-- Executing [s@macro-blkvm-clr:3] MacroExit("SIP/05-0000014e", "") in new stack
-- Executing [s@macro-auto-blkvm:7] ExecIf("SIP/05-0000014e", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(num))=05)") in new stack
-- Executing [s@macro-auto-blkvm:8] ExecIf("SIP/05-0000014e", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(name))=Techsupport-22)") in new stack
-- Local/05@from-queue-00000160;1 answered SIP/702-0000014b
-- <Local/05@from-queue-00000160;1> Playing 'queue-reporthold.slin' (language 'ru')
> 0x7fe9400e5720 -- Probation passed - setting RTP source address to 10.1.16.208:10154
-- <Local/05@from-queue-00000160;1> Playing 'digits/12.slin' (language 'ru')
-- <Local/05@from-queue-00000160;1> Playing 'queue-seconds.slin' (language 'ru')
-- Stopped music on hold on SIP/702-0000014b
[2015-02-09 12:48:26] NOTICE[19448]: chan_sip.c:14993 sip_reregister: -- Re-registration for 4967316666@194.190.64.81
[2015-02-09 12:48:27] NOTICE[19448]: chan_sip.c:23534 handle_response_register: Outbound Registration: Expiry for 194.190.64.81 is 120 sec (Scheduling reregistration in 105 s)
[2015-02-09 12:48:31] NOTICE[19448]: chan_sip.c:14993 sip_reregister: -- Re-registration for bezzubov@sip.nonoh.net
[2015-02-09 12:48:31] NOTICE[19448]: chan_sip.c:23534 handle_response_register: Outbound Registration: Expiry for sip.nonoh.net is 120 sec (Scheduling reregistration in 105 s)

<--- SIP read from UDP:10.1.16.208:5060 --->
REGISTER sip:91.207.114.4 SIP/2.0
Via: SIP/2.0/UDP 10.1.16.208:5060;branch=z9hG4bK703530141291227400;rport
From: 05 <sip:05@91.207.114.4:5060>;tag=2906022732
To: 05 <sip:05@91.207.114.4:5060>
Call-ID: 31802130493701-166481871114673@10.1.16.208
CSeq: 26569 REGISTER
Contact: <sip:05@10.1.16.208:5060>
Max-Forwards: 70
Expires: 60
Supported: path
User-Agent: Voip Phone 1.0
Content-Length: 0

<------------->
--- (12 headers 0 lines) ---
Sending to 10.1.16.208:5060 (NAT)

<--- Transmitting (NAT) to 10.1.16.208:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 10.1.16.208:5060;branch=z9hG4bK703530141291227400;received=10.1.16.208;rport=5060
From: 05 <sip:05@91.207.114.4:5060>;tag=2906022732
To: 05 <sip:05@91.207.114.4:5060>;tag=as5da3baf6
Call-ID: 31802130493701-166481871114673@10.1.16.208
CSeq: 26569 REGISTER
Server: FPBX-12.0.36(11.15.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="237f0e2f"
Content-Length: 0


<------------>
Scheduling destruction of SIP dialog '31802130493701-166481871114673@10.1.16.208' in 32000 ms (Method: REGISTER)

<--- SIP read from UDP:10.1.16.208:5060 --->
REGISTER sip:91.207.114.4 SIP/2.0
Via: SIP/2.0/UDP 10.1.16.208:5060;branch=z9hG4bK96461877817515808;rport
From: 05 <sip:05@91.207.114.4:5060>;tag=2906022732
To: 05 <sip:05@91.207.114.4:5060>
Call-ID: 31802130493701-166481871114673@10.1.16.208
CSeq: 26570 REGISTER
Contact: <sip:05@10.1.16.208:5060>
Authorization: Digest username="05", realm="asterisk", nonce="237f0e2f", uri="sip:91.207.114.4", response="a82babcacc6e2c007611c169a1aa298e", algorithm=MD5
Max-Forwards: 70
Expires: 60
Supported: path
User-Agent: Voip Phone 1.0
Content-Length: 0

<------------->
--- (13 headers 0 lines) ---
Sending to 10.1.16.208:5060 (NAT)
Reliably Transmitting (NAT) to 10.1.16.208:5060:
OPTIONS sip:05@10.1.16.208:5060 SIP/2.0
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK1f71c24f;rport
Max-Forwards: 70
From: "Unknown" <sip:Unknown@91.207.114.4>;tag=as1ea43aff
To: <sip:05@10.1.16.208:5060>
Contact: <sip:Unknown@91.207.114.4:5060>
Call-ID: 07bc57c502e5f56053e1be091e1ea532@91.207.114.4:5060
CSeq: 102 OPTIONS
User-Agent: FPBX-12.0.36(11.15.0)
Date: Mon, 09 Feb 2015 09:48:36 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Content-Length: 0


---

<--- Transmitting (NAT) to 10.1.16.208:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.1.16.208:5060;branch=z9hG4bK96461877817515808;received=10.1.16.208;rport=5060
From: 05 <sip:05@91.207.114.4:5060>;tag=2906022732
To: 05 <sip:05@91.207.114.4:5060>;tag=as5da3baf6
Call-ID: 31802130493701-166481871114673@10.1.16.208
CSeq: 26570 REGISTER
Server: FPBX-12.0.36(11.15.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Expires: 60
Contact: <sip:05@10.1.16.208:5060>;expires=60
Date: Mon, 09 Feb 2015 09:48:36 GMT
Content-Length: 0


<------------>
Scheduling destruction of SIP dialog '555bac876bbcda4a4d4ec54f11376198@91.207.114.4:5060' in 6400 ms (Method: NOTIFY)
Reliably Transmitting (NAT) to 10.1.16.208:5060:
NOTIFY sip:05@10.1.16.208:5060 SIP/2.0
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK18113206;rport
Max-Forwards: 70
From: "Unknown" <sip:Unknown@91.207.114.4>;tag=as60cb4916
To: <sip:05@10.1.16.208:5060>
Contact: <sip:Unknown@91.207.114.4:5060>
Call-ID: 555bac876bbcda4a4d4ec54f11376198@91.207.114.4:5060
CSeq: 102 NOTIFY
User-Agent: FPBX-12.0.36(11.15.0)
Event: message-summary
Content-Type: application/simple-message-summary
Content-Length: 87

Messages-Waiting: no
Message-Account: sip:*97@91.207.114.4
Voice-Message: 0/0 (0/0)

---
Scheduling destruction of SIP dialog '31802130493701-166481871114673@10.1.16.208' in 32000 ms (Method: REGISTER)

<--- SIP read from UDP:10.1.16.208:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK1f71c24f;rport
From: "Unknown" <sip:Unknown@91.207.114.4>;tag=as1ea43aff
To: <sip:05@10.1.16.208:5060>
Call-ID: 07bc57c502e5f56053e1be091e1ea532@91.207.114.4:5060
CSeq: 102 OPTIONS
Contact: <sip:05@10.1.16.208:5060>
Supported: 100rel, replaces, timer
Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REFER, NOTIFY, INFO, PRACK, UPDATE, MESSAGE
Accept: application/sdp, message/sipfrag, application/dtmf-relay
Content-Length: 0

<------------->
--- (11 headers 0 lines) ---
Really destroying SIP dialog '07bc57c502e5f56053e1be091e1ea532@91.207.114.4:5060' Method: OPTIONS

<--- SIP read from UDP:10.1.16.208:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK18113206;rport
From: "Unknown" <sip:Unknown@91.207.114.4>;tag=as60cb4916
To: <sip:05@10.1.16.208:5060>
Call-ID: 555bac876bbcda4a4d4ec54f11376198@91.207.114.4:5060
CSeq: 102 NOTIFY
Content-Length: 0

<------------->
--- (7 headers 0 lines) ---
Really destroying SIP dialog '555bac876bbcda4a4d4ec54f11376198@91.207.114.4:5060' Method: NOTIFY
-- Executing [h@ext-queues:1] Macro("SIP/702-0000014b", "hangupcall,") in new stack
-- Executing [s@macro-hangupcall:1] ExecIf("SIP/702-0000014b", "0?Set(CDR(recordingfile)=.wav)") in new stack
-- Executing [s@macro-hangupcall:2] GotoIf("SIP/702-0000014b", "1?theend") in new stack
-- Goto (macro-hangupcall,s,4)
-- Executing [s@macro-hangupcall:4] ExecIf("SIP/702-0000014b", "0?Set(CDR(recordingfile)=)") in new stack
-- Executing [s@macro-hangupcall:5] Hangup("SIP/702-0000014b", "") in new stack
== Spawn extension (macro-hangupcall, s, 5) exited non-zero on 'SIP/702-0000014b' in macro 'hangupcall'
== Spawn extension (ext-queues, h, 1) exited non-zero on 'SIP/702-0000014b'
-- Executing [h@macro-dial-one:1] Macro("Local/05@from-queue-00000160;2", "hangupcall,") in new stack
-- Executing [s@macro-hangupcall:1] ExecIf("Local/05@from-queue-00000160;2", "0?Set(CDR(recordingfile)=.wav)") in new stack
-- Executing [s@macro-hangupcall:2] GotoIf("Local/05@from-queue-00000160;2", "1?theend") in new stack
-- Goto (macro-hangupcall,s,4)
-- Executing [s@macro-hangupcall:4] ExecIf("Local/05@from-queue-00000160;2", "0?Set(CDR(recordingfile)=)") in new stack
-- Executing [s@macro-hangupcall:5] Hangup("Local/05@from-queue-00000160;2", "") in new stack
== Spawn extension (macro-hangupcall, s, 5) exited non-zero on 'Local/05@from-queue-00000160;2' in macro 'hangupcall'
== Spawn extension (macro-dial-one, h, 1) exited non-zero on 'Local/05@from-queue-00000160;2'
== Spawn extension (ext-queues, 1000, 39) exited non-zero on 'SIP/702-0000014b'
Scheduling destruction of SIP dialog '2ccf3826620134f16282a8eb02732b97@91.207.114.4:5060' in 6400 ms (Method: INVITE)
set_destination: Parsing <sip:05@10.1.16.208:5060> for address/port to send to
set_destination: set destination to 10.1.16.208:5060
Reliably Transmitting (NAT) to 10.1.16.208:5060:
BYE sip:05@10.1.16.208:5060 SIP/2.0
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK5a2f2ad4;rport
Max-Forwards: 70
From: "340529" <sip:340529@91.207.114.4>;tag=as3ec6464f
To: <sip:05@10.1.16.208:5060>;tag=2142215481
Call-ID: 2ccf3826620134f16282a8eb02732b97@91.207.114.4:5060
CSeq: 103 BYE
User-Agent: FPBX-12.0.36(11.15.0)
X-Asterisk-HangupCause: Normal Clearing
X-Asterisk-HangupCauseCode: 16
Content-Length: 0


---
== Spawn extension (macro-dial-one, s, 44) exited non-zero on 'Local/05@from-queue-00000160;2' in macro 'dial-one'
== Spawn extension (macro-exten-vm, s, 16) exited non-zero on 'Local/05@from-queue-00000160;2' in macro 'exten-vm'
== Spawn extension (ext-local, 05, 2) exited non-zero on 'Local/05@from-queue-00000160;2'

<--- SIP read from UDP:10.1.16.208:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK5a2f2ad4;rport
From: "340529" <sip:340529@91.207.114.4>;tag=as3ec6464f
To: <sip:05@10.1.16.208:5060>;tag=2142215481
Call-ID: 2ccf3826620134f16282a8eb02732b97@91.207.114.4:5060
CSeq: 103 BYE
Server: Voip Phone 1.0
Content-Length: 0

<------------->
--- (8 headers 0 lines) ---
Really destroying SIP dialog '2ccf3826620134f16282a8eb02732b97@91.207.114.4:5060' Method: INVITE
[2015-02-09 12:48:49] WARNING[19448]: chan_sip.c:4020 retrans_pkt: Retransmission timeout reached on transmission 91b7aff9cc1fd88f3dc7f6639d4c37c0 for seqno 1 (Non-critical Response) -- See https://wiki.asterisk.org/wiki/display/ ... nsmissions
Packet timed out after 31999ms with no response
[2015-02-09 12:48:49] WARNING[19448]: chan_sip.c:4082 retrans_pkt: Timeout on 91b7aff9cc1fd88f3dc7f6639d4c37c0 on non-critical invite transaction.
[2015-02-09 12:49:03] NOTICE[19448]: chan_sip.c:14993 sip_reregister: -- Re-registration for 17002@sip.zadarma.com
[2015-02-09 12:49:03] NOTICE[19448]: chan_sip.c:23534 handle_response_register: Outbound Registration: Expiry for sip.zadarma.com is 120 sec (Scheduling reregistration in 105 s)

<--- SIP read from UDP:10.1.16.208:5060 --->
REGISTER sip:91.207.114.4 SIP/2.0
Via: SIP/2.0/UDP 10.1.16.208:5060;branch=z9hG4bK14180158741546611151;rport
From: 05 <sip:05@91.207.114.4:5060>;tag=2906022732
To: 05 <sip:05@91.207.114.4:5060>
Call-ID: 31802130493701-166481871114673@10.1.16.208
CSeq: 26571 REGISTER
Contact: <sip:05@10.1.16.208:5060>
Max-Forwards: 70
Expires: 60
Supported: path
User-Agent: Voip Phone 1.0
Content-Length: 0

<------------->
--- (12 headers 0 lines) ---
Sending to 10.1.16.208:5060 (NAT)

<--- Transmitting (NAT) to 10.1.16.208:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 10.1.16.208:5060;branch=z9hG4bK14180158741546611151;received=10.1.16.208;rport=5060
From: 05 <sip:05@91.207.114.4:5060>;tag=2906022732
To: 05 <sip:05@91.207.114.4:5060>;tag=as5da3baf6
Call-ID: 31802130493701-166481871114673@10.1.16.208
CSeq: 26571 REGISTER
Server: FPBX-12.0.36(11.15.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="71c94429"
Content-Length: 0


<------------>
Scheduling destruction of SIP dialog '31802130493701-166481871114673@10.1.16.208' in 32000 ms (Method: REGISTER)

<--- SIP read from UDP:10.1.16.208:5060 --->
REGISTER sip:91.207.114.4 SIP/2.0
Via: SIP/2.0/UDP 10.1.16.208:5060;branch=z9hG4bK2571429077477232282;rport
From: 05 <sip:05@91.207.114.4:5060>;tag=2906022732
To: 05 <sip:05@91.207.114.4:5060>
Call-ID: 31802130493701-166481871114673@10.1.16.208
CSeq: 26572 REGISTER
Contact: <sip:05@10.1.16.208:5060>
Authorization: Digest username="05", realm="asterisk", nonce="71c94429", uri="sip:91.207.114.4", response="94c00a7bb4d2aa49ab74e4efbcf1c964", algorithm=MD5
Max-Forwards: 70
Expires: 60
Supported: path
User-Agent: Voip Phone 1.0
Content-Length: 0

<------------->
--- (13 headers 0 lines) ---
Sending to 10.1.16.208:5060 (NAT)
Reliably Transmitting (NAT) to 10.1.16.208:5060:
OPTIONS sip:05@10.1.16.208:5060 SIP/2.0
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK6b330bc9;rport
Max-Forwards: 70
From: "Unknown" <sip:Unknown@91.207.114.4>;tag=as7f923454
To: <sip:05@10.1.16.208:5060>
Contact: <sip:Unknown@91.207.114.4:5060>
Call-ID: 72c60533626777cc08742a1b511e924d@91.207.114.4:5060
CSeq: 102 OPTIONS
User-Agent: FPBX-12.0.36(11.15.0)
Date: Mon, 09 Feb 2015 09:49:07 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Content-Length: 0


---

<--- Transmitting (NAT) to 10.1.16.208:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.1.16.208:5060;branch=z9hG4bK2571429077477232282;received=10.1.16.208;rport=5060
From: 05 <sip:05@91.207.114.4:5060>;tag=2906022732
To: 05 <sip:05@91.207.114.4:5060>;tag=as5da3baf6
Call-ID: 31802130493701-166481871114673@10.1.16.208
CSeq: 26572 REGISTER
Server: FPBX-12.0.36(11.15.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Expires: 60
Contact: <sip:05@10.1.16.208:5060>;expires=60
Date: Mon, 09 Feb 2015 09:49:07 GMT
Content-Length: 0
kirush
Сообщения: 23
Зарегистрирован: 13 май 2012, 14:05

Re: FreePBX+DV6004S рвет соединение.

Сообщение kirush »

Пришлось разделить на 2 части
PRIME_BBCODE_SPOILER_SHOW PRIME_BBCODE_SPOILER:
<------------>
Scheduling destruction of SIP dialog '4ba2b9652be9375a29967c7a0ca35355@91.207.114.4:5060' in 6400 ms (Method: NOTIFY)
Reliably Transmitting (NAT) to 10.1.16.208:5060:
NOTIFY sip:05@10.1.16.208:5060 SIP/2.0
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK0d8bc879;rport
Max-Forwards: 70
From: "Unknown" <sip:Unknown@91.207.114.4>;tag=as1b95cda4
To: <sip:05@10.1.16.208:5060>
Contact: <sip:Unknown@91.207.114.4:5060>
Call-ID: 4ba2b9652be9375a29967c7a0ca35355@91.207.114.4:5060
CSeq: 102 NOTIFY
User-Agent: FPBX-12.0.36(11.15.0)
Event: message-summary
Content-Type: application/simple-message-summary
Content-Length: 87

Messages-Waiting: no
Message-Account: sip:*97@91.207.114.4
Voice-Message: 0/0 (0/0)

---
Scheduling destruction of SIP dialog '31802130493701-166481871114673@10.1.16.208' in 32000 ms (Method: REGISTER)

<--- SIP read from UDP:10.1.16.208:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK6b330bc9;rport
From: "Unknown" <sip:Unknown@91.207.114.4>;tag=as7f923454
To: <sip:05@10.1.16.208:5060>
Call-ID: 72c60533626777cc08742a1b511e924d@91.207.114.4:5060
CSeq: 102 OPTIONS
Contact: <sip:05@10.1.16.208:5060>
Supported: 100rel, replaces, timer
Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REFER, NOTIFY, INFO, PRACK, UPDATE, MESSAGE
Accept: application/sdp, message/sipfrag, application/dtmf-relay
Content-Length: 0

<------------->
--- (11 headers 0 lines) ---
Really destroying SIP dialog '72c60533626777cc08742a1b511e924d@91.207.114.4:5060' Method: OPTIONS

<--- SIP read from UDP:10.1.16.208:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK0d8bc879;rport
From: "Unknown" <sip:Unknown@91.207.114.4>;tag=as1b95cda4
To: <sip:05@10.1.16.208:5060>
Call-ID: 4ba2b9652be9375a29967c7a0ca35355@91.207.114.4:5060
CSeq: 102 NOTIFY
Content-Length: 0

<------------->
--- (7 headers 0 lines) ---
Really destroying SIP dialog '4ba2b9652be9375a29967c7a0ca35355@91.207.114.4:5060' Method: NOTIFY
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
-- Executing [4967340666@from-trunk-sip-702:1] Set("SIP/702-0000014f", "GROUP()=OUT_7") in new stack
-- Executing [4967340666@from-trunk-sip-702:2] Goto("SIP/702-0000014f", "from-trunk,4967340666,1") in new stack
-- Goto (from-trunk,4967340666,1)
-- Executing [4967340666@from-trunk:1] Set("SIP/702-0000014f", "__FROM_DID=4967340666") in new stack
-- Executing [4967340666@from-trunk:2] Set("SIP/702-0000014f", "CHANNEL(language)=ru") in new stack
-- Executing [4967340666@from-trunk:3] Gosub("SIP/702-0000014f", "sub-record-check,s,1(in,4967340666,dontcare)") in new stack
-- Executing [s@sub-record-check:1] GotoIf("SIP/702-0000014f", "0?initialized") in new stack
-- Executing [s@sub-record-check:2] Set("SIP/702-0000014f", "__REC_STATUS=INITIALIZED") in new stack
-- Executing [s@sub-record-check:3] Set("SIP/702-0000014f", "NOW=1423475362") in new stack
-- Executing [s@sub-record-check:4] Set("SIP/702-0000014f", "__DAY=09") in new stack
-- Executing [s@sub-record-check:5] Set("SIP/702-0000014f", "__MONTH=02") in new stack
-- Executing [s@sub-record-check:6] Set("SIP/702-0000014f", "__YEAR=2015") in new stack
-- Executing [s@sub-record-check:7] Set("SIP/702-0000014f", "__TIMESTR=20150209-124922") in new stack
-- Executing [s@sub-record-check:8] Set("SIP/702-0000014f", "__FROMEXTEN=unknown") in new stack
-- Executing [s@sub-record-check:9] Set("SIP/702-0000014f", "__MON_FMT=wav") in new stack
-- Executing [s@sub-record-check:10] NoOp("SIP/702-0000014f", "Recordings initialized") in new stack
-- Executing [s@sub-record-check:11] ExecIf("SIP/702-0000014f", "0?Set(ARG3=dontcare)") in new stack
-- Executing [s@sub-record-check:12] Set("SIP/702-0000014f", "REC_POLICY_MODE_SAVE=") in new stack
-- Executing [s@sub-record-check:13] ExecIf("SIP/702-0000014f", "0?Set(REC_STATUS=NO)") in new stack
-- Executing [s@sub-record-check:14] GotoIf("SIP/702-0000014f", "2?checkaction") in new stack
-- Goto (sub-record-check,s,17)
-- Executing [s@sub-record-check:17] GotoIf("SIP/702-0000014f", "1?sub-record-check,in,1") in new stack
-- Goto (sub-record-check,in,1)
-- Executing [in@sub-record-check:1] NoOp("SIP/702-0000014f", "Inbound Recording Check to 4967340666") in new stack
-- Executing [in@sub-record-check:2] Set("SIP/702-0000014f", "FROMEXTEN=unknown") in new stack
-- Executing [in@sub-record-check:3] ExecIf("SIP/702-0000014f", "6?Set(FROMEXTEN=340529)") in new stack
-- Executing [in@sub-record-check:4] Gosub("SIP/702-0000014f", "recordcheck,1(dontcare,in,4967340666)") in new stack
-- Executing [recordcheck@sub-record-check:1] NoOp("SIP/702-0000014f", "Starting recording check against dontcare") in new stack
-- Executing [recordcheck@sub-record-check:2] Goto("SIP/702-0000014f", "dontcare") in new stack
-- Goto (sub-record-check,recordcheck,3)
-- Executing [recordcheck@sub-record-check:3] Return("SIP/702-0000014f", "") in new stack
-- Executing [in@sub-record-check:5] Return("SIP/702-0000014f", "") in new stack
-- Executing [4967340666@from-trunk:4] Gosub("SIP/702-0000014f", "app-blacklist-check,s,1()") in new stack
-- Executing [s@app-blacklist-check:1] GotoIf("SIP/702-0000014f", "0?blacklisted") in new stack
-- Executing [s@app-blacklist-check:2] Set("SIP/702-0000014f", "CALLED_BLACKLIST=1") in new stack
-- Executing [s@app-blacklist-check:3] Return("SIP/702-0000014f", "") in new stack
-- Executing [4967340666@from-trunk:5] Set("SIP/702-0000014f", "CDR(did)=4967340666") in new stack
-- Executing [4967340666@from-trunk:6] ExecIf("SIP/702-0000014f", "1 ?Set(CALLERID(name)=340529)") in new stack
-- Executing [4967340666@from-trunk:7] Set("SIP/702-0000014f", "CHANNEL(musicclass)=default") in new stack
-- Executing [4967340666@from-trunk:8] Set("SIP/702-0000014f", "__MOHCLASS=default") in new stack
[2015-02-09 12:49:22] WARNING[26596][C-0000127f]: func_channel.c:538 func_channel_read: Unknown or unavailable item requested: 'reversecharge'
-- Executing [4967340666@from-trunk:9] GotoIf("SIP/702-0000014f", "0?macro-hangupcall") in new stack
-- Executing [4967340666@from-trunk:10] Set("SIP/702-0000014f", "__CALLINGPRES_SV=allowed_not_screened") in new stack
-- Executing [4967340666@from-trunk:11] Set("SIP/702-0000014f", "CALLERPRES()=allowed_not_screened") in new stack
-- Executing [4967340666@from-trunk:12] Goto("SIP/702-0000014f", "timeconditions,2,1") in new stack
-- Goto (timeconditions,2,1)
-- Executing [2@timeconditions:1] Set("SIP/702-0000014f", "DB(TC/2/INUSESTATE)=INUSE") in new stack
-- Executing [2@timeconditions:2] Set("SIP/702-0000014f", "DB(TC/2/NOT_INUSESTATE)=NOT_INUSE") in new stack
-- Executing [2@timeconditions:3] GotoIfTime("SIP/702-0000014f", "10:00-18:00,sat-sun,*,*?truestate") in new stack
-- Executing [2@timeconditions:4] GotoIfTime("SIP/702-0000014f", "09:00-21:00,mon-fri,*,*?truestate") in new stack
-- Goto (timeconditions,2,12)
-- Executing [2@timeconditions:12] GotoIf("SIP/702-0000014f", "0?falsegoto") in new stack
-- Executing [2@timeconditions:13] ExecIf("SIP/702-0000014f", "0?Set(DB(TC/2)=)") in new stack
-- Executing [2@timeconditions:14] Set("SIP/702-0000014f", "DEVICE_STATE(Custom:TC2)=NOT_INUSE") in new stack
-- Executing [2@timeconditions:15] ExecIf("SIP/702-0000014f", "0?Set(NOT_INUSE)") in new stack
-- Executing [2@timeconditions:16] GotoIf("SIP/702-0000014f", "1?ivr-1,s,1") in new stack
-- Goto (ivr-1,s,1)
-- Executing [s@ivr-1:1] Set("SIP/702-0000014f", "_IVR_CONTEXT_ivr-1=") in new stack
-- Executing [s@ivr-1:2] Set("SIP/702-0000014f", "_IVR_CONTEXT=ivr-1") in new stack
-- Executing [s@ivr-1:3] Set("SIP/702-0000014f", "__IVR_RETVM=") in new stack
-- Executing [s@ivr-1:4] GotoIf("SIP/702-0000014f", "0?skip") in new stack
-- Executing [s@ivr-1:5] Answer("SIP/702-0000014f", "") in new stack
> 0x7fe8f0162ad0 -- Probation passed - setting RTP source address to 91.207.114.6:10002
-- Executing [s@ivr-1:6] Wait("SIP/702-0000014f", "1") in new stack
-- Executing [s@ivr-1:7] Set("SIP/702-0000014f", "IVR_MSG=custom/work") in new stack
-- Executing [s@ivr-1:8] Set("SIP/702-0000014f", "TIMEOUT(digit)=3") in new stack
-- Digit timeout set to 3.000
-- Executing [s@ivr-1:9] ExecIf("SIP/702-0000014f", "1?Background(custom/work)") in new stack
-- <SIP/702-0000014f> Playing 'custom/work.slin' (language 'ru')
[2015-02-09 12:49:27] WARNING[19448]: chan_sip.c:4020 retrans_pkt: Retransmission timeout reached on transmission cbe2136ae4cf02255e5b7a53efa8197f for seqno 1 (Non-critical Response) -- See https://wiki.asterisk.org/wiki/display/ ... nsmissions
Packet timed out after 32000ms with no response
[2015-02-09 12:49:27] WARNING[19448]: chan_sip.c:4082 retrans_pkt: Timeout on cbe2136ae4cf02255e5b7a53efa8197f on non-critical invite transaction.

<--- SIP read from UDP:10.1.16.208:5060 --->
REGISTER sip:91.207.114.4 SIP/2.0
Via: SIP/2.0/UDP 10.1.16.208:5060;branch=z9hG4bK1663513239081468;rport
From: 05 <sip:05@91.207.114.4:5060>;tag=2906022732
To: 05 <sip:05@91.207.114.4:5060>
Call-ID: 31802130493701-166481871114673@10.1.16.208
CSeq: 26573 REGISTER
Contact: <sip:05@10.1.16.208:5060>
Max-Forwards: 70
Expires: 60
Supported: path
User-Agent: Voip Phone 1.0
Content-Length: 0

<------------->
--- (12 headers 0 lines) ---
Sending to 10.1.16.208:5060 (NAT)

<--- Transmitting (NAT) to 10.1.16.208:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 10.1.16.208:5060;branch=z9hG4bK1663513239081468;received=10.1.16.208;rport=5060
From: 05 <sip:05@91.207.114.4:5060>;tag=2906022732
To: 05 <sip:05@91.207.114.4:5060>;tag=as5da3baf6
Call-ID: 31802130493701-166481871114673@10.1.16.208
CSeq: 26573 REGISTER
Server: FPBX-12.0.36(11.15.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="12acef32"
Content-Length: 0


<------------>
Scheduling destruction of SIP dialog '31802130493701-166481871114673@10.1.16.208' in 32000 ms (Method: REGISTER)

<--- SIP read from UDP:10.1.16.208:5060 --->
REGISTER sip:91.207.114.4 SIP/2.0
Via: SIP/2.0/UDP 10.1.16.208:5060;branch=z9hG4bK2990511614193017927;rport
From: 05 <sip:05@91.207.114.4:5060>;tag=2906022732
To: 05 <sip:05@91.207.114.4:5060>
Call-ID: 31802130493701-166481871114673@10.1.16.208
CSeq: 26574 REGISTER
Contact: <sip:05@10.1.16.208:5060>
Authorization: Digest username="05", realm="asterisk", nonce="12acef32", uri="sip:91.207.114.4", response="70fbbdba285a7024ad9388d52001a4a5", algorithm=MD5
Max-Forwards: 70
Expires: 60
Supported: path
User-Agent: Voip Phone 1.0
Content-Length: 0

<------------->
--- (13 headers 0 lines) ---
Sending to 10.1.16.208:5060 (NAT)
Reliably Transmitting (NAT) to 10.1.16.208:5060:
OPTIONS sip:05@10.1.16.208:5060 SIP/2.0
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK2cd2da43;rport
Max-Forwards: 70
From: "Unknown" <sip:Unknown@91.207.114.4>;tag=as024fb124
To: <sip:05@10.1.16.208:5060>
Contact: <sip:Unknown@91.207.114.4:5060>
Call-ID: 7ef217c72a2e431264785e3e0478b110@91.207.114.4:5060
CSeq: 102 OPTIONS
User-Agent: FPBX-12.0.36(11.15.0)
Date: Mon, 09 Feb 2015 09:49:37 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Content-Length: 0


---

<--- Transmitting (NAT) to 10.1.16.208:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.1.16.208:5060;branch=z9hG4bK2990511614193017927;received=10.1.16.208;rport=5060
From: 05 <sip:05@91.207.114.4:5060>;tag=2906022732
To: 05 <sip:05@91.207.114.4:5060>;tag=as5da3baf6
Call-ID: 31802130493701-166481871114673@10.1.16.208
CSeq: 26574 REGISTER
Server: FPBX-12.0.36(11.15.0)
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Expires: 60
Contact: <sip:05@10.1.16.208:5060>;expires=60
Date: Mon, 09 Feb 2015 09:49:37 GMT
Content-Length: 0


<------------>
Scheduling destruction of SIP dialog '0607cd1754c2c3663accc1811721a9cd@91.207.114.4:5060' in 6400 ms (Method: NOTIFY)
Reliably Transmitting (NAT) to 10.1.16.208:5060:
NOTIFY sip:05@10.1.16.208:5060 SIP/2.0
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK505602a6;rport
Max-Forwards: 70
From: "Unknown" <sip:Unknown@91.207.114.4>;tag=as161038e5
To: <sip:05@10.1.16.208:5060>
Contact: <sip:Unknown@91.207.114.4:5060>
Call-ID: 0607cd1754c2c3663accc1811721a9cd@91.207.114.4:5060
CSeq: 102 NOTIFY
User-Agent: FPBX-12.0.36(11.15.0)
Event: message-summary
Content-Type: application/simple-message-summary
Content-Length: 87

Messages-Waiting: no
Message-Account: sip:*97@91.207.114.4
Voice-Message: 0/0 (0/0)

---
Scheduling destruction of SIP dialog '31802130493701-166481871114673@10.1.16.208' in 32000 ms (Method: REGISTER)

<--- SIP read from UDP:10.1.16.208:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK2cd2da43;rport
From: "Unknown" <sip:Unknown@91.207.114.4>;tag=as024fb124
To: <sip:05@10.1.16.208:5060>
Call-ID: 7ef217c72a2e431264785e3e0478b110@91.207.114.4:5060
CSeq: 102 OPTIONS
Contact: <sip:05@10.1.16.208:5060>
Supported: 100rel, replaces, timer
Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REFER, NOTIFY, INFO, PRACK, UPDATE, MESSAGE
Accept: application/sdp, message/sipfrag, application/dtmf-relay
Content-Length: 0

<------------->
--- (11 headers 0 lines) ---
Really destroying SIP dialog '7ef217c72a2e431264785e3e0478b110@91.207.114.4:5060' Method: OPTIONS

<--- SIP read from UDP:10.1.16.208:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK505602a6;rport
From: "Unknown" <sip:Unknown@91.207.114.4>;tag=as161038e5
To: <sip:05@10.1.16.208:5060>
Call-ID: 0607cd1754c2c3663accc1811721a9cd@91.207.114.4:5060
CSeq: 102 NOTIFY
Content-Length: 0


<------------->
--- (7 headers 0 lines) ---
Really destroying SIP dialog '0607cd1754c2c3663accc1811721a9cd@91.207.114.4:5060' Method: NOTIFY
-- Executing [s@ivr-1:10] WaitExten("SIP/702-0000014f", "1,") in new stack
-- Timeout on SIP/702-0000014f, going to 't'
-- Executing [t@ivr-1:1] Goto("SIP/702-0000014f", "ext-queues,1000,1") in new stack
-- Goto (ext-queues,1000,1)
-- Executing [1000@ext-queues:1] Macro("SIP/702-0000014f", "user-callerid,") in new stack
-- Executing [s@macro-user-callerid:1] Set("SIP/702-0000014f", "TOUCH_MONITOR=1423475362.1041") in new stack
-- Executing [s@macro-user-callerid:2] Set("SIP/702-0000014f", "AMPUSER=340529") in new stack
-- Executing [s@macro-user-callerid:3] GotoIf("SIP/702-0000014f", "0?report") in new stack
-- Executing [s@macro-user-callerid:4] ExecIf("SIP/702-0000014f", "1?Set(REALCALLERIDNUM=340529)") in new stack
-- Executing [s@macro-user-callerid:5] Set("SIP/702-0000014f", "AMPUSER=") in new stack
-- Executing [s@macro-user-callerid:6] GotoIf("SIP/702-0000014f", "0?limit") in new stack
-- Executing [s@macro-user-callerid:7] Set("SIP/702-0000014f", "AMPUSERCIDNAME=") in new stack
-- Executing [s@macro-user-callerid:8] GotoIf("SIP/702-0000014f", "1?report") in new stack
-- Goto (macro-user-callerid,s,16)
-- Executing [s@macro-user-callerid:16] GotoIf("SIP/702-0000014f", "0?continue") in new stack
-- Executing [s@macro-user-callerid:17] ExecIf("SIP/702-0000014f", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
-- Executing [s@macro-user-callerid:18] Set("SIP/702-0000014f", "__TTL=64") in new stack
-- Executing [s@macro-user-callerid:19] GotoIf("SIP/702-0000014f", "1?continue") in new stack
-- Goto (macro-user-callerid,s,30)
-- Executing [s@macro-user-callerid:30] Set("SIP/702-0000014f", "CALLERID(number)=340529") in new stack
-- Executing [s@macro-user-callerid:31] Set("SIP/702-0000014f", "CALLERID(name)=340529") in new stack
-- Executing [s@macro-user-callerid:32] Set("SIP/702-0000014f", "CDR(cnum)=340529") in new stack
-- Executing [s@macro-user-callerid:33] Set("SIP/702-0000014f", "CDR(cnam)=340529") in new stack
-- Executing [s@macro-user-callerid:34] Set("SIP/702-0000014f", "CHANNEL(language)=ru") in new stack
-- Executing [1000@ext-queues:2] Answer("SIP/702-0000014f", "") in new stack
-- Executing [1000@ext-queues:3] Macro("SIP/702-0000014f", "blkvm-set,reset") in new stack
-- Executing [s@macro-blkvm-set:1] ExecIf("SIP/702-0000014f", "1?Set(__BLKVM_CHANNEL=SIP/702-0000014f)") in new stack
-- Executing [s@macro-blkvm-set:2] Set("SIP/702-0000014f", "SHARED(BLKVM,SIP/702-0000014f)=TRUE") in new stack
-- Executing [s@macro-blkvm-set:3] Set("SIP/702-0000014f", "GOSUB_RETVAL=TRUE") in new stack
-- Executing [s@macro-blkvm-set:4] MacroExit("SIP/702-0000014f", "") in new stack
-- Executing [1000@ext-queues:4] ExecIf("SIP/702-0000014f", "1?Set(_DIAL_OPTIONS=TtrM(auto-blkvm))") in new stack
-- Executing [1000@ext-queues:5] Set("SIP/702-0000014f", "__NODEST=1000") in new stack
-- Executing [1000@ext-queues:6] Set("SIP/702-0000014f", "QCIDPP=") in new stack
-- Executing [1000@ext-queues:7] Set("SIP/702-0000014f", "VQ_CIDPP=") in new stack
-- Executing [1000@ext-queues:8] ExecIf("SIP/702-0000014f", "0?Macro(prepend-cid,)") in new stack
-- Executing [1000@ext-queues:9] Set("SIP/702-0000014f", "QAINFO=") in new stack
-- Executing [1000@ext-queues:10] Set("SIP/702-0000014f", "VQ_AINFO=") in new stack
-- Executing [1000@ext-queues:11] ExecIf("SIP/702-0000014f", "0?Set(__ALERT_INFO=)") in new stack
-- Executing [1000@ext-queues:12] Set("SIP/702-0000014f", "QJOINMSG=ru/queue-periodic-announce") in new stack
-- Executing [1000@ext-queues:13] Set("SIP/702-0000014f", "VQ_JOINMSG=") in new stack
-- Executing [1000@ext-queues:14] Set("SIP/702-0000014f", "QRETRY=n") in new stack
-- Executing [1000@ext-queues:15] Set("SIP/702-0000014f", "VQ_RETRY=") in new stack
-- Executing [1000@ext-queues:16] Set("SIP/702-0000014f", "QOPTIONS=tn") in new stack
-- Executing [1000@ext-queues:17] Set("SIP/702-0000014f", "VQ_OPTIONS=") in new stack
-- Executing [1000@ext-queues:18] Set("SIP/702-0000014f", "QGOSUB=") in new stack
-- Executing [1000@ext-queues:19] Set("SIP/702-0000014f", "VQ_GOSUB=") in new stack
-- Executing [1000@ext-queues:20] Set("SIP/702-0000014f", "QAGI=") in new stack
-- Executing [1000@ext-queues:21] Set("SIP/702-0000014f", "VQ_AGI=") in new stack
-- Executing [1000@ext-queues:22] Set("SIP/702-0000014f", "QRULE=") in new stack
-- Executing [1000@ext-queues:23] Set("SIP/702-0000014f", "VQ_RULE=") in new stack
-- Executing [1000@ext-queues:24] Set("SIP/702-0000014f", "QPOSITION=") in new stack
-- Executing [1000@ext-queues:25] Set("SIP/702-0000014f", "VQ_POSITION=") in new stack
-- Executing [1000@ext-queues:26] Gosub("SIP/702-0000014f", "sub-record-check,s,1(q,1000,never)") in new stack
-- Executing [s@sub-record-check:1] GotoIf("SIP/702-0000014f", "6?initialized") in new stack
-- Goto (sub-record-check,s,10)
-- Executing [s@sub-record-check:10] NoOp("SIP/702-0000014f", "Recordings initialized") in new stack
-- Executing [s@sub-record-check:11] ExecIf("SIP/702-0000014f", "0?Set(ARG3=dontcare)") in new stack
-- Executing [s@sub-record-check:12] Set("SIP/702-0000014f", "REC_POLICY_MODE_SAVE=") in new stack
-- Executing [s@sub-record-check:13] ExecIf("SIP/702-0000014f", "0?Set(REC_STATUS=NO)") in new stack
-- Executing [s@sub-record-check:14] GotoIf("SIP/702-0000014f", "1?checkaction") in new stack
-- Goto (sub-record-check,s,17)
-- Executing [s@sub-record-check:17] GotoIf("SIP/702-0000014f", "0?sub-record-check,q,1") in new stack
-- Executing [s@sub-record-check:18] NoOp("SIP/702-0000014f", "Generic q Recording Check - 340529 1000") in new stack
-- Executing [s@sub-record-check:19] Gosub("SIP/702-0000014f", "recordcheck,1(never,q,1000)") in new stack
-- Executing [recordcheck@sub-record-check:1] NoOp("SIP/702-0000014f", "Starting recording check against never") in new stack
-- Executing [recordcheck@sub-record-check:2] Goto("SIP/702-0000014f", "never") in new stack
-- Goto (sub-record-check,recordcheck,14)
-- Executing [recordcheck@sub-record-check:14] Set("SIP/702-0000014f", "__REC_POLICY_MODE=NEVER") in new stack
-- Executing [recordcheck@sub-record-check:15] Goto("SIP/702-0000014f", "stoprec") in new stack
-- Goto (sub-record-check,recordcheck,25)
-- Executing [recordcheck@sub-record-check:25] NoOp("SIP/702-0000014f", "Stopping recording: q, 1000") in new stack
-- Executing [recordcheck@sub-record-check:26] Set("SIP/702-0000014f", "__REC_STATUS=STOPPED") in new stack
-- Executing [recordcheck@sub-record-check:27] System("SIP/702-0000014f", "/var/lib/asterisk/bin/stoprecording.php "SIP/702-0000014f"") in new stack
-- Executing [recordcheck@sub-record-check:28] Return("SIP/702-0000014f", "") in new stack
-- Executing [s@sub-record-check:20] Return("SIP/702-0000014f", "") in new stack
-- Executing [1000@ext-queues:27] ExecIf("SIP/702-0000014f", "0?Playback(ru/queue-periodic-announce, )") in new stack
-- Executing [1000@ext-queues:28] QueueLog("SIP/702-0000014f", "1000,1423475362.1041,NONE,DID,4967340666") in new stack
-- Executing [1000@ext-queues:29] Set("SIP/702-0000014f", "QAANNOUNCE=") in new stack
-- Executing [1000@ext-queues:30] Set("SIP/702-0000014f", "VQ_AANNOUNCE=") in new stack
-- Executing [1000@ext-queues:31] Set("SIP/702-0000014f", "QMOH=") in new stack
-- Executing [1000@ext-queues:32] Set("SIP/702-0000014f", "VQ_MOH=") in new stack
-- Executing [1000@ext-queues:33] ExecIf("SIP/702-0000014f", "0?Set(__MOHCLASS=)") in new stack
-- Executing [1000@ext-queues:34] ExecIf("SIP/702-0000014f", "1?Set(CHANNEL(musicclass)=default)") in new stack
-- Executing [1000@ext-queues:35] Set("SIP/702-0000014f", "QMAXWAIT=") in new stack
-- Executing [1000@ext-queues:36] Set("SIP/702-0000014f", "VQ_MAXWAIT=") in new stack
-- Executing [1000@ext-queues:37] Set("SIP/702-0000014f", "QUEUENUM=1000") in new stack
-- Executing [1000@ext-queues:38] Set("SIP/702-0000014f", "QUEUEJOINTIME=1423475384") in new stack
-- Executing [1000@ext-queues:39] Queue("SIP/702-0000014f", "1000,tn,,,,,,,,") in new stack
-- Started music on hold, class 'default', on SIP/702-0000014f
-- LazyMembers debugging - Numbusies: 0, Nummems: 1
-- Executing [05@from-queue:1] Set("Local/05@from-queue-00000161;2", "QAGENT=05") in new stack
-- Executing [05@from-queue:2] Goto("Local/05@from-queue-00000161;2", "1000,1") in new stack
-- Goto (from-queue,1000,1)
-- Executing [1000@from-queue:1] Goto("Local/05@from-queue-00000161;2", "from-internal,05,1") in new stack
-- Goto (from-internal,05,1)
-- Executing [05@from-internal:1] GotoIf("Local/05@from-queue-00000161;2", "1?ext-local,05,1") in new stack
-- Goto (ext-local,05,1)
-- Executing [05@ext-local:1] Set("Local/05@from-queue-00000161;2", "__RINGTIMER=60") in new stack
-- Executing [05@ext-local:2] Macro("Local/05@from-queue-00000161;2", "exten-vm,novm,05,0,0,0") in new stack
-- Executing [s@macro-exten-vm:1] Macro("Local/05@from-queue-00000161;2", "user-callerid,") in new stack
-- Executing [s@macro-user-callerid:1] Set("Local/05@from-queue-00000161;2", "TOUCH_MONITOR=1423475384.1043") in new stack
-- Executing [s@macro-user-callerid:2] Set("Local/05@from-queue-00000161;2", "AMPUSER=340529") in new stack
-- Executing [s@macro-user-callerid:3] GotoIf("Local/05@from-queue-00000161;2", "1?report") in new stack
-- Goto (macro-user-callerid,s,16)
-- Executing [s@macro-user-callerid:16] GotoIf("Local/05@from-queue-00000161;2", "0?continue") in new stack
-- Executing [s@macro-user-callerid:17] ExecIf("Local/05@from-queue-00000161;2", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
-- Executing [s@macro-user-callerid:18] Set("Local/05@from-queue-00000161;2", "__TTL=63") in new stack
-- Executing [s@macro-user-callerid:19] GotoIf("Local/05@from-queue-00000161;2", "1?continue") in new stack
-- Goto (macro-user-callerid,s,30)
-- Executing [s@macro-user-callerid:30] Set("Local/05@from-queue-00000161;2", "CALLERID(number)=340529") in new stack
-- Executing [s@macro-user-callerid:31] Set("Local/05@from-queue-00000161;2", "CALLERID(name)=340529") in new stack
-- Executing [s@macro-user-callerid:32] Set("Local/05@from-queue-00000161;2", "CDR(cnum)=340529") in new stack
-- Executing [s@macro-user-callerid:33] Set("Local/05@from-queue-00000161;2", "CDR(cnam)=340529") in new stack
-- Executing [s@macro-user-callerid:34] Set("Local/05@from-queue-00000161;2", "CHANNEL(language)=ru") in new stack
-- Executing [s@macro-exten-vm:2] Set("Local/05@from-queue-00000161;2", "RingGroupMethod=none") in new stack
-- Executing [s@macro-exten-vm:3] Set("Local/05@from-queue-00000161;2", "__EXTTOCALL=05") in new stack
-- Executing [s@macro-exten-vm:4] Set("Local/05@from-queue-00000161;2", "__PICKUPMARK=05") in new stack
-- Executing [s@macro-exten-vm:5] Set("Local/05@from-queue-00000161;2", "RT=") in new stack
[2015-02-09 12:49:44] WARNING[26601][C-0000127f]: chan_sip.c:21976 func_header_read: This function can only be used on SIP channels.
-- Executing [s@macro-exten-vm:6] ExecIf("Local/05@from-queue-00000161;2", "0?Macro(vm,novm,DIRECTDIAL,)") in new stack
[2015-02-09 12:49:44] WARNING[26601][C-0000127f]: chan_sip.c:21976 func_header_read: This function can only be used on SIP channels.
[2015-02-09 12:49:44] WARNING[26601][C-0000127f]: chan_sip.c:21976 func_header_read: This function can only be used on SIP channels.
-- Executing [s@macro-exten-vm:7] ExecIf("Local/05@from-queue-00000161;2", "0?MacroExit()") in new stack
[2015-02-09 12:49:44] WARNING[26601][C-0000127f]: chan_sip.c:21976 func_header_read: This function can only be used on SIP channels.
-- Executing [s@macro-exten-vm:8] Gosub("Local/05@from-queue-00000161;2", "sub-record-check,s,1(exten,05,)") in new stack
-- Executing [s@sub-record-check:1] GotoIf("Local/05@from-queue-00000161;2", "0?initialized") in new stack
-- Executing [s@sub-record-check:2] Set("Local/05@from-queue-00000161;2", "__REC_STATUS=INITIALIZED") in new stack
-- Executing [s@sub-record-check:3] Set("Local/05@from-queue-00000161;2", "NOW=1423475384") in new stack
-- Executing [s@sub-record-check:4] Set("Local/05@from-queue-00000161;2", "__DAY=09") in new stack
-- Executing [s@sub-record-check:5] Set("Local/05@from-queue-00000161;2", "__MONTH=02") in new stack
-- Executing [s@sub-record-check:6] Set("Local/05@from-queue-00000161;2", "__YEAR=2015") in new stack
-- Executing [s@sub-record-check:7] Set("Local/05@from-queue-00000161;2", "__TIMESTR=20150209-124944") in new stack
-- Executing [s@sub-record-check:8] Set("Local/05@from-queue-00000161;2", "__FROMEXTEN=340529") in new stack
-- Executing [s@sub-record-check:9] Set("Local/05@from-queue-00000161;2", "__MON_FMT=wav") in new stack
-- Executing [s@sub-record-check:10] NoOp("Local/05@from-queue-00000161;2", "Recordings initialized") in new stack
-- Executing [s@sub-record-check:11] ExecIf("Local/05@from-queue-00000161;2", "0?Set(ARG3=dontcare)") in new stack
-- Executing [s@sub-record-check:12] Set("Local/05@from-queue-00000161;2", "REC_POLICY_MODE_SAVE=NEVER") in new stack
-- Executing [s@sub-record-check:13] ExecIf("Local/05@from-queue-00000161;2", "0?Set(REC_STATUS=NO)") in new stack
-- Executing [s@sub-record-check:14] GotoIf("Local/05@from-queue-00000161;2", "5?checkaction") in new stack
-- Goto (sub-record-check,s,17)
-- Executing [s@sub-record-check:17] GotoIf("Local/05@from-queue-00000161;2", "1?sub-record-check,exten,1") in new stack
-- Goto (sub-record-check,exten,1)
-- Executing [exten@sub-record-check:1] NoOp("Local/05@from-queue-00000161;2", "Exten Recording Check between 340529 and 05") in new stack
-- Executing [exten@sub-record-check:2] Set("Local/05@from-queue-00000161;2", "CALLTYPE=external") in new stack
-- Executing [exten@sub-record-check:3] ExecIf("Local/05@from-queue-00000161;2", "0?Set(CALLTYPE=)") in new stack
-- Executing [exten@sub-record-check:4] Set("Local/05@from-queue-00000161;2", "CALLEE=yes") in new stack
-- Executing [exten@sub-record-check:5] ExecIf("Local/05@from-queue-00000161;2", "0?Set(CALLEE=dontcare)") in new stack
-- Executing [exten@sub-record-check:6] GotoIf("Local/05@from-queue-00000161;2", "1?callee") in new stack
-- Goto (sub-record-check,exten,11)
-- Executing [exten@sub-record-check:11] Gosub("Local/05@from-queue-00000161;2", "recordcheck,1(yes,external,05)") in new stack
-- Executing [recordcheck@sub-record-check:1] NoOp("Local/05@from-queue-00000161;2", "Starting recording check against yes") in new stack
-- Executing [recordcheck@sub-record-check:2] Goto("Local/05@from-queue-00000161;2", "yes") in new stack
-- Goto (sub-record-check,recordcheck,9)
-- Executing [recordcheck@sub-record-check:9] ExecIf("Local/05@from-queue-00000161;2", "1?Return()") in new stack
-- Executing [exten@sub-record-check:12] Return("Local/05@from-queue-00000161;2", "") in new stack
-- Executing [s@macro-exten-vm:9] GotoIf("Local/05@from-queue-00000161;2", "10?macrodial") in new stack
-- Goto (macro-exten-vm,s,15)
-- Executing [s@macro-exten-vm:15] GosubIf("Local/05@from-queue-00000161;2", "0?clrheader,1()") in new stack
-- Executing [s@macro-exten-vm:16] Macro("Local/05@from-queue-00000161;2", "dial-one,,TtrM(auto-blkvm),05") in new stack
-- Executing [s@macro-dial-one:1] Set("Local/05@from-queue-00000161;2", "DEXTEN=05") in new stack
-- Executing [s@macro-dial-one:2] Set("Local/05@from-queue-00000161;2", "DIALSTATUS_CW=") in new stack
-- Executing [s@macro-dial-one:3] GosubIf("Local/05@from-queue-00000161;2", "0?screen,1()") in new stack
-- Executing [s@macro-dial-one:4] GosubIf("Local/05@from-queue-00000161;2", "0?cf,1()") in new stack
-- Executing [s@macro-dial-one:5] GotoIf("Local/05@from-queue-00000161;2", "1?skip1") in new stack
-- Goto (macro-dial-one,s,8)
-- Executing [s@macro-dial-one:8] GotoIf("Local/05@from-queue-00000161;2", "0?nodial") in new stack
-- Executing [s@macro-dial-one:9] GotoIf("Local/05@from-queue-00000161;2", "0?continue") in new stack
-- Executing [s@macro-dial-one:10] Set("Local/05@from-queue-00000161;2", "EXTHASCW=ENABLED") in new stack
-- Executing [s@macro-dial-one:11] GotoIf("Local/05@from-queue-00000161;2", "0?next1:cwinusebusy") in new stack
-- Goto (macro-dial-one,s,23)
-- Executing [s@macro-dial-one:23] GotoIf("Local/05@from-queue-00000161;2", "1?next3:continue") in new stack
-- Goto (macro-dial-one,s,24)
-- Executing [s@macro-dial-one:24] ExecIf("Local/05@from-queue-00000161;2", "0?Set(DIALSTATUS_CW=BUSY)") in new stack
-- Executing [s@macro-dial-one:25] GotoIf("Local/05@from-queue-00000161;2", "0?nodial") in new stack
-- Executing [s@macro-dial-one:26] GosubIf("Local/05@from-queue-00000161;2", "1?dstring,1():dlocal,1()") in new stack
-- Executing [dstring@macro-dial-one:1] Set("Local/05@from-queue-00000161;2", "DSTRING=") in new stack
-- Executing [dstring@macro-dial-one:2] Set("Local/05@from-queue-00000161;2", "DEVICES=05") in new stack
-- Executing [dstring@macro-dial-one:3] ExecIf("Local/05@from-queue-00000161;2", "0?Return()") in new stack
-- Executing [dstring@macro-dial-one:4] ExecIf("Local/05@from-queue-00000161;2", "0?Set(DEVICES=5)") in new stack
-- Executing [dstring@macro-dial-one:5] Set("Local/05@from-queue-00000161;2", "LOOPCNT=1") in new stack
-- Executing [dstring@macro-dial-one:6] Set("Local/05@from-queue-00000161;2", "ITER=1") in new stack
-- Executing [dstring@macro-dial-one:7] Set("Local/05@from-queue-00000161;2", "THISDIAL=SIP/05") in new stack
-- Executing [dstring@macro-dial-one:8] GosubIf("Local/05@from-queue-00000161;2", "1?zap2dahdi,1()") in new stack
-- Executing [zap2dahdi@macro-dial-one:1] ExecIf("Local/05@from-queue-00000161;2", "0?Return()") in new stack
-- Executing [zap2dahdi@macro-dial-one:2] Set("Local/05@from-queue-00000161;2", "NEWDIAL=") in new stack
-- Executing [zap2dahdi@macro-dial-one:3] Set("Local/05@from-queue-00000161;2", "LOOPCNT2=1") in new stack
-- Executing [zap2dahdi@macro-dial-one:4] Set("Local/05@from-queue-00000161;2", "ITER2=1") in new stack
-- Executing [zap2dahdi@macro-dial-one:5] Set("Local/05@from-queue-00000161;2", "THISPART2=SIP/05") in new stack
-- Executing [zap2dahdi@macro-dial-one:6] ExecIf("Local/05@from-queue-00000161;2", "0?Set(THISPART2=DAHDI/05)") in new stack
-- Executing [zap2dahdi@macro-dial-one:7] Set("Local/05@from-queue-00000161;2", "NEWDIAL=SIP/05&") in new stack
-- Executing [zap2dahdi@macro-dial-one:8] Set("Local/05@from-queue-00000161;2", "ITER2=2") in new stack
-- Executing [zap2dahdi@macro-dial-one:9] GotoIf("Local/05@from-queue-00000161;2", "0?begin2") in new stack
-- Executing [zap2dahdi@macro-dial-one:10] Set("Local/05@from-queue-00000161;2", "THISDIAL=SIP/05") in new stack
-- Executing [zap2dahdi@macro-dial-one:11] Return("Local/05@from-queue-00000161;2", "") in new stack
-- Executing [dstring@macro-dial-one:9] GotoIf("Local/05@from-queue-00000161;2", "1?doset") in new stack
-- Goto (macro-dial-one,dstring,12)
-- Executing [dstring@macro-dial-one:12] Set("Local/05@from-queue-00000161;2", "DSTRING=SIP/05&") in new stack
-- Executing [dstring@macro-dial-one:13] Set("Local/05@from-queue-00000161;2", "ITER=2") in new stack
-- Executing [dstring@macro-dial-one:14] GotoIf("Local/05@from-queue-00000161;2", "0?begin") in new stack
-- Executing [dstring@macro-dial-one:15] Set("Local/05@from-queue-00000161;2", "DSTRING=SIP/05") in new stack
-- Executing [dstring@macro-dial-one:16] Return("Local/05@from-queue-00000161;2", "") in new stack
-- Executing [s@macro-dial-one:27] GotoIf("Local/05@from-queue-00000161;2", "0?nodial") in new stack
-- Executing [s@macro-dial-one:28] GotoIf("Local/05@from-queue-00000161;2", "0?skiptrace") in new stack
-- Executing [s@macro-dial-one:29] GosubIf("Local/05@from-queue-00000161;2", "1?ctset,1():ctclear,1()") in new stack
-- Executing [ctset@macro-dial-one:1] Set("Local/05@from-queue-00000161;2", "DB(CALLTRACE/05)=340529") in new stack
-- Executing [ctset@macro-dial-one:2] Return("Local/05@from-queue-00000161;2", "") in new stack
-- Executing [s@macro-dial-one:30] Set("Local/05@from-queue-00000161;2", "D_OPTIONS=TtrM(auto-blkvm)") in new stack
-- Executing [s@macro-dial-one:31] ExecIf("Local/05@from-queue-00000161;2", "0?SIPAddHeader(Alert-Info: )") in new stack
-- Executing [s@macro-dial-one:32] ExecIf("Local/05@from-queue-00000161;2", "0?SIPAddHeader()") in new stack
-- Executing [s@macro-dial-one:33] ExecIf("Local/05@from-queue-00000161;2", "1?Set(CHANNEL(musicclass)=default)") in new stack
-- Executing [s@macro-dial-one:34] GosubIf("Local/05@from-queue-00000161;2", "0?qwait,1()") in new stack
-- Executing [s@macro-dial-one:35] Set("Local/05@from-queue-00000161;2", "__CWIGNORE=") in new stack
-- Executing [s@macro-dial-one:36] Set("Local/05@from-queue-00000161;2", "__KEEPCID=TRUE") in new stack
-- Executing [s@macro-dial-one:37] GotoIf("Local/05@from-queue-00000161;2", "0?usegoto,1") in new stack
-- Executing [s@macro-dial-one:38] GotoIf("Local/05@from-queue-00000161;2", "1?godial") in new stack
-- Goto (macro-dial-one,s,43)
-- Executing [s@macro-dial-one:43] Macro("Local/05@from-queue-00000161;2", "dialout-one-predial-hook,") in new stack
-- Executing [s@macro-dialout-one-predial-hook:1] MacroExit("Local/05@from-queue-00000161;2", "") in new stack
-- Executing [s@macro-dial-one:44] Dial("Local/05@from-queue-00000161;2", "SIP/05,,TtrM(auto-blkvm)") in new stack
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
Audio is at 13308
Adding codec 100004 (alaw) to SDP
Adding codec 100003 (ulaw) to SDP
Adding codec 100002 (gsm) to SDP
Adding codec 100011 (g726) to SDP
Adding non-codec 0x1 (telephone-event) to SDP
Reliably Transmitting (NAT) to 10.1.16.208:5060:
INVITE sip:05@10.1.16.208:5060 SIP/2.0
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK3168d820;rport
Max-Forwards: 70
From: "340529" <sip:340529@91.207.114.4>;tag=as4030c774
To: <sip:05@10.1.16.208:5060>
Contact: <sip:340529@91.207.114.4:5060>
Call-ID: 65c00c2305321fc804aaa76a224685d5@91.207.114.4:5060
CSeq: 102 INVITE
User-Agent: FPBX-12.0.36(11.15.0)
Date: Mon, 09 Feb 2015 09:49:44 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
P-Asserted-Identity: "340529" <sip:340529@91.207.114.4>
Content-Type: application/sdp
Content-Length: 312

v=0
o=root 932744415 932744415 IN IP4 91.207.114.4
s=Asterisk PBX 11.15.0
c=IN IP4 91.207.114.4
t=0 0
m=audio 13308 RTP/AVP 8 0 3 111 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:3 GSM/8000
a=rtpmap:111 G726-32/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

---
-- Called SIP/05
-- Local/05@from-queue-00000161;1 is ringing
-- Local/05@from-queue-00000161;1 connected line has changed. Saving it until answer for SIP/702-0000014f
-- Local/05@from-queue-00000161;1 connected line has changed. Saving it until answer for SIP/702-0000014f

<--- SIP read from UDP:10.1.16.208:5060 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK3168d820;rport
From: "340529" <sip:340529@91.207.114.4>;tag=as4030c774
To: <sip:05@10.1.16.208:5060>
Call-ID: 65c00c2305321fc804aaa76a224685d5@91.207.114.4:5060
CSeq: 102 INVITE
Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REFER, NOTIFY, INFO, PRACK, UPDATE, MESSAGE
Content-Length: 0

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

<--- SIP read from UDP:10.1.16.208:5060 --->
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 91.207.114.4:5060;branch=z9hG4bK3168d820;rport
From: "340529" <sip:340529@91.207.114.4>;tag=as4030c774
To: <sip:05@10.1.16.208:5060>;tag=1038527949
Call-ID: 65c00c2305321fc804aaa76a224685d5@91.207.114.4:5060
CSeq: 102 INVITE
Contact: <sip:05@10.1.16.208:5060>
Server: Voip Phone 1.0
Allow: INVITE, ACK, OPTIONS, BYE, CANCEL, REFER, NOTIFY, INFO, PRACK, UPDATE, MESSAGE
Content-Length: 0

<------------->
--- (10 headers 0 lines) ---
list_route: hop: <sip:05@10.1.16.208:5060>
-- SIP/05-00000150 is ringing
-- Local/05@from-queue-00000161;1 is ringing
ded
Сообщения: 15625
Зарегистрирован: 26 авг 2010, 19:00

Re: FreePBX+DV6004S рвет соединение.

Сообщение ded »

1. в этих дебах нет разрыва.
2. хорошо бы Вам самим разбираться в портянках!
Ответить
© 2008 — 2024 Asterisk.ru
Digium, Asterisk and AsteriskNOW are registered trademarks of Digium, Inc.
Design and development by PostMet-Netzwerk GmbH