ВидеоКонф(ВКС)  ::   FAQ  ::   Поиск  ::   Регистрация  ::   Вход

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

Вопросы по использованию и настройке IP телефонов, шлюзов и всего прочего

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

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

Сообщение rom@nыч » 15 дек 2023, 14:34

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

Консоль астериск:
[Показать] Спойлер:
Код: выделить все
  == 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'

Вложения
2023-12-15_17-18-30.png
2023-12-15_17-17-08.png
2023-12-15_17-16-27.png
rom@nыч
 
Сообщений: 25
Зарегистрирован: 30 ноя 2023, 08:55

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

Сообщение rom@nыч » 15 дек 2023, 14:36

Скрины настроек астериск
2023-12-15_17-28-19.png

2023-12-15_17-27-14.png

2023-12-15_17-23-29.png
rom@nыч
 
Сообщений: 25
Зарегистрирован: 30 ноя 2023, 08:55

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

Сообщение ded » 15 дек 2023, 16:30

ded
 
Сообщений: 15847
Зарегистрирован: 26 авг 2010, 19:00

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

Сообщение rom@nыч » 16 дек 2023, 18:16

Сделал все по инструкции из ссылки, но исходящие так и не работают.
Может кто-нибудь сможет помочь мне в этом.
Это лог из шлюза:
[Показать] Спойлер:
Код: выделить все
<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   
rom@nыч
 
Сообщений: 25
Зарегистрирован: 30 ноя 2023, 08:55

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

Сообщение rom@nыч » 16 дек 2023, 18:16

Это консоль астериска:
[Показать] Спойлер:
Код: выделить все
  == 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>
rom@nыч
 
Сообщений: 25
Зарегистрирован: 30 ноя 2023, 08:55

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

Сообщение ded » 17 дек 2023, 18:47

Два плеча создаются, соединяются в бридж

но потом PJSIP/505 вываливается. Почему? Ответ надо искать в sip дампах пира
PJSIP/3956633508 и
PJSIP/505
ded
 
Сообщений: 15847
Зарегистрирован: 26 авг 2010, 19:00

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

Сообщение rom@nыч » 17 дек 2023, 21:33

Т.е. это проблема в астериске, а не шлюзе (как я думал)?
Посоветуйте, пожалуйста, что и где мне посмотреть? Уже голова скоро лопнет. Теории много прочитал, но на практике ни к сему не могу прийти.
rom@nыч
 
Сообщений: 25
Зарегистрирован: 30 ноя 2023, 08:55

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

Сообщение Zavr2008 » 18 дек 2023, 02:55

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

Но я не об этом - сейчас это явно аут ставить FXO на городские линии - операторы с радостью переводят оставшихся абонентов на SIP.
Нет сейчас преимуществ у FXO ни по стоимости ни по возможностям (нет CallerID)
Именно этим путем я Вам и предлагаю пойти. В Иркутске РТК это может, проверьте.
Российские E1 шлюзы Alvis. Модернизация УПАТС с E1,Подключение к ИС "Антифрод" E1 PRI/SS#7 УВР Телестор, Грифин и др..
Аватар пользователя
Zavr2008
 
Сообщений: 2176
Зарегистрирован: 27 янв 2011, 01:35

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

Сообщение rom@nыч » 18 дек 2023, 07:49

Я и не говорил про "глючный астериск". Я прекрасно понимаю, что проблема в моих знаниях. Просто хочу выяснить сейчас, или астериск неправильно настроен или шлюз.
Я не в самом Иркутске. Мой номер в сип не могут перевести, уже пройдено.
rom@nыч
 
Сообщений: 25
Зарегистрирован: 30 ноя 2023, 08:55

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

Сообщение ded » 18 дек 2023, 12:45

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

http://asterisk.ru/knowledgebase/analogue

По логам, IMHO:
считаю анализ чужих логов равным аналиам мочи и кала. Можно ли найти баклабораторию, где такие анализы - на посев, на сахар, лейкоциты, делают бесплатно? Конечно нет.
rom@nыч писал(а):Уже голова скоро лопнет. Теории много прочитал, но на практике ни к сему не могу прийти.
Невозможно за несколько дней адекватно освоить огромную область знаний и практики. Даже с подсказками.
http://asterisk.ru/knowledgebase/debug
ded
 
Сообщений: 15847
Зарегистрирован: 26 авг 2010, 19:00

След.

Вернуться в VoIP оборудование

Кто сейчас на форуме

Сейчас этот форум просматривают: нет зарегистрированных пользователей и гости: 7

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