﻿22:38:10.599 - Start logging...
22:38:10.911 -  ProgDVBVideoWindow    NotForceAPforRadio WinGetStateInMainThread
22:38:11.033 - InterfaceApiManagerWnd CreateWnd
22:38:11.034 - DevicesManager::Start
22:38:11.063 - AVManager::Init
22:38:11.115 - SetDefaultNullCodecs
22:38:11.128 - Codec from file: D:\ProgDVB x64 Network Edition\LAVAudio.ax 000001D621874898
22:38:11.153 - Codec from file: D:\ProgDVB x64 Network Edition\LAVAudio.ax 000001D621874898
22:38:11.178 - Codec from file: D:\ProgDVB x64 Network Edition\LAVAudio.ax 000001D621874898
22:38:11.209 - Codec from file: D:\ProgDVB x64 Network Edition\LAVAudio.ax 000001D621874898
22:38:11.246 - Codec from file: D:\ProgDVB x64 Network Edition\LAVVideo.ax 000001D621914858
22:38:11.279 - Codec from file: D:\ProgDVB x64 Network Edition\LAVVideo.ax 000001D621914858
22:38:11.304 - Codec from file: D:\ProgDVB x64 Network Edition\LAVVideo.ax 000001D621914858
22:38:11.336 - Codec from file: D:\ProgDVB x64 Network Edition\LAVVideo.ax 000001D621914858
22:38:11.366 - Codec from file: D:\ProgDVB x64 Network Edition\LAVVideo.ax 000001D621914858
22:38:11.409 - Codec from file: D:\ProgDVB x64 Network Edition\LAVVideo.ax 000001D621914858
22:38:11.449 - Codec from file: D:\ProgDVB x64 Network Edition\LAVVideo.ax 000001D621914858
22:38:11.481 - RemoveAllCreateBlank needBlank0
22:38:11.800 - DevicesManager::EnableCISupport
22:38:11.800 - CAVManager::SetSettings
22:38:11.836 - DevicesManager::DestroyAllTransponderManager
22:38:11.915 - SetDefaultNullCodecs
22:38:11.922 - Codec from file: D:\ProgDVB x64 Network Edition\LAVAudio.ax 000001D62186C018
22:38:11.959 - Codec from file: D:\ProgDVB x64 Network Edition\LAVAudio.ax 000001D62186C018
22:38:11.979 - Codec from file: D:\ProgDVB x64 Network Edition\LAVAudio.ax 000001D62186C018
22:38:12.022 - Codec from file: D:\ProgDVB x64 Network Edition\LAVAudio.ax 000001D62186C018
22:38:12.058 - Codec from file: D:\ProgDVB x64 Network Edition\LAVVideo.ax 000001D621928198
22:38:12.089 - Codec from file: D:\ProgDVB x64 Network Edition\LAVVideo.ax 000001D621928198
22:38:12.130 - Codec from file: D:\ProgDVB x64 Network Edition\LAVVideo.ax 000001D621928198
22:38:12.169 - Codec from file: D:\ProgDVB x64 Network Edition\LAVVideo.ax 000001D621928198
22:38:12.201 - Codec from file: D:\ProgDVB x64 Network Edition\LAVVideo.ax 000001D621928198
22:38:12.232 - Codec from file: D:\ProgDVB x64 Network Edition\LAVVideo.ax 000001D621928198
22:38:12.263 - Codec from file: D:\ProgDVB x64 Network Edition\LAVVideo.ax 000001D621928198
22:38:12.502 - DevicesManager::StartDevices...
22:38:12.502 - DevicesManager::Before start:
22:38:12.540 - device netclient.0 22:38:12.581 - LoadDll D:\ProgDVB x64 Network Edition\Modules\netclient.Device - 00007FF82C960000
22:38:12.626 - dev: UpdateNetworkRecommendations  760x524 -1x-1
22:38:12.658 - dev: Created  netclient.0 000001D62187E350
OK
22:38:12.731 - Api2BaseModule.GetAdditionInfo
22:38:12.767 - Api2BaseModule.GetAdditionInfo OK
22:38:12.840 - AV:UpdateAudioParamsAfterActive
22:38:13.123 - DevicesManager::EnableCISupport
22:38:13.123 - Api2Device::CI3_EnableCISupport
22:38:13.155 - CAVManager::SetSettings
22:38:13.211 - Api2BaseModule.SetDialogSettings
22:38:13.235 - Api2BaseModule.SetDialogSettings
22:38:14.041 - Api2BaseModule.OnDisplaySize
22:38:14.041 - dev: UpdateNetworkRecommendations  2361x1280 -1x-1
22:38:14.174 - Api2BaseModule.OnDisplaySize
22:38:14.174 - dev: UpdateNetworkRecommendations  3866x2090 -1x-1
22:38:14.852 - * s:0 q:0 tr=0 (0)  offline
22:38:15.631 - * s:0 q:0 tr=0 (0)  offline
22:38:16.673 - * s:0 q:0 tr=0 (0)  offline
22:38:17.665 - * s:0 q:0 tr=0 (0)  offline
22:38:18.645 - * s:0 q:0 tr=0 (0)  offline
22:38:19.687 - * s:0 q:0 tr=0 (0)  offline
22:38:20.697 - * s:0 q:0 tr=0 (0)  offline
22:38:21.675 - * s:0 q:0 tr=0 (0)  offline
22:38:22.723 - * s:0 q:0 tr=0 (0)  offline
22:38:22.908 - Api2BaseModule.OnDisplaySize
22:38:22.908 - dev: UpdateNetworkRecommendations  2361x1280 -1x-1
22:38:23.115 - Api2BaseModule.OnDisplaySize
22:38:23.115 - dev: UpdateNetworkRecommendations  3840x2160 -1x-1
22:38:23.213 - Api2BaseModule.OnDisplaySize
22:38:23.213 - dev: UpdateNetworkRecommendations  3866x2090 -1x-1
22:38:23.658 - * s:0 q:0 tr=0 (0)  offline
22:38:24.578 - * s:0 q:0 tr=0 (0)  offline
22:38:25.564 - * s:0 q:0 tr=0 (0)  offline
22:38:26.564 - * s:0 q:0 tr=0 (0)  offline
22:38:27.568 - * s:0 q:0 tr=0 (0)  offline
22:38:28.574 - * s:0 q:0 tr=0 (0)  offline
22:38:29.581 - * s:0 q:0 tr=0 (0)  offline
22:38:30.753 - 
22:38:30.753 - 
22:38:30.800 - ########################### Mark of start channel changing.###########################
22:38:30.837 - 
22:38:30.865 - GraphManager::MainChangeChannel Laym Armenius TV  1 provs
22:38:30.907 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
22:38:30.929 - SetChannelLogic::SetChannel 0
22:38:30.961 - SetChannelLogic::SetNormalChannel
22:38:31.007 - DevicesManager::CreateCloneDevice
22:38:31.040 - DevicesManager::CreateCloneDevice OK - founded in list
22:38:31.072 - TransponderManager
22:38:31.106 - CTransponderManager::InitOnNewDevice 000001D62194C968
22:38:31.142 - SetOwner N -> Incoming Stream Cache
22:38:31.179 - TrafficProcessingScheme_CreateForNewEngineTransport 1 ss=0
22:38:31.215 - Normal TsInputTrafficProcessor.
22:38:31.253 - FilterManager::InitOnNewDevice 1
22:38:31.281 - TS router+MarkerFinder -> InputTrafficProcessor
22:38:31.310 - Incoming Stream Cache -> TS router+MarkerFinder
22:38:31.342 - InputTrafficProcessor -> Router to timeshift
22:38:31.378 - InputTrafficProcessor(FM) -> FilterManager
22:38:31.406 - ModuleList::Free
22:38:31.444 - Add timer 1000 BaseTransponderManaer
22:38:31.470 - TransponderManager::AddChildChannel
22:38:31.502 - TimeShift.TimeShift
22:38:31.533 - TimeShift.Create 500 mbytes 
22:38:31.565 - ts:One channel
22:38:31.612 - HugeMemoryBlocksManager::GetBlock 500 mbytes OK
22:38:31.653 - TransponderManager::CreateTimeshiftBuffer OK
22:38:31.701 - TimeShift.CreateReadingCursor
22:38:31.725 - TransponderChannelSource.Plugins 000001D62296F700 c 0000000000000000
22:38:31.757 - TsInputTrafficProcessor.AddChannel 0
22:38:31.793 - AndroidChannelPlayback created TestMode=0
22:38:31.821 - SetChannelLogic::LookDeviceWithoutChannelsOrCloneAndMakeGraph
22:38:31.852 - add graph 000001D622ACD8A0 101
22:38:31.918 - ChannelGraph.SetActiveState 1
22:38:31.918 - TransponderManager::SelectChannel
22:38:31.950 - TsInputTrafficProcessor.SelectChannel 0
22:38:31.979 - Api2BaseModule.UpdateAllOpenedChannels 0
22:38:32.018 - **** StopChannel time 1.266ms
22:38:32.059 - 
22:38:32.091 - TransponderManager::SetTransponder (CH) 0 Laym Armenius TV
22:38:32.122 - *Transport TS
22:38:32.156 - Api2Device::SetChannel https://v2.catcast.tv/content/40504/index.m3u8
22:38:32.408 - Api2BaseModule.OnTunerStateChanged Connecting
22:38:32.450 - Api2BaseModule.OnTunerStateChanged  -3
22:38:32.450 - Api2Device::SetChannel result OK
22:38:32.479 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=43981
22:38:32.520 - TsInputTrafficProcessor.OpenTransponder 1
22:38:32.554 - FilterManager::OnSetTransponder SetChannel
22:38:32.592 - TimeShift.Reset
22:38:32.640 - TimeShift.Cursor reset
22:38:32.679 - ReaderCursor::Reset.. OK
22:38:32.769 - Prereader.Reset ...-OK
22:38:32.845 - ModuleList::ChangeChannel 0
22:38:32.890 - **** SetTransponder time 0.859ms
22:38:32.924 - [101]ChannelGraph5::StartChannel Laym Armenius TV
22:38:32.967 - AV:UpdateAudioParamsAfterActive
22:38:33.003 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
22:38:33.043 - GR:UpdateAudioProcessor old=0 new=0
22:38:33.086 - CPCG SetVolume 0000000000000000 0
22:38:33.131 - 
22:38:33.179 - [101]       #################### Start stream. (2.422ms) #######################
22:38:33.183 - 
22:38:33.213 - TimeShift.Cursor SetChannel pidmask=0000000000000000 first=1
22:38:33.249 - TimeShift.Cursor SetChannel::v 0 (0)
22:38:33.288 - ReaderCursor::SetChannel.. OK
22:38:33.368 - ReaderCursor::SetPosition 0 (w=0)
22:38:33.416 - Prereader.SetChannel..
22:38:33.456 - Prereader.SetChannel unmask 1
22:38:33.498 - Plugin::SetChannel 43981
22:38:33.535 - TransponderManager::SelectChannel
22:38:33.585 - TsInputTrafficProcessor.SelectChannel 43981
22:38:33.641 - Api2BaseModule.UpdateAllOpenedChannels 1
22:38:33.683 - TsInputTrafficProcessor.UpdateChannel 43981
22:38:33.721 - GraphState: Undef by StartChannelIsReady
22:38:33.767 - PreScanner.StartChannelIsReady net=1 parseall=1
22:38:33.823 - SimpleTsDemux::Init apid=0, vpid=0
22:38:33.863 - GraphState: RequestPATScan by StartChannelIsReady TS
22:38:33.911 - Api2BaseModule.Filters_EnabledFullTS 1
22:38:33.956 - PlayTimePATParser.OpenParser 43981
22:38:33.999 - Open TSTS filter pid=0 data=0
22:38:34.041 - TSTS cur size=0
22:38:34.082 - **** StartChannel time 1.204ms
22:38:34.125 - [101]OnChangeCurrentGraph2 -endOfSetChannel
22:38:34.166 - ChannelGraph.SetActiveState 1
22:38:34.177 - Api2BaseModule.OnTunerStateChanged Preparing
22:38:34.359 - Api2BaseModule.OnTunerStateChanged  -4
22:38:34.373 - Api2BaseModule.OnTunerStateChanged Playing
22:38:34.401 - CPCG SetVolume 0000000000000000 0
22:38:34.474 - Api2BaseModule.OnTunerStateChanged  -4
22:38:34.712 - ------sGetVideoParams
22:38:34.885 - Api2BaseModule.OnTunerStateChanged AnswerNotRecognized
22:38:34.976 - Api2BaseModule.OnTunerStateChanged  --108
22:38:36.106 - [101]**** SetChannel is finished (OK). Duration 5.344ms
22:38:36.762 - Api2BaseModule.OnTunerStateChanged AnswerNotRecognized
22:38:36.802 - Api2BaseModule.OnTunerStateChanged  --108
22:38:37.030 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 AnswerNotRecognized
22:38:37.777 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 AnswerNotRecognized
22:38:38.591 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 AnswerNotRecognized
22:38:39.333 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 AnswerNotRecognized
22:38:40.245 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 AnswerNotRecognized
22:38:41.247 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 AnswerNotRecognized
22:38:42.275 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 AnswerNotRecognized
22:38:43.236 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 AnswerNotRecognized
22:38:44.238 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 AnswerNotRecognized
22:38:45.266 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 AnswerNotRecognized
22:38:46.234 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 AnswerNotRecognized
22:38:47.222 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 AnswerNotRecognized
22:38:48.207 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 AnswerNotRecognized
22:38:49.240 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 AnswerNotRecognized
22:38:50.239 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 AnswerNotRecognized
22:38:51.225 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 AnswerNotRecognized
22:38:52.275 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 AnswerNotRecognized
22:38:53.209 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 AnswerNotRecognized
22:38:54.442 - 
22:38:54.442 - 
22:38:54.474 - ########################### Mark of start channel changing.###########################
22:38:54.507 - 
22:38:54.537 - GraphManager::MainChangeChannel Hi Hop TV  1 provs
22:38:54.569 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
22:38:54.606 - SetChannelLogic::SetChannel 0
22:38:54.648 - SetChannelLogic::SetNormalChannel
22:38:54.732 - [101]Stop channel
22:38:54.732 - PreScanner.Stop
22:38:54.762 - GraphState: Undef by PreScanner.Stop
22:38:54.791 - Api2BaseModule.Filters_EnabledFullTS 0
22:38:54.825 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
22:38:54.857 - Prereader::ReaderCursor.. OK
22:38:54.919 - ReaderCursor::SetPosition 0 (w=0)
22:38:54.951 - Prereader.StartPlayback Disable buffering=0 recv=0000000000000000 [Engine5ChannelBase.StopChannel]
22:38:54.998 - Prereader.StartPlayback after lock
22:38:55.036 - subsm.StopChannel
22:38:55.062 - **** StopChannel time 0.609ms
22:38:55.110 - 
22:38:55.142 - TransponderManager::SetTransponder (CH) 0 Hi Hop TV
22:38:55.174 - *Transport TS
22:38:55.224 - Api2Device::SetChannel http://k4.usastreams.com/festivatelevision/HiHop/media.m3u8
22:38:55.511 - Api2BaseModule.OnTunerStateChanged Connecting
22:38:55.553 - Api2BaseModule.OnTunerStateChanged  -3
22:38:55.553 - Api2Device::SetChannel result OK
22:38:55.615 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=43981
22:38:55.657 - TsInputTrafficProcessor.OpenTransponder 1
22:38:55.700 - FilterManager::OnSetTransponder SetChannel
22:38:55.734 - TimeShift.Reset
22:38:55.771 - TimeShift.Cursor reset
22:38:55.795 - ReaderCursor::Reset.. OK
22:38:55.887 - Prereader.Reset ...-OK
22:38:55.954 - ModuleList::ChangeChannel 0
22:38:55.986 - **** SetTransponder time 0.938ms
22:38:56.037 - [101]ChannelGraph5::StartChannel Hi Hop TV
22:38:56.066 - AV:UpdateAudioParamsAfterActive
22:38:56.113 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
22:38:56.113 - Api2BaseModule.OnTunerStateChanged Preparing
22:38:56.151 - GR:UpdateAudioProcessor old=0 new=0
22:38:56.244 - Api2BaseModule.OnTunerStateChanged  -4
22:38:56.244 - CPCG SetVolume 0000000000000000 0
22:38:56.303 - 
22:38:56.303 - Api2BaseModule.OnTunerStateChanged Playing
22:38:56.335 - [101]       #################### Start stream. (1.891ms) #######################
22:38:56.414 - Api2BaseModule.OnTunerStateChanged  -4
22:38:56.414 - 
22:38:56.769 - TimeShift.Cursor SetChannel pidmask=0000000000000000 first=1
22:38:56.769 - TimeShift.Cursor SetChannel::v 0 (0)
22:38:56.821 - ReaderCursor::SetChannel.. OK
22:38:56.875 - ReaderCursor::SetPosition 0 (w=0)
22:38:56.907 - Prereader.SetChannel..
22:38:56.955 - Prereader.SetChannel unmask 1
22:38:56.990 - Plugin::SetChannel 43981
22:38:57.018 - TransponderManager::SelectChannel
22:38:57.050 - TsInputTrafficProcessor.SelectChannel 43981
22:38:57.098 - Api2BaseModule.UpdateAllOpenedChannels 1
22:38:57.133 - TsInputTrafficProcessor.UpdateChannel 43981
22:38:57.173 - GraphState: Undef by StartChannelIsReady
22:38:57.217 - PreScanner.StartChannelIsReady net=1 parseall=1
22:38:57.257 - VideoMediaTypeDetection: h.264
22:38:57.289 - SetMarkerAudioLngStream Gen New stream
22:38:57.321 - SimpleTsDemux::Init apid=257, vpid=256
22:38:57.359 - GraphState: RequestPATScan by StartChannelIsReady TS
22:38:57.385 - Api2BaseModule.Filters_EnabledFullTS 1
22:38:57.416 - PlayTimePATParser.OpenParser 43981
22:38:57.458 - Open TSTS filter pid=0 data=0
22:38:57.480 - TSTS cur size=0
22:38:57.530 - **** StartChannel time 1.531ms
22:38:57.560 - [101]OnChangeCurrentGraph2 -endOfSetChannel
22:38:57.596 - ChannelGraph.SetActiveState 1
22:38:58.318 - [101]**** SetChannel is finished (OK). Duration 3.875ms
22:38:58.799 - Add timer 1000 HlsReader
22:38:58.943 - Api2BaseModule.EngineApi_ChList_SendSubChannels 1/2
22:38:59.544 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 Connecting
22:39:00.353 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 Connecting
22:39:01.170 - TransportMarker: TS
22:39:01.170 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=524288000
22:39:01.212 - 
22:39:01.268 -        #################### First traffic. (6.828ms) #######################
22:39:01.312 - --SwitchEngineTransport TS > TS
22:39:01.312 - 
22:39:01.401 - PlayTimePATParser.EndTask
22:39:01.435 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=524288000
22:39:01.477 - PreScanner.OnTransportMarker TS
22:39:01.630 - --SwitchEngineTransport end
22:39:01.630 - PreScanner.OnAfterScanPat count=2 {1;4095}
22:39:01.673 - Api2BaseModule.Filters_EnabledFullTS 0
22:39:01.722 - GraphState: RequestPMTScan by OnAfterScanPat
22:39:01.773 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=1
22:39:01.806 - Open TSTS filter pid=4095 data=2
22:39:01.842 - TSTS cur size=144572
22:39:01.874 - TSTS quick finish
22:39:01.914 - PreScanner.OnAfterScanPmt pmt=4095
22:39:01.957 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
22:39:01.994 - PlayTimePmtParser::StopParser
22:39:02.476 - TimeShift.Cursor SetChannel pidmask=0000000000000000 first=0
22:39:02.476 - TimeShift.Cursor SetChannel::v 358892 (358892)
22:39:02.516 - Prereader.SetChannel unmask 1
22:39:02.564 - Plugin::SetChannel 1
22:39:02.597 - TransponderManager::SelectChannel
22:39:02.627 - TsInputTrafficProcessor.SelectChannel 1
22:39:02.660 - Api2BaseModule.UpdateAllOpenedChannels 1
22:39:02.691 - TsInputTrafficProcessor.UpdateChannel 1
22:39:02.741 - PreScanner.StartChannelIsReady net=1 parseall=0
22:39:02.787 - LngDefaultSelector.try select audio pid=257 type=1 lng=0-(rus,enm;ang;eng,rus) l=99
22:39:02.818 - ChannelGraph::AfterDetectChannelParams
22:39:02.856 - VideoMediaTypeDetection: h.264
22:39:02.882 - SimpleTsDemux::Init apid=257, vpid=256
22:39:02.914 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
22:39:02.952 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
22:39:02.982 - Prereader::ReaderCursor.. OK
22:39:03.053 - ReaderCursor::SetPosition 0 (w=568324)
22:39:03.089 - Prereader.StartPlayback Push buffering=0 recv=000001D622ACE290 [StartChannelHelperBase(sl)]
22:39:03.121 - Prereader.StartPlayback after lock
22:39:03.163 - PreScanner.StartPmtParserIfNeed
22:39:03.163 - VideoParser::First packet 38554 h.264
22:39:03.195 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=0
22:39:03.217 - h264 detected 0 ms
22:39:03.265 - Open TSTS filter pid=4095 data=2
22:39:03.281 - AudioParser::First packet 1205
22:39:03.329 - TSTS cur size=712708
22:39:03.360 - AudioParser::aac detected
22:39:03.424 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
22:39:03.524 - PreScanner.Post_InitRender [ReceiveTraffic]
22:39:03.524 - * s:100 q:100 tr=784148 (0) - ntt-1 dmx0 -1 Preparing
22:39:03.602 - 
22:39:03.651 - [101]       #################### Init Render. (9.203ms) #######################
22:39:03.687 - 
22:39:03.721 - ------sGetVideoParams
22:39:03.754 - video:h264 SD
22:39:03.787 - selector PlaybackTag=none videocodec=DS/ ts=1
22:39:03.822 - Channel PlaybackWay after check DS
22:39:03.893 - GraphState: GraphStarted by AsyncInitRender
22:39:03.895 - CalculBufferingSize prov=000001D62194E1B4 marker=1 request=1
22:39:03.932 - CalculBuffering 5200ms br=2941kb to 1911 kbytes. from marker
22:39:03.974 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
22:39:04.010 - Prereader::ReaderCursor.. OK
22:39:04.076 - ReaderCursor::SetPosition 0 (w=1019336)
22:39:04.108 - Prereader.StartPlayback Pull buffering=1957831 recv=0000000000000000 [EnablePullModeAndStartPlayback]
22:39:04.158 - Prereader.StartPlayback after lock
22:39:04.190 - Buffering/prereader size 1911/3906 kbytes
22:39:04.225 - Not same player! old 0 new 13 prev 0
22:39:04.261 - ------sGetVideoParams
22:39:04.302 - ------sGetVideoParams
22:39:04.450 - Add timer 1000 DirectShowPlayer
22:39:04.484 - Graph::SetVideoWindowRect {753 0 2623 1870}
22:39:04.484 - Graph::UpdateRenderMode
22:39:04.679 - Graph::SetVideoRect {8 8 712 568}
22:39:04.679 - Graph::SetVideoWindowRect {442 0 2935 1870}
22:39:04.730 - demux: ProgDemux
22:39:04.860 - ------sGetVideoParams
22:39:04.860 - ChannelGraph5.CreateInterfacesAndRenderGraph
22:39:04.903 - CreateCustomGraph
22:39:04.939 - VideoType:H.264/AVC ffmpeg=0
22:39:04.979 - Video/4.H264 : MPEG2_VIDEO s={0,0,720,576}, t={0,0,720,576}, bmp=720x576, r=48/29, br=0,frametime=40ms, IF=0x0, CF=0x0)
22:39:05.015 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f
22:39:05.049 - Codec from file: D:\ProgDVB x64 Network Edition\LAVVideo.ax 000001D622C6DE68
22:39:05.133 - OK
22:39:05.134 - CChannelGraph5::CreateRender 9
22:39:05.165 - VR: VMR9 Custom
22:39:05.202 - VR: create new render
22:39:05.583 - VR: Add video renderer Video Renderer - OK
22:39:05.584 - CreateAudioPartOfGraph
22:39:05.630 - AudioType:aac/adts 
22:39:05.669 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 44100 16bit formatTag= 0x1600)
22:39:05.705 - Codec from file: D:\ProgDVB x64 Network Edition\LAVAudio.ax 000001D644A76478
22:39:05.760 - Add audio codec e8e73b6b-4cb3-44a4-be99-4f7bcb96e491 - OK
22:39:05.836 - IMyGraphBuilder::CreateAudioRenderFilter::DirectSound: DENON-AVR -2 (Intel(R) Display Audio) OK (normal)
22:39:05.837 - Added audio renderer
22:39:05.905 - Add and connect audio renderer - OK
22:39:05.912 - Graph::AfterRender
22:39:05.952 - AV:UpdateAudioParamsAfterActive
22:39:05.994 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
22:39:06.032 - GR:UpdateAudioProcessor old=0 new=0
22:39:06.065 - CPCG SetVolume 000001D60472BFF0 0
22:39:06.101 - Graph::SetVolume 0% -10000db
22:39:06.138 - Graph::Run
22:39:06.337 - Graph::Run 1
22:39:06.385 - Graph::SetVideoRect {8 8 712 568}
22:39:06.389 - Graph::SetVideoWindowRect {141 0 3236 1870}
22:39:06.430 - 
22:39:06.438 - [0]########################### Mark of finish channel changing. (11.984ms) #############
22:39:06.472 - 
22:39:06.453 - AV:UpdateAudioParamsAfterActive
22:39:06.553 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
22:39:06.723 - GR:UpdateAudioProcessor old=0 new=0
22:39:06.725 - CPCG SetVolume 000001D60472BFF0 0
22:39:06.733 - Graph::SetVolume 0% -10000db
22:39:06.764 - Graph::Run
22:39:06.766 - Graph::Run 0
22:39:06.769 - subsm.StartChannel demux=ProgDemux tr=TS
22:39:06.771 - subsm.RecreateSubtitlesParsers 000001D6448BB3C0 ts=1 subindex=-1 st=-1
22:39:06.775 - subsm.Stop teletext parser
22:39:07.634 - subsm.RecreateSubtitlesParsers end
22:39:07.634 - subs: OnSetChannel
22:39:07.756 - ------sGetVideoParams
22:39:07.806 - ------sGetVideoParams
22:39:10.840 - * s:100 q:100 tr=2004268 (0) - ntt0 dmx4862 -1 Playing
22:39:12.101 - * s:100 q:100 tr=796744 (0) - ntt0 dmx5947 -1 Playing
22:39:13.998 - * s:100 q:100 tr=208304 (0) - ntt0 dmx5622 -1 Playing
22:39:15.998 - * s:100 q:100 tr=359268 (0) - ntt0 dmx5485 -1 Playing
22:39:18.129 - * s:100 q:100 tr=601412 (0) - ntt0 dmx4900 -1 Playing
22:39:19.579 - * s:100 q:100 tr=20304 (0) - ntt0 dmx6453 -1 Playing
22:39:21.155 - * s:100 q:100 tr=904844 (0) - ntt0 dmx5736 -1 Playing
22:39:22.362 - * s:100 q:100 tr=254928 (0) - ntt0 dmx4886 -1 Playing
22:39:23.181 - * s:100 q:100 tr=403260 (0) - ntt0 dmx4941 -1 Playing
22:39:24.527 - * s:100 q:100 tr=393860 (0) - ntt0 dmx4907 -1 Playing
22:39:25.771 - * s:100 q:100 tr=341220 (0) - ntt0 dmx11881 -1 Playing
22:39:26.281 - * s:100 q:100 tr=268276 (0) - ntt0 dmx11348 -1 Playing
22:39:27.456 - * s:100 q:100 tr=99640 (0) - ntt0 dmx10249 -1 Playing
22:39:27.786 - * s:100 q:100 tr=12596 (0) - ntt0 dmx9932 -1 Playing
22:39:30.043 - * s:100 q:100 tr=698984 (0) - ntt0 dmx10341 -1 Playing
22:39:30.556 - * s:100 q:100 tr=331632 (0) - ntt0 dmx9760 -1 Playing
22:39:31.245 - * s:100 q:100 tr=368480 (0) - ntt0 dmx9638 -1 Playing
22:39:32.182 - * s:100 q:100 tr=266020 (0) - ntt0 dmx8990 -1 Playing
22:39:32.879 - * s:100 q:100 tr=283316 (0) - ntt0 dmx8048 -1 Playing
22:39:33.553 - * s:100 q:100 tr=260380 (0) - ntt0 dmx8453 -1 Playing
22:39:34.199 - * s:100 q:100 tr=218644 (0) - ntt0 dmx8042 -1 Playing
22:39:35.351 - * s:100 q:100 tr=419428 (0) - ntt0 dmx7740 -1 Playing
22:39:37.252 - * s:100 q:100 tr=412284 (0) - ntt0 dmx8204 -1 Playing
22:39:38.769 - * s:100 q:100 tr=278616 (0) - ntt0 dmx7688 -1 Playing
22:39:39.654 - * s:100 q:100 tr=518504 (0) - ntt0 dmx7276 -1 Playing
22:39:40.359 - * s:100 q:100 tr=275044 (0) - ntt0 dmx7065 -1 Playing
22:39:41.489 - * s:100 q:100 tr=376188 (0) - ntt0 dmx6330 -1 Playing
22:39:42.950 - * s:100 q:100 tr=485040 (0) - ntt0 dmx5887 -1 Playing
22:39:43.978 - * s:100 q:100 tr=403824 (0) - ntt0 dmx6066 -1 Playing
22:39:45.766 - * s:100 q:100 tr=131412 (0) - ntt0 dmx4814 -1 Playing
22:39:46.765 - * s:100 q:100 tr=303432 (0) - ntt0 dmx4831 -1 Playing
22:39:47.735 - * s:100 q:100 tr=286136 (0) - ntt0 dmx4706 -1 Playing
22:39:48.651 - * s:100 q:100 tr=328248 (0) - ntt0 dmx4878 -1 Playing
22:39:49.381 - * s:100 q:100 tr=357200 (0) - ntt0 dmx9611 -1 Playing
22:39:50.135 - * s:100 q:100 tr=309072 (0) - ntt0 dmx8994 -1 Playing
22:39:50.673 - * s:100 q:100 tr=250416 (0) - ntt0 dmx9396 -1 Playing
22:39:51.130 - DestroyGraph 0
22:39:51.131 - remove graph idx=0 count=1
22:39:51.198 - add graph 000001D644C71660 102
22:39:51.256 - subsm.StopChannel
22:39:51.298 - DestroyPlayer th=0
22:39:51.342 - Graph::Stop
22:39:51.529 - Before Stop ...22:39:51.574 - OnGraphStop ...22:39:51.865 - VR: Disconnect
22:39:51.916 - Graph::ReleaseAllFilters
22:39:51.917 - release: Audio Renderer - RR - OK.
22:39:51.992 - release: Video Renderer - RR - OK.
22:39:52.066 - release: Video decoder  - RR - OK.
22:39:52.148 - release: Audio decoder - RR - OK.
22:39:52.220 - FilterGraph: 1
22:39:52.257 - Delete timer 1000 DirectShowPlayer
22:39:52.294 - Graph::ReleaseAllFilters
22:39:52.476 - DestroyPlayer - after
22:39:52.479 - TransponderManager::CloseChannel
22:39:52.524 - TsInputTrafficProcessor.RemoveChannel 1
22:39:52.570 - ~TransponderChannelSource
22:39:52.860 - TimeShift.DestroyReadingCursor
22:39:52.865 - Prereader.Exit22:39:52.899 - Api2BaseModule.UpdateAllOpenedChannels 0
22:39:52.935 - ~ChannelPlaybackGraph
22:39:53.026 - Destroy TSTS filter pid=0
22:39:53.026 - PlayTimePmtParser::StopParser
22:39:53.065 - PlayTimePmtParser::StopParser
22:39:53.098 - Destroy TSTS filter pid=4095
22:39:53.133 - DevicesManager::DestroyTransponderManager
22:39:53.170 - Api2Device::SetChannel - None
22:39:53.215 - Delete timer 1000 HlsReader
22:39:53.739 - Api2Device::SetChannel result OK
22:39:53.739 - SetOwner N -> 0
22:39:53.772 - SetOwner SetTransponder null
22:39:53.804 - ~TransponderManager
22:39:53.833 - Delete timer 1000 BaseTransponderManaer
22:39:53.865 - SetOwner N -> 0
22:39:53.898 - SetOwner SetTransponder null
22:39:53.931 - TimeShift.~TimeShift
22:39:53.971 - HugeMemoryBlocksManager::Free
22:39:54.009 - ModuleList::Free
22:39:54.043 - [102]OnChangeCurrentGraph2 -CloseGraph
22:39:54.353 - GraphManager::MultiChannelRendering
22:39:54.739 - * s:100 q:100 tr=15656452 (0)  Playing
22:39:55.876 - * s:0 q:0 tr=0 (0)  Playing
22:39:56.973 - * s:0 q:0 tr=0 (0)  Playing
22:39:57.944 - 
22:39:57.944 - Stop engine
22:39:57.976 - DevicesManager::Stop
22:39:58.005 - DevicesManager::Free devices
22:39:58.037 - SDP:Destroy netclient.0 own=0000000000000000
22:39:58.118 - SDP:after destroy device
22:39:58.120 - DevicesManager::Free RC
22:39:58.150 - Engine stopped
22:39:58.758 - !m_D3DDevices.size()
