asterisk.ru

Русский форум Asterisk сообщества
https://forum.asterisk.ru/

Не работают исходящие через FXO

https://forum.asterisk.ru/viewtopic.php?t=25462

Страница 1 из 2

Не работают исходящие через FXO

Добавлено: 15 дек 2023, 13:34
rom@nыч
Подключил шлюз HT813 к астериск, но вот уже сутки бьюсь, не могу победить исходящие через него. Входящие не могу попробовать, т.к. на данный момент на городском номере стоит безусловная переадресация. В шлюзе уже всякие разные комбинации настроек пробовал. На данный момент сбросил и установил. В статистике шлюза указано, что зарегистрировано. Но при исходящем мне астериск сообщает, что "все линии заняты". все возможные мануалы, ничего не могу понять. Прошу помощи. Скрины настроек шлюза и астериска прикладываю.

Консоль астериск:
PRIME_BBCODE_SPOILER_SHOW PRIME_BBCODE_SPOILER:

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

  == Using SIP RTP Audio TOS bits 184
  == Using SIP RTP Audio CoS mark 5
    -- Executing [89500000000@from-internal:1] Macro("PJSIP/505-00000044", "user-callerid,LIMIT,EXTERNAL,") in new stack
    -- Executing [s@macro-user-callerid:1] Set("PJSIP/505-00000044", "TOUCH_MONITOR=1702635862.68") in new stack
    -- Executing [s@macro-user-callerid:2] Set("PJSIP/505-00000044", "CHANCONTEXT=") in new stack
    -- Executing [s@macro-user-callerid:3] Set("PJSIP/505-00000044", "CHANCONTEXT=") in new stack
    -- Executing [s@macro-user-callerid:4] Set("PJSIP/505-00000044", "CHANEXTENCONTEXT=505-00000044") in new stack
    -- Executing [s@macro-user-callerid:5] Set("PJSIP/505-00000044", "CHANEXTEN=505-00000044") in new stack
    -- Executing [s@macro-user-callerid:6] Set("PJSIP/505-00000044", "CALLERID(number)=505") in new stack
    -- Executing [s@macro-user-callerid:7] Set("PJSIP/505-00000044", "AMPUSER=505") in new stack
    -- Executing [s@macro-user-callerid:8] Set("PJSIP/505-00000044", "HOTDESCKCHAN=505-00000044") in new stack
    -- Executing [s@macro-user-callerid:9] Set("PJSIP/505-00000044", "HOTDESKEXTEN=505") in new stack
    -- Executing [s@macro-user-callerid:10] Set("PJSIP/505-00000044", "HOTDESKCALL=0") in new stack
    -- Executing [s@macro-user-callerid:11] ExecIf("PJSIP/505-00000044", "0?Set(HOTDESKCALL=1)") in new stack
    -- Executing [s@macro-user-callerid:12] ExecIf("PJSIP/505-00000044", "0?Set(CALLERID(name)=)") in new stack
    -- Executing [s@macro-user-callerid:13] GotoIf("PJSIP/505-00000044", "0?report") in new stack
    -- Executing [s@macro-user-callerid:14] ExecIf("PJSIP/505-00000044", "1?Set(REALCALLERIDNUM=505)") in new stack
    -- Executing [s@macro-user-callerid:15] Set("PJSIP/505-00000044", "AMPUSER=505") in new stack
    -- Executing [s@macro-user-callerid:16] GotoIf("PJSIP/505-00000044", "0?limit") in new stack
    -- Executing [s@macro-user-callerid:17] Set("PJSIP/505-00000044", "AMPUSERCIDNAME=Роман") in new stack
    -- Executing [s@macro-user-callerid:18] ExecIf("PJSIP/505-00000044", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
    -- Executing [s@macro-user-callerid:19] GotoIf("PJSIP/505-00000044", "0?report") in new stack
    -- Executing [s@macro-user-callerid:20] Set("PJSIP/505-00000044", "AMPUSERCID=505") in new stack
    -- Executing [s@macro-user-callerid:21] Set("PJSIP/505-00000044", "__DIAL_OPTIONS=HhTtr") in new stack
    -- Executing [s@macro-user-callerid:22] Set("PJSIP/505-00000044", "CALLERID(all)="Роман" <505>") in new stack
    -- Executing [s@macro-user-callerid:23] ExecIf("PJSIP/505-00000044", "0?Set(CUSDIAL=)") in new stack
    -- Executing [s@macro-user-callerid:24] ExecIf("PJSIP/505-00000044", "0?Set(CALLERID(all)="Роман" <505>)") in new stack
    -- Executing [s@macro-user-callerid:25] GotoIf("PJSIP/505-00000044", "0?limit") in new stack
    -- Executing [s@macro-user-callerid:26] ExecIf("PJSIP/505-00000044", "1?Set(GROUP(concurrency_limit)=505)") in new stack
    -- Executing [s@macro-user-callerid:27] NoOp("PJSIP/505-00000044", "Macro Depth is 1") in new stack
    -- Executing [s@macro-user-callerid:28] GotoIf("PJSIP/505-00000044", "1?report2:macroerror") in new stack
    -- Goto (macro-user-callerid,s,29)
    -- Executing [s@macro-user-callerid:29] GotoIf("PJSIP/505-00000044", "1?continue") in new stack
    -- Goto (macro-user-callerid,s,47)
    -- Executing [s@macro-user-callerid:47] Set("PJSIP/505-00000044", "CALLERID(number)=505") in new stack
    -- Executing [s@macro-user-callerid:48] Set("PJSIP/505-00000044", "CALLERID(name)=Роман") in new stack
    -- Executing [s@macro-user-callerid:49] GotoIf("PJSIP/505-00000044", "0?cnum") in new stack
    -- Executing [s@macro-user-callerid:50] Set("PJSIP/505-00000044", "CDR(cnam)=Роман") in new stack
    -- Executing [s@macro-user-callerid:51] Set("PJSIP/505-00000044", "CDR(cnum)=505") in new stack
    -- Executing [s@macro-user-callerid:52] Set("PJSIP/505-00000044", "CHANNEL(language)=ru") in new stack
    -- Executing [89500000000@from-internal:2] Gosub("PJSIP/505-00000044", "sub-record-check,s,1(out,89500000000,dontcare)") in new stack
    -- Executing [s@sub-record-check:1] GotoIf("PJSIP/505-00000044", "0?initialized") in new stack
    -- Executing [s@sub-record-check:2] Set("PJSIP/505-00000044", "__REC_STATUS=INITIALIZED") in new stack
    -- Executing [s@sub-record-check:3] Set("PJSIP/505-00000044", "NOW=1702635862") in new stack
    -- Executing [s@sub-record-check:4] Set("PJSIP/505-00000044", "__DAY=15") in new stack
    -- Executing [s@sub-record-check:5] Set("PJSIP/505-00000044", "__MONTH=12") in new stack
    -- Executing [s@sub-record-check:6] Set("PJSIP/505-00000044", "__YEAR=2023") in new stack
    -- Executing [s@sub-record-check:7] Set("PJSIP/505-00000044", "__TIMESTR=20231215-182422") in new stack
    -- Executing [s@sub-record-check:8] Set("PJSIP/505-00000044", "__FROMEXTEN=505") in new stack
    -- Executing [s@sub-record-check:9] Set("PJSIP/505-00000044", "__MON_FMT=wav") in new stack
    -- Executing [s@sub-record-check:10] NoOp("PJSIP/505-00000044", "Recordings initialized") in new stack
    -- Executing [s@sub-record-check:11] ExecIf("PJSIP/505-00000044", "0?Set(ARG3=dontcare)") in new stack
    -- Executing [s@sub-record-check:12] Set("PJSIP/505-00000044", "REC_POLICY_MODE_SAVE=") in new stack
    -- Executing [s@sub-record-check:13] ExecIf("PJSIP/505-00000044", "0?Set(REC_STATUS=NO)") in new stack
    -- Executing [s@sub-record-check:14] GotoIf("PJSIP/505-00000044", "3?checkaction") in new stack
    -- Goto (sub-record-check,s,17)
    -- Executing [s@sub-record-check:17] GotoIf("PJSIP/505-00000044", "1?sub-record-check,out,1") in new stack
    -- Goto (sub-record-check,out,1)
    -- Executing [out@sub-record-check:1] NoOp("PJSIP/505-00000044", "Outbound Recording Check from 505 to 89500000000") in new stack
    -- Executing [out@sub-record-check:2] Set("PJSIP/505-00000044", "RECMODE=dontcare") in new stack
    -- Executing [out@sub-record-check:3] ExecIf("PJSIP/505-00000044", "1?Goto(routewins)") in new stack
    -- Goto (sub-record-check,out,7)
    -- Executing [out@sub-record-check:7] Gosub("PJSIP/505-00000044", "recordcheck,1(dontcare,out,89500000000)") in new stack
    -- Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/505-00000044", "Starting recording check against dontcare") in new stack
    -- Executing [recordcheck@sub-record-check:2] Goto("PJSIP/505-00000044", "dontcare") in new stack
    -- Goto (sub-record-check,recordcheck,3)
    -- Executing [recordcheck@sub-record-check:3] Return("PJSIP/505-00000044", "") in new stack
    -- Executing [out@sub-record-check:8] Return("PJSIP/505-00000044", "") in new stack
    -- Executing [89500000000@from-internal:3] Set("PJSIP/505-00000044", "_ROUTEID=3") in new stack
    -- Executing [89500000000@from-internal:4] Set("PJSIP/505-00000044", "_ROUTENAME=73956600000") in new stack
    -- Executing [89500000000@from-internal:5] Set("PJSIP/505-00000044", "MOHCLASS=default") in new stack
    -- Executing [89500000000@from-internal:6] ExecIf("PJSIP/505-00000044", "1?Set(TRUNKCIDOVERRIDE=73956600000)") in new stack
    -- Executing [89500000000@from-internal:7] Set("PJSIP/505-00000044", "_CALLERIDNAMEINTERNAL=Роман") in new stack
    -- Executing [89500000000@from-internal:8] Set("PJSIP/505-00000044", "_CALLERIDNUMINTERNAL=505") in new stack
    -- Executing [89500000000@from-internal:9] Set("PJSIP/505-00000044", "_EMAILNOTIFICATION=FALSE") in new stack
    -- Executing [89500000000@from-internal:10] Set("PJSIP/505-00000044", "_NODEST=") in new stack
    -- Executing [89500000000@from-internal:11] Macro("PJSIP/505-00000044", "dialout-trunk,3,+79500000000,,off") in new stack
    -- Executing [s@macro-dialout-trunk:1] Set("PJSIP/505-00000044", "DIAL_TRUNK=3") in new stack
    -- Executing [s@macro-dialout-trunk:2] ExecIf("PJSIP/505-00000044", "0?Set(DIAL_OPTIONS=Hhtr)") in new stack
    -- Executing [s@macro-dialout-trunk:3] GosubIf("PJSIP/505-00000044", "0?sub-pincheck,s,1()") in new stack
    -- Executing [s@macro-dialout-trunk:4] ExecIf("PJSIP/505-00000044", "0?Set(CALLERID(num)=505)") in new stack
    -- Executing [s@macro-dialout-trunk:5] GotoIf("PJSIP/505-00000044", "0?disabletrunk,1") in new stack
    -- Executing [s@macro-dialout-trunk:6] Set("PJSIP/505-00000044", "DIAL_NUMBER=+79500000000") in new stack
    -- Executing [s@macro-dialout-trunk:7] Set("PJSIP/505-00000044", "DIAL_TRUNK_OPTIONS=HhTtr") in new stack
    -- Executing [s@macro-dialout-trunk:8] Set("PJSIP/505-00000044", "OUTBOUND_GROUP=OUT_3") in new stack
    -- Executing [s@macro-dialout-trunk:9] Set("PJSIP/505-00000044", "DIAL_TRUNK_OPTIONS=T") in new stack
    -- Executing [s@macro-dialout-trunk:10] GotoIf("PJSIP/505-00000044", "0?nomax") in new stack
    -- Executing [s@macro-dialout-trunk:11] GotoIf("PJSIP/505-00000044", "0?chanfull") in new stack
    -- Executing [s@macro-dialout-trunk:12] GotoIf("PJSIP/505-00000044", "0?skipoutcid") in new stack
    -- Executing [s@macro-dialout-trunk:13] Macro("PJSIP/505-00000044", "outbound-callerid,3") in new stack
    -- Executing [s@macro-outbound-callerid:1] NoOp("PJSIP/505-00000044", "505") in new stack
    -- Executing [s@macro-outbound-callerid:2] NoOp("PJSIP/505-00000044", "") in new stack
    -- Executing [s@macro-outbound-callerid:3] NoOp("PJSIP/505-00000044", "off") in new stack
    -- Executing [s@macro-outbound-callerid:4] ExecIf("PJSIP/505-00000044", "0?Set(CALLERID(name-pres)=)") in new stack
    -- Executing [s@macro-outbound-callerid:5] ExecIf("PJSIP/505-00000044", "0?Set(CALLERID(num-pres)=)") in new stack
    -- Executing [s@macro-outbound-callerid:6] Set("PJSIP/505-00000044", "HOTDESCKCHAN=505-00000044") in new stack
    -- Executing [s@macro-outbound-callerid:7] Set("PJSIP/505-00000044", "HOTDESKEXTEN=505") in new stack
    -- Executing [s@macro-outbound-callerid:8] Set("PJSIP/505-00000044", "HOTDESKCALL=0") in new stack
    -- Executing [s@macro-outbound-callerid:9] ExecIf("PJSIP/505-00000044", "0?Set(HOTDESKCALL=1)") in new stack
    -- Executing [s@macro-outbound-callerid:10] ExecIf("PJSIP/505-00000044", "0?Set(CALLERID(name)=)") in new stack
    -- Executing [s@macro-outbound-callerid:11] Set("PJSIP/505-00000044", "ALLOWTHISROUTE=NO") in new stack
    -- Executing [s@macro-outbound-callerid:12] ExecIf("PJSIP/505-00000044", "0?Set(ALLOWTHISROUTE=YES)") in new stack
    -- Executing [s@macro-outbound-callerid:13] ExecIf("PJSIP/505-00000044", "0?Hangup()") in new stack
    -- Executing [s@macro-outbound-callerid:14] ExecIf("PJSIP/505-00000044", "0?Set(REALCALLERIDNUM=505)") in new stack
    -- Executing [s@macro-outbound-callerid:15] ExecIf("PJSIP/505-00000044", "0?Set(AMPUSER=505)") in new stack
    -- Executing [s@macro-outbound-callerid:16] GotoIf("PJSIP/505-00000044", "1?normcid") in new stack
    -- Goto (macro-outbound-callerid,s,20)
    -- Executing [s@macro-outbound-callerid:20] Set("PJSIP/505-00000044", "USEROUTCID=") in new stack
    -- Executing [s@macro-outbound-callerid:21] Set("PJSIP/505-00000044", "EMERGENCYCID=") in new stack
    -- Executing [s@macro-outbound-callerid:22] ExecIf("PJSIP/505-00000044", "0?Set(EMERGENCYCID=)") in new stack
    -- Executing [s@macro-outbound-callerid:23] Set("PJSIP/505-00000044", "TRUNKOUTCID=73956600000") in new stack
    -- Executing [s@macro-outbound-callerid:24] GotoIf("PJSIP/505-00000044", "1?trunkcid") in new stack
    -- Goto (macro-outbound-callerid,s,30)
    -- Executing [s@macro-outbound-callerid:30] ExecIf("PJSIP/505-00000044", "1?Set(CALLERID(all)=73956600000)") in new stack
    -- Executing [s@macro-outbound-callerid:31] ExecIf("PJSIP/505-00000044", "0?Set(CALLERID(all)=)") in new stack
    -- Executing [s@macro-outbound-callerid:32] ExecIf("PJSIP/505-00000044", "1?Set(CALLERID(all)=73956600000)") in new stack
    -- Executing [s@macro-outbound-callerid:33] ExecIf("PJSIP/505-00000044", "0?Set(CALLERID(all)=505)") in new stack
    -- Executing [s@macro-outbound-callerid:34] ExecIf("PJSIP/505-00000044", "0?Set(CALLERID(all)=505)") in new stack
    -- Executing [s@macro-outbound-callerid:35] Set("PJSIP/505-00000044", "TIOHIDE=no") in new stack
    -- Executing [s@macro-outbound-callerid:36] ExecIf("PJSIP/505-00000044", "0?Set(CALLERID(name-pres)=prohib_passed_screen)") in new stack
    -- Executing [s@macro-outbound-callerid:37] ExecIf("PJSIP/505-00000044", "0?Set(CALLERID(num-pres)=prohib_passed_screen)") in new stack
    -- Executing [s@macro-outbound-callerid:38] ExecIf("PJSIP/505-00000044", "0?Set(CALLERID(name-pres)=prohib_passed_screen)") in new stack
    -- Executing [s@macro-outbound-callerid:39] ExecIf("PJSIP/505-00000044", "0?Set(CALLERID(num-pres)=prohib_passed_screen)") in new stack
    -- Executing [s@macro-outbound-callerid:40] Set("PJSIP/505-00000044", "CDR(outbound_cnum)=73956600000") in new stack
    -- Executing [s@macro-outbound-callerid:41] Set("PJSIP/505-00000044", "CDR(outbound_cnam)=") in new stack
    -- Executing [s@macro-dialout-trunk:14] GosubIf("PJSIP/505-00000044", "0?sub-flp-3,s,1()") in new stack
    -- Executing [s@macro-dialout-trunk:15] Set("PJSIP/505-00000044", "OUTNUM=+79500000000") in new stack
    -- Executing [s@macro-dialout-trunk:16] Set("PJSIP/505-00000044", "custom=PJSIP") in new stack
    -- Executing [s@macro-dialout-trunk:17] ExecIf("PJSIP/505-00000044", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)") in new stack
    -- Executing [s@macro-dialout-trunk:18] ExecIf("PJSIP/505-00000044", "0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))") in new stack
    -- Executing [s@macro-dialout-trunk:19] Macro("PJSIP/505-00000044", "dialout-trunk-predial-hook,") in new stack
    -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("PJSIP/505-00000044", "") in new stack
    -- Executing [s@macro-dialout-trunk:20] GotoIf("PJSIP/505-00000044", "0?bypass,1") in new stack
    -- Executing [s@macro-dialout-trunk:21] ExecIf("PJSIP/505-00000044", "1?Set(CONNECTEDLINE(num,i)=+79500000000)") in new stack
    -- Executing [s@macro-dialout-trunk:22] ExecIf("PJSIP/505-00000044", "1?Set(CONNECTEDLINE(name,i)=CID:73956600000)") in new stack
    -- Executing [s@macro-dialout-trunk:23] ExecIf("PJSIP/505-00000044", "0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)73956600000)") in new stack
    -- Executing [s@macro-dialout-trunk:24] GotoIf("PJSIP/505-00000044", "0?customtrunk") in new stack
    -- Executing [s@macro-dialout-trunk:25] ExecIf("PJSIP/505-00000044", "0?Set(DIAL_TRUNK_OPTIONS=)") in new stack
    -- Executing [s@macro-dialout-trunk:26] Set("PJSIP/505-00000044", "HASH(__SIPHEADERS,Alert-Info)=unset") in new stack
    -- Executing [s@macro-dialout-trunk:27] Dial("PJSIP/505-00000044", "PJSIP/+79500000000@73956600000,300,Tb(func-apply-sipheaders^s^1,(3))U(sub-send-obroute-email^+79500000000^89500000000^3^1702635862^^73956600000)") in new stack
    -- PJSIP/73956600000-00000045 Internal Gosub(func-apply-sipheaders,s,1(3)) start
    -- Executing [s@func-apply-sipheaders:1] NoOp("PJSIP/73956600000-00000045", "Applying SIP Headers to channel PJSIP/73956600000-00000045") in new stack
    -- Executing [s@func-apply-sipheaders:2] Set("PJSIP/73956600000-00000045", "TECH=PJSIP") in new stack
    -- Executing [s@func-apply-sipheaders:3] Set("PJSIP/73956600000-00000045", "SIPHEADERKEYS=Alert-Info") in new stack
    -- Executing [s@func-apply-sipheaders:4] While("PJSIP/73956600000-00000045", "1") in new stack
    -- Executing [s@func-apply-sipheaders:5] Set("PJSIP/73956600000-00000045", "sipheader=unset") in new stack
    -- Executing [s@func-apply-sipheaders:6] ExecIf("PJSIP/73956600000-00000045", "1?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack
[2023-12-15 18:24:22] ERROR[520889]: res_pjsip_header_funcs.c:722 remove_header: No headers had been previously added to this session.
    -- Executing [s@func-apply-sipheaders:7] ExecIf("PJSIP/73956600000-00000045", "0?Set(sipheader=<http://127.0.0.1>;info=unset)") in new stack
    -- Executing [s@func-apply-sipheaders:8] ExecIf("PJSIP/73956600000-00000045", "0?Set(sipheader=<http://127.0.0.1>unset)") in new stack
    -- Executing [s@func-apply-sipheaders:9] ExecIf("PJSIP/73956600000-00000045", "0?Set(PJSIP_HEADER(add,Alert-Info)=unset)") in new stack
    -- Executing [s@func-apply-sipheaders:10] EndWhile("PJSIP/73956600000-00000045", "") in new stack
    -- Executing [s@func-apply-sipheaders:4] While("PJSIP/73956600000-00000045", "0") in new stack
    -- Executing [s@func-apply-sipheaders:11] Return("PJSIP/73956600000-00000045", "") in new stack
  == Spawn extension (from-pstn, 89500000000, 1) exited non-zero on 'PJSIP/73956600000-00000045'
    -- PJSIP/73956600000-00000045 Internal Gosub(func-apply-sipheaders,s,1(3)) complete GOSUB_RETVAL=
    -- Called PJSIP/+79500000000@73956600000
  == Everyone is busy/congested at this time (1:0/0/1)
    -- Executing [s@macro-dialout-trunk:28] NoOp("PJSIP/505-00000044", "Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 21") in new stack
    -- Executing [s@macro-dialout-trunk:29] GotoIf("PJSIP/505-00000044", "0?continue,1:s-CHANUNAVAIL,1") in new stack
    -- Goto (macro-dialout-trunk,s-CHANUNAVAIL,1)
    -- Executing [s-CHANUNAVAIL@macro-dialout-trunk:1] Set("PJSIP/505-00000044", "RC=21") in new stack
    -- Executing [s-CHANUNAVAIL@macro-dialout-trunk:2] Goto("PJSIP/505-00000044", "21,1") in new stack
    -- Goto (macro-dialout-trunk,21,1)
    -- Executing [21@macro-dialout-trunk:1] Goto("PJSIP/505-00000044", "continue,1") in new stack
    -- Goto (macro-dialout-trunk,continue,1)
    -- Executing [continue@macro-dialout-trunk:1] NoOp("PJSIP/505-00000044", "TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 21 - failing through to other trunks") in new stack
    -- Executing [continue@macro-dialout-trunk:2] ExecIf("PJSIP/505-00000044", "1?Set(CALLERID(number)=505)") in new stack
    -- Executing [89500000000@from-internal:12] Macro("PJSIP/505-00000044", "outisbusy,") in new stack
    -- Executing [s@macro-outisbusy:1] Playback("PJSIP/505-00000044", "all-circuits-busy-now&please-try-call-later") in new stack
    -- <PJSIP/505-00000044> Playing 'all-circuits-busy-now.ulaw' (language 'ru')
  == Spawn extension (macro-outisbusy, s, 1) exited non-zero on 'PJSIP/505-00000044' in macro 'outisbusy'
  == Spawn extension (from-internal, 89500000000, 12) exited non-zero on 'PJSIP/505-00000044'
    -- Executing [h@from-internal:1] Macro("PJSIP/505-00000044", "hangupcall") in new stack
    -- Executing [s@macro-hangupcall:1] GotoIf("PJSIP/505-00000044", "1?theend") in new stack
    -- Goto (macro-hangupcall,s,3)
    -- Executing [s@macro-hangupcall:3] ExecIf("PJSIP/505-00000044", "0?Set(CDR(recordingfile)=)") in new stack
    -- Executing [s@macro-hangupcall:4] Hangup("PJSIP/505-00000044", "") in new stack
  == Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'PJSIP/505-00000044' in macro 'hangupcall'
  == Spawn extension (from-internal, h, 1) exited non-zero on 'PJSIP/505-00000044'

Re: Не работают исходящие через FXO

Добавлено: 15 дек 2023, 13:36
rom@nыч
Скрины настроек астериск
2023-12-15_17-28-19.png
2023-12-15_17-27-14.png
2023-12-15_17-23-29.png

Re: Не работают исходящие через FXO

Добавлено: 15 дек 2023, 15:30
ded
https://forums5.grandstream.com/t/aster ... -fxo/48710

Re: Не работают исходящие через FXO

Добавлено: 16 дек 2023, 17:16
rom@nыч
Сделал все по инструкции из ссылки, но исходящие так и не работают.
Может кто-нибудь сможет помочь мне в этом.
Это лог из шлюза:
PRIME_BBCODE_SPOILER_SHOW PRIME_BBCODE_SPOILER:

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

<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727265.961345 SIPStack(1)::cb_nist_kill_transaction: Kill NIST transaction 3034
	192.168.254.3	16/12 18:47:45.510	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.702802 SIPStack(1)::isMessageFromAllowedProxy, fromHost = 192.168.33.12,fromPort= 5060
	192.168.254.3	16/12 18:47:56.267	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727276.706225 SIPStack(1)::isMessageFromAllowedProxy, acct= 0, server= NULL:5060, failover= NULL:5060, obp= NULL:5060, backup obp= NULL:5060
	192.168.254.3	16/12 18:47:56.269	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727276.707882 SIPStack(1)::isMessageFromAllowedProxy, acct= 1, server= 192.168.33.12:5060, failover= NULL:5060, obp= NULL:5060, backup obp= NULL:5060
	192.168.254.3	16/12 18:47:56.270	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727276.712433 SIPStack(1)::cb_rcvreq: Received SIP request INVITE
	192.168.254.3	16/12 18:47:56.271	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.718164 SIPDialog(67)::SIPDialog, create a SIPDialog, id = 67
	192.168.254.3	16/12 18:47:56.271	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.721192 SIPDialog, set SDP media to remote 192.168.33.12:17792, state=1 sdp=0 new sdp=0x1b8d50
	192.168.254.3	16/12 18:47:56.272	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.722465 SIPDialog, set SDP media, sdp set to 0x1b8d50
	192.168.254.3	16/12 18:47:56.272	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.726676 EventManager::run: Dispatching event 57 (SIG_REMOTE_CONNECT) on port -1:-1
	192.168.254.3	16/12 18:47:56.283	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.739616 Call::incCallCount, callCountIn =67
	192.168.254.3	16/12 18:47:56.288	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.742537 SIPStack(1)::cb_snd_message, host=192.168.33.12, original port=5060
	192.168.254.3	16/12 18:47:56.291	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.747019 SIPStack(1)::snd_message: Present IP Addr:192.168.33.12
	192.168.254.3	16/12 18:47:56.294	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727276.758341 SIPStack(1)::run: Active call dialogs: 1
	192.168.254.3	16/12 18:47:56.306	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.761263 Call::incCallCount, callCountTotal =67
	192.168.254.3	16/12 18:47:56.309	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.762455 SigCtrl::processSigRemoteConnect, TR-104 call_cnt_in_rcv fxs:1
	192.168.254.3	16/12 18:47:56.310	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727276.767794 SIPStack(1)::run: Active call dialogs: 1
	192.168.254.3	16/12 18:47:56.316	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727276.778181 SigCtrl::processSigRemoteConnect, FXO Port 1 , channel status = CALL_IDLE/CALL_IDLE, special feature=100
	192.168.254.3	16/12 18:47:56.331	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727276.786193 SigCtrl::SigRemoteConnect, FXO outgoing Call initiated, at port 1
	192.168.254.3	16/12 18:47:56.337	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.787693 EventManager::run: Dispatching event 40 (FXO_OUTGOING_CALL_INITIATED) on port 1:0
	192.168.254.3	16/12 18:47:56.340	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.788764 ATACtrl::processFxoOutgoingCallInitiated on port 1:0, status = CALL_IDLE/CALL_IDLE, sigReferred:0
	192.168.254.3	16/12 18:47:56.341	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.792471 Nuvoton::getFxoLineStatus, Ch(1) Hook status is 2
	192.168.254.3	16/12 18:47:56.342	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.793436 Nuvoton::getFxoLineStatus, Ch(1) Batt status is 1
	192.168.254.3	16/12 18:47:56.351	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.797289 Nuvoton::getFxoLineStatus, Ch(1) Ring status is 0
	192.168.254.3	16/12 18:47:56.351	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.798287 Nuvoton::getFxoLineStatus, Ch(1) Pol  status is -1
	192.168.254.3	16/12 18:47:56.353	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.799423 Nuvoton::getFxoLineStatus, Ch(1) Apoh status is 0
	192.168.254.3	16/12 18:47:56.354	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.800420 Nuvoton::getFxoLineStatus, Ch(1) Line Voltage is -47 V, Line current is 0 mA
	192.168.254.3	16/12 18:47:56.354	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.808005 ATACtrl::processFxoOutgoingCallInitiated, 1 Stage Dialing, To: 33508
	192.168.254.3	16/12 18:47:56.362	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.809194 DialPlanSeg::match: match [0-9]+[#]*$
	192.168.254.3	16/12 18:47:56.362	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.810213 ATACtrl::processFxoOutgoingCallInitiated, Dial Plan Match = 4, r=33508
	192.168.254.3	16/12 18:47:56.363	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.816653 Nuvoton::fxoHookSet, Set Hook to  OffHook on port 1:0
	192.168.254.3	16/12 18:47:56.370	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.818249 ATACtrl::processVoip2PstnCall 33508, FXO Port 1:0 Off-hook
	192.168.254.3	16/12 18:47:56.372	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.841212 GSDSP::startCPTDetection, Start CPT Detection (tone 31) on port 1
	192.168.254.3	16/12 18:47:56.390	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.842019 ATACtrl::Start CPT Detection (tone 31) on port 1
	192.168.254.3	16/12 18:47:56.391	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727276.921771 LIBGSDSP: CSS: 2339228891, In API callback event = 138, inst = 2053
	192.168.254.3	16/12 18:47:56.469	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.143114 ATACtrl::fxoDigitDialing, digit play time = 100, inter-digit = 100
	192.168.254.3	16/12 18:47:56.695	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.143386 Nuvoton::fxoStartDial, dialing digits = 33508, num of digits=5
	192.168.254.3	16/12 18:47:56.696	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.143901 LIBGSDSP: Local tone has been stoped	192.168.254.3	16/12 18:47:56.697	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.162677 LIBGSDSP: CSS: 2339468906, In API callback event = 178, inst = 2074
	192.168.254.3	16/12 18:47:56.718	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.163050 LIBGSDSP: CSS: 2339469028, In API callback event = 178, inst = 2075
	192.168.254.3	16/12 18:47:56.719	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.312650 LIBGSDSP: CSS: 2339618870, In API callback event = 140, inst = 2053
	192.168.254.3	16/12 18:47:56.871	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.313019 LIBGSDSP: CSS: 2339619008, In API callback event = 137, inst = 2053
	192.168.254.3	16/12 18:47:56.876	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.563859 ATACtrl::fxoDigitDialing, save outgoing digits 33508 to cidInfo.callerNumber
	192.168.254.3	16/12 18:47:57.112	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.568758 LIBGSDSP: CSS: 2339868932, In API callback event = 179, inst = 2074
	192.168.254.3	16/12 18:47:57.121	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.569139 LIBGSDSP: CSS: 2339869046, In API callback event = 179, inst = 2075
	192.168.254.3	16/12 18:47:57.122	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.571946 EventPvalueChanged( :call_cnt_in )
	192.168.254.3	16/12 18:47:57.123	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.572274 EventPvalueChanged( :call_cnt_total )
	192.168.254.3	16/12 18:47:57.124	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.572467 EventPvalueChanged( :call_cnt_in_rcv_fxs1 )
	192.168.254.3	16/12 18:47:57.131	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.572633 EventPvalueChanged( :4902 )
	192.168.254.3	16/12 18:47:57.133	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.572835 EventManager::run: Dispatching event 80 (PVALUE_CHANGED) on port -1:-1
	192.168.254.3	16/12 18:47:57.135	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.572975 SigCtrl::processPvalueChange ( call_cnt_in )
	192.168.254.3	16/12 18:47:57.137	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.573158 EventManager::run: Dispatching event 80 (PVALUE_CHANGED) on port -1:-1
	192.168.254.3	16/12 18:47:57.141	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.573287 SigCtrl::processPvalueChange ( call_cnt_total )
	192.168.254.3	16/12 18:47:57.147	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.573447 EventManager::run: Dispatching event 80 (PVALUE_CHANGED) on port -1:-1
	192.168.254.3	16/12 18:47:57.152	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.573574 SigCtrl::processPvalueChange ( call_cnt_in_rcv_fxs1 )
	192.168.254.3	16/12 18:47:57.155	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.579166 EventManager::run: Dispatching event 80 (PVALUE_CHANGED) on port -1:-1
	192.168.254.3	16/12 18:47:57.157	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727277.579353 SigCtrl::processPvalueChange ( 4902 )
	192.168.254.3	16/12 18:47:57.160	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727278.377610 LIBGSDSP: CSS: 2340684879, In API callback event = 177, inst = 1
	192.168.254.3	16/12 18:47:57.925	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727278.380417 GSDSP::event_handler_chan, EVENT_DTMF_DIALING_DONE on port 1
	192.168.254.3	16/12 18:47:57.931	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727280.223122 GSDSP::event_handler_chan, EVENT_CPD_CONT_TONE_DETECTED on port 1
	192.168.254.3	16/12 18:47:59.773	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.581612 SigCtrl::Send 180 Ringing on port 1:0, status CALL_DIALING
	192.168.254.3	16/12 18:48:02.131	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.585375 SIPStack(1)::cb_snd_message, host=192.168.33.12, original port=5060
	192.168.254.3	16/12 18:48:02.138	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.587319 SIPStack(1)::snd_message: Present IP Addr:192.168.33.12
	192.168.254.3	16/12 18:48:02.140	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727282.592708 SIPStack(1)::run: Active call dialogs: 1
	192.168.254.3	16/12 18:48:02.142	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.602885 EventManager::registerEventListener: listener Call
	192.168.254.3	16/12 18:48:02.158	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.604572 Call(55)::init, DialPlan callFeatureFlag = 0x0
	192.168.254.3	16/12 18:48:02.160	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727282.607233 Call(55)::Call, Creating Call object 55 at port 1:0 with digits 33508
	192.168.254.3	16/12 18:48:02.162	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.608605 EventPvalueChanged( :cur_call_cnt )
	192.168.254.3	16/12 18:48:02.164	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.609679 EventManager::run: Dispatching event 80 (PVALUE_CHANGED) on port -1:-1
	192.168.254.3	16/12 18:48:02.168	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.610656 SigCtrl::processPvalueChange ( cur_call_cnt )
	192.168.254.3	16/12 18:48:02.170	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.622943 Call(55)::run, TR-104 call_cnt_in_ans fxs:1
	192.168.254.3	16/12 18:48:02.287	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.638122 RTP::RTP, construct 0x1b4698
	192.168.254.3	16/12 18:48:02.291	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.639383 RTP::openSocket, Bound to RTP port 5012, socket 26
	192.168.254.3	16/12 18:48:02.294	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.640601 RTP::openSocket, Bound to RTCP port 5013, socket 27
	192.168.254.3	16/12 18:48:02.296	
<11> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.ERR    1702727282.648317 RTP::openSocket: Layer 3 DSCP for RTP set to 46
	192.168.254.3	16/12 18:48:02.298	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.649884 ATACtrl::acceptCall on port 1:0, skipSig 0
	192.168.254.3	16/12 18:48:02.300	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727282.658587 SigCtrl::acceptCall, SRTP enabled on port 1 : 0
	192.168.254.3	16/12 18:48:02.302	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.659959 SigCtrl::acceptCall, holdFlag[1][0] = 0
	192.168.254.3	16/12 18:48:02.305	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.661301 SigCtrl::acceptCall, NEW holdFlag[1][0] = 0
	192.168.254.3	16/12 18:48:02.306	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.662990 SigCtrl::acceptCall, negotiated 2 codecs, top: PCMU, fLen 10, pLen 20, ptime 20
	192.168.254.3	16/12 18:48:02.310	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.666224 SigCtrl::acceptCall, Peer has no RFC2833 in SDP, has INFO 0, port 1, ch 0
	192.168.254.3	16/12 18:48:02.315	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.667759 SigCtrl::acceptCall, DTMF method negotiated: IN_AUDIO
	192.168.254.3	16/12 18:48:02.320	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.669528 SigCtrl::uasProcessSessionTimer, REFRESH REMOTE on port 1:0, sessionExpire=1800
	192.168.254.3	16/12 18:48:02.323	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.674339 SIPStack(1)::cb_snd_message, host=192.168.33.12, original port=5060
	192.168.254.3	16/12 18:48:02.326	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.676981 SIPStack(1)::snd_message: Present IP Addr:192.168.33.12
	192.168.254.3	16/12 18:48:02.327	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.682674 SIPStack(1)::cb_ist_kill_transaction: Kill IST transaction 3035
	192.168.254.3	16/12 18:48:02.329	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727282.687834 SIPStack(1)::run: Active call dialogs: 1
	192.168.254.3	16/12 18:48:02.332	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.691995 SIPStack(1)::isMessageFromAllowedProxy, fromHost = 192.168.33.12,fromPort= 5060
	192.168.254.3	16/12 18:48:02.333	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727282.693041 SIPStack(1)::isMessageFromAllowedProxy, acct= 0, server= NULL:5060, failover= NULL:5060, obp= NULL:5060, backup obp= NULL:5060
	192.168.254.3	16/12 18:48:02.335	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727282.697108 SIPStack(1)::isMessageFromAllowedProxy, acct= 1, server= 192.168.33.12:5060, failover= NULL:5060, obp= NULL:5060, backup obp= NULL:5060
	192.168.254.3	16/12 18:48:02.337	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727282.698855 RTP::setSDP on port 1:0, current sdp: 0, new sdp: 0x1b8d50
	192.168.254.3	16/12 18:48:02.339	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.699298 ATACtrl::processCallStarted on port 1:0, status = CALL_DIALED/CALL_IDLE, isCaller 0 canConf:0
	192.168.254.3	16/12 18:48:02.340	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727282.707658 SIPStack(1)::run: Active call dialogs: 1
	192.168.254.3	16/12 18:48:02.342	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.709036 EventManager::run: Dispatching event 19 (CALL_STARTED) on port 1:0
	192.168.254.3	16/12 18:48:02.343	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.709411 Call(55)::processEvent, CALL_STARTED, port 1:0, evtPort 1:0
	192.168.254.3	16/12 18:48:02.345	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.709634 Call(55)::processEvent, TR-104 call_time_total start sysinfo.uptime: 148375 fxs:1
	192.168.254.3	16/12 18:48:02.346	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.710051 EventPvalueChanged( :pthread_1438 )
	192.168.254.3	16/12 18:48:02.348	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.710284 EventPvalueChanged( :call_cnt_in_ans_fxs1 )
	192.168.254.3	16/12 18:48:02.349	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.710497 EventManager::run: Dispatching event 80 (PVALUE_CHANGED) on port -1:-1
	192.168.254.3	16/12 18:48:02.351	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.710640 SigCtrl::processPvalueChange ( pthread_1438 )
	192.168.254.3	16/12 18:48:02.353	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.713597 EventManager::run: Dispatching event 80 (PVALUE_CHANGED) on port -1:-1
	192.168.254.3	16/12 18:48:02.354	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.715662 SigCtrl::processPvalueChange ( call_cnt_in_ans_fxs1 )
	192.168.254.3	16/12 18:48:02.357	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.717363 Call(55)::run, TR-104 call_cnt_in_conn fxs:1
	192.168.254.3	16/12 18:48:02.361	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727282.730035 Call(55)::processMedia, Call started on port 1:0:5012,status=CALL_COMMUNICATION,canSend=1,canRecv=1,disable2833=1,dtmf:IN_AUDIO,disableLEC:0
	192.168.254.3	16/12 18:48:02.365	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.731441 ATACtrl::stopRTP on 1:0, status = CALL_COMMUNICATION, force: 0, specialFeature = 100
	192.168.254.3	16/12 18:48:02.368	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727282.733103 GSDSP::stop RTP on port 1:0
	192.168.254.3	16/12 18:48:02.370	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.737148 LIBGSDSP: dua_disconnect_fxo ( 1 )	192.168.254.3	16/12 18:48:02.372	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.738290 LIBGSDSP: dua_disconnect_fxo done	192.168.254.3	16/12 18:48:02.374	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727282.739303 GSDSP::RTP stopped on port 1:0
	192.168.254.3	16/12 18:48:02.375	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727282.740462 RTP::start, RTP start on port 1:0, remote target [192.168.33.12]:17792, local rtp port:5012
	192.168.254.3	16/12 18:48:02.377	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727282.741893 RTP::start on port 1:0, SRTP status NO_SRTP, Call SRTP status NO_SRTP, Call key NULL
	192.168.254.3	16/12 18:48:02.378	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727282.743375 RTP::start: no SRTP
	192.168.254.3	16/12 18:48:02.380	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.747141 ATACtrl::startRTP on 1:0, status = CALL_COMMUNICATION/CALL_IDLE
	192.168.254.3	16/12 18:48:02.381	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727282.769033 GSDSP::startRTP at port 1:0, RTP encoder 0@20, VAD 0, disableLEC:0, ptevt:0, fax_detected:0, isNat:0, rfc_relay:0
	192.168.254.3	16/12 18:48:02.383	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727282.770219 GSDSP::startRTP, JB min =120, JB max =1000, silence =0
	192.168.254.3	16/12 18:48:02.384	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.771637 GSDSP::startRTP, SRTP Disabled on port 1:0
	192.168.254.3	16/12 18:48:02.387	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.772648 GSDSP::startRTP set up RTCP on port 1:0
	192.168.254.3	16/12 18:48:02.391	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.777282 LIBGSDSP: dua_alloc_voip	192.168.254.3	16/12 18:48:02.396	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.788736 LIBGSDSP: dua_alloc_voip allocates 6	192.168.254.3	16/12 18:48:02.400	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.798219 LIBGSDSP: CSS: 2345104122, p_Do_FXO: DTMF Mute : 0x1
	192.168.254.3	16/12 18:48:02.402	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.802319 LIBGSDSP: ch 6 srtp DISABLED	192.168.254.3	16/12 18:48:02.405	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727282.803336 GSDSP::startRTP, Start RTP on port 1:0, socket 26, sndrcv 3, remote [192.168.33.12]:17792
	192.168.254.3	16/12 18:48:02.407	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.807857 LIBGSDSP: dua_connect_fxo	192.168.254.3	16/12 18:48:02.408	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.808975 LIBGSDSP: dua_connect_fxo done	192.168.254.3	16/12 18:48:02.410	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.810057 LIBGSDSP: dua_set_sp_voip_mode	192.168.254.3	16/12 18:48:02.411	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.818207 LIBGSDSP: dua_set_sp_voip_mode done	192.168.254.3	16/12 18:48:02.413	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.819388 LIBGSDSP: dua_connect_voip:3421 ( 1, 6, 0 )	192.168.254.3	16/12 18:48:02.414	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.821090 LIBGSDSP: dua_connect_voip:3478 ( 1, 6, 0 )	192.168.254.3	16/12 18:48:02.416	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.823899 LIBGSDSP: CSS: 2345130867, Function create_voice_message; Sending coma response 1
	192.168.254.3	16/12 18:48:02.418	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.828739 LIBGSDSP: CSS: 2345136034, Function create_voice_message; Sending coma response 3
	192.168.254.3	16/12 18:48:02.421	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.832249 LIBGSDSP: CSS: 2345138351, voice_start_chan: Request to start an RTP session
	192.168.254.3	16/12 18:48:02.424	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.832810 LIBGSDSP: CSS: 2345138436, Codec Opts provided in ioctl is 30014b
	192.168.254.3	16/12 18:48:02.427	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.833156 LIBGSDSP: CSS: 2345138806, The Timestamp value received from user space 1586299349 
	192.168.254.3	16/12 18:48:02.431	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.833492 LIBGSDSP: CSS: 2345138897,  #### List of Rx codec received from user space 
	192.168.254.3	16/12 18:48:02.433	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.840387 LIBGSDSP: CSS: 2345138932,  @@@ Codec 0 
	192.168.254.3	16/12 18:48:02.435	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.840665 LIBGSDSP: CSS: 2345139009,  @@@ Dynamic String  
	192.168.254.3	16/12 18:48:02.438	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.853569 LIBGSDSP: CSS: 2345139052,  @@@ Encode string codec  0
	192.168.254.3	16/12 18:48:02.440	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.859539 LIBGSDSP: CSS: 2345139125,  @@@ Codec 8 
	192.168.254.3	16/12 18:48:02.441	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.865364 LIBGSDSP: CSS: 2345139156,  @@@ Dynamic String  
	192.168.254.3	16/12 18:48:02.443	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727282.866673 GSDSP::startRTP started on port 1:0
	192.168.254.3	16/12 18:48:02.445	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.868826 LIBGSDSP: CSS: 2345139226,  @@@ Encode string codec  0
	192.168.254.3	16/12 18:48:02.446	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.869228 LIBGSDSP: CSS: 2345139261,  @@@ Codec 0 
	192.168.254.3	16/12 18:48:02.448	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.869462 LIBGSDSP: CSS: 2345139299,  @@@ Dynamic String  
	192.168.254.3	16/12 18:48:02.449	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.869661 LIBGSDSP: CSS: 2345139371,  @@@ Encode string codec  0
	192.168.254.3	16/12 18:48:02.451	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.869852 LIBGSDSP: CSS: 2345139406,  @@@ Codec 0 
	192.168.254.3	16/12 18:48:02.455	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.870045 LIBGSDSP: CSS: 2345139438,  @@@ Dynamic String  
	192.168.254.3	16/12 18:48:02.457	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.870238 LIBGSDSP: CSS: 2345139509,  @@@ Encode string codec  0
	192.168.254.3	16/12 18:48:02.459	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.870430 LIBGSDSP: CSS: 2345139541,  @@@ Codec 0 
	192.168.254.3	16/12 18:48:02.460	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.870622 LIBGSDSP: CSS: 2345139618,  @@@ Dynamic String  
	192.168.254.3	16/12 18:48:02.462	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.890480 LIBGSDSP: CSS: 2345139656,  @@@ Encode string codec  0
	192.168.254.3	16/12 18:48:02.464	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.898195 LIBGSDSP: CSS: 2345139729,  @@@ Codec 0 
	192.168.254.3	16/12 18:48:02.465	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.899306 LIBGSDSP: CSS: 2345139766,  @@@ Dynamic String  
	192.168.254.3	16/12 18:48:02.467	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.899643 LIBGSDSP: CSS: 2345139804,  @@@ Encode string codec  0
	192.168.254.3	16/12 18:48:02.471	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.899869 LIBGSDSP: CSS: 2345139888, 
 p_rtpapp_Start:  capabilities[0x30014b]  
	192.168.254.3	16/12 18:48:02.475	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.900080 LIBGSDSP: CSS: 2345139981, 
 p_rtpapp_Start: TX codec is 0 and TX codec Str is  and line is 6
	192.168.254.3	16/12 18:48:02.479	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.900275 LIBGSDSP: CSS: 2345140053, MTDCodec Index is 0
	192.168.254.3	16/12 18:48:02.480	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.900462 LIBGSDSP: CSS: 2345140130, !!!!!!!!!! pRtpMtdCodec->PackedFrameSize 80 
	192.168.254.3	16/12 18:48:02.482	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.908307 LIBGSDSP: CSS: 2345140161, Assign ARM Codec
	192.168.254.3	16/12 18:48:02.485	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.908673 LIBGSDSP: CSS: 2345140190, 
 ENC Codec 46 
	192.168.254.3	16/12 18:48:02.487	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.908903 LIBGSDSP: CSS: 2345140376, 
#### CODEC_PT_GET(pRtpData->wCodecTx) = 0 Codec.duration=20 coderTypeEnc=46 pLineData->bBufSize=160 pLineData
	192.168.254.3	16/12 18:48:02.488	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.909029 LIBGSDSP: ->bPackedBufSize160
	192.168.254.3	16/12 18:48:02.490	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.909221 LIBGSDSP: CSS: 2345140438, MTDCodec Index is 0
	192.168.254.3	16/12 18:48:02.491	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.909407 LIBGSDSP: CSS: 2345140517, RX Codec assigned from ARM and line is 6
	192.168.254.3	16/12 18:48:02.493	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.909597 LIBGSDSP: CSS: 2345140774, p_rtp_SessionInit: Init reqEvent=0xFF	192.168.254.3	16/12 18:48:02.494	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.909783 LIBGSDSP: CSS: 2345140936, Session start Session is 22fe020
	192.168.254.3	16/12 18:48:02.496	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.909970 LIBGSDSP: CSS: 2345141020, Session start with retransmission mode 0
	192.168.254.3	16/12 18:48:02.497	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.910164 LIBGSDSP: CSS: 2345141059,  RTP VOIP flows activated
	192.168.254.3	16/12 18:48:02.498	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.910346 LIBGSDSP: CSS: 2345141122,  !!!!!! Recieved payload is 
	192.168.254.3	16/12 18:48:02.503	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.910535 LIBGSDSP: CSS: 2345141159,  pRtpSession->CodecInfo.rx_list[0] = 0
	192.168.254.3	16/12 18:48:02.508	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.919700 LIBGSDSP: CSS: 2345141239,  pRtpSession->CodecInfo.rx_list[1] = 8
	192.168.254.3	16/12 18:48:02.510	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.920169 LIBGSDSP: CSS: 2345141282,  pRtpSession->CodecInfo.rx_list[2] = 0
	192.168.254.3	16/12 18:48:02.512	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.920419 LIBGSDSP: CSS: 2345141352,  pRtpSession->CodecInfo.rx_list[3] = 0
	192.168.254.3	16/12 18:48:02.514	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.920622 LIBGSDSP: CSS: 2345141387,  pRtpSession->CodecInfo.rx_list[4] = 0
	192.168.254.3	16/12 18:48:02.516	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.928284 LIBGSDSP: CSS: 2345141423,  pRtpSession->CodecInfo.rx_list[5] = 0
	192.168.254.3	16/12 18:48:02.518	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.928971 LIBGSDSP: CSS: 2345141512, RTPAPP 732 uid 258-1280, rfc_relay 0, gain 0
	192.168.254.3	16/12 18:48:02.520	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.929242 LIBGSDSP: CSS: 2345141608,  RTPAPP capabilities 30014B, EvtTx 255, EvTRX 255
	192.168.254.3	16/12 18:48:02.522	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.929459 LIBGSDSP: CSS: 2345141769, RTP started coder  pt 0 Ts 160 FS 160
	192.168.254.3	16/12 18:48:02.524	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.929661 LIBGSDSP: CSS: 2345141883, The RTP Retransmission flag 0 and retransmission buffer size 0 with rtp_config_size is 732
	192.168.254.3	16/12 18:48:02.525	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.929856 LIBGSDSP: CSS: 2345141932, The RTP Redundacy mode is 0 
	192.168.254.3	16/12 18:48:02.527	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.930048 LIBGSDSP: CSS: 2345142020, p_da_AUCChannelAllocDec coderTypeDec:46 dec_chan:-1 RTP Line:6
	192.168.254.3	16/12 18:48:02.528	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.930240 LIBGSDSP: CSS: 2345142756, RTPSTART: dec_chan=122, coderTypeDec = 46, status = 0
	192.168.254.3	16/12 18:48:02.530	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.930431 LIBGSDSP: CSS: 2345143290, RTPSTART: enc_chan=123 coderTypeEnc = 46, status = 0
	192.168.254.3	16/12 18:48:02.533	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.930620 LIBGSDSP: CSS: 2345143479, 
 Value of sid_update for G711 is 0 
	192.168.254.3	16/12 18:48:02.537	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.939395 LIBGSDSP: CSS: 2345143780, pLineData->dwCapabilities = 3146059, pLineData->dec_chan = 122, jib_instance = 1820
	192.168.254.3	16/12 18:48:02.540	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.939709 LIBGSDSP: CSS: 2345143988, 
 @@@@@ Value of pktsize 10 ms is 1 
	192.168.254.3	16/12 18:48:02.543	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.939921 LIBGSDSP: CSS: 2345144117,   @@ ### JB ADAPTATION TYPE is ENABLED
	192.168.254.3	16/12 18:48:02.544	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.940119 LIBGSDSP: CSS: 2345144157,  The MAX JIB value received from User space 1000 
	192.168.254.3	16/12 18:48:02.546	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.940316 LIBGSDSP: CSS: 2345144257,  The INPUTBUFFERSETPOINT value received from User space 120 
	192.168.254.3	16/12 18:48:02.548	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.940517 LIBGSDSP: CSS: 2345144304,  The ADAPTATION TYPE value received from User space 1 
	192.168.254.3	16/12 18:48:02.550	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.949020 LIBGSDSP: CSS: 2345144390,  The RESYNCRONISATION THRESHOLD received from User space 3 
	192.168.254.3	16/12 18:48:02.551	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.952057 LIBGSDSP: CSS: 2345144483,  The TARGET PLAYOUT DELAY received from User space 20 
	192.168.254.3	16/12 18:48:02.553	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.952300 LIBGSDSP: CSS: 2345144534,  The MONITORING INTERVAL value received from User space 2000 
	192.168.254.3	16/12 18:48:02.555	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.952504 LIBGSDSP: CSS: 2345144620,  The ADAPTATION STEPSIZE RESET TIME value received from User space 60 
	192.168.254.3	16/12 18:48:02.556	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.952707 LIBGSDSP: CSS: 2345144674,  The ADAPTATION SLOPE value received from User space 24 
	192.168.254.3	16/12 18:48:02.558	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.952902 LIBGSDSP: CSS: 2345144764,  The POST ADAPTATION STEP SIZE MEDIUM value received from User space 0 
	192.168.254.3	16/12 18:48:02.559	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.953096 LIBGSDSP: CSS: 2345144910,  The POST ADAPTATION STEP SIZE value received from User space 0 
	192.168.254.3	16/12 18:48:02.561	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.953288 LIBGSDSP: CSS: 2345145011,  The MIN JIB value received from User space 120 
	192.168.254.3	16/12 18:48:02.562	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.953482 LIBGSDSP: CSS: 2345145174, The JIB has been initialized to this 238fa20 for line id 6
	192.168.254.3	16/12 18:48:02.569	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.965356 LIBGSDSP: CSS: 2345145269, Function p_rtpapp_Start;Line 1820; STATE 2
	192.168.254.3	16/12 18:48:02.574	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.967674 LIBGSDSP: CSS: 2345145419, Line variables: bBufSize: 160;bDecFrameSize: 80;bDecPackedFrameSize: 80;bFrameSize: 80;bPackedBufSize: 160, bP
	192.168.254.3	16/12 18:48:02.576	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.967906 LIBGSDSP: ackedFrameSize: 80 
	192.168.254.3	16/12 18:48:02.578	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.968153 LIBGSDSP: CSS: 2345145544, voice_request_start_chan returning 6
	192.168.254.3	16/12 18:48:02.581	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.968366 LIBGSDSP: CSS: 2345155136, In API callback event = 281, inst = 123
	192.168.254.3	16/12 18:48:02.583	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.968573 LIBGSDSP: CSS: 2345155298,  p_rtpapp_AUCCallback is getting called 
	192.168.254.3	16/12 18:48:02.585	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.968773 LIBGSDSP: CSS: 2345155422, p_rtpapp_AUCMssgHandler: Encoder chan 123 started for line 6 
	192.168.254.3	16/12 18:48:02.587	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.968970 LIBGSDSP: CSS: 2345155563, In API callback event = 281, inst = 122
	192.168.254.3	16/12 18:48:02.588	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.969173 LIBGSDSP: CSS: 2345155642,  p_rtpapp_AUCCallback is getting called 
	192.168.254.3	16/12 18:48:02.590	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.969372 LIBGSDSP: CSS: 2345155729, p_rtpapp_AUCMssgHandler: Decoder chan 122 started for line 6 
	192.168.254.3	16/12 18:48:02.591	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.969565 LIBGSDSP: CSS: 2345155797, p_rtpapp_SetSesionStatus: started decoder and encoder for line 6
	192.168.254.3	16/12 18:48:02.593	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.980602 LIBGSDSP: CSS: 2345155894,  
 ##### AUC Channel started sending COMA REPLY #####
	192.168.254.3	16/12 18:48:02.594	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.981660 LIBGSDSP: CSS: 2345155937, Function create_voice_message; Sending coma response 5
	192.168.254.3	16/12 18:48:02.598	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.981914 LIBGSDSP: CSS: 2345156230, Function p_rtpapp_SetSesionStatus;Line 704; STATE CHANGE: to 3
	192.168.254.3	16/12 18:48:02.602	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.982120 LIBGSDSP: CSS: 2345165635, voice_request_start_rtcp:770: Calling voice_start_rtcp
	192.168.254.3	16/12 18:48:02.608	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.982324 LIBGSDSP: CSS: 2345165786, Function p_rtpapp_RtcpStart;Line 151; Calling p_rtcp_SessionInit
	192.168.254.3	16/12 18:48:02.609	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.982519 LIBGSDSP: CSS: 2345165891,  rtcp interval 5 and opts flag 19 
	192.168.254.3	16/12 18:48:02.611	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.982717 LIBGSDSP: CSS: 2345165930,  ### p_rtcp_SessionInit 5 opts 19 
	192.168.254.3	16/12 18:48:02.613	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.982910 LIBGSDSP: CSS: 2345166131, The RTCP Feedback type is '0' fb_bw '0' fb_trr_interval '0' max_rtt 0 and sizeof RTCP_config 816
	192.168.254.3	16/12 18:48:02.615	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.983099 LIBGSDSP: CSS: 2345166225, 
 Session RB TYPE :: 255 
	192.168.254.3	16/12 18:48:02.616	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.983286 LIBGSDSP: CSS: 2345166270,  AFTER COPY TO rtcpsession interval  5 opts 19 
	192.168.254.3	16/12 18:48:02.618	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.983471 LIBGSDSP: CSS: 2345166365, 
 The RTCP XR - thining 3 & gmin 16 
	192.168.254.3	16/12 18:48:02.620	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.991915 LIBGSDSP: CSS: 2345166413,  p_rtcp_xr_SessionInit function called ---- Number Of SIP SESSIONS '8'  
	192.168.254.3	16/12 18:48:02.621	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.992316 LIBGSDSP: CSS: 2345166539, 
 p_rtcp_xr_SessionInit called with Gmin : 16 and Thining : 3 value 
	192.168.254.3	16/12 18:48:02.623	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.992554 LIBGSDSP: CSS: 2345166739,  Modes of RTCP 19 
	192.168.254.3	16/12 18:48:02.624	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.992751 LIBGSDSP: CSS: 2345166790,  ######## RTCP interval given from user space 5 
	192.168.254.3	16/12 18:48:02.626	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.992942 LIBGSDSP: CSS: 2345167403,  p_rtcp_xr_SessionStart function called ---- 
	192.168.254.3	16/12 18:48:02.629	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727282.993132 LIBGSDSP: CSS: 2345167541, Function create_voice_message; Sending coma response 14
	192.168.254.3	16/12 18:48:02.630	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727283.108295 LIBGSDSP: CSS: 2345415139, p_rtp_SeqInit 12791
	192.168.254.3	16/12 18:48:02.721	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727283.162213 LIBGSDSP: CSS: 2345469064, p_rtp_SeqInit 12793
	192.168.254.3	16/12 18:48:02.728	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727283.722463 EventPvalueChanged( :call_cnt_in_conn_fxs1 )
	192.168.254.3	16/12 18:48:03.274	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727283.727225 EventManager::run: Dispatching event 80 (PVALUE_CHANGED) on port -1:-1
	192.168.254.3	16/12 18:48:03.276	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727283.731270 SigCtrl::processPvalueChange ( call_cnt_in_conn_fxs1 )
	192.168.254.3	16/12 18:48:03.285	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727284.984986 SIPStack(1)::isMessageFromAllowedProxy, fromHost = 192.168.33.12,fromPort= 5060
	192.168.254.3	16/12 18:48:04.561	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727284.988093 SIPStack(1)::isMessageFromAllowedProxy, acct= 0, server= NULL:5060, failover= NULL:5060, obp= NULL:5060, backup obp= NULL:5060
	192.168.254.3	16/12 18:48:04.567	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727284.989372 SIPStack(1)::isMessageFromAllowedProxy, acct= 1, server= 192.168.33.12:5060, failover= NULL:5060, obp= NULL:5060, backup obp= NULL:5060
	192.168.254.3	16/12 18:48:04.571	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727284.992446 SIPStack(1)::cb_rcvreq: Received SIP request BYE
	192.168.254.3	16/12 18:48:04.573	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727284.994949 EventManager::run: Dispatching event 60 (SIG_REMOTE_DISCONNECT) on port 1:0
	192.168.254.3	16/12 18:48:04.575	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727284.995276 ATACtrl::processSigRemoteDisconnect on port 1:0, status = CALL_COMMUNICATION/CALL_IDLE
	192.168.254.3	16/12 18:48:04.577	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727284.995554 ATACtrl::processSigRemoteDisconnect on port 1:0, Start FxoWaitIdle Timer 4 secs
	192.168.254.3	16/12 18:48:04.579	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727284.998267 EventManager::run: Dispatching event 27 (CALL_COMPLETED) on port 1:0
	192.168.254.3	16/12 18:48:04.580	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727284.998583 SigCtrl::processCallCompleted on port 1:0, status = FXO_WAIT_IDLE/CALL_IDLE
	192.168.254.3	16/12 18:48:04.582	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727284.998808 ATACtrl::processCallCompleted on port 1:0, status = FXO_WAIT_IDLE/CALL_IDLE canConf:0
	192.168.254.3	16/12 18:48:04.584	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727284.998975 ATACtrl::processCallCompleted, Port 1:0, peer port -1:-1 ptype 1
	192.168.254.3	16/12 18:48:04.589	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727284.999119 ATACtrl::cleanupTimer, port:1 ch:0, isOffHook:1
	192.168.254.3	16/12 18:48:04.591	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727284.999247 ATACtrl::resetFxoRingCnt, !!!!!!reset ring counter to 0
	192.168.254.3	16/12 18:48:04.593	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727284.999388 ATACtrl::processCallCompleted, FXO Port 1:0 On-hook
	192.168.254.3	16/12 18:48:04.594	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.005234 SIPStack(1)::cb_snd_message, host=192.168.33.12, original port=5060
	192.168.254.3	16/12 18:48:04.596	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.005570 SIPStack(1)::snd_message: Present IP Addr:192.168.33.12
	192.168.254.3	16/12 18:48:04.598	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727285.014041 SIPStack(1)::run: Active call dialogs: 1
	192.168.254.3	16/12 18:48:04.599	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.017970 Nuvoton::fxoHookSet, Set Hook to  OnHook on port 1:0
	192.168.254.3	16/12 18:48:04.601	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727285.022887 SIPStack(1)::run: Active call dialogs: 1
	192.168.254.3	16/12 18:48:04.608	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.050532 Call(55)::processEvent, CALL_COMPLETED, port 1:0, evtPort 1:0
	192.168.254.3	16/12 18:48:04.613	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.053063 ATACtrl::stopRTP on 1:0, status = FXO_WAIT_IDLE, force: 0, specialFeature = 100
	192.168.254.3	16/12 18:48:04.616	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727285.053349 GSDSP::stop RTP on port 1:0
	192.168.254.3	16/12 18:48:04.619	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.057634 LIBGSDSP: CSS: 2347362101, voice_request_stop_chan
	192.168.254.3	16/12 18:48:04.620	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.058237 LIBGSDSP: CSS: 2347362281, voice_stop_chan
	192.168.254.3	16/12 18:48:04.622	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.058604 LIBGSDSP: CSS: 2347362349, About to call peakdetect_stop
	192.168.254.3	16/12 18:48:04.625	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.058967 LIBGSDSP: CSS: 2347362400, After calling peakdetect stop
	192.168.254.3	16/12 18:48:04.627	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.059279 LIBGSDSP: CSS: 2347362499,  Sending RTCP BYE Packet 
	192.168.254.3	16/12 18:48:04.628	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.059611 LIBGSDSP: CSS: 2347362591,  #### In function ByeLen reasonlen 3 pad 0 and rtcpLen 12 
	192.168.254.3	16/12 18:48:04.678	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.066591 LIBGSDSP: dua_disconnect_voip:3493 ( 1, 6, 0 )	192.168.254.3	16/12 18:48:04.685	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.067075 LIBGSDSP: dua_disconnect_voip:3545 ( 1, 6, 0 )	192.168.254.3	16/12 18:48:04.687	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.067278 LIBGSDSP: dua_free_voip( 6 )	192.168.254.3	16/12 18:48:04.689	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.072347 EventPvalueChanged( :4902 )
	192.168.254.3	16/12 18:48:04.691	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.072685 EventManager::run: Dispatching event 80 (PVALUE_CHANGED) on port -1:-1
	192.168.254.3	16/12 18:48:04.693	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.072843 SigCtrl::processPvalueChange ( 4902 )
	192.168.254.3	16/12 18:48:04.698	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.073570 LIBGSDSP: CSS: 2347362641, p_rtcp_ByeLen: 12
	192.168.254.3	16/12 18:48:04.703	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.074111 LIBGSDSP: CSS: 2347362860, Function p_rtpapp_Stop;Line 2381; STATE CHANGE: to 4
	192.168.254.3	16/12 18:48:04.707	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.074349 LIBGSDSP: CSS: 2347363082, pMember->stats.dwJibDuplicated '0'  pMember->stats.dwJibDiscarded '0' pMember->stats.dwJibInvalid '0' pMember-
	192.168.254.3	16/12 18:48:04.709	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.074478 LIBGSDSP: >stats.dwJibReceived '15	192.168.254.3	16/12 18:48:04.711	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.074670 LIBGSDSP: CSS: 2347363206, return value of p_rtpapp_Stopis 0
	192.168.254.3	16/12 18:48:04.712	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.074870 LIBGSDSP: CSS: 2347365401, In API callback event = 283, inst = 123
	192.168.254.3	16/12 18:48:04.715	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.075061 LIBGSDSP: CSS: 2347365515,  p_rtpapp_AUCCallback is getting called 
	192.168.254.3	16/12 18:48:04.717	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.089639 LIBGSDSP: dua_free_voip done	192.168.254.3	16/12 18:48:04.721	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.089957 LIBGSDSP: dua_disconnect_fxo ( 1 )	192.168.254.3	16/12 18:48:04.722	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.090187 LIBGSDSP: dua_disconnect_fxo done	192.168.254.3	16/12 18:48:04.724	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727285.090345 GSDSP::RTP stopped on port 1:0
	192.168.254.3	16/12 18:48:04.726	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727285.090554 RTP stop on port 1:0 local rtp port:5012 sdp:0x1b8d50
	192.168.254.3	16/12 18:48:04.728	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.090709 RTP::closeSocket(), Closing socket: 26, local RTP port: 5012
	192.168.254.3	16/12 18:48:04.729	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.092278 RTP::closeSocket(), Closing socket: 27, local RTCP port: 5013
	192.168.254.3	16/12 18:48:04.731	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727285.092607 Call(55)::processMedia, Call stopped on port 1:0, inTransfer = 0
	192.168.254.3	16/12 18:48:04.732	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.092823 Call(55)::processMedia call_time_total total: 2 fxs:1
	192.168.254.3	16/12 18:48:04.736	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.095305 LIBGSDSP: CSS: 2347365621, p_da_AUCChannelRelease status 0, ch 123 
	192.168.254.3	16/12 18:48:04.739	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.095671 LIBGSDSP: CSS: 2347365746, In API callback event = 283, inst = 122
	192.168.254.3	16/12 18:48:04.743	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.098323 LIBGSDSP: CSS: 2347365823,  p_rtpapp_AUCCallback is getting called 
	192.168.254.3	16/12 18:48:04.748	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.101955 LIBGSDSP: CSS: 2347365870, p_da_AUCChannelRelease status 0, ch 122 
	192.168.254.3	16/12 18:48:04.750	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.102236 LIBGSDSP: CSS: 2347366012, Function p_rtp_session_jb_stop;Line 2511; STATE CHANGE: to 5
	192.168.254.3	16/12 18:48:04.753	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.102445 LIBGSDSP: CSS: 2347366107, p_rtp_SessionDestroy: 022fe020 - 02301798
	192.168.254.3	16/12 18:48:04.757	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.102647 LIBGSDSP: CSS: 2347366219,  p_rtcp_xr_SessionStop function called ---- 
	192.168.254.3	16/12 18:48:04.759	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.102837 LIBGSDSP: CSS: 2347366275,  ** Stat Summary **** 
	192.168.254.3	16/12 18:48:04.760	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.111267 LIBGSDSP: CSS: 2347366357,  ** Begin Seq :: 31f7 
	192.168.254.3	16/12 18:48:04.764	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.121814 LIBGSDSP: CSS: 2347366394,  ** End Seq   :: 3248 
	192.168.254.3	16/12 18:48:04.766	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.128495 LIBGSDSP: CSS: 2347366455,  ** Lost Packet :: 10 
	192.168.254.3	16/12 18:48:04.767	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.128820 LIBGSDSP: CSS: 2347366485,  ** Du Packet :: 0
	192.168.254.3	16/12 18:48:04.775	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.129044 LIBGSDSP: CSS: 2347366516,  ** Max. Jitter value :: 600 
	192.168.254.3	16/12 18:48:04.780	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.129250 LIBGSDSP: CSS: 2347366584,  ** Min. Jitter value :: 0 
	192.168.254.3	16/12 18:48:04.782	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.129443 LIBGSDSP: CSS: 2347366622,  ** Mean. Jitter value :: 75 
	192.168.254.3	16/12 18:48:04.784	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.129641 LIBGSDSP: CSS: 2347366699,  ** Max. TTL :: 64 
	192.168.254.3	16/12 18:48:04.788	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.129831 LIBGSDSP: CSS: 2347366735,  ** Min. TTL :: 64 
	192.168.254.3	16/12 18:48:04.790	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.130018 LIBGSDSP: CSS: 2347366766,  ** Mean. TTL :: 64 
	192.168.254.3	16/12 18:48:04.792	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.130201 LIBGSDSP: CSS: 2347366837, ** p_rtcp_xr_ClearSession called **	192.168.254.3	16/12 18:48:04.794	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.130387 LIBGSDSP: CSS: 2347366872,  ** sizeof(pXRSession->stat.statsummary) :: 124 
	192.168.254.3	16/12 18:48:04.797	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.130576 LIBGSDSP: CSS: 2347366948,  ** sizeof(pXRSession->stat.voip_mtr) :: 28 
	192.168.254.3	16/12 18:48:04.799	
<14> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.INFO   1702727285.146998 Deleting Call object 55 port 1:0, callCount=0
	192.168.254.3	16/12 18:48:04.805	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.147284 EventManager::unregisterEventListener: listener Call
	192.168.254.3	16/12 18:48:04.808	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.147481 RTP::~RTP, destruct 0x1b4698
	192.168.254.3	16/12 18:48:04.810	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.149782 LIBGSDSP: CSS: 2347367089, total fb requested '0' and total removal of fb requested '0'
	192.168.254.3	16/12 18:48:04.812	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.150138 LIBGSDSP: CSS: 2347367138, p_rtcp_SessionFree: 022fe120 - 022feca0
	192.168.254.3	16/12 18:48:04.813	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.150355 LIBGSDSP: CSS: 2347367240, p_rtp_SessionDestroy: 022fe020 - 02301798
	192.168.254.3	16/12 18:48:04.814	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.150554 LIBGSDSP: CSS: 2347367325,  
 ##### AUC Channel STOPPED sending COMA REPLY ##### 
	192.168.254.3	16/12 18:48:04.816	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.161313 LIBGSDSP: CSS: 2347367379, Function create_voice_message; Sending coma response 7
	192.168.254.3	16/12 18:48:04.817	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.161685 LIBGSDSP: CSS: 2347367594, create_voice_message ret 0 
	192.168.254.3	16/12 18:48:04.820	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.161916 LIBGSDSP: CSS: 2347368608, Function create_voice_message; Sending coma response 9
	192.168.254.3	16/12 18:48:04.821	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.282065 LIBGSDSP: CSS: 2347587927, In API callback event = 139, inst = 2053
	192.168.254.3	16/12 18:48:04.916	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727285.282427 LIBGSDSP: CSS: 2347588124, In API callback event = 138, inst = 2053
	192.168.254.3	16/12 18:48:04.924	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727286.074014 EventPvalueChanged( :call_time_total_fxs1 )
	192.168.254.3	16/12 18:48:05.621	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727286.075319 EventPvalueChanged( :cur_call_cnt )
	192.168.254.3	16/12 18:48:05.625	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727286.077236 EventPvalueChanged( :pthread_1438 )
	192.168.254.3	16/12 18:48:05.627	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727286.077600 EventManager::run: Dispatching event 80 (PVALUE_CHANGED) on port -1:-1
	192.168.254.3	16/12 18:48:05.629	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727286.077763 SigCtrl::processPvalueChange ( call_time_total_fxs1 )
	192.168.254.3	16/12 18:48:05.631	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727286.079554 EventManager::run: Dispatching event 80 (PVALUE_CHANGED) on port -1:-1
	192.168.254.3	16/12 18:48:05.643	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727286.079851 SigCtrl::processPvalueChange ( cur_call_cnt )
	192.168.254.3	16/12 18:48:05.648	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727286.080073 EventManager::run: Dispatching event 80 (PVALUE_CHANGED) on port -1:-1
	192.168.254.3	16/12 18:48:05.650	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727286.080207 SigCtrl::processPvalueChange ( pthread_1438 )
	192.168.254.3	16/12 18:48:05.653	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727289.082020 ATACtrl::resetCidInfo, @@@@@reset Cid Info!!!!!!  port 1
	192.168.254.3	16/12 18:48:08.644	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727289.082307 ATACtrl::resetFxoRingCnt, !!!!!!reset ring counter to 0
	192.168.254.3	16/12 18:48:08.649	
<15> HT813 [00:0b:82:f2:a4:7a] [1.0.17.2] GS_ATA: USER.DEBUG  1702727289.082472 ATACtrl::FxoWaitIdleTimer Expired at 1:0, state FXO_WAIT_IDLE
	192.168.254.3	16/12 18:48:08.651

Re: Не работают исходящие через FXO

Добавлено: 16 дек 2023, 17:16
rom@nыч
Это консоль астериска:
PRIME_BBCODE_SPOILER_SHOW PRIME_BBCODE_SPOILER:

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

  == Using SIP RTP Audio TOS bits 184
  == Using SIP RTP Audio CoS mark 5
    -- Executing [83956633508@from-internal:1] Verbose("PJSIP/505-00000002", "1, "Didn't match any restricted numbers, proceeding with outbound dial."") in new stack
  "Didn't match any restricted numbers, proceeding with outbound dial."
    -- Executing [83956633508@from-internal:2] Set("PJSIP/505-00000002", "CALLERID(num)=+739566XXXXX") in new stack
    -- Executing [83956633508@from-internal:3] Dial("PJSIP/505-00000002", "PJSIP/83956633508@739566XXXXX") in new stack
    -- Called PJSIP/83956633508@739566XXXXX
    -- PJSIP/739566XXXXX-00000003 is ringing
    -- PJSIP/739566XXXXX-00000003 answered PJSIP/505-00000002
    -- Channel PJSIP/739566XXXXX-00000003 joined 'simple_bridge' basic-bridge <3f6e29f9-fec3-45be-86be-2fe5e782dc2f>
    -- Channel PJSIP/505-00000002 joined 'simple_bridge' basic-bridge <3f6e29f9-fec3-45be-86be-2fe5e782dc2f>
    -- Channel PJSIP/505-00000002 left 'simple_bridge' basic-bridge <3f6e29f9-fec3-45be-86be-2fe5e782dc2f>
  == Spawn extension (from-internal, 83956633508, 3) exited non-zero on 'PJSIP/505-00000002'
    -- Executing [h@from-internal:1] Macro("PJSIP/505-00000002", "hangupcall") in new stack
    -- Executing [s@macro-hangupcall:1] GotoIf("PJSIP/505-00000002", "1?theend") in new stack
    -- Goto (macro-hangupcall,s,3)
    -- Executing [s@macro-hangupcall:3] ExecIf("PJSIP/505-00000002", "0?Set(CDR(recordingfile)=)") in new stack
    -- Executing [s@macro-hangupcall:4] Hangup("PJSIP/505-00000002", "") in new stack
  == Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'PJSIP/505-00000002' in macro 'hangupcall'
  == Spawn extension (from-internal, h, 1) exited non-zero on 'PJSIP/505-00000002'
    -- Channel PJSIP/739566XXXXX-00000003 left 'simple_bridge' basic-bridge <3f6e29f9-fec3-45be-86be-2fe5e782dc2f>

Re: Не работают исходящие через FXO

Добавлено: 17 дек 2023, 17:47
ded
Два плеча создаются, соединяются в бридж

но потом PJSIP/505 вываливается. Почему? Ответ надо искать в sip дампах пира
PJSIP/3956633508 и
PJSIP/505

Re: Не работают исходящие через FXO

Добавлено: 17 дек 2023, 20:33
rom@nыч
Т.е. это проблема в астериске, а не шлюзе (как я думал)?
Посоветуйте, пожалуйста, что и где мне посмотреть? Уже голова скоро лопнет. Теории много прочитал, но на практике ни к сему не могу прийти.

Re: Не работают исходящие через FXO

Добавлено: 18 дек 2023, 01:55
Zavr2008
Проблема не в "глючном Астериске" поверьте. Проблема в Ваших знаниях)
учиться включать отладку sip, понять что там есть что..

Но я не об этом - сейчас это явно аут ставить FXO на городские линии - операторы с радостью переводят оставшихся абонентов на SIP.
Нет сейчас преимуществ у FXO ни по стоимости ни по возможностям (нет CallerID)
Именно этим путем я Вам и предлагаю пойти. В Иркутске РТК это может, проверьте.

Re: Не работают исходящие через FXO

Добавлено: 18 дек 2023, 06:49
rom@nыч
Я и не говорил про "глючный астериск". Я прекрасно понимаю, что проблема в моих знаниях. Просто хочу выяснить сейчас, или астериск неправильно настроен или шлюз.
Я не в самом Иркутске. Мой номер в сип не могут перевести, уже пройдено.

Re: Не работают исходящие через FXO

Добавлено: 18 дек 2023, 11:45
ded
rom@nыч писал(а):Посоветуйте, пожалуйста, что и где мне посмотреть?
На этом этапе вам надо бы обратиться в платный суппорт.
Затраченное время специалистов на FXO/FXS-SIP соединения вообще, и ваше время - в частности, перекрывают экономическую целесообразность результата.

http://asterisk.ru/knowledgebase/analogue

По логам, IMHO:
считаю анализ чужих логов равным аналиам мочи и кала. Можно ли найти баклабораторию, где такие анализы - на посев, на сахар, лейкоциты, делают бесплатно? Конечно нет.
rom@nыч писал(а):Уже голова скоро лопнет. Теории много прочитал, но на практике ни к сему не могу прийти.
Невозможно за несколько дней адекватно освоить огромную область знаний и практики. Даже с подсказками.
http://asterisk.ru/knowledgebase/debug
Часовой пояс: UTC+03:00
Страница 1 из 2

Создано на основе phpBB® Forum Software © phpBB Limited

Русская поддержка phpBB