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

Grandstream ucm6100 + AsteriskNOW 11 через IAX

Новичком считается только что прочитавший «Астериск - будущее телефонии»
http://asterisk.ru/knowledgebase/books
и пытающийся сделать большее

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

Ответить
PingWin
Сообщения: 4
Зарегистрирован: 27 июл 2015, 06:56

Grandstream ucm6100 + AsteriskNOW 11 через IAX

Сообщение PingWin »

Транк IAX настроен. Звонки проходят с обоих сторон замечательно, но, если звонить с астерисканау на грандстрим не отображается callerid, вместо него пишет NEW USER с номером asterisk. При этом звонки с грандстрима на астерискнау приходят с верным callerid.
Снимал трейс на грандстриме, судя по нему и по логам астерискнау callerid передает. А вот в логах грандстрима callerid пуст...
Это лог с астериск нау:

Код: Выделить всё

  == Using SIP RTP TOS bits 184
  == Using SIP RTP CoS mark 5
    -- Executing [199@from-internal:1] Macro("SIP/301-00000040", "user-callerid,LIMIT,EXTERNAL,") in new stack
    -- Executing [s@macro-user-callerid:1] Set("SIP/301-00000040", "TOUCH_MONITOR=1437984287.118") in new stack
    -- Executing [s@macro-user-callerid:2] Set("SIP/301-00000040", "AMPUSER=301") in new stack
    -- Executing [s@macro-user-callerid:3] GotoIf("SIP/301-00000040", "0?report") in new stack
    -- Executing [s@macro-user-callerid:4] ExecIf("SIP/301-00000040", "1?Set(REALCALLERIDNUM=301)") in new stack
    -- Executing [s@macro-user-callerid:5] Set("SIP/301-00000040", "AMPUSER=301") in new stack
    -- Executing [s@macro-user-callerid:6] GotoIf("SIP/301-00000040", "0?limit") in new stack
    -- Executing [s@macro-user-callerid:7] Set("SIP/301-00000040", "AMPUSERCIDNAME=Evgeniy Lomakov") in new stack
    -- Executing [s@macro-user-callerid:8] GotoIf("SIP/301-00000040", "0?report") in new stack
    -- Executing [s@macro-user-callerid:9] Set("SIP/301-00000040", "AMPUSERCID=301") in new stack
    -- Executing [s@macro-user-callerid:10] Set("SIP/301-00000040", "__DIAL_OPTIONS=Ttr") in new stack
    -- Executing [s@macro-user-callerid:11] Set("SIP/301-00000040", "CALLERID(all)="Evgeniy Lomakov" <301>") in new stack
    -- Executing [s@macro-user-callerid:12] GotoIf("SIP/301-00000040", "0?limit") in new stack
    -- Executing [s@macro-user-callerid:13] ExecIf("SIP/301-00000040", "1?Set(GROUP(concurrency_limit)=301)") in new stack
    -- Executing [s@macro-user-callerid:14] GosubIf("SIP/301-00000040", "7?sub-ccss,s,1(from-internal,199)") in new stack
    -- Executing [s@sub-ccss:1] ExecIf("SIP/301-00000040", "0?Return()") in new stack
    -- Executing [s@sub-ccss:2] Set("SIP/301-00000040", "CCSS_SETUP=TRUE") in new stack
    -- Executing [s@sub-ccss:3] GosubIf("SIP/301-00000040", "0?monitor_config,1(from-internal,199):monitor_default,1(from-internal,199)") in new stack
    -- Executing [monitor_default@sub-ccss:1] GotoIf("SIP/301-00000040", "0?is_exten") in new stack
    -- Executing [monitor_default@sub-ccss:2] StackPop("SIP/301-00000040", "") in new stack
    -- Executing [monitor_default@sub-ccss:3] Return("SIP/301-00000040", "FALSE") in new stack
    -- Executing [s@macro-user-callerid:15] ExecIf("SIP/301-00000040", "0?Set(CHANNEL(language)=)") in new stack
    -- Executing [s@macro-user-callerid:16] GotoIf("SIP/301-00000040", "1?continue") in new stack
    -- Goto (macro-user-callerid,s,30)
    -- Executing [s@macro-user-callerid:30] Set("SIP/301-00000040", "CALLERID(number)=301") in new stack
    -- Executing [s@macro-user-callerid:31] Set("SIP/301-00000040", "CALLERID(name)=Evgeniy Lomakov") in new stack
    -- Executing [s@macro-user-callerid:32] Set("SIP/301-00000040", "CDR(cnum)=301") in new stack
    -- Executing [s@macro-user-callerid:33] Set("SIP/301-00000040", "CDR(cnam)=Evgeniy Lomakov") in new stack
    -- Executing [s@macro-user-callerid:34] Set("SIP/301-00000040", "CHANNEL(language)=en") in new stack
    -- Executing [199@from-internal:2] Gosub("SIP/301-00000040", "sub-record-check,s,1(out,199,dontcare)") in new stack
    -- Executing [s@sub-record-check:1] GotoIf("SIP/301-00000040", "0?initialized") in new stack
    -- Executing [s@sub-record-check:2] Set("SIP/301-00000040", "__REC_STATUS=INITIALIZED") in new stack
    -- Executing [s@sub-record-check:3] Set("SIP/301-00000040", "NOW=1437984287") in new stack
    -- Executing [s@sub-record-check:4] Set("SIP/301-00000040", "__DAY=27") in new stack
    -- Executing [s@sub-record-check:5] Set("SIP/301-00000040", "__MONTH=07") in new stack
    -- Executing [s@sub-record-check:6] Set("SIP/301-00000040", "__YEAR=2015") in new stack
    -- Executing [s@sub-record-check:7] Set("SIP/301-00000040", "__TIMESTR=20150727-160447") in new stack
    -- Executing [s@sub-record-check:8] Set("SIP/301-00000040", "__FROMEXTEN=301") in new stack
    -- Executing [s@sub-record-check:9] Set("SIP/301-00000040", "__MON_FMT=wav") in new stack
    -- Executing [s@sub-record-check:10] NoOp("SIP/301-00000040", "Recordings initialized") in new stack
    -- Executing [s@sub-record-check:11] ExecIf("SIP/301-00000040", "0?Set(ARG3=dontcare)") in new stack
    -- Executing [s@sub-record-check:12] Set("SIP/301-00000040", "REC_POLICY_MODE_SAVE=") in new stack
    -- Executing [s@sub-record-check:13] ExecIf("SIP/301-00000040", "0?Set(REC_STATUS=NO)") in new stack
    -- Executing [s@sub-record-check:14] GotoIf("SIP/301-00000040", "3?checkaction") in new stack
    -- Goto (sub-record-check,s,17)
    -- Executing [s@sub-record-check:17] GotoIf("SIP/301-00000040", "1?sub-record-check,out,1") in new stack
    -- Goto (sub-record-check,out,1)
    -- Executing [out@sub-record-check:1] NoOp("SIP/301-00000040", "Outbound Recording Check from 301 to 199") in new stack
    -- Executing [out@sub-record-check:2] Set("SIP/301-00000040", "RECMODE=dontcare") in new stack
    -- Executing [out@sub-record-check:3] ExecIf("SIP/301-00000040", "1?Goto(routewins)") in new stack
    -- Goto (sub-record-check,out,7)
    -- Executing [out@sub-record-check:7] Gosub("SIP/301-00000040", "recordcheck,1(dontcare,out,199)") in new stack
    -- Executing [recordcheck@sub-record-check:1] NoOp("SIP/301-00000040", "Starting recording check against dontcare") in new stack
    -- Executing [recordcheck@sub-record-check:2] Goto("SIP/301-00000040", "dontcare") in new stack
    -- Goto (sub-record-check,recordcheck,3)
    -- Executing [recordcheck@sub-record-check:3] Return("SIP/301-00000040", "") in new stack
    -- Executing [out@sub-record-check:8] Return("SIP/301-00000040", "") in new stack
    -- Executing [199@from-internal:3] ExecIf("SIP/301-00000040", "0 ?Set(CDR(accountcode)=)") in new stack
    -- Executing [199@from-internal:4] Set("SIP/301-00000040", "INTRACOMPANYROUTE=YES") in new stack
    -- Executing [199@from-internal:5] Set("SIP/301-00000040", "MOHCLASS=default") in new stack
    -- Executing [199@from-internal:6] Set("SIP/301-00000040", "_NODEST=") in new stack
    -- Executing [199@from-internal:7] Macro("SIP/301-00000040", "dialout-trunk,2,199,,off") in new stack
    -- Executing [s@macro-dialout-trunk:1] Set("SIP/301-00000040", "DIAL_TRUNK=2") in new stack
    -- Executing [s@macro-dialout-trunk:2] GosubIf("SIP/301-00000040", "0?sub-pincheck,s,1()") in new stack
    -- Executing [s@macro-dialout-trunk:3] GotoIf("SIP/301-00000040", "0?disabletrunk,1") in new stack
    -- Executing [s@macro-dialout-trunk:4] Set("SIP/301-00000040", "DIAL_NUMBER=199") in new stack
    -- Executing [s@macro-dialout-trunk:5] Set("SIP/301-00000040", "DIAL_TRUNK_OPTIONS=Ttr") in new stack
    -- Executing [s@macro-dialout-trunk:6] Set("SIP/301-00000040", "OUTBOUND_GROUP=OUT_2") in new stack
    -- Executing [s@macro-dialout-trunk:7] GotoIf("SIP/301-00000040", "1?nomax") in new stack
    -- Goto (macro-dialout-trunk,s,9)
    -- Executing [s@macro-dialout-trunk:9] GotoIf("SIP/301-00000040", "1?skipoutcid") in new stack
    -- Goto (macro-dialout-trunk,s,12)
    -- Executing [s@macro-dialout-trunk:12] GosubIf("SIP/301-00000040", "0?sub-flp-2,s,1()") in new stack
    -- Executing [s@macro-dialout-trunk:13] Set("SIP/301-00000040", "OUTNUM=199") in new stack
    -- Executing [s@macro-dialout-trunk:14] Set("SIP/301-00000040", "custom=IAX2/trunk_3") in new stack
    -- Executing [s@macro-dialout-trunk:15] ExecIf("SIP/301-00000040", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)Ttr)") in new stack
    -- Executing [s@macro-dialout-trunk:16] ExecIf("SIP/301-00000040", "0?Set(DIAL_TRUNK_OPTIONS=TtrM(confirm))") in new stack
    -- Executing [s@macro-dialout-trunk:17] Macro("SIP/301-00000040", "dialout-trunk-predial-hook,") in new stack
    -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("SIP/301-00000040", "") in new stack
    -- Executing [s@macro-dialout-trunk:18] GotoIf("SIP/301-00000040", "0?bypass,1") in new stack
    -- Executing [s@macro-dialout-trunk:19] ExecIf("SIP/301-00000040", "1?Set(CONNECTEDLINE(num,i)=199)") in new stack
    -- Executing [s@macro-dialout-trunk:20] ExecIf("SIP/301-00000040", "1?Set(CONNECTEDLINE(name,i)=CID:301)") in new stack
    -- Executing [s@macro-dialout-trunk:21] GotoIf("SIP/301-00000040", "0?customtrunk") in new stack
    -- Executing [s@macro-dialout-trunk:22] Dial("SIP/301-00000040", "IAX2/trunk_3/199,300,Ttr") in new stack
    -- Called IAX2/trunk_3/199
    -- Call accepted by 192.168.10.22 (format ulaw)
    -- Format for call is (ulaw)
    -- IAX2/trunk_3-18024 is ringing
    -- Hungup 'IAX2/trunk_3-18024'
  == Spawn extension (macro-dialout-trunk, s, 22) exited non-zero on 'SIP/301-00000040' in macro 'dialout-trunk'
  == Spawn extension (from-internal, 199, 7) exited non-zero on 'SIP/301-00000040'
    -- Executing [h@from-internal:1] Hangup("SIP/301-00000040", "") in new stack
  == Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/301-00000040'
Это лог с грандстрима:

Код: Выделить всё

Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.505] DEBUG[30314] chan_iax2.c:2366: ip callno count incremented to 5 for 192.168.25.99
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.524] VERB [30308] chan_iax2.c:11132:     -- Accepting AUTHENTICATED call from 192.168.25.99:
       > requested format = ulaw,
       > requested prefs = disabled,
       > actual format = ulaw,
       > hos
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.526] DEBUG[13181] pbx.c:4948: __ast_pbx_run(0x42d94758, 0x00000000) ...
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.527] DEBUG[13181] pbx.c:4237: Launching 'NoOp'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.527] VERB [13181] pbx.c:4245:     -- Executing [199@ext-did-3:1] NoOp("IAX2/trunk_3-899", "") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.528] DEBUG[13181] pbx.c:4237: Launching 'Set'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.529] VERB [13181] pbx.c:4245:     -- Executing [199@ext-did-3:2] Set("IAX2/trunk_3-899", "__FROM_TRUNK=YES") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.529] DEBUG[13181] pbx.c:4237: Launching 'Set'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.530] VERB [13181] pbx.c:4245:     -- Executing [199@ext-did-3:3] Set("IAX2/trunk_3-899", "__DISA_PERMISSION=internal-local-national-international") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.531] NOTIC[13181] pbx.c:3243: Result of 'BLACKLIST_CHECK' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.532] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.533] DEBUG[13181] pbx.c:4237: Launching 'GosubIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.533] VERB [13181] pbx.c:4245:     -- Executing [199@ext-did-3:4] GosubIf("IAX2/trunk_3-899", "0?app-blacklist-check,s,1") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.534] NOTIC[13181] pbx.c:3246: Result of 'EXTEN' is '199'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.534] DEBUG[13181] pbx.c:4237: Launching 'Goto'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.534] VERB [13181] pbx.c:4245:     -- Executing [199@ext-did-3:5] Goto("IAX2/trunk_3-899", "ext-did-3-did-additional,199,1") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.535] VERB [13181] pbx.c:9854:     -- Goto (ext-did-3-did-additional,199,1)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.536] DEBUG[13181] pbx.c:4237: Launching 'Macro'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.536] VERB [13181] pbx.c:4245:     -- Executing [199@ext-did-3-did-additional:1] Macro("IAX2/trunk_3-899", "exten-vm,199,199") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.540] DEBUG[13181] pbx.c:4237: Launching 'Macro'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.540] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:1] Macro("IAX2/trunk_3-899", "user-callerid") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.542] NOTIC[13181] pbx.c:3243: Result of 'AAUSER' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.542] DEBUG[13181] pbx.c:4133: Expression result is '1'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.542] DEBUG[13181] pbx.c:4065: Function result is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.543] NOTIC[13181] pbx.c:3243: Result of 'AAUSER' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.543] DEBUG[13181] pbx.c:4065: Function result is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.543] DEBUG[13181] pbx.c:4237: Launching 'Set'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.543] VERB [13181] pbx.c:4245:     -- Executing [s@macro-user-callerid:1] Set("IAX2/trunk_3-899", "_AAUSER=") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.546] NOTIC[13181] pbx.c:3246: Result of 'CHANNEL' is 'IAX2/trunk_3-899'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.546] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.546] DEBUG[13181] pbx.c:4237: Launching 'GotoIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.546] VERB [13181] pbx.c:4245:     -- Executing [s@macro-user-callerid:2] GotoIf("IAX2/trunk_3-899", "0?report") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.546] DEBUG[13181] pbx.c:10167: Not taking any branch
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.548] NOTIC[13181] pbx.c:3243: Result of 'REALCALLERIDNUM' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.548] DEBUG[13181] pbx.c:4133: Expression result is '1'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.548] DEBUG[13181] pbx.c:4065: Function result is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.548] DEBUG[13181] pbx.c:4237: Launching 'ExecIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.548] VERB [13181] pbx.c:4245:     -- Executing [s@macro-user-callerid:3] ExecIf("IAX2/trunk_3-899", "1?Set(REALCALLERIDNUM=)") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.549] DEBUG[13181] pbx.c:3832: Evaluating 'REALCALLERIDNUM:1:2' (from 'REALCALLERIDNUM:1:2}" = ""' len 19)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.549] NOTIC[13181] pbx.c:3246: Result of 'REALCALLERIDNUM' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.549] DEBUG[13181] pbx.c:3924: Expression result is '1'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.549] DEBUG[13181] pbx.c:3832: Evaluating 'CALLERID(number)' (from 'CALLERID(number)})' len 16)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.549] DEBUG[13181] pbx.c:3866: Function result is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.550] NOTIC[13181] pbx.c:3246: Result of 'AAUSER' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.551] DEBUG[13181] pbx.c:4065: Function result is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.551] DEBUG[13181] pbx.c:4237: Launching 'Set'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.551] VERB [13181] pbx.c:4245:     -- Executing [s@macro-user-callerid:4] Set("IAX2/trunk_3-899", "AAUSERCIDNAME=") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.553] NOTIC[13181] pbx.c:3246: Result of 'FROM_TRUNK' is 'YES'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.553] DEBUG[13181] pbx.c:4133: Expression result is '1'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.554] DEBUG[13181] pbx.c:4065: Function result is 'New User'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.554] DEBUG[13181] pbx.c:4237: Launching 'ExecIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.554] VERB [13181] pbx.c:4245:     -- Executing [s@macro-user-callerid:5] ExecIf("IAX2/trunk_3-899", "1?Set(AAUSERCIDNAME=New User)") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.555] DEBUG[13181] pbx.c:3832: Evaluating 'FROM_TRUNK' (from 'FROM_TRUNK}" = "YES"' len 10)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.555] NOTIC[13181] pbx.c:3246: Result of 'FROM_TRUNK' is 'YES'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.555] DEBUG[13181] pbx.c:3924: Expression result is '1'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.555] DEBUG[13181] pbx.c:3832: Evaluating 'CALLERID(name)' (from 'CALLERID(name)})' len 14)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.555] DEBUG[13181] pbx.c:3866: Function result is 'New User'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.557] NOTIC[13181] pbx.c:3246: Result of 'AAUSERCIDNAME' is 'New User'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.557] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.557] DEBUG[13181] pbx.c:4237: Launching 'GotoIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.557] VERB [13181] pbx.c:4245:     -- Executing [s@macro-user-callerid:6] GotoIf("IAX2/trunk_3-899", "0?report") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.558] DEBUG[13181] pbx.c:10167: Not taking any branch
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.559] NOTIC[13181] pbx.c:3246: Result of 'AAUSER' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.559] DEBUG[13181] pbx.c:4065: Function result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.559] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.567] DEBUG[13181] pbx.c:3866: Function result is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.568] NOTIC[13181] pbx.c:3246: Result of 'AAUSER' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.569] DEBUG[13181] pbx.c:4065: Function result is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.569] DEBUG[13181] pbx.c:4237: Launching 'Set'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.569] VERB [13181] pbx.c:4245:     -- Executing [s@macro-user-callerid:10] Set("IAX2/trunk_3-899", "OUTBOUNDCID=") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.572] NOTIC[13181] pbx.c:3246: Result of 'OUTBOUNDCID' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.572] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.572] NOTIC[13181] pbx.c:3246: Result of 'OUTBOUNDCID' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.572] DEBUG[13181] pbx.c:4237: Launching 'ExecIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.572] VERB [13181] pbx.c:4245:     -- Executing [s@macro-user-callerid:11] ExecIf("IAX2/trunk_3-899", "0?Set(CALLERID(all)=)") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.572] DEBUG[13181] pbx.c:3832: Evaluating 'OUTBOUNDCID' (from 'OUTBOUNDCID}" != ""' len 11)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.572] NOTIC[13181] pbx.c:3246: Result of 'OUTBOUNDCID' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.573] DEBUG[13181] pbx.c:3924: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.573] DEBUG[13181] pbx.c:3832: Evaluating 'OUTBOUNDCID' (from 'OUTBOUNDCID})' len 11)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.573] NOTIC[13181] pbx.c:3246: Result of 'OUTBOUNDCID' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.573] NOTIC[13181] pbx.c:3246: Result of 'ARG1' is '199'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.574] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.574] DEBUG[13181] pbx.c:4237: Launching 'GotoIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.574] VERB [13181] pbx.c:4245:     -- Executing [s@macro-user-callerid:12] GotoIf("IAX2/trunk_3-899", "0?continue") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.574] DEBUG[13181] pbx.c:10167: Not taking any branch
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.575] NOTIC[13181] pbx.c:3243: Result of 'TTL' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.575] DEBUG[13181] pbx.c:4133: Expression result is '1'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.575] NOTIC[13181] pbx.c:3243: Result of 'TTL' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.575] DEBUG[13181] pbx.c:4133: Expression result is '-1'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.576] DEBUG[13181] pbx.c:4065: Function result is '64'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.576] DEBUG[13181] pbx.c:4237: Launching 'Set'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.576] VERB [13181] pbx.c:4245:     -- Executing [s@macro-user-callerid:13] Set("IAX2/trunk_3-899", "__TTL=64") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.578] NOTIC[13181] pbx.c:3246: Result of 'TTL' is '64'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.578] DEBUG[13181] pbx.c:4133: Expression result is '1'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.578] DEBUG[13181] pbx.c:4237: Launching 'GotoIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.578] VERB [13181] pbx.c:4245:     -- Executing [s@macro-user-callerid:14] GotoIf("IAX2/trunk_3-899", "1?continue") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.579] VERB [13181] pbx.c:9854:     -- Goto (macro-user-callerid,s,21)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.580] DEBUG[13181] pbx.c:4065: Function result is '"New User" <>'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.580] DEBUG[13181] pbx.c:4237: Launching 'Log'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.580] VERB [13181] pbx.c:4245:     -- Executing [s@macro-user-callerid:21] Log("IAX2/trunk_3-899", "NOTICE, "Using CallerID "New User" <>"") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.582] DEBUG[13181] pbx.c:4237: Launching 'Set'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.582] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:2] Set("IAX2/trunk_3-899", "CDR(userfield)=EXT") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.584] NOTIC[13181] pbx.c:3246: Result of 'ARG1' is '199'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.584] DEBUG[13181] pbx.c:4237: Launching 'Set'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.584] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:3] Set("IAX2/trunk_3-899", "VMBOX=199") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.586] NOTIC[13181] pbx.c:3246: Result of 'ARG2' is '199'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.586] DEBUG[13181] pbx.c:4237: Launching 'Set'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.586] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:4] Set("IAX2/trunk_3-899", "EXTTOCALL=199") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.587] NOTIC[13181] pbx.c:3246: Result of 'EXTTOCALL' is '199'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.588] DEBUG[13181] pbx.c:4065: Function result is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.588] DEBUG[13181] pbx.c:4237: Launching 'Set'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.588] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:5] Set("IAX2/trunk_3-899", "DNDON=") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.589] NOTIC[13181] pbx.c:3246: Result of 'EXTTOCALL' is '199'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.589] DEBUG[13181] pbx.c:4065: Function result is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.589] DEBUG[13181] pbx.c:4237: Launching 'Set'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.589] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:6] Set("IAX2/trunk_3-899", "CFBEXT=") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.591] NOTIC[13181] pbx.c:3246: Result of 'EXTTOCALL' is '199'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.592] DEBUG[13181] pbx.c:4065: Function result is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.592] DEBUG[13181] pbx.c:4237: Launching 'Set'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.592] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:7] Set("IAX2/trunk_3-899", "CFNEXT=") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.594] NOTIC[13181] pbx.c:3246: Result of 'EXTTOCALL' is '199'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.594] DEBUG[13181] pbx.c:4065: Function result is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.594] DEBUG[13181] pbx.c:4237: Launching 'Set'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.594] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:8] Set("IAX2/trunk_3-899", "CFUEXT=") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.596] NOTIC[13181] pbx.c:3243: Result of 'IN_FOLLOWME' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.596] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.597] NOTIC[13181] pbx.c:3243: Result of 'NODEST' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.597] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.597] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.597] DEBUG[13181] pbx.c:4237: Launching 'ExecIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.597] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:9] ExecIf("IAX2/trunk_3-899", "0?Set(DNDON=NO)") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.598] DEBUG[13181] pbx.c:3832: Evaluating 'IN_FOLLOWME' (from 'IN_FOLLOWME}" == "YES"' len 11)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.598] NOTIC[13181] pbx.c:3243: Result of 'IN_FOLLOWME' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.598] DEBUG[13181] pbx.c:3924: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.598] DEBUG[13181] pbx.c:3832: Evaluating 'NODEST' (from 'NODEST}" != ""' len 6)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.598] NOTIC[13181] pbx.c:3243: Result of 'NODEST' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.598] DEBUG[13181] pbx.c:3924: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.598] DEBUG[13181] pbx.c:3924: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.600] NOTIC[13181] pbx.c:3243: Result of 'IN_FOLLOWME' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.600] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.600] NOTIC[13181] pbx.c:3243: Result of 'NODEST' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.600] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.600] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.600] DEBUG[13181] pbx.c:4237: Launching 'ExecIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.600] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:10] ExecIf("IAX2/trunk_3-899", "0?Set(CFBEXT=)") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.602] DEBUG[13181] pbx.c:3832: Evaluating 'IN_FOLLOWME' (from 'IN_FOLLOWME}" == "YES"' len 11)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.602] NOTIC[13181] pbx.c:3243: Result of 'IN_FOLLOWME' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.602] DEBUG[13181] pbx.c:3924: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.602] DEBUG[13181] pbx.c:3832: Evaluating 'NODEST' (from 'NODEST}" != ""' len 6)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.602] NOTIC[13181] pbx.c:3243: Result of 'NODEST' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.602] DEBUG[13181] pbx.c:3924: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.602] DEBUG[13181] pbx.c:3924: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.604] NOTIC[13181] pbx.c:3243: Result of 'IN_FOLLOWME' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.604] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.604] NOTIC[13181] pbx.c:3243: Result of 'NODEST' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.604] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.604] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.604] DEBUG[13181] pbx.c:4237: Launching 'ExecIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.604] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:11] ExecIf("IAX2/trunk_3-899", "0?Set(CFNEXT=)") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.605] DEBUG[13181] pbx.c:3832: Evaluating 'IN_FOLLOWME' (from 'IN_FOLLOWME}" == "YES"' len 11)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.605] NOTIC[13181] pbx.c:3243: Result of 'IN_FOLLOWME' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.605] DEBUG[13181] pbx.c:3924: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.605] DEBUG[13181] pbx.c:3832: Evaluating 'NODEST' (from 'NODEST}" != ""' len 6)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.606] NOTIC[13181] pbx.c:3243: Result of 'NODEST' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.606] DEBUG[13181] pbx.c:3924: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.606] DEBUG[13181] pbx.c:3924: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.607] NOTIC[13181] pbx.c:3243: Result of 'IN_FOLLOWME' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.608] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.608] NOTIC[13181] pbx.c:3243: Result of 'NODEST' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.608] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.608] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.608] DEBUG[13181] pbx.c:4237: Launching 'ExecIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.608] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:12] ExecIf("IAX2/trunk_3-899", "0?Set(CFUEXT=)") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.608] DEBUG[13181] pbx.c:3832: Evaluating 'IN_FOLLOWME' (from 'IN_FOLLOWME}" == "YES"' len 11)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.608] NOTIC[13181] pbx.c:3243: Result of 'IN_FOLLOWME' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.609] DEBUG[13181] pbx.c:3924: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.609] DEBUG[13181] pbx.c:3832: Evaluating 'NODEST' (from 'NODEST}" != ""' len 6)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.609] NOTIC[13181] pbx.c:3243: Result of 'NODEST' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.609] DEBUG[13181] pbx.c:3924: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.609] DEBUG[13181] pbx.c:3924: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.610] NOTIC[13181] pbx.c:3246: Result of 'DNDON' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.610] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.610] DEBUG[13181] pbx.c:4237: Launching 'ExecIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.610] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:13] ExecIf("IAX2/trunk_3-899", "0?Set(DIALSTATUS=BUSY)") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.612] DEBUG[13181] pbx.c:3832: Evaluating 'DNDON' (from 'DNDON}" = "YES"' len 5)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.612] NOTIC[13181] pbx.c:3246: Result of 'DNDON' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.612] DEBUG[13181] pbx.c:3924: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.613] NOTIC[13181] pbx.c:3246: Result of 'DNDON' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.613] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.613] DEBUG[13181] pbx.c:4237: Launching 'GotoIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.613] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:14] GotoIf("IAX2/trunk_3-899", "0?sent2vm") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.613] DEBUG[13181] pbx.c:10167: Not taking any branch
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.615] NOTIC[13181] pbx.c:3246: Result of 'CFUEXT' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.615] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.615] DEBUG[13181] pbx.c:4237: Launching 'GotoIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.615] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:15] GotoIf("IAX2/trunk_3-899", "0?docfu,1") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.615] DEBUG[13181] pbx.c:10167: Not taking any branch
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.617] NOTIC[13181] pbx.c:3246: Result of 'RINGTIME' is '60'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.617] DEBUG[13181] pbx.c:4237: Launching 'Set'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.617] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:16] Set("IAX2/trunk_3-899", "CALL_RT=60") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.619] NOTIC[13181] pbx.c:3246: Result of 'EXTTOCALL' is '199'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.620] DEBUG[13181] pbx.c:4065: Function result is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.620] DEBUG[13181] pbx.c:4237: Launching 'Set'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.620] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:17] Set("IAX2/trunk_3-899", "USER_RT=") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.622] NOTIC[13181] pbx.c:3246: Result of 'USER_RT' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.622] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.622] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.622] NOTIC[13181] pbx.c:3246: Result of 'USER_RT' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.622] DEBUG[13181] pbx.c:4237: Launching 'ExecIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.622] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:18] ExecIf("IAX2/trunk_3-899", "0?Set(CALL_RT=)") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.623] DEBUG[13181] pbx.c:3832: Evaluating 'USER_RT' (from 'USER_RT}" != ""' len 7)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.623] NOTIC[13181] pbx.c:3246: Result of 'USER_RT' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.623] DEBUG[13181] pbx.c:3924: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.623] DEBUG[13181] pbx.c:3924: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.623] DEBUG[13181] pbx.c:3832: Evaluating 'USER_RT' (from 'USER_RT})' len 7)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.623] NOTIC[13181] pbx.c:3246: Result of 'USER_RT' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.624] NOTIC[13181] pbx.c:3246: Result of 'EXTTOCALL' is '199'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.624] NOTIC[13181] pbx.c:3246: Result of 'CALL_RT' is '60'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.624] DEBUG[13181] pbx.c:4237: Launching 'Macro'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.624] VERB [13181] pbx.c:4245:     -- Executing [s@macro-exten-vm:19] Macro("IAX2/trunk_3-899", "dial,199,60") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.628] NOTIC[13181] pbx.c:3243: Result of 'MOHCLASS' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.628] DEBUG[13181] pbx.c:4133: Expression result is '1'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.628] DEBUG[13181] pbx.c:4237: Launching 'GotoIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.628] VERB [13181] pbx.c:4245:     -- Executing [s@macro-dial:1] GotoIf("IAX2/trunk_3-899", "1?dial") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.628] VERB [13181] pbx.c:9854:     -- Goto (macro-dial,s,3)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.629] NOTIC[13181] pbx.c:3246: Result of 'ARG1' is '199'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.630] DEBUG[13181] pbx.c:4065: Function result is 'SIP/199'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.630] DEBUG[13181] pbx.c:4237: Launching 'Set'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.630] VERB [13181] pbx.c:4245:     -- Executing [s@macro-dial:3] Set("IAX2/trunk_3-899", "DIAL_STR=SIP/199") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.632] NOTIC[13181] pbx.c:3246: Result of 'ARG2' is '60'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.632] DEBUG[13181] pbx.c:4237: Launching 'Set'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.632] VERB [13181] pbx.c:4245:     -- Executing [s@macro-dial:4] Set("IAX2/trunk_3-899", "CALL_RT=60") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.635] NOTIC[13181] pbx.c:3243: Result of 'DISA_HANGUP' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.635] DEBUG[13181] pbx.c:4237: Launching 'Macro'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.635] VERB [13181] pbx.c:4245:     -- Executing [s@macro-dial:5] Macro("IAX2/trunk_3-899", "set-call-options,") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.637] NOTIC[13181] pbx.c:3246: Result of 'ARG1' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.637] NOTIC[13181] pbx.c:3246: Result of 'DIAL_OPTIONS' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.637] DEBUG[13181] pbx.c:4237: Launching 'Set'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.637] VERB [13181] pbx.c:4245:     -- Executing [s@macro-set-call-options:1] Set("IAX2/trunk_3-899", "CALL_OPTIONS=") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.639] NOTIC[13181] pbx.c:3246: Result of 'FROM_TRUNK' is 'YES'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.639] DEBUG[13181] pbx.c:4133: Expression result is '1'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.639] NOTIC[13181] pbx.c:3246: Result of 'ARG1' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.639] NOTIC[13181] pbx.c:3246: Result of 'FROM_TRUNK_OPTIONS' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.639] DEBUG[13181] pbx.c:4237: Launching 'ExecIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.641] DEBUG[13181] pbx.c:3832: Evaluating 'FROM_TRUNK' (from 'FROM_TRUNK}" = "YES"' len 10)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.641] NOTIC[13181] pbx.c:3246: Result of 'FROM_TRUNK' is 'YES'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.641] DEBUG[13181] pbx.c:3924: Expression result is '1'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.641] DEBUG[13181] pbx.c:3832: Evaluating 'ARG1' (from 'ARG1}${FROM_TRUNK_OPTIONS})' len 4)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.641] NOTIC[13181] pbx.c:3246: Result of 'ARG1' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.641] DEBUG[13181] pbx.c:3832: Evaluating 'FROM_TRUNK_OPTIONS' (from 'FROM_TRUNK_OPTIONS})' len 18)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.641] NOTIC[13181] pbx.c:3246: Result of 'FROM_TRUNK_OPTIONS' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.644] NOTIC[13181] pbx.c:3243: Result of 'FROM_IVR' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.644] DEBUG[13181] pbx.c:4133: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.644] NOTIC[13181] pbx.c:3246: Result of 'CALL_OPTIONS' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.644] DEBUG[13181] pbx.c:4237: Launching 'ExecIf'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.644] VERB [13181] pbx.c:4245:     -- Executing [s@macro-dial:6] ExecIf("IAX2/trunk_3-899", "0?Set(CALL_OPTIONS=m(rbt))") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.645] DEBUG[13181] pbx.c:3832: Evaluating 'FROM_IVR' (from 'FROM_IVR}" != ""' len 8)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.645] NOTIC[13181] pbx.c:3243: Result of 'FROM_IVR' is NULL
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.645] DEBUG[13181] pbx.c:3924: Expression result is '0'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.645] DEBUG[13181] pbx.c:3832: Evaluating 'CALL_OPTIONS' (from 'CALL_OPTIONS}m(rbt))' len 12)
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.645] NOTIC[13181] pbx.c:3246: Result of 'CALL_OPTIONS' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.647] NOTIC[13181] pbx.c:3246: Result of 'DIAL_STR' is 'SIP/199'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.647] NOTIC[13181] pbx.c:3246: Result of 'CALL_RT' is '60'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.647] NOTIC[13181] pbx.c:3246: Result of 'CALL_OPTIONS' is ''
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.647] DEBUG[13181] pbx.c:4237: Launching 'Dial'
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.647] VERB [13181] pbx.c:4245:     -- Executing [s@macro-dial:7] Dial("IAX2/trunk_3-899", "SIP/199,60,") in new stack
Jul 27 15:11:25 192.168.10.22 asterisk: 
[20150727 151125.648] CC   [13181] ccss.c:2180: Agent policy for IAX2/trunk_3-899 is 'never'. CC not possible
То ли лыжи не едут то ли я....но никак не могу понять в чем проблема
Вернуться к началу
ded
Сообщения: 15630
Зарегистрирован: 26 авг 2010, 19:00

Re: Grandstream ucm6100 + AsteriskNOW 11 через IAX

Сообщение ded »

Две станции соединять друг за другом надо через внутренний контекст from-internal (для транка IAX2) а у вас - через внешний контекст ext-did

Код: Выделить всё

Executing [199@ext-did
Для вэб интерфейсов в соединениях транков есть птичка, что-то типа - Intercompany route для того, чтобы не перетыркивало Caller ID.
Вернуться к началу
PingWin
Сообщения: 4
Зарегистрирован: 27 июл 2015, 06:56

Re: Grandstream ucm6100 + AsteriskNOW 11 через IAX

Сообщение PingWin »

На астерискнау стоит контекст from-internal
trunk.jpg
trunk.jpg (19.23 КБ) 7331 просмотр
а вот на грандстриме нигде не нашел возможность поменять контекст на транке...
Птичка тож стояла на астериск нау
птичка.jpg
птичка.jpg (4.95 КБ) 7331 просмотр
а вот на грандстрим опять же обделен настройками:
grandstream.jpg
grandstream.jpg (28.07 КБ) 7331 просмотр
Вернуться к началу
ded
Сообщения: 15630
Зарегистрирован: 26 авг 2010, 19:00

Re: Grandstream ucm6100 + AsteriskNOW 11 через IAX

Сообщение ded »

На астерискNOW контекст from-internal для входящих из вашего грандстрима.
а вот на грандстриме нигде не нашел возможность поменять контекст на транке...
Обращайтес в тех поддержку Grandstream?
Вернуться к началу
PingWin
Сообщения: 4
Зарегистрирован: 27 июл 2015, 06:56

Re: Grandstream ucm6100 + AsteriskNOW 11 через IAX

Сообщение PingWin »

ded писал(а):Обращайтес в тех поддержку Grandstream?
Пробовал, серийника моего грандстрима нет у них в базе, поэтому максимум что они мне посоветовали это использовать захват пакетов.
Пакеты снял, но толку я в них особого не увидел, callerid вродя передается:
https://yadi.sk/d/S-Ewq3Hfi8CXh
ded писал(а):На астерискNOW контекст from-internal для входящих из вашего грандстрима.
Тут уточню, когда на грандстриме создал iax транк в астерискNOW начали долбится два транка первый trunk_3 и второй trunk_3?trunk_3. В общем приютил я их так:
trunk.jpg
trunk.jpg (18.47 КБ) 7280 просмотров
Зарегистрировались и, собственно, звоночки отлично пошли в обе стороны, кроме текущей проблемы...
На обычных sip пользователях астерискNOW контехт тоже from-internal, без него они и не могут дозвонится до грандстрима.
Вернуться к началу
awsswa
Сообщения: 2390
Зарегистрирован: 09 июн 2012, 10:52
Откуда: Россия, Пермь skype: yarick_perm

Re: Grandstream ucm6100 + AsteriskNOW 11 через IAX

Сообщение awsswa »

Изображение


Внимательно смотрим на галочку intra-company и отдельный маршрут для другой АТС
платный суппорт по мере возможностей
Вернуться к началу
PingWin
Сообщения: 4
Зарегистрирован: 27 июл 2015, 06:56

Re: Grandstream ucm6100 + AsteriskNOW 11 через IAX

Сообщение PingWin »

PingWin писал(а):Внимательно смотрим на галочку intra-company и отдельный маршрут для другой АТС
Галка стоит, да и все другие настройки одинаковы, кроме того что у Вас по sip, а у меня iax
outtrunk.jpg
outtrunk.jpg (37.71 КБ) 7253 просмотра
Входящие маршрут у грандстрима:
intrunkgr.jpg
intrunkgr.jpg (44.32 КБ) 7253 просмотра
Вернуться к началу
Ответить

Вернуться в «Вопросы новичков»

© 2008 — 2025 Asterisk.ru
Digium, Asterisk and AsteriskNOW are registered trademarks of Digium, Inc.
Design and development by PostMet-Netzwerk GmbH