Баг ПрогДВБ 7.60.01.

#1
Последняя версия ПрогДВБ вызывает противоречивые чувства. С одной стороны, каналы включаются очень быстро. С другой стороны, возникают реконнекты и иногда довольно часто. Не уверен, что это хорошо и правильно.
А ещё я заметил баг с радиоканалами. Что-то похожее уже как-то было. Они прекращают работать вскоре после их включения. Лог с 13:29 по 13:32 тому подтверждение.
Attachments
2024-02-24_13-29-39.png
ProgLogs (1).zip
(2.59 MiB) Downloaded 17 times

Re: Баг ПрогДВБ 7.60.01.

#3
Prog wrote:
Sat Feb 24, 2024 11:55 am
После пропания звука лог сохранили? Как это место найти?
Лог с 13:29 по 13:32. Как включил BBC Radio London в 13:29, так звук через некоторое количество секунд - может, пятнадцать - и пропал.

Re: Баг ПрогДВБ 7.60.01.

#4
Prog wrote:
Sat Feb 24, 2024 11:55 am
Да не должно работать быстрее. Все изменения были посвещены добавлению libvlc
Каналы включаются быстрее. Не знаю, может, у ПрогДВБ какой-то баг с накоплением, например, оно не работает, как надо, тем более возникают реконнекты.
Мне в принципе нравится, когда каналы быстро открываются, хотя реконнекты немного расстраивают. Может, можно как-тоо подкрутить ПрогДВБ, чтобы каналы открывалися быстро, а реконнектов не было?

Re: Баг ПрогДВБ 7.60.01.

#5
Всё тот же баг:


09:20:15.822 -
09:20:15.823 -
09:20:15.823 - ########################### Mark of start channel changing.###########################
09:20:15.824 -
09:20:15.824 - GraphManager::MainChangeChannel BBC Radio London 1 provs
09:20:15.825 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
09:20:15.825 - SetChannelLogic::SetChannel 0
09:20:15.826 - SetChannelLogic::SetNormalChannel
09:20:15.827 - [102]Stop channel
09:20:15.827 - PreScanner.Stop
09:20:15.828 - GraphState: Undef by PreScanner.Stop
09:20:15.828 - PlayTimePmtParser::StopParser
09:20:15.829 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
09:20:15.829 - Prereader::ReaderCursor.. OK
09:20:15.830 - ReaderCursor::SetPosition 0 (w=2102609829691392)
09:20:15.831 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
09:20:15.831 - Prereader.StartPlayback after lock
09:20:15.832 - subsm.StopChannel
09:20:15.832 - DestroyPlayer th=0
09:20:15.855 - Destroy Audio Processor stop
09:20:15.855 - DestroyPlayer - after
09:20:15.856 - **** StopChannel time 0.031ms
09:20:15.856 -
09:20:15.856 - TransponderManager::SetTransponder (CH) 0 BBC Radio London
09:20:15.857 - *Transport TS
09:20:15.857 - Api2Device::SetChannel http://as-hls-ww-live.akamaized.net/poo ... ewind.m3u8
09:20:15.860 - Delete timer 1000 HlsReader
09:20:15.861 - Api2Device::SetChannel result OK
09:20:15.861 - Api2BaseModule.OnTunerStateChanged Connecting
09:20:15.861 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=43981
09:20:15.862 - TsInputTrafficProcessor.OpenTransponder 1
09:20:15.863 - FilterManager::OnSetTransponder SetChannel
09:20:15.863 - TimeShift.Reset
09:20:15.864 - TimeShift.Cursor reset
09:20:15.865 - ReaderCursor::Reset.. OK
09:20:15.866 - Prereader.Reset ...09:20:15.867 - Api2BaseModule.OnTunerStateChanged Preparing
-OK
09:20:15.869 - Create EPGparser on SetChannel
09:20:15.869 - DvbEpgParser::SetChannel ID=7b340002.e3ebffc28105951b.abcd
09:20:15.873 - DvbEpgParser::mode normal pos=0
09:20:15.873 - ModuleList::ChangeChannel 0
09:20:15.874 - **** SetTransponder time 0.016ms
09:20:15.874 - [102]ChannelGraph5::StartChannel BBC Radio London
09:20:15.875 - AV:UpdateAudioParamsAfterActive
09:20:15.875 - AV:UpdateAudioProcessor spec=0 agc=1 bands=-200
09:20:15.876 - GR:UpdateAudioProcessor old=0 new=1
09:20:15.876 - CPCG SetVolume 00000000 100
09:20:15.877 -
09:20:15.877 - [102] #################### Start stream. (0.047ms) #######################
09:20:15.877 -
09:20:15.883 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
09:20:15.884 - TimeShift.Cursor SetChannel::v 0 (0)
09:20:15.884 - ReaderCursor::SetChannel.. OK
09:20:15.885 - ReaderCursor::SetPosition 0 (w=0)
09:20:15.885 - Prereader.SetChannel..
09:20:15.886 - Prereader.SetChannel unmask 1
09:20:15.886 - Plugin::SetChannel 43981
09:20:15.886 - TransponderManager::SelectChannel
09:20:15.887 - TsInputTrafficProcessor.SelectChannel 43981
09:20:15.887 - Api2BaseModule.UpdateAllOpenedChannels 1
09:20:15.887 - TsInputTrafficProcessor.UpdateChannel 43981
09:20:15.888 - GraphState: Undef by StartChannelIsReady
09:20:15.888 - PreScanner.StartChannelIsReady net=1 parseall=1
09:20:15.888 - VideoMediaTypeDetection: mpeg2
09:20:15.889 - SetMarkerAudioLngStream Gen New stream
09:20:15.889 - SimpleTsDemux::Init apid=34, vpid=100
09:20:15.890 - GraphState: RequestPATScan by StartChannelIsReady TS
09:20:15.890 - Api2BaseModule.Filters_EnabledFullTS 1
09:20:15.891 - PlayTimePATParser.OpenParser 43981
09:20:15.891 - Open TSTS filter pid=0 data=0
09:20:15.891 - TSTS cur size=0
09:20:15.892 - **** StartChanbnel time 0.016ms
09:20:15.892 - [102]OnChangeCurrentGraph2 -endOfSetChannel
09:20:15.893 - ChannelGraph.SetActiveState 1
09:20:15.904 - [102]**** SetChannel is finished (OK). Duration 0.078ms
09:20:15.909 - ------sGetVideoParams
09:20:16.380 - Api2BaseModule.OnTunerStateChanged Playing
09:20:16.549 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 Connecting
09:20:16.561 - Add timer 1000 HlsReader
09:20:16.716 - TransportMarker: TS
09:20:16.717 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
09:20:16.818 -
09:20:16.819 - #################### First traffic. (1.000ms) #######################
09:20:16.819 -
09:20:16.820 - PlayTimePATParser.EndTask
09:20:16.922 - --SwitchEngineTransport TS > TS
09:20:16.923 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
09:20:16.923 - PreScanner.OnTransportMarker TS
09:20:16.924 - --SwitchEngineTransport end
09:20:16.924 - PreScanner.OnAfterScanPat count=2 {16727;32}
09:20:16.924 - Api2BaseModule.Filters_EnabledFullTS 0
09:20:16.925 - GraphState: RequestPMTScan by OnAfterScanPat
09:20:16.925 - PlayTimePmtParser::OpenParser SID=16727 PMT=32 unknow channel=1
09:20:16.925 - Open TSTS filter pid=32 data=2
09:20:16.926 - TSTS cur size=81592
09:20:16.926 - TSTS quick finish
09:20:16.928 - PreScanner.OnAfterScanPmt pmt=32
09:20:16.928 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
09:20:16.929 - PlayTimePmtParser::StopParser
09:20:16.936 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
09:20:16.936 - TimeShift.Cursor SetChannel::v 81592 (81592)
09:20:16.936 - Prereader.SetChannel unmask 1
09:20:16.937 - Plugin::SetChannel 16727
09:20:16.937 - TransponderManager::SelectChannel
09:20:16.938 - TsInputTrafficProcessor.SelectChannel 16727
09:20:16.938 - Api2BaseModule.UpdateAllOpenedChannels 1
09:20:16.938 - TsInputTrafficProcessor.UpdateChannel 16727
09:20:16.939 - PreScanner.StartChannelIsReady net=1 parseall=0
09:20:16.939 - LngDefaultSelector.try select audio pid=34 type=1 lng=0-(enm;ang;eng,deu;gmh;goh;ger,rus) l=99
09:20:16.939 - ChannelGraph::AfterDetectChannelParams
09:20:16.940 - SimpleTsDemux::Init apid=34, vpid=0
09:20:16.940 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
09:20:16.940 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
09:20:16.941 - Prereader::ReaderCursor.. OK
09:20:16.941 - ReaderCursor::SetPosition 0 (w=350434971615232)
09:20:16.942 - Prereader.StartPlayback Push buffering=0 recv=0F71D7B4 [StartChannelHelperBase(sl)]
09:20:16.942 - Prereader.StartPlayback after lock
09:20:16.943 - PreScanner.StartPmtParserIfNeed
09:20:16.943 - PlayTimePmtParser::OpenParser SID=16727 PMT=32 unknow channel=0
09:20:16.944 - Open TSTS filter pid=32 data=2
09:20:16.944 - TSTS cur size=81592
09:20:16.946 - AudioParser::First packet 3090
09:20:16.946 - AudioParser::AAC detected
09:20:16.946 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
09:20:16.947 - PreScanner.Post_InitRender [ReceiveTraffic]
09:20:16.950 -
09:20:16.951 - [102] #################### Init Render. (1.125ms) #######################
09:20:16.951 -
09:20:16.952 - selector PlaybackTag=none videocodec=FFmpegS/ ts=1
09:20:16.952 - Channel PlaybackWay after check FFmpegS
09:20:16.953 - GraphState: GraphStarted by AsyncInitRender
09:20:16.953 - CalculBufferingSize prov=0C9AAD04 marker=1 request=1
09:20:16.954 - CalculBuffering 2000ms br=128kb to 32 kbytes. By type
09:20:16.954 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
09:20:16.954 - Prereader::ReaderCursor.. OK
09:20:16.955 - ReaderCursor::SetPosition 0 (w=350434971615232)
09:20:16.956 - Prereader.StartPlayback Pull buffering=32768 recv=00000000 [EnablePullModeAndStartPlayback]
09:20:16.956 - Prereader.StartPlayback after lock
09:20:16.956 - Buffering/prereader size 32/3906 kbytes
09:20:16.957 - Not same player! old 0 new 3 prev 3
09:20:16.957 - ------sGetVideoParams
09:20:16.961 - Create FFMpegTvPlayer
09:20:16.962 - before render create or reset m=3 radio=1
09:20:16.963 - AV:UpdateAudioParamsAfterActive
09:20:16.963 - AV:UpdateAudioProcessor spec=0 agc=1 bands=-200
09:20:16.964 - GR:UpdateAudioProcessor old=0 new=1
09:20:16.964 - AP: created
09:20:16.965 - Create Audio Processor update 1FEA4990
09:20:16.966 - CPCG SetVolume 1FEA1AC0 100
09:20:16.966 - AudioProcessor::Equalizer_SetBands
09:20:16.966 - AP: Spectrum_Enable 0
09:20:16.967 - AP: agc enable 1 1/4000
09:20:16.967 - subsm.StartChannel demux=FFmpeg tr=TS
09:20:16.968 - subsm.RecreateSubtitlesParsers 1FEA1AD0 ts=1 subindex=-1 st=-1
09:20:16.968 - subsm.Stop teletext parser
09:20:16.970 - subsm.RecreateSubtitlesParsers end
09:20:16.970 - subs: OnSetChannel
09:20:16.974 - ------sGetVideoParams
09:20:16.999 - * s:100 q:100 tr=81780 (0) - ntt-1 dmx-2147483648 -1 Preparing
09:20:17.105 -
09:20:17.106 - [0]########################### Mark of finish channel changing. (1.281ms) #############
09:20:17.106 -
09:20:17.714 - * s:0 q:100 tr=81592 (0) - ntt375 dmx0 -1 Buffering
09:20:18.465 - * s:0 q:100 tr=0 (0) - ntt1125 dmx0 -1 Buffering
09:20:19.451 - * s:100 q:100 tr=163184 (0) - ntt0 dmx0 -1 Playing
09:20:20.516 - * s:100 q:100 tr=81592 (0) - ntt0 dmx0 -1 Playing
09:20:21.516 - * s:100 q:100 tr=0 (0) - ntt0 dmx0 -1 Playing
09:20:22.428 - * s:100 q:100 tr=0 (0) - ntt0 dmx0 -1 Playing
09:20:23.434 - * s:100 q:100 tr=0 (0) - ntt0 dmx0 -1 Playing
09:20:24.437 - * s:100 q:100 tr=0 (0) - ntt0 dmx0 -1 Playing
09:20:25.436 - * s:0 q:0 tr=0 (0) - ntt0 dmx0 -1 Playing
09:20:26.470 - * s:0 q:0 tr=0 (0) - ntt0 dmx0 -1 Playing
09:20:27.439 - * s:100 q:100 tr=81592 (0) - ntt0 dmx0 -1 Playing
09:20:28.121 - * s:100 q:100 tr=0 (0) - ntt0 dmx0 -1 Playing
09:20:28.740 - * s:100 q:100 tr=0 (0) - ntt0 dmx0 -1 Playing
09:20:29.212 - TransponderManager::RefreshChannel ! 0s chunk=1 net=1 10000ms error0

Звук с 09:20:16.999 по 09:20:29.212. Дальше - тишина.
Attachments
ProgLogs (2).zip
(205.72 KiB) Downloaded 15 times