freepbx billsec

Freepbx 15.0.21 Asterisk 16.13.0

Billsec считается от начала звонка, а не от начала разговора. То есть duration и billsec всегда имеют одинаковые значения.

Меня интересуют исходящие звонки, так что я написал custom dialplan.

exten => s,1,NoOp(Entering custom context) same => n,Dial(SIP/77777777/${dest},25,M(resetcdr)) #Trying to reset CDR on answer ;same => n,Dial(SIP/77777777/${dest},25,M(getAnswer)) #Saving ring time to custom var same => n,ResetCDR() #Even not executing same => n,ForkCDR() #Even not executing same => n,hangup() #Sending variables to script to calculate real Billsec exten => h,1,System(/opt/asterisk/save-billsec.sh ${CDR(UNIQUEID)} ${CDR(billsec)} ${MY_RINGTIME}) [macro-resetcdr] exten => s,1,Dumpchan() same => n,ResetCDR() #Does nothing same => n,ForkCDR() #Does nothing [macro-getAnswer] exten => s,1,Dumpchan() same => n,Set(MY_RINGTIME=${ElapsedTime}) #Saving ring time to custom var 

Тут я пытался всяко разно reset-нуть CDR - не получается. Далее я пытался перезаписать CDR(billsec) переменную. На что система мне ответила, billsec is read-only variable. И последнее что я сделал это написал скрипт, который сохраняет uniqueID и настоящий billsec в файл. А потом уже другой скрипт через крон переписывает значение billsec в таблице CDR:

update cdr set billsec = $time where uniqueid = $uniqueid order by calldate desc; 

Но это извращение и не всегда работает. Я предполагаю что это могут быть какие-нибудь настройки, которые исправят billsec. Вот немного лога касающегося нашего кейса:

[2022-02-17 14:21:51] VERBOSE[26180][C-000001b9] app_dial.c: Called SIP/77777777/88888888 [2022-02-17 14:21:53] VERBOSE[26180][C-000001b9] app_dial.c: SIP/77777777-00000379 is making progress passing it to SIP/+97677777778-00000378 [2022-02-17 14:21:53] VERBOSE[26180][C-000001b9] app_dial.c: SIP/77777777-00000379 is ringing [2022-02-17 14:22:04] VERBOSE[26180][C-000001b9] app_dial.c: SIP/77777777-00000379 answered SIP/+97677777778-00000378 [2022-02-17 14:22:04] VERBOSE[26180][C-000001b9] pbx.c: Executing [s@macro-dumpchan:1] DumpChan("SIP/77777777-00000379", "") in new stack [2022-02-17 14:22:04] VERBOSE[26180][C-000001b9] app_dumpchan.c: Dumping Info For Channel: SIP/77777777-00000379: ================================================================================ Info: Name= SIP/77777777-00000379 Type= SIP UniqueID= 1645078911.1159 LinkedID= 1645078909.1158 CallerIDNum= s CallerIDName= (N/A) ConnectedLineIDNum= 88888889 ConnectedLineIDName=88888889 DNIDDigits= (N/A) RDNIS= (N/A) Parkinglot= default Language= mn State= Up (6) Rings= 0 NativeFormat= (ulaw) WriteFormat= ulaw ReadFormat= ulaw RawWriteFormat= ulaw RawReadFormat= ulaw WriteTranscode= No ReadTranscode= No 1stFileDescriptor= 46 Framesin= 559 Framesout= 625 TimetoHangup= 0 ElapsedTime= 0h0m s BridgeID= (Not bridged) Context= macro-dumpchan Extension= s Priority= 1 CallGroup= PickupGroup= Application= DumpChan Data= (Empty) Blocking_in= (Not Blocking) Variables: MACRO_DEPTH=1 MACRO_PRIORITY=1 MACRO_CONTEXT=send-sms MACRO_EXTEN=s DIALEDPEERNUMBER=77777777/88888888 SIPCALLID=2acb005419bf921317853c8e0a1cafa5@ims.ub.unitel.mn ivrreturn=0 IVR_RETVM= IVR_CONTEXT=ivr-10 IVR_CONTEXT_ivr-10= CALLINGNUMPRES_SV=allowed_not_screened CALLINGNAMEPRES_SV=allowed_not_screened REVERSAL_REJECT=FALSE MOHCLASS= FROM_DID=+97677777777 REC_STATUS=RECORDING RECORD_ID=SIP/+97677777778-00000378 MIXMON_ID=0x7fb1d0056e10 CALLFILENAME=in-+97677777777-88888889-20220217-142149-1645078909.1158 REC_POLICY_MODE=FORCE MON_FMT=wav TIMESTR=20220217-142149 YEAR=2022 MONTH=02 DAY=17 DIRECTION=INBOUND ================================================================================ [2022-02-17 14:22:04] VERBOSE[26180][C-000001b9] pbx.c: Executing [s@macro-dumpchan:2] ResetCDR("SIP/77777777-00000379", "") in new stack [2022-02-17 14:22:04] VERBOSE[26180][C-000001b9] pbx.c: Executing [s@macro-dumpchan:3] ForkCDR("SIP/77777777-00000379", "") in new stack [2022-02-17 14:22:10] VERBOSE[26180][C-000001b9] bridge_channel.c: Channel SIP/+97677777778-00000378 left 'simple_bridge' basic-bridge <c8643e3c-067d-41ae-a228-fb8503564634> [2022-02-17 14:22:10] VERBOSE[26180][C-000001b9] pbx.c: Executing [h@send-sms:8] DumpChan("SIP/+97677777778-00000378", "") in new stack [2022-02-17 14:22:10] VERBOSE[26180][C-000001b9] app_dumpchan.c: Dumping Info For Channel: SIP/+97677777778-00000378: ================================================================================ Info: Name= SIP/+97677777778-00000378 Type= SIP UniqueID= 1645078909.1158 LinkedID= 1645078909.1158 CallerIDNum= 88888889 CallerIDName= 88888889 ConnectedLineIDNum= (N/A) ConnectedLineIDName=(N/A) DNIDDigits= +97677777777 RDNIS= (N/A) Parkinglot= default Language= mn State= Up (6) Rings= 0 NativeFormat= (ulaw) WriteFormat= ulaw ReadFormat= ulaw RawWriteFormat= ulaw RawReadFormat= ulaw WriteTranscode= No ReadTranscode= No 1stFileDescriptor= 22 Framesin= 1074 Framesout= 982 TimetoHangup= 0 ElapsedTime= 0h0m21s BridgeID= (Not bridged) Context= send-sms Extension= h Priority= 8 CallGroup= PickupGroup= Application= DumpChan Data= (Empty) Blocking_in= (Not Blocking) Variables: SYSTEMSTATUS=SUCCESS DIALSTATUS=ANSWER DIALEDTIME_MS=21483 DIALEDTIME=21 ANSWEREDTIME_MS=21462 ANSWEREDTIME=21 RTPAUDIOQOSRTT=minrtt=0.002273;maxrtt=0.004501;avgrtt=0.003117;stdevrtt=0.000019; RTPAUDIOQOSLOSS=minrxlost=0.000000;maxrxlost=0.000000;avgrxlost=0.000000;stdevrxlost=0.000000;reported_minlost=0.000000;reported_maxlost=13.000000;reported_avglost=3.750000;reported_stdevlost=15.256658; RTPAUDIOQOSJITTER=minrxjitter=0.000003;maxrxjitter=0.001043;avgrxjitter=0.000274;stdevrxjitter=inf;reported_minjitter=0.000000;reported_maxjitter=16.000000;reported_avgjitter=6.000000;reported_stdevjitter=32.484184; RTPAUDIOQOS=ssrc=916409440;themssrc=1681473114;lp=0;rxjitter=0.000000;rxcount=1061;txjitter=0.000440;txcount=963;rlp=0;rtt=0.002273 RTPAUDIOQOSRTTBRIDGED=minrtt=0.001098;maxrtt=0.001144;avgrtt=0.001121;stdevrtt=0.000001; RTPAUDIOQOSLOSSBRIDGED=minrxlost=0.000000;maxrxlost=1.000000;avgrxlost=0.333333;stdevrxlost=1.170628;reported_minlost=0.000000;reported_maxlost=12.000000;reported_avglost=4.000000;reported_stdevlost=14.047538; RTPAUDIOQOSJITTERBRIDGED=minrxjitter=0.000001;maxrxjitter=0.001128;avgrxjitter=0.000308;stdevrxjitter=inf;reported_minjitter=8.000000;reported_maxjitter=32.000000;reported_avgjitter=18.666667;reported_stdevjitter=20.014809; RTPAUDIOQOSBRIDGED=ssrc=1143936400;themssrc=3875000504;lp=1;rxjitter=0.000000;rxcount=860;txjitter=0.000331;txcount=864;rlp=0;rtt=0.001098 DIALEDPEERNUMBER=77777777/88888888 DIALEDPEERNAME=SIP/77777777-00000379 RINGTIME_MS=1671 RINGTIME=1 PROGRESSTIME_MS=1487 PROGRESSTIME=1 dugaar=202 dest=88888888 ivrreturn=0 BACKGROUNDSTATUS=SUCCESS IVR_MSG=custom/tsomoo_announce_day-8khz IVR_RETVM= IVR_CONTEXT=ivr-10 IVR_CONTEXT_ivr-10= INVALID_LOOPCOUNT=0 TIMEOUT_LOOPCOUNT=0 DB_RESULT= CALLINGNUMPRES_SV=allowed_not_screened CALLINGNAMEPRES_SV=allowed_not_screened REVERSAL_REJECT=FALSE MOHCLASS= GOSUB_RETVAL= CALLED_BLACKLIST=1 returnhere=1 FROM_DID=+97677777777 REC_STATUS=RECORDING RECORD_ID=SIP/+97677777778-00000378 MIXMON_ID=0x7fb1d0056e10 LOCAL_MIXMON_ID=0x7fb1d0056e10 MIXMONITOR_FILENAME=/var/spool/asterisk/monitor/2022/02/17/in-+97677777777-88888889-20220217-142149-1645078909.1158.wav CALLFILENAME=in-+97677777777-88888889-20220217-142149-1645078909.1158 REC_POLICY_MODE=FORCE FROMEXTEN=88888889 REC_POLICY_MODE_SAVE= MON_FMT=wav TIMESTR=20220217-142149 YEAR=2022 MONTH=02 DAY=17 NOW=1645078909 DIRECTION=INBOUND 

14:21:53 - 14:22:04 - 11 сек - телефон звонил

14:22:04 - 14:22:10 - 6 сек - был отвечен / разговаривал

первый dumpchan - переменные, сразу после того как ответил

второй dumpchan - переменные, после того как положил трубку - dialedtime=21 answeredtime=21

Отсюда мы видим что, несмотря на то что разговор был 6 секунд, answeredtime считает с самого начал звонка и имеет значение 21 секунду. Отсюда и billsec в таблице cdr (asteriskcdrdb) тоже 21 секунда. Может есть какие-нибудь настройки которые исправят ошибку.