Не работают исходящие через 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'

**rom@nыч** » 15 дек 2023, 14:36

Скрины настроек астериск

**ded** » 15 дек 2023, 16:30

https://forums5.grandstream.com/t/aster ... -fxo/48710

**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ыч** » 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>

**ded** » 17 дек 2023, 18:47

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

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

**rom@nыч** » 17 дек 2023, 21:33

Т.е. это проблема в астериске, а не шлюзе (как я думал)?
Посоветуйте, пожалуйста, что и где мне посмотреть? Уже голова скоро лопнет. Теории много прочитал, но на практике ни к сему не могу прийти.

**Zavr2008** » 18 дек 2023, 02:55

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

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

**rom@nыч** » 18 дек 2023, 07:49

Я и не говорил про "глючный астериск". Я прекрасно понимаю, что проблема в моих знаниях. Просто хочу выяснить сейчас, или астериск неправильно настроен или шлюз.
Я не в самом Иркутске. Мой номер в сип не могут перевести, уже пройдено.

**ded** » 18 дек 2023, 12:45

rom@nыч писал(а):Посоветуйте, пожалуйста, что и где мне посмотреть?

На этом этапе вам надо бы обратиться в платный суппорт.
Затраченное время специалистов на FXO/FXS-SIP соединения вообще, и ваше время - в частности, перекрывают экономическую целесообразность результата.

http://asterisk.ru/knowledgebase/analogue

По логам, IMHO:
считаю анализ чужих логов равным аналиам мочи и кала. Можно ли найти баклабораторию, где такие анализы - на посев, на сахар, лейкоциты, делают бесплатно? Конечно нет.

rom@nыч писал(а):Уже голова скоро лопнет. Теории много прочитал, но на практике ни к сему не могу прийти.

Невозможно за несколько дней адекватно освоить огромную область знаний и практики. Даже с подсказками.
http://asterisk.ru/knowledgebase/debug

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

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

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

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

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

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

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

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

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

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

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

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