﻿11:22:55.763 - Start logging...
11:22:55.822 - ExceptionFilter::Init. restart=1
11:22:56.608 - DevicesManager::EnableCISupport
11:22:56.614 - CAVManager::SetSettings
11:22:56.621 - DevicesManager::DestroyAllTransponderManager
11:22:56.679 - SetDefaultNullCodecs
11:22:56.724 - SetDefaultNullCodecs
11:22:56.753 - DevicesManager::Start
11:22:56.759 - AVManager::Init
11:22:56.765 - RemoveAllCreateBlank needBlank1
11:22:56.777 - add graph 0C895D68 101
11:22:56.784 - [101]OnChangeCurrentGraph2 -RemoveAllBlank
11:22:56.827 - VR: GUI
11:22:56.856 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
11:22:56.939 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
11:22:56.945 - AV:UpdateAudioParamsAfterActive
11:22:56.951 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
11:22:56.966 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
11:22:57.151 - remove graph idx=0 count=1
11:22:57.158 - DevicesManager::StartDevices...
11:22:57.164 - device netclient.0 11:22:57.174 - dev: Created  netclient.0 0C8500F0
OK
11:22:57.201 - Api2BaseModule.GetAdditionInfo
11:22:57.934 - 
11:22:57.941 - 
11:22:57.949 - ########################### Mark of start channel changing.###########################
11:22:57.956 - 
11:22:57.962 - GraphManager::MainChangeChannel Кинохит  1 provs
11:22:57.971 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
11:22:57.978 - SetChannelLogic::SetChannel 0
11:22:57.985 - SetChannelLogic::SetNormalChannel
11:22:57.992 - DevicesManager::CreateCloneDevice
11:22:58.001 - DevicesManager::CreateCloneDevice OK - founded in list
11:22:58.010 - TransponderManager
11:22:58.016 - CTransponderManager::InitOnNewDevice 0EC50F54
11:22:58.025 - SetOwner N -> Incoming Stream Cache
11:22:58.031 - TrafficProcessingScheme_CreateForNewEngineTransport 1 ss=0
11:22:58.038 - Normal TsInputTrafficProcessor.
11:22:58.046 - FilterManager::InitOnNewDevice 1
11:22:58.053 - TS router+MarkerFinder -> InputTrafficProcessor
11:22:58.063 - Incoming Stream Cache -> TS router+MarkerFinder
11:22:58.072 - InputTrafficProcessor -> Router to timeshift
11:22:58.078 - InputTrafficProcessor(FM) -> FilterManager
11:22:58.084 - ModuleList::Free
11:22:58.092 - Api2BaseModule::GetCurrentDeviceInfo
11:22:58.099 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\PidRecorder.module OK
11:22:58.105 - Api2BaseModule::GetCurrentDeviceInfo
11:22:58.119 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\ProgMediaServer.Module OK
11:22:58.125 - ChannelGraph5.CChannelGraph5
11:22:58.132 - TransponderManager::AddChildChannel
11:22:58.139 - TimeShift.TimeShift
11:22:58.145 - TimeShift.Create 200 mbytes 
11:22:58.152 - ts:One channel
11:22:58.158 - HugeMemoryBlocksManager::GetBlock 200 mbytes OK
11:22:58.165 - TransponderManager::CreateTimeshiftBuffer OK
11:22:58.191 - TimeShift.CreateReadingCursor
11:22:58.200 - TransponderChannelSource.Plugins 0EFF6DF0 csa 00000000
11:22:58.207 - TsInputTrafficProcessor.AddChannel 0
11:22:58.217 - SetChannelLogic::LookDeviceWithoutChannelsOrCloneAndMakeGraph
11:22:58.224 - add graph 1268CD7C 102
11:22:58.243 - ChannelGraph5.SetActiveState 1
11:22:58.250 - TransponderManager::SelectChannel
11:22:58.257 - TsInputTrafficProcessor.SelectChannel 0
11:22:58.265 - Api2BaseModule.UpdateAllOpenedChannels 0
11:22:58.278 - AV:UpdateAudioParamsAfterActive
11:22:58.284 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
11:22:58.292 - GR:UpdateAudioProcessor old=0 new=0
11:22:58.299 - Graph::SetAudioChannelMask
11:22:58.305 - 
11:22:58.312 - TransponderManager::SetTransponder (CH) 0 Кинохит
11:22:58.319 - *Transport TS
11:22:58.328 - Api2Device::SetChannel http://cf3e5210.rossteleccom.net/iptv/392XTEQ7L49GFY/516/index.m3u8
11:22:58.373 - Api2Device::SetChannel result OK
11:22:58.380 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
11:22:58.387 - TsInputTrafficProcessor.OpenTransponder 1
11:22:58.386 - Api2BaseModule.OnTunerStateChanged Connecting
11:22:58.394 - FilterManager::OnSetTransponder SetChannel
11:22:58.401 - Api2BaseModule.OnTunerStateChanged  -3
11:22:58.408 - TimeShift.Reset
11:22:58.423 - TimeShift.Cursor reset
11:22:58.431 - ReaderCursor::Reset.. OK
11:22:58.445 - Prereader.Reset ...-OK
11:22:58.459 - Create EPGparser on SetChannel
11:22:58.467 - DvbEpgParser::SetChannel ID=10018.e0cc070d5583a57e.1
11:22:58.487 - DvbEpgParser::mode normal pos=0
11:22:58.494 - ModuleList::ChangeChannel 0
11:22:58.501 - Api2BaseModule.OnTunerStateChanged Preparing
11:22:58.509 - Api2BaseModule.OnTunerStateChanged  -4
11:22:58.541 - Api2BaseModule.OnTunerStateChanged Playing
11:22:58.541 - Api2BaseModule::GetCurrentDeviceInfo
11:22:58.548 - Api2BaseModule.OnTunerStateChanged  -4
11:22:58.575 - Api2BaseModule::GetCurrentDeviceInfo
11:22:58.583 - [102]ChannelGraph5::StartChannel Кинохит
11:22:58.590 - 
11:22:58.597 - [102]       #################### Start stream. (0.656ms) #######################
11:22:58.604 - 
11:22:58.679 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
11:22:58.687 - TimeShift.Cursor SetChannel::v 0 (0)
11:22:58.697 - ReaderCursor::SetChannel.. OK
11:22:58.712 - ReaderCursor::SetPosition 0 (w=0)
11:22:58.719 - Prereader.SetChannel..
11:22:58.728 - Prereader.SetChannel unmask 1
11:22:58.736 - Plugin::SetChannel 1
11:22:58.747 - TransponderManager::SelectChannel
11:22:58.754 - TsInputTrafficProcessor.SelectChannel 1
11:22:58.762 - Api2BaseModule.UpdateAllOpenedChannels 1
11:22:58.776 - Api2BaseModule::GetCurrentDeviceInfo
11:22:58.790 - Api2BaseModule::OpenFilter 18 OK
11:22:58.804 - Api2BaseModule::OpenFilter 211 OK
11:22:58.818 - Api2BaseModule::OpenFilter 4095 OK
11:22:58.832 - Api2BaseModule::OpenFilter 221 OK
11:22:58.845 - Api2BaseModule::OpenFilter 222 OK
11:22:58.859 - Api2BaseModule::OpenFilter 0 OK
11:22:58.866 - TsInputTrafficProcessor.UpdateChannel 1
11:22:58.876 - GraphState: Undef by StartChannelIsReady
11:22:58.883 - PreScanner.StartChannelIsReady net=1 parseall=1
11:22:58.893 - VideoMediaTypeDetection: h.264
11:22:58.900 - SetMarkerAudioLngStream Gen New stream
11:22:58.907 - SimpleTsDemux::Init apid=221, vpid=211
11:22:58.913 - GraphState: RequestPATScan by StartChannelIsReady TS
11:22:58.920 - Api2BaseModule.Filters_EnabledFullTS 1
11:22:58.933 - PlayTimePATParser.OpenParser 1
11:22:58.940 - Open TSTS filter pid=0 data=0
11:22:58.947 - TSTS cur size=0
11:22:58.954 - Graph::SetVideoRect {8 8 712 568}
11:22:58.962 - [102]OnChangeCurrentGraph2 -endOfSetChannel
11:22:58.968 - ChannelGraph5.SetActiveState 1
11:22:59.017 - Graph::SetVideoWindowRect {33 0 166 100}
11:22:59.026 - Graph::UpdateRenderMode
11:22:59.161 - GraphManager::MultiChannelRendering
11:22:59.168 - ChannelGraph5.SetActiveState 1
11:22:59.185 - Graph::SetVideoWindowRect {212 0 1394 887}
11:22:59.210 - Graph::SetVideoWindowRect {212 0 1394 887}
11:22:59.247 - Graph::SetVideoWindowRect {212 0 1394 887}
11:22:59.342 - OK. 102
11:22:59.644 - TransportMarker: TS
11:22:59.653 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
11:22:59.672 - 
11:22:59.680 -        #################### First traffic. (1.750ms) #######################
11:22:59.689 - 
11:22:59.694 - --SwitchEngineTransport TS > TS
11:22:59.698 - PlayTimePATParser.EndTask
11:22:59.714 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
11:22:59.721 - PreScanner.OnTransportMarker TS
11:22:59.730 - --SwitchEngineTransport end
11:22:59.739 - PreScanner.OnAfterScanPat count=2 {1;4095}
11:22:59.746 - Api2BaseModule.Filters_EnabledFullTS 0
11:22:59.759 - GraphState: RequestPMTScan by OnAfterScanPat
11:22:59.767 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=1
11:22:59.774 - Open TSTS filter pid=4095 data=2
11:22:59.781 - TSTS cur size=2403392
11:22:59.789 - TSTS quick finish
11:22:59.825 - PreScanner.OnAfterScanPmt pmt=4095
11:22:59.833 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
11:22:59.840 - PlayTimePmtParser::StopParser
11:22:59.922 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
11:22:59.931 - TimeShift.Cursor SetChannel::v 4779712 (4779712)
11:22:59.938 - Prereader.SetChannel unmask 1
11:22:59.945 - Plugin::SetChannel 1
11:22:59.953 - TransponderManager::SelectChannel
11:22:59.960 - TsInputTrafficProcessor.SelectChannel 1
11:22:59.967 - Api2BaseModule.UpdateAllOpenedChannels 1
11:22:59.982 - Api2BaseModule::CloseFilter 1 pid 18
11:22:59.997 - Api2BaseModule::CloseFilter 2 pid 211
11:23:00.015 - Api2BaseModule::CloseFilter 3 pid 4095
11:23:00.036 - Api2BaseModule::CloseFilter 4 pid 221
11:23:00.053 - Api2BaseModule::CloseFilter 5 pid 222
11:23:00.067 - Api2BaseModule::CloseFilter 6 pid 0
11:23:00.081 - Api2BaseModule::GetCurrentDeviceInfo
11:23:00.097 - Api2BaseModule::OpenFilter 18 OK
11:23:00.111 - Api2BaseModule::OpenFilter 211 OK
11:23:00.125 - Api2BaseModule::OpenFilter 4095 OK
11:23:00.139 - Api2BaseModule::OpenFilter 221 OK
11:23:00.152 - Api2BaseModule::OpenFilter 222 OK
11:23:00.167 - Api2BaseModule::OpenFilter 0 OK
11:23:00.176 - TsInputTrafficProcessor.UpdateChannel 1
11:23:00.184 - PreScanner.StartChannelIsReady net=1 parseall=0
11:23:00.191 - LngDefaultSelector.try select audio pid=221 type=1 lng=7566706-rus(goh,goh,rus) l=10
11:23:00.199 - LngDefaultSelector.try select audio pid=222 type=1 lng=7566706-rus(goh,goh,rus) l=10
11:23:00.208 - LngDefaultSelector. selected audio pid=221
11:23:00.216 - ChannelGraph5::AfterDetectChannelParams
11:23:00.226 - VideoMediaTypeDetection: h.264
11:23:00.233 - SimpleTsDemux::Init apid=221, vpid=211
11:23:00.242 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
11:23:00.251 - demux: ProgDemux
11:23:00.284 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
11:23:00.292 - Prereader::ReaderCursor.. OK
11:23:00.308 - ReaderCursor::SetPosition 0 (w=40501885198663680)
11:23:00.315 - Prereader.StartPlayback Push buffering=0 recv=1268DD20 [StartChannelHelperBase(sl)]
11:23:00.323 - Prereader.StartPlayback after lock
11:23:00.331 - PreScanner.StartPmtParserIfNeed
11:23:00.332 - AudioParser::First packet 357
11:23:00.339 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=0
11:23:00.347 - VideoParser::First packet 15409 h.264
11:23:00.354 - Open TSTS filter pid=4095 data=2
11:23:00.362 - h264 detected 0 ms
11:23:00.370 - TSTS cur size=9430080
11:23:00.378 - AudioParser::packet 370
11:23:00.392 - AudioParser::packet 360
11:23:00.400 - AudioParser::packet 332
11:23:00.410 - AudioParser::AAC detected
11:23:00.418 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
11:23:00.426 - PreScanner.Post_InitRender [ReceiveTraffic]
11:23:00.442 - [102]sm: TvInitRenderer 1
11:23:00.451 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
11:23:00.462 - CalculBufferingSize prov=0EC52394 marker=1 request=1
11:23:00.473 - CalculBuffering 2000ms br=2000kb to 500 kbytes. By type
11:23:00.485 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
11:23:00.494 - Prereader::ReaderCursor.. OK
11:23:00.512 - ReaderCursor::SetPosition 0 (w=50824375238131712)
11:23:00.520 - Prereader.StartPlayback Pull buffering=512000 recv=00000000 [EnablePullModeAndStartPlayback]
11:23:00.527 - Prereader.StartPlayback after lock
11:23:00.535 - Buffering/prereader size 500/3906 kbytes
11:23:00.542 - ------sGetVideoParams
11:23:00.550 - ChannelGraph5.CreateInterfacesAndRenderGraph
11:23:00.559 - * s:100 q:100 tr=11848888 (0) Preparing
11:23:00.566 - subsm.StartChannel demux=ProgDemux tr=TS
11:23:00.576 - subsm.RecreateSubtitlesParsers 0C84B058 ts=1 subindex=-1
11:23:00.568 - OnBuffering.OnTunerStateChanged  4
11:23:00.587 - subsm.Set Teletext parser 0
11:23:00.602 - subsm.RecreateSubtitlesParsers end
11:23:00.610 - subs: OnSetChannel
11:23:00.618 - CreateCustomGraph
11:23:00.625 - VideoType:H.264/AVC ffmpeg=0
11:23:00.632 - Video/4.H264 : MPEG2_VIDEO s={0,0,720,576}, t={0,0,720,576}, bmp=720x576, r=254/139, br=0,frametime=40ms, IF=0x0, CF=0x0)
11:23:00.639 - Add video codec 212690fb-83e5-4526-8fd7-74478b7939cd
11:23:00.663 - OK
11:23:00.672 - CChannelGraph5::CreateRender 10
11:23:00.680 - VR: EVR Custom
11:23:00.688 - VR: create new render
11:23:01.311 - VR: Add video renderer Video Renderer - OK
11:23:01.319 - CreateAudioPartOfGraph
11:23:01.327 - AudioType:AAC/ADTS 
11:23:01.335 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 48000 16bit formatTag= 0x1600)
11:23:01.344 - Add audio codec e1f1a0b8-beee-490d-ba7c-066c40b5e2b9 - OK
11:23:01.362 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
11:23:01.372 - Added audio renderer
11:23:01.424 - Add and connect audio renderer - OK
11:23:01.432 - Graph::AfterRender
11:23:01.440 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
11:23:01.448 - AV:UpdateAudioParamsAfterActive
11:23:01.455 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
11:23:01.462 - GR:UpdateAudioProcessor old=0 new=0
11:23:01.470 - Graph::SetVolume 25% -2500db
11:23:01.479 - Graph::SetAudioChannelMask
11:23:01.488 - Graph::Run
11:23:01.606 - Graph::Run 1
11:23:01.628 - Graph::SetPictureParams
11:23:01.635 - Graph::SetVideoRect {8 8 712 568}
11:23:01.644 - Graph::SetVideoWindowRect {0 4 1606 882}
11:23:01.687 - 
11:23:01.696 - [0]########################### Mark of finish channel changing. (3.765ms) #############
11:23:01.705 - 
11:23:01.827 - CChannelGraph5::HideSubtitles
11:23:01.910 - * s:100 q:100 tr=2391360 (0) Playing
11:23:01.923 - 
11:23:01.933 - [0]########################### First video frame. (4.000ms) #############
11:23:01.942 - 
11:23:02.459 - * s:100 q:100 tr=0 (0) Playing
11:23:03.472 - * s:100 q:100 tr=0 (0) Playing
11:23:03.931 - 
11:23:03.938 - 
11:23:03.946 - ########################### Mark of start channel changing.###########################
11:23:03.953 - 
11:23:03.961 - GraphManager::MainChangeChannel КИНО ТВ HD  1 provs
11:23:03.969 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
11:23:03.977 - SetChannelLogic::SetChannel 0
11:23:03.985 - SetChannelLogic::SetNormalChannel
11:23:04.011 - ChannelGraph5::StopChannel КИНО ТВ HD
11:23:04.019 - PreScanner.Stop
11:23:04.027 - GraphState: Undef by PreScanner.Stop
11:23:04.042 - PlayTimePmtParser::StopParser
11:23:04.050 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
11:23:04.057 - Prereader::ReaderCursor.. OK
11:23:04.074 - ReaderCursor::SetPosition 0 (w=61082268969467904)
11:23:04.082 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
11:23:04.089 - Prereader.StartPlayback after lock
11:23:04.097 - subsm.StopChannel
11:23:04.107 - Graph::Stop
11:23:04.240 - Before Stop ...11:23:04.257 - OnGraphStop ...11:23:04.333 - VR: Disconnect
11:23:04.347 - Graph::ReleaseAllFilters
11:23:04.355 - release: Prog Audio renderer - RR - OK.
11:23:04.453 - release: Video Renderer - RR - OK.
11:23:04.540 - release: Microsoft DTV-DVD Video Decoder - RR - OK.
11:23:04.558 - release: Microsoft DTV-DVD Audio Decoder - RR - OK.
11:23:04.573 - FilterGraph: 1
11:23:04.582 - 
11:23:04.590 - TransponderManager::SetTransponder (CH) 0 КИНО ТВ HD
11:23:04.598 - *Transport TS
11:23:04.605 - Api2Device::SetChannel http://cf3e5210.rossteleccom.net/iptv/392XTEQ7L49GFY/2097/index.m3u8
11:23:04.673 - Api2BaseModule.OnTunerStateChanged Connecting
11:23:04.682 - Api2BaseModule.OnTunerStateChanged  -3
11:23:04.697 - Api2Device::SetChannel result OK
11:23:04.706 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
11:23:04.713 - TsInputTrafficProcessor.OpenTransponder 1
11:23:04.721 - FilterManager::OnSetTransponder SetChannel
11:23:04.728 - TimeShift.Reset
11:23:04.736 - TimeShift.Cursor reset
11:23:04.743 - ReaderCursor::Reset.. OK
11:23:04.761 - Prereader.Reset ...-OK
11:23:04.773 - Api2BaseModule.OnTunerStateChanged Preparing
11:23:04.787 - Api2BaseModule.OnTunerStateChanged  -4
11:23:04.780 - Create EPGparser on SetChannel
11:23:04.803 - DvbEpgParser::SetChannel ID=10018.df832be71f8b33ff.1
11:23:04.814 - Api2BaseModule.OnTunerStateChanged Playing
11:23:04.821 - Api2BaseModule.OnTunerStateChanged  -4
11:23:04.825 - DvbEpgParser::mode normal pos=0
11:23:04.837 - ModuleList::ChangeChannel 0
11:23:04.845 - [102]ChannelGraph5::StartChannel КИНО ТВ HD
11:23:04.854 - 
11:23:04.861 - [102]       #################### Start stream. (0.921ms) #######################
11:23:04.868 - 
11:23:04.928 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
11:23:04.936 - TimeShift.Cursor SetChannel::v 0 (0)
11:23:04.943 - ReaderCursor::SetChannel.. OK
11:23:04.958 - ReaderCursor::SetPosition 0 (w=0)
11:23:04.965 - Prereader.SetChannel..
11:23:04.972 - Prereader.SetChannel unmask 1
11:23:04.979 - Plugin::SetChannel 1
11:23:04.987 - TransponderManager::SelectChannel
11:23:04.994 - TsInputTrafficProcessor.SelectChannel 1
11:23:05.001 - Api2BaseModule.UpdateAllOpenedChannels 1
11:23:05.014 - Api2BaseModule::CloseFilter 1 pid 18
11:23:05.028 - Api2BaseModule::CloseFilter 2 pid 211
11:23:05.042 - Api2BaseModule::CloseFilter 3 pid 4095
11:23:05.056 - Api2BaseModule::CloseFilter 4 pid 221
11:23:05.069 - Api2BaseModule::CloseFilter 5 pid 222
11:23:05.088 - Api2BaseModule::CloseFilter 6 pid 0
11:23:05.101 - Api2BaseModule::GetCurrentDeviceInfo
11:23:05.115 - Api2BaseModule::OpenFilter 18 OK
11:23:05.128 - Api2BaseModule::OpenFilter 211 OK
11:23:05.143 - Api2BaseModule::OpenFilter 4095 OK
11:23:05.156 - Api2BaseModule::OpenFilter 221 OK
11:23:05.169 - Api2BaseModule::OpenFilter 0 OK
11:23:05.177 - TsInputTrafficProcessor.UpdateChannel 1
11:23:05.184 - GraphState: Undef by StartChannelIsReady
11:23:05.191 - PreScanner.StartChannelIsReady net=1 parseall=1
11:23:05.199 - VideoMediaTypeDetection: h.264
11:23:05.206 - SetMarkerAudioLngStream Gen New stream
11:23:05.213 - SimpleTsDemux::Init apid=221, vpid=211
11:23:05.220 - GraphState: RequestPATScan by StartChannelIsReady TS
11:23:05.227 - Api2BaseModule.Filters_EnabledFullTS 1
11:23:05.241 - PlayTimePATParser.OpenParser 1
11:23:05.248 - Open TSTS filter pid=0 data=0
11:23:05.255 - TSTS cur size=0
11:23:05.262 - Graph::UpdateRenderMode
11:23:05.379 - Graph::SetVideoRect {8 8 712 568}
11:23:05.387 - Graph::SetVideoWindowRect {0 4 1606 882}
11:23:05.394 - [102]OnChangeCurrentGraph2 -endOfSetChannel
11:23:05.402 - ChannelGraph5.SetActiveState 1
11:23:05.520 - OK. 102
11:23:05.806 - * s:0 q:0 tr=0 (0) Preparing
11:23:05.836 - TransportMarker: TS
11:23:05.846 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
11:23:05.864 - 
11:23:05.872 -        #################### First traffic. (1.937ms) #######################
11:23:05.883 - 
11:23:05.873 - --SwitchEngineTransport TS > TS
11:23:05.892 - PlayTimePATParser.EndTask
11:23:05.911 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
11:23:05.919 - PreScanner.OnTransportMarker TS
11:23:05.929 - --SwitchEngineTransport end
11:23:05.938 - PreScanner.OnAfterScanPat count=2 {1;4095}
11:23:05.948 - Api2BaseModule.Filters_EnabledFullTS 0
11:23:05.964 - GraphState: RequestPMTScan by OnAfterScanPat
11:23:05.974 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=1
11:23:05.983 - Open TSTS filter pid=4095 data=2
11:23:05.992 - TSTS cur size=4775200
11:23:06.001 - TSTS quick finish
11:23:06.040 - PreScanner.OnAfterScanPmt pmt=4095
11:23:06.050 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
11:23:06.057 - PlayTimePmtParser::StopParser
11:23:06.125 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
11:23:06.133 - TimeShift.Cursor SetChannel::v 5147816 (5147816)
11:23:06.143 - Prereader.SetChannel unmask 1
11:23:06.151 - Plugin::SetChannel 1
11:23:06.159 - TransponderManager::SelectChannel
11:23:06.167 - TsInputTrafficProcessor.SelectChannel 1
11:23:06.176 - Api2BaseModule.UpdateAllOpenedChannels 1
11:23:06.191 - Api2BaseModule::CloseFilter 1 pid 18
11:23:06.207 - Api2BaseModule::CloseFilter 2 pid 211
11:23:06.225 - Api2BaseModule::CloseFilter 3 pid 4095
11:23:06.238 - Api2BaseModule::CloseFilter 4 pid 221
11:23:06.252 - Api2BaseModule::CloseFilter 5 pid 0
11:23:06.268 - Api2BaseModule::GetCurrentDeviceInfo
11:23:06.284 - Api2BaseModule::OpenFilter 18 OK
11:23:06.298 - Api2BaseModule::OpenFilter 211 OK
11:23:06.311 - Api2BaseModule::OpenFilter 4095 OK
11:23:06.325 - Api2BaseModule::OpenFilter 221 OK
11:23:06.339 - Api2BaseModule::OpenFilter 0 OK
11:23:06.346 - TsInputTrafficProcessor.UpdateChannel 1
11:23:06.353 - PreScanner.StartChannelIsReady net=1 parseall=0
11:23:06.360 - LngDefaultSelector.try select audio pid=221 type=1 lng=0-(goh,goh,rus) l=99
11:23:06.369 - ChannelGraph5::AfterDetectChannelParams
11:23:06.377 - VideoMediaTypeDetection: h.264
11:23:06.384 - SimpleTsDemux::Init apid=221, vpid=211
11:23:06.391 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
11:23:06.399 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
11:23:06.410 - Prereader::ReaderCursor.. OK
11:23:06.429 - ReaderCursor::SetPosition 0 (w=44670769434722304)
11:23:06.439 - Prereader.StartPlayback Push buffering=0 recv=1268DD20 [StartChannelHelperBase(sl)]
11:23:06.449 - Prereader.StartPlayback after lock
11:23:06.460 - PreScanner.StartPmtParserIfNeed
11:23:06.460 - VideoParser::First packet 38266 h.264
11:23:06.477 - h264 detected 0 ms
11:23:06.470 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=0
11:23:06.485 - AudioParser::First packet 473
11:23:06.505 - AudioParser::packet 496
11:23:06.494 - Open TSTS filter pid=4095 data=2
11:23:06.514 - AudioParser::packet 440
11:23:06.524 - TSTS cur size=12339568
11:23:06.531 - AudioParser::packet 439
11:23:06.552 - AudioParser::AAC detected
11:23:06.560 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
11:23:06.570 - PreScanner.Post_InitRender [ReceiveTraffic]
11:23:06.594 - * s:100 q:100 tr=13784348 (0) Preparing
11:23:06.712 - OSDManager::Window_Add
11:23:06.725 - OSDManager::Window_Show
11:23:06.810 - OSDManager::Window_Show
11:23:06.825 - OSDManager::Window_Show
11:23:06.960 - [102]sm: TvInitRenderer 1
11:23:06.968 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
11:23:06.975 - CalculBufferingSize prov=0EC52394 marker=1 request=1
11:23:06.983 - CalculBuffering 2000ms br=2000kb to 500 kbytes. By type
11:23:06.990 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
11:23:06.997 - Prereader::ReaderCursor.. OK
11:23:07.012 - ReaderCursor::SetPosition 0 (w=64338730353164288)
11:23:07.023 - Prereader.StartPlayback Pull buffering=512000 recv=00000000 [EnablePullModeAndStartPlayback]
11:23:07.030 - Prereader.StartPlayback after lock
11:23:07.038 - Buffering/prereader size 500/3906 kbytes
11:23:07.047 - ------sGetVideoParams
11:23:07.047 - OnBuffering.OnTunerStateChanged  0
11:23:07.056 - ChannelGraph5.CreateInterfacesAndRenderGraph
11:23:07.081 - subsm.StartChannel demux=ProgDemux tr=TS
11:23:07.089 - subsm.RecreateSubtitlesParsers 0C84B058 ts=1 subindex=-1
11:23:07.100 - subsm.Set Teletext parser 0
11:23:07.108 - subsm.RecreateSubtitlesParsers end
11:23:07.116 - subs: OnSetChannel
11:23:07.123 - CreateCustomGraph
11:23:07.134 - VideoType:H.264/AVC ffmpeg=0
11:23:07.144 - Video/4.H264 : MPEG2_VIDEO s={0,0,1920,1080}, t={0,0,1920,1080}, bmp=1920x1088, r=30/17, br=0,frametime=40ms, IF=0x0, CF=0x0)
11:23:07.153 - Add video codec 212690fb-83e5-4526-8fd7-74478b7939cd
11:23:07.168 - OK
11:23:07.177 - CChannelGraph5::CreateRender 10
11:23:07.185 - VR: EVR Custom
11:23:07.192 - VR: create new render
11:23:07.833 - VR: Add video renderer Video Renderer - OK
11:23:07.844 - CreateAudioPartOfGraph
11:23:07.854 - AudioType:AAC/ADTS 
11:23:07.865 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 48000 16bit formatTag= 0x1600)
11:23:07.877 - Add audio codec e1f1a0b8-beee-490d-ba7c-066c40b5e2b9 - OK
11:23:07.891 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
11:23:07.899 - Added audio renderer
11:23:07.962 - Add and connect audio renderer - OK
11:23:07.970 - Graph::AfterRender
11:23:07.977 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
11:23:07.985 - AV:UpdateAudioParamsAfterActive
11:23:07.993 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
11:23:08.003 - GR:UpdateAudioProcessor old=0 new=0
11:23:08.010 - Graph::SetVolume 25% -2500db
11:23:08.020 - Graph::SetAudioChannelMask
11:23:08.027 - Graph::Run
11:23:08.230 - Graph::Run 1
11:23:08.253 - Graph::SetPictureParams
11:23:08.261 - Graph::SetVideoRect {24 16 1896 1068}
11:23:08.269 - Graph::SetVideoWindowRect {20 0 1585 887}
11:23:08.304 - 
11:23:08.312 - [0]########################### Mark of finish channel changing. (4.375ms) #############
11:23:08.320 - 
11:23:08.447 - CChannelGraph5::HideSubtitles
11:23:08.479 - * s:100 q:100 tr=9877896 (0) Playing
11:23:08.950 - 
11:23:08.959 - [0]########################### First video frame. (5.031ms) #############
11:23:08.970 - 
11:23:09.247 - changed ratio to 1920/1080
11:23:09.255 - Graph::SetVideoRect {24 16 1896 1068}
11:23:09.262 - Graph::SetVideoWindowRect {10 0 1596 887}
11:23:09.468 - * s:100 q:100 tr=4029780 (0) Playing
11:23:10.245 - 
11:23:10.253 - 
11:23:10.261 - ########################### Mark of start channel changing.###########################
11:23:10.271 - 
11:23:10.279 - GraphManager::MainChangeChannel КИНОПРЕМЬЕРА HD  1 provs
11:23:10.287 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
11:23:10.295 - SetChannelLogic::SetChannel 0
11:23:10.303 - SetChannelLogic::SetNormalChannel
11:23:10.327 - ChannelGraph5::StopChannel КИНОПРЕМЬЕРА HD
11:23:10.335 - PreScanner.Stop
11:23:10.342 - GraphState: Undef by PreScanner.Stop
11:23:10.356 - PlayTimePmtParser::StopParser
11:23:10.363 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
11:23:10.371 - Prereader::ReaderCursor.. OK
11:23:10.387 - ReaderCursor::SetPosition 0 (w=118857206962585600)
11:23:10.395 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
11:23:10.403 - Prereader.StartPlayback after lock
11:23:10.411 - subsm.StopChannel
11:23:10.419 - Graph::Stop
11:23:10.932 - Before Stop ...11:23:10.949 - OnGraphStop ...11:23:11.021 - VR: Disconnect
11:23:11.037 - Graph::ReleaseAllFilters
11:23:11.044 - release: Prog Audio renderer - RR - OK.
11:23:11.145 - release: Video Renderer - RR - OK.
11:23:11.234 - release: Microsoft DTV-DVD Video Decoder - RR - OK.
11:23:11.252 - release: Microsoft DTV-DVD Audio Decoder - RR - OK.
11:23:11.266 - FilterGraph: 1
11:23:11.275 - 
11:23:11.283 - TransponderManager::SetTransponder (CH) 0 КИНОПРЕМЬЕРА HD
11:23:11.292 - *Transport TS
11:23:11.299 - Api2Device::SetChannel http://cf3e5210.rossteleccom.net/iptv/392XTEQ7L49GFY/224/index.m3u8
11:23:11.367 - Api2BaseModule.OnTunerStateChanged Connecting
11:23:11.375 - Api2BaseModule.OnTunerStateChanged  -3
11:23:11.390 - Api2Device::SetChannel result OK
11:23:11.398 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
11:23:11.405 - TsInputTrafficProcessor.OpenTransponder 1
11:23:11.412 - FilterManager::OnSetTransponder SetChannel
11:23:11.419 - TimeShift.Reset
11:23:11.426 - TimeShift.Cursor reset
11:23:11.434 - ReaderCursor::Reset.. OK
11:23:11.448 - Prereader.Reset ...-OK
11:23:11.458 - Api2BaseModule.OnTunerStateChanged Preparing
11:23:11.463 - Create EPGparser on SetChannel
11:23:11.477 - DvbEpgParser::SetChannel ID=10018.3325bddd58c5e2ad.1
11:23:11.470 - Api2BaseModule.OnTunerStateChanged  -4
11:23:11.499 - DvbEpgParser::mode normal pos=0
11:23:11.507 - ModuleList::ChangeChannel 0
11:23:11.514 - [102]ChannelGraph5::StartChannel КИНОПРЕМЬЕРА HD
11:23:11.525 - 
11:23:11.534 - [102]       #################### Start stream. (1.281ms) #######################
11:23:11.510 - Api2BaseModule.OnTunerStateChanged Playing
11:23:11.544 - 
11:23:11.551 - Api2BaseModule.OnTunerStateChanged  -4
11:23:11.618 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
11:23:11.625 - TimeShift.Cursor SetChannel::v 0 (0)
11:23:11.632 - ReaderCursor::SetChannel.. OK
11:23:11.651 - ReaderCursor::SetPosition 0 (w=0)
11:23:11.660 - Prereader.SetChannel..
11:23:11.667 - Prereader.SetChannel unmask 1
11:23:11.676 - Plugin::SetChannel 1
11:23:11.683 - TransponderManager::SelectChannel
11:23:11.690 - TsInputTrafficProcessor.SelectChannel 1
11:23:11.697 - Api2BaseModule.UpdateAllOpenedChannels 1
11:23:11.710 - Api2BaseModule::CloseFilter 1 pid 18
11:23:11.722 - Api2BaseModule::CloseFilter 2 pid 211
11:23:11.735 - Api2BaseModule::CloseFilter 3 pid 4095
11:23:11.748 - Api2BaseModule::CloseFilter 4 pid 221
11:23:11.761 - Api2BaseModule::CloseFilter 5 pid 0
11:23:11.774 - Api2BaseModule::GetCurrentDeviceInfo
11:23:11.787 - Api2BaseModule::OpenFilter 18 OK
11:23:11.800 - Api2BaseModule::OpenFilter 211 OK
11:23:11.813 - Api2BaseModule::OpenFilter 4095 OK
11:23:11.826 - Api2BaseModule::OpenFilter 221 OK
11:23:11.839 - Api2BaseModule::OpenFilter 0 OK
11:23:11.846 - TsInputTrafficProcessor.UpdateChannel 1
11:23:11.853 - GraphState: Undef by StartChannelIsReady
11:23:11.860 - PreScanner.StartChannelIsReady net=1 parseall=1
11:23:11.868 - VideoMediaTypeDetection: h.264
11:23:11.875 - SetMarkerAudioLngStream Gen New stream
11:23:11.882 - SimpleTsDemux::Init apid=221, vpid=211
11:23:11.888 - GraphState: RequestPATScan by StartChannelIsReady TS
11:23:11.895 - Api2BaseModule.Filters_EnabledFullTS 1
11:23:11.908 - PlayTimePATParser.OpenParser 1
11:23:11.915 - Open TSTS filter pid=0 data=0
11:23:11.922 - TSTS cur size=0
11:23:11.929 - Graph::UpdateRenderMode
11:23:12.002 - Graph::SetVideoRect {8 8 712 568}
11:23:12.009 - Graph::SetVideoWindowRect {10 0 1596 887}
11:23:12.018 - [102]OnChangeCurrentGraph2 -endOfSetChannel
11:23:12.025 - ChannelGraph5.SetActiveState 1
11:23:12.143 - OK. 102
11:23:12.427 - * s:0 q:0 tr=0 (0) Preparing
11:23:12.464 - TransportMarker: TS
11:23:12.471 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
11:23:12.488 - 
11:23:12.496 -        #################### First traffic. (2.250ms) #######################
11:23:12.503 - 
11:23:12.496 - --SwitchEngineTransport TS > TS
11:23:12.514 - PlayTimePATParser.EndTask
11:23:12.529 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
11:23:12.536 - PreScanner.OnTransportMarker TS
11:23:12.544 - --SwitchEngineTransport end
11:23:12.554 - PreScanner.OnAfterScanPat count=2 {1;4095}
11:23:12.562 - Api2BaseModule.Filters_EnabledFullTS 0
11:23:12.576 - GraphState: RequestPMTScan by OnAfterScanPat
11:23:12.583 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=1
11:23:12.592 - Open TSTS filter pid=4095 data=2
11:23:12.599 - TSTS cur size=3144300
11:23:12.606 - TSTS quick finish
11:23:12.671 - OSDManager::Window_Show
11:23:12.686 - PreScanner.OnAfterScanPmt pmt=4095
11:23:12.693 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
11:23:12.702 - PlayTimePmtParser::StopParser
11:23:12.768 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
11:23:12.776 - TimeShift.Cursor SetChannel::v 4785728 (4785728)
11:23:12.783 - Prereader.SetChannel unmask 1
11:23:12.791 - Plugin::SetChannel 1
11:23:12.798 - TransponderManager::SelectChannel
11:23:12.805 - TsInputTrafficProcessor.SelectChannel 1
11:23:12.812 - Api2BaseModule.UpdateAllOpenedChannels 1
11:23:12.824 - Api2BaseModule::CloseFilter 1 pid 18
11:23:12.837 - Api2BaseModule::CloseFilter 2 pid 211
11:23:12.850 - Api2BaseModule::CloseFilter 3 pid 4095
11:23:12.863 - Api2BaseModule::CloseFilter 4 pid 221
11:23:12.877 - Api2BaseModule::CloseFilter 5 pid 0
11:23:12.890 - Api2BaseModule::GetCurrentDeviceInfo
11:23:12.904 - Api2BaseModule::OpenFilter 18 OK
11:23:12.917 - Api2BaseModule::OpenFilter 211 OK
11:23:12.930 - Api2BaseModule::OpenFilter 4095 OK
11:23:12.944 - Api2BaseModule::OpenFilter 221 OK
11:23:12.958 - Api2BaseModule::OpenFilter 0 OK
11:23:12.966 - TsInputTrafficProcessor.UpdateChannel 1
11:23:12.977 - PreScanner.StartChannelIsReady net=1 parseall=0
11:23:12.985 - LngDefaultSelector.try select audio pid=221 type=1 lng=0-(goh,goh,rus) l=99
11:23:12.993 - ChannelGraph5::AfterDetectChannelParams
11:23:13.001 - VideoMediaTypeDetection: h.264
11:23:13.009 - SimpleTsDemux::Init apid=221, vpid=211
11:23:13.017 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
11:23:13.027 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
11:23:13.034 - Prereader::ReaderCursor.. OK
11:23:13.049 - ReaderCursor::SetPosition 0 (w=22345477890506752)
11:23:13.056 - Prereader.StartPlayback Push buffering=0 recv=1268DD20 [StartChannelHelperBase(sl)]
11:23:13.063 - Prereader.StartPlayback after lock
11:23:13.070 - PreScanner.StartPmtParserIfNeed
11:23:13.078 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=0
11:23:13.071 - AudioParser::First packet 463
11:23:13.085 - Open TSTS filter pid=4095 data=2
11:23:13.092 - VideoParser::First packet 67992 h.264
11:23:13.107 - h264 detected 0 ms
11:23:13.099 - TSTS cur size=5350104
11:23:13.114 - AudioParser::packet 444
11:23:13.129 - AudioParser::packet 456
11:23:13.136 - AudioParser::packet 440
11:23:13.145 - AudioParser::AAC detected
11:23:13.153 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
11:23:13.161 - PreScanner.Post_InitRender [ReceiveTraffic]
11:23:13.171 - * s:100 q:100 tr=5588864 (0) Preparing
11:23:13.332 - [102]sm: TvInitRenderer 1
11:23:13.339 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
11:23:13.347 - CalculBufferingSize prov=0EC52394 marker=1 request=1
11:23:13.356 - CalculBuffering 2000ms br=2000kb to 500 kbytes. By type
11:23:13.364 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
11:23:13.371 - Prereader::ReaderCursor.. OK
11:23:13.385 - ReaderCursor::SetPosition 0 (w=27901567843696640)
11:23:13.393 - Prereader.StartPlayback Pull buffering=512000 recv=00000000 [EnablePullModeAndStartPlayback]
11:23:13.400 - Prereader.StartPlayback after lock
11:23:13.407 - Buffering/prereader size 500/3906 kbytes
11:23:13.414 - ------sGetVideoParams
11:23:13.414 - OnBuffering.OnTunerStateChanged  0
11:23:13.421 - ChannelGraph5.CreateInterfacesAndRenderGraph
11:23:13.439 - subsm.StartChannel demux=ProgDemux tr=TS
11:23:13.447 - subsm.RecreateSubtitlesParsers 0C84B058 ts=1 subindex=-1
11:23:13.455 - subsm.Set Teletext parser 0
11:23:13.463 - subsm.RecreateSubtitlesParsers end
11:23:13.470 - subs: OnSetChannel
11:23:13.477 - CreateCustomGraph
11:23:13.483 - VideoType:H.264/AVC ffmpeg=0
11:23:13.492 - Video/4.H264 : MPEG2_VIDEO s={0,0,1920,1080}, t={0,0,1920,1080}, bmp=1920x1088, r=30/17, br=0,frametime=40ms, IF=0x0, CF=0x0)
11:23:13.499 - Add video codec 212690fb-83e5-4526-8fd7-74478b7939cd
11:23:13.515 - OK
11:23:13.523 - CChannelGraph5::CreateRender 10
11:23:13.531 - VR: EVR Custom
11:23:13.539 - VR: create new render
11:23:14.158 - VR: Add video renderer Video Renderer - OK
11:23:14.165 - CreateAudioPartOfGraph
11:23:14.177 - AudioType:AAC/ADTS 
11:23:14.188 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 48000 16bit formatTag= 0x1600)
11:23:14.198 - Add audio codec e1f1a0b8-beee-490d-ba7c-066c40b5e2b9 - OK
11:23:14.211 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
11:23:14.219 - Added audio renderer
11:23:14.279 - Add and connect audio renderer - OK
11:23:14.287 - Graph::AfterRender
11:23:14.296 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
11:23:14.304 - AV:UpdateAudioParamsAfterActive
11:23:14.311 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
11:23:14.318 - GR:UpdateAudioProcessor old=0 new=0
11:23:14.325 - Graph::SetVolume 25% -2500db
11:23:14.333 - Graph::SetAudioChannelMask
11:23:14.340 - Graph::Run
11:23:14.485 - Graph::Run 1
11:23:14.506 - Graph::SetPictureParams
11:23:14.513 - Graph::SetVideoRect {24 16 1896 1068}
11:23:14.521 - Graph::SetVideoWindowRect {20 0 1585 887}
11:23:14.556 - 
11:23:14.563 - [0]########################### Mark of finish channel changing. (4.313ms) #############
11:23:14.572 - 
11:23:14.593 - OSDManager::Window_Show
11:23:14.937 - CChannelGraph5::HideSubtitles
11:23:14.978 - * s:100 q:100 tr=6099472 (0) Playing
11:23:15.065 - 
11:23:15.075 - [0]########################### First video frame. (4.828ms) #############
11:23:15.085 - 
11:23:15.098 - changed ratio to 1920/1080
11:23:15.105 - Graph::SetVideoRect {24 16 1896 1068}
11:23:15.113 - Graph::SetVideoWindowRect {10 0 1596 887}
11:23:15.727 - * s:100 q:100 tr=3062144 (0) Playing
11:23:16.463 - * s:100 q:100 tr=9118376 (0) Playing
11:23:17.464 - * s:100 q:100 tr=3919800 (0) Playing
11:23:18.463 - * s:100 q:100 tr=911048 (0) Playing
11:23:19.470 - * s:100 q:100 tr=0 (0) Playing
11:23:20.457 - OSDManager::Window_Show
11:23:20.504 - OSDManager::Window_Delete
11:23:20.561 - * s:100 q:100 tr=3470104 (0) Playing
11:23:21.470 - * s:100 q:100 tr=1237416 (0) Playing
11:23:22.472 - * s:100 q:100 tr=0 (0) Playing
11:23:23.463 - * s:100 q:100 tr=0 (0) Playing
11:23:24.470 - * s:100 q:100 tr=0 (0) Playing
11:23:25.458 - * s:100 q:100 tr=0 (0) Playing
11:23:25.646 - 
11:23:25.655 - 
11:23:25.666 - ########################### Mark of start channel changing.###########################
11:23:25.675 - 
11:23:25.684 - GraphManager::MainChangeChannel VIP Premiere  1 provs
11:23:25.692 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
11:23:25.700 - SetChannelLogic::SetChannel 0
11:23:25.708 - SetChannelLogic::SetNormalChannel
11:23:25.731 - ChannelGraph5::StopChannel VIP Premiere
11:23:25.739 - PreScanner.Stop
11:23:25.748 - GraphState: Undef by PreScanner.Stop
11:23:25.763 - PlayTimePmtParser::StopParser
11:23:25.771 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
11:23:25.779 - Prereader::ReaderCursor.. OK
11:23:25.795 - ReaderCursor::SetPosition 0 (w=143390884791058432)
11:23:25.802 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
11:23:25.810 - Prereader.StartPlayback after lock
11:23:25.818 - subsm.StopChannel
11:23:25.828 - Graph::Stop
11:23:25.976 - Before Stop ...11:23:25.992 - OnGraphStop ...11:23:26.072 - VR: Disconnect
11:23:26.088 - Graph::ReleaseAllFilters
11:23:26.095 - release: Prog Audio renderer - RR - OK.
11:23:26.187 - release: Video Renderer - RR - OK.
11:23:26.278 - release: Microsoft DTV-DVD Video Decoder - RR - OK.
11:23:26.295 - release: Microsoft DTV-DVD Audio Decoder - RR - OK.
11:23:26.310 - FilterGraph: 1
11:23:26.319 - 
11:23:26.326 - TransponderManager::SetTransponder (CH) 0 VIP Premiere
11:23:26.333 - *Transport TS
11:23:26.340 - Api2Device::SetChannel http://cf3e5210.rossteleccom.net/iptv/392XTEQ7L49GFY/202/index.m3u8
11:23:26.408 - Api2BaseModule.OnTunerStateChanged Connecting
11:23:26.415 - Api2BaseModule.OnTunerStateChanged  -3
11:23:26.441 - Api2Device::SetChannel result OK
11:23:26.448 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=43981
11:23:26.455 - TsInputTrafficProcessor.OpenTransponder 1
11:23:26.462 - FilterManager::OnSetTransponder SetChannel
11:23:26.470 - TimeShift.Reset
11:23:26.477 - TimeShift.Cursor reset
11:23:26.485 - ReaderCursor::Reset.. OK
11:23:26.499 - Api2BaseModule.OnTunerStateChanged Preparing
11:23:26.510 - Api2BaseModule.OnTunerStateChanged  -4
11:23:26.499 - Prereader.Reset ...-OK
11:23:26.534 - Create EPGparser on SetChannel
11:23:26.538 - Api2BaseModule.OnTunerStateChanged Playing
11:23:26.541 - DvbEpgParser::SetChannel ID=10018.ba0f803d76fcfd47.abcd
11:23:26.548 - Api2BaseModule.OnTunerStateChanged  -4
11:23:26.569 - DvbEpgParser::mode normal pos=0
11:23:26.577 - ModuleList::ChangeChannel 0
11:23:26.584 - [102]ChannelGraph5::StartChannel VIP Premiere
11:23:26.592 - 
11:23:26.599 - [102]       #################### Start stream. (0.953ms) #######################
11:23:26.606 - 
11:23:26.683 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
11:23:26.690 - TimeShift.Cursor SetChannel::v 0 (0)
11:23:26.697 - ReaderCursor::SetChannel.. OK
11:23:26.712 - ReaderCursor::SetPosition 0 (w=0)
11:23:26.719 - Prereader.SetChannel..
11:23:26.726 - Prereader.SetChannel unmask 1
11:23:26.733 - Plugin::SetChannel 43981
11:23:26.740 - TransponderManager::SelectChannel
11:23:26.747 - TsInputTrafficProcessor.SelectChannel 43981
11:23:26.754 - Api2BaseModule.UpdateAllOpenedChannels 1
11:23:26.766 - Api2BaseModule::CloseFilter 1 pid 18
11:23:26.780 - Api2BaseModule::CloseFilter 2 pid 211
11:23:26.801 - Api2BaseModule::CloseFilter 3 pid 4095
11:23:26.821 - Api2BaseModule::CloseFilter 4 pid 221
11:23:26.834 - Api2BaseModule::CloseFilter 5 pid 0
11:23:26.848 - Api2BaseModule::GetCurrentDeviceInfo
11:23:26.862 - Api2BaseModule::OpenFilter 18 OK
11:23:26.875 - Api2BaseModule::OpenFilter 100 OK
11:23:26.889 - Api2BaseModule::OpenFilter 221 OK
11:23:26.902 - Api2BaseModule::OpenFilter 222 OK
11:23:26.915 - Api2BaseModule::OpenFilter 0 OK
11:23:26.922 - TsInputTrafficProcessor.UpdateChannel 43981
11:23:26.930 - GraphState: Undef by StartChannelIsReady
11:23:26.937 - PreScanner.StartChannelIsReady net=1 parseall=1
11:23:26.947 - VideoMediaTypeDetection: mpeg2
11:23:26.954 - SetMarkerAudioLngStream Gen New stream
11:23:26.961 - SimpleTsDemux::Init apid=221, vpid=100
11:23:26.968 - GraphState: RequestPATScan by StartChannelIsReady TS
11:23:26.975 - Api2BaseModule.Filters_EnabledFullTS 1
11:23:26.988 - PlayTimePATParser.OpenParser 43981
11:23:26.995 - Open TSTS filter pid=0 data=0
11:23:27.002 - TSTS cur size=0
11:23:27.009 - Graph::UpdateRenderMode
11:23:27.128 - Graph::SetVideoRect {8 8 712 568}
11:23:27.136 - Graph::SetVideoWindowRect {10 0 1596 887}
11:23:27.143 - [102]OnChangeCurrentGraph2 -endOfSetChannel
11:23:27.150 - ChannelGraph5.SetActiveState 1
11:23:27.274 - OK. 102
11:23:27.569 - * s:0 q:0 tr=0 (0) Preparing
11:23:27.730 - 
11:23:27.738 -        #################### First traffic. (2.078ms) #######################
11:23:27.745 - 
11:23:27.753 - TransportMarker: TS
11:23:27.760 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
11:23:27.767 - --SwitchEngineTransport TS > TS
11:23:27.768 - PlayTimePATParser.EndTask
11:23:27.782 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
11:23:27.789 - PreScanner.OnTransportMarker TS
11:23:27.796 - --SwitchEngineTransport end
11:23:27.803 - PreScanner.OnAfterScanPat count=2 {1;4095}
11:23:27.811 - Api2BaseModule.Filters_EnabledFullTS 0
11:23:27.827 - GraphState: RequestPMTScan by OnAfterScanPat
11:23:27.834 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=1
11:23:27.841 - Open TSTS filter pid=4095 data=2
11:23:27.848 - TSTS cur size=532792
11:23:27.855 - TSTS quick finish
11:23:27.890 - PreScanner.OnAfterScanPmt pmt=4095
11:23:27.898 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
11:23:27.905 - PlayTimePmtParser::StopParser
11:23:27.989 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
11:23:27.996 - TimeShift.Cursor SetChannel::v 1059756 (1059756)
11:23:28.003 - Prereader.SetChannel unmask 1
11:23:28.010 - Plugin::SetChannel 1
11:23:28.017 - TransponderManager::SelectChannel
11:23:28.027 - TsInputTrafficProcessor.SelectChannel 1
11:23:28.035 - Api2BaseModule.UpdateAllOpenedChannels 1
11:23:28.049 - Api2BaseModule::CloseFilter 1 pid 18
11:23:28.063 - Api2BaseModule::CloseFilter 2 pid 100
11:23:28.086 - Api2BaseModule::CloseFilter 3 pid 221
11:23:28.100 - Api2BaseModule::CloseFilter 4 pid 222
11:23:28.113 - Api2BaseModule::CloseFilter 5 pid 0
11:23:28.127 - Api2BaseModule::GetCurrentDeviceInfo
11:23:28.140 - Api2BaseModule::OpenFilter 18 OK
11:23:28.153 - Api2BaseModule::OpenFilter 211 OK
11:23:28.166 - Api2BaseModule::OpenFilter 4095 OK
11:23:28.179 - Api2BaseModule::OpenFilter 221 OK
11:23:28.192 - Api2BaseModule::OpenFilter 222 OK
11:23:28.207 - Api2BaseModule::OpenFilter 0 OK
11:23:28.214 - TsInputTrafficProcessor.UpdateChannel 1
11:23:28.223 - PreScanner.StartChannelIsReady net=1 parseall=0
11:23:28.230 - ChannelGraph5::AfterDetectChannelParams
11:23:28.237 - VideoMediaTypeDetection: h.264
11:23:28.244 - SimpleTsDemux::Init apid=221, vpid=211
11:23:28.252 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
11:23:28.260 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
11:23:28.268 - Prereader::ReaderCursor.. OK
11:23:28.282 - ReaderCursor::SetPosition 0 (w=8802861890666496)
11:23:28.290 - Prereader.StartPlayback Push buffering=0 recv=1268DD20 [StartChannelHelperBase(sl)]
11:23:28.297 - Prereader.StartPlayback after lock
11:23:28.305 - PreScanner.StartPmtParserIfNeed
11:23:28.313 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=0
11:23:28.320 - Open TSTS filter pid=4095 data=2
11:23:28.306 - VideoParser::First packet 50950 h.264
11:23:28.328 - TSTS cur size=2194148
11:23:28.335 - h264 detected 0 ms
11:23:28.352 - AudioParser::First packet 399
11:23:28.359 - AudioParser::packet 388
11:23:28.371 - AudioParser::packet 417
11:23:28.383 - AudioParser::packet 439
11:23:28.392 - AudioParser::AAC detected
11:23:28.399 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
11:23:28.406 - PreScanner.Post_InitRender [ReceiveTraffic]
11:23:28.413 - [102]sm: TvInitRenderer 1
11:23:28.420 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
11:23:28.427 - CalculBufferingSize prov=0EC52394 marker=1 request=1
11:23:28.434 - CalculBuffering 2000ms br=2000kb to 500 kbytes. By type
11:23:28.441 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
11:23:28.448 - Prereader::ReaderCursor.. OK
11:23:28.463 - ReaderCursor::SetPosition 0 (w=11938205196615680)
11:23:28.470 - Prereader.StartPlayback Pull buffering=512000 recv=00000000 [EnablePullModeAndStartPlayback]
11:23:28.476 - Prereader.StartPlayback after lock
11:23:28.483 - Buffering/prereader size 500/3906 kbytes
11:23:28.491 - ------sGetVideoParams
11:23:28.498 - ChannelGraph5.CreateInterfacesAndRenderGraph
11:23:28.506 - * s:100 q:100 tr=2939004 (0) Preparing
11:23:28.509 - subsm.StartChannel demux=ProgDemux tr=TS
11:23:28.513 - OnBuffering.OnTunerStateChanged  4
11:23:28.521 - subsm.RecreateSubtitlesParsers 0C84B058 ts=1 subindex=-1
11:23:28.536 - subsm.Set Teletext parser 0
11:23:28.544 - subsm.RecreateSubtitlesParsers end
11:23:28.551 - subs: OnSetChannel
11:23:28.559 - CreateCustomGraph
11:23:28.567 - VideoType:H.264/AVC ffmpeg=0
11:23:28.574 - Video/4.H264 : MPEG2_VIDEO s={0,0,1920,1080}, t={0,0,1920,1080}, bmp=1920x1088, r=30/17, br=0,frametime=40ms, IF=0x0, CF=0x0)
11:23:28.581 - Add video codec 212690fb-83e5-4526-8fd7-74478b7939cd
11:23:28.598 - OK
11:23:28.606 - CChannelGraph5::CreateRender 10
11:23:28.613 - VR: EVR Custom
11:23:28.620 - VR: create new render
11:23:29.283 - VR: Add video renderer Video Renderer - OK
11:23:29.293 - CreateAudioPartOfGraph
11:23:29.302 - AudioType:AAC/ADTS 
11:23:29.309 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 48000 16bit formatTag= 0x1600)
11:23:29.317 - Add audio codec e1f1a0b8-beee-490d-ba7c-066c40b5e2b9 - OK
11:23:29.331 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
11:23:29.339 - Added audio renderer
11:23:29.396 - Add and connect audio renderer - OK
11:23:29.403 - Graph::AfterRender
11:23:29.410 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
11:23:29.417 - AV:UpdateAudioParamsAfterActive
11:23:29.424 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
11:23:29.433 - GR:UpdateAudioProcessor old=0 new=0
11:23:29.440 - Graph::SetVolume 25% -2500db
11:23:29.448 - Graph::SetAudioChannelMask
11:23:29.455 - Graph::Run
11:23:29.604 - Graph::Run 1
11:23:29.627 - Graph::SetPictureParams
11:23:29.637 - Graph::SetVideoRect {24 16 1896 1068}
11:23:29.646 - Graph::SetVideoWindowRect {20 0 1585 887}
11:23:29.678 - 
11:23:29.688 - [0]########################### Mark of finish channel changing. (4.032ms) #############
11:23:29.697 - 
11:23:29.727 - OSDManager::Window_Add
11:23:29.742 - OSDManager::Window_Show
11:23:29.784 - * s:100 q:100 tr=3894608 (0) Playing
11:23:29.856 - OSDManager::Window_Show
11:23:29.871 - OSDManager::Window_Show
11:23:30.171 - CChannelGraph5::HideSubtitles
11:23:30.468 - * s:100 q:100 tr=1345892 (0) Playing
11:23:31.468 - * s:100 q:100 tr=6833800 (0) Playing
11:23:31.470 - 
11:23:31.487 - [0]########################### First video frame. (5.828ms) #############
11:23:31.496 - 
11:23:32.276 - changed ratio to 1920/1080
11:23:32.283 - Graph::SetVideoRect {24 16 1896 1068}
11:23:32.291 - Graph::SetVideoWindowRect {10 0 1596 887}
11:23:32.464 - * s:100 q:100 tr=6823272 (0) Playing
11:23:33.513 - 
11:23:33.522 - 
11:23:33.533 - ########################### Mark of start channel changing.###########################
11:23:33.543 - 
11:23:33.552 - GraphManager::MainChangeChannel Кинохит HD  1 provs
11:23:33.565 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
11:23:33.576 - SetChannelLogic::SetChannel 0
11:23:33.587 - SetChannelLogic::SetNormalChannel
11:23:33.616 - ChannelGraph5::StopChannel Кинохит HD
11:23:33.624 - PreScanner.Stop
11:23:33.633 - GraphState: Undef by PreScanner.Stop
11:23:33.650 - PlayTimePmtParser::StopParser
11:23:33.657 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
11:23:33.666 - Prereader::ReaderCursor.. OK
11:23:33.682 - ReaderCursor::SetPosition 0 (w=129478454927163392)
11:23:33.691 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
11:23:33.698 - Prereader.StartPlayback after lock
11:23:33.709 - subsm.StopChannel
11:23:33.719 - Graph::Stop
11:23:34.275 - Before Stop ...11:23:34.294 - OnGraphStop ...11:23:34.381 - VR: Disconnect
11:23:34.399 - Graph::ReleaseAllFilters
11:23:34.407 - release: Prog Audio renderer - RR - OK.
11:23:34.510 - release: Video Renderer - RR - OK.
11:23:34.617 - release: Microsoft DTV-DVD Video Decoder - RR - OK.
11:23:34.634 - release: Microsoft DTV-DVD Audio Decoder - RR - OK.
11:23:34.653 - FilterGraph: 1
11:23:34.663 - 
11:23:34.672 - TransponderManager::SetTransponder (CH) 0 Кинохит HD
11:23:34.681 - *Transport TS
11:23:34.690 - Api2Device::SetChannel http://cf3e5210.rossteleccom.net/iptv/392XTEQ7L49GFY/7250/index.m3u8
11:23:34.774 - Api2BaseModule.OnTunerStateChanged Connecting
11:23:34.779 - Api2Device::SetChannel result OK
11:23:34.792 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=43981
11:23:34.800 - TsInputTrafficProcessor.OpenTransponder 1
11:23:34.783 - Api2BaseModule.OnTunerStateChanged  -3
11:23:34.808 - FilterManager::OnSetTransponder SetChannel
11:23:34.825 - TimeShift.Reset
11:23:34.833 - TimeShift.Cursor reset
11:23:34.841 - ReaderCursor::Reset.. OK
11:23:34.857 - Prereader.Reset ...-OK
11:23:34.872 - Create EPGparser on SetChannel
11:23:34.880 - DvbEpgParser::SetChannel ID=10018.b6f136ef8d6f365f.abcd
11:23:34.895 - Api2BaseModule.OnTunerStateChanged Preparing
11:23:34.902 - DvbEpgParser::mode normal pos=0
11:23:34.902 - Api2BaseModule.OnTunerStateChanged  -4
11:23:34.910 - ModuleList::ChangeChannel 0
11:23:34.927 - [102]ChannelGraph5::StartChannel Кинохит HD
11:23:34.934 - 
11:23:34.941 - [102]       #################### Start stream. (1.407ms) #######################
11:23:34.948 - 
11:23:34.936 - Api2BaseModule.OnTunerStateChanged Playing
11:23:34.962 - Api2BaseModule.OnTunerStateChanged  -4
11:23:35.024 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
11:23:35.032 - TimeShift.Cursor SetChannel::v 0 (0)
11:23:35.039 - ReaderCursor::SetChannel.. OK
11:23:35.054 - ReaderCursor::SetPosition 0 (w=0)
11:23:35.061 - Prereader.SetChannel..
11:23:35.068 - Prereader.SetChannel unmask 1
11:23:35.075 - Plugin::SetChannel 43981
11:23:35.082 - TransponderManager::SelectChannel
11:23:35.092 - TsInputTrafficProcessor.SelectChannel 43981
11:23:35.099 - Api2BaseModule.UpdateAllOpenedChannels 1
11:23:35.112 - Api2BaseModule::CloseFilter 1 pid 18
11:23:35.125 - Api2BaseModule::CloseFilter 2 pid 211
11:23:35.145 - Api2BaseModule::CloseFilter 3 pid 4095
11:23:35.164 - Api2BaseModule::CloseFilter 4 pid 221
11:23:35.177 - Api2BaseModule::CloseFilter 5 pid 222
11:23:35.190 - Api2BaseModule::CloseFilter 6 pid 0
11:23:35.204 - Api2BaseModule::GetCurrentDeviceInfo
11:23:35.217 - Api2BaseModule::OpenFilter 18 OK
11:23:35.230 - Api2BaseModule::OpenFilter 100 OK
11:23:35.243 - Api2BaseModule::OpenFilter 221 OK
11:23:35.256 - Api2BaseModule::OpenFilter 222 OK
11:23:35.270 - Api2BaseModule::OpenFilter 0 OK
11:23:35.277 - TsInputTrafficProcessor.UpdateChannel 43981
11:23:35.286 - GraphState: Undef by StartChannelIsReady
11:23:35.293 - PreScanner.StartChannelIsReady net=1 parseall=1
11:23:35.300 - VideoMediaTypeDetection: mpeg2
11:23:35.307 - SetMarkerAudioLngStream Gen New stream
11:23:35.314 - SimpleTsDemux::Init apid=221, vpid=100
11:23:35.321 - GraphState: RequestPATScan by StartChannelIsReady TS
11:23:35.328 - Api2BaseModule.Filters_EnabledFullTS 1
11:23:35.341 - PlayTimePATParser.OpenParser 43981
11:23:35.348 - Open TSTS filter pid=0 data=0
11:23:35.355 - TSTS cur size=0
11:23:35.362 - Graph::UpdateRenderMode
11:23:35.437 - Graph::SetVideoRect {8 8 712 568}
11:23:35.446 - Graph::SetVideoWindowRect {10 0 1596 887}
11:23:35.454 - [102]OnChangeCurrentGraph2 -endOfSetChannel
11:23:35.462 - ChannelGraph5.SetActiveState 1
11:23:35.589 - OK. 102
11:23:35.960 - OSDManager::Window_Show
11:23:36.005 - OSDManager::Window_Delete
11:23:36.031 - * s:0 q:0 tr=0 (0) Preparing
11:23:36.047 - 
11:23:36.054 -        #################### First traffic. (2.532ms) #######################
11:23:36.062 - 
11:23:36.069 - TransportMarker: TS
11:23:36.076 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
11:23:36.085 - PlayTimePATParser.EndTask
11:23:36.107 - --SwitchEngineTransport TS > TS
11:23:36.114 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
11:23:36.121 - PreScanner.OnTransportMarker TS
11:23:36.129 - --SwitchEngineTransport end
11:23:36.136 - PreScanner.OnAfterScanPat count=2 {1;4095}
11:23:36.144 - Api2BaseModule.Filters_EnabledFullTS 0
11:23:36.159 - GraphState: RequestPMTScan by OnAfterScanPat
11:23:36.166 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=1
11:23:36.174 - Open TSTS filter pid=4095 data=2
11:23:36.181 - TSTS cur size=1218992
11:23:36.188 - TSTS quick finish
11:23:36.224 - PreScanner.OnAfterScanPmt pmt=4095
11:23:36.232 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
11:23:36.240 - PlayTimePmtParser::StopParser
11:23:36.326 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
11:23:36.333 - TimeShift.Cursor SetChannel::v 2486112 (2486112)
11:23:36.340 - Prereader.SetChannel unmask 1
11:23:36.347 - Plugin::SetChannel 1
11:23:36.354 - TransponderManager::SelectChannel
11:23:36.361 - TsInputTrafficProcessor.SelectChannel 1
11:23:36.367 - Api2BaseModule.UpdateAllOpenedChannels 1
11:23:36.380 - Api2BaseModule::CloseFilter 1 pid 18
11:23:36.393 - Api2BaseModule::CloseFilter 2 pid 100
11:23:36.412 - Api2BaseModule::CloseFilter 3 pid 221
11:23:36.425 - Api2BaseModule::CloseFilter 4 pid 222
11:23:36.438 - Api2BaseModule::CloseFilter 5 pid 0
11:23:36.451 - Api2BaseModule::GetCurrentDeviceInfo
11:23:36.464 - Api2BaseModule::OpenFilter 18 OK
11:23:36.477 - Api2BaseModule::OpenFilter 211 OK
11:23:36.490 - Api2BaseModule::OpenFilter 4095 OK
11:23:36.503 - Api2BaseModule::OpenFilter 221 OK
11:23:36.515 - Api2BaseModule::OpenFilter 222 OK
11:23:36.529 - Api2BaseModule::OpenFilter 0 OK
11:23:36.535 - TsInputTrafficProcessor.UpdateChannel 1
11:23:36.542 - PreScanner.StartChannelIsReady net=1 parseall=0
11:23:36.549 - ChannelGraph5::AfterDetectChannelParams
11:23:36.556 - VideoMediaTypeDetection: h.264
11:23:36.563 - SimpleTsDemux::Init apid=221, vpid=211
11:23:36.570 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
11:23:36.577 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
11:23:36.584 - Prereader::ReaderCursor.. OK
11:23:36.597 - ReaderCursor::SetPosition 0 (w=20397899200331776)
11:23:36.604 - Prereader.StartPlayback Push buffering=0 recv=1268DD20 [StartChannelHelperBase(sl)]
11:23:36.611 - Prereader.StartPlayback after lock
11:23:36.617 - PreScanner.StartPmtParserIfNeed
11:23:36.618 - AudioParser::First packet 355
11:23:36.624 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=0
11:23:36.639 - Open TSTS filter pid=4095 data=2
11:23:36.632 - VideoParser::First packet 45515 h.264
11:23:36.652 - h264 detected 0 ms
11:23:36.645 - TSTS cur size=5210796
11:23:36.658 - AudioParser::packet 363
11:23:36.674 - AudioParser::AAC detected
11:23:36.682 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
11:23:36.691 - PreScanner.Post_InitRender [ReceiveTraffic]
11:23:36.705 - [102]sm: TvInitRenderer 1
11:23:36.713 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
11:23:36.720 - CalculBufferingSize prov=0EC52394 marker=1 request=1
11:23:36.727 - CalculBuffering 2000ms br=2000kb to 500 kbytes. By type
11:23:36.733 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
11:23:36.741 - Prereader::ReaderCursor.. OK
11:23:36.754 - ReaderCursor::SetPosition 0 (w=26787281528422400)
11:23:36.761 - Prereader.StartPlayback Pull buffering=512000 recv=00000000 [EnablePullModeAndStartPlayback]
11:23:36.768 - Prereader.StartPlayback after lock
11:23:36.774 - Buffering/prereader size 500/3906 kbytes
11:23:36.782 - ------sGetVideoParams
11:23:36.789 - ChannelGraph5.CreateInterfacesAndRenderGraph
11:23:36.796 - * s:100 q:100 tr=6515704 (0) Preparing
11:23:36.800 - subsm.StartChannel demux=ProgDemux tr=TS
11:23:36.804 - OnBuffering.OnTunerStateChanged  4
11:23:36.812 - subsm.RecreateSubtitlesParsers 0C84B058 ts=1 subindex=-1
11:23:36.827 - subsm.Set Teletext parser 0
11:23:36.834 - subsm.RecreateSubtitlesParsers end
11:23:36.841 - subs: OnSetChannel
11:23:36.848 - CreateCustomGraph
11:23:36.855 - VideoType:H.264/AVC ffmpeg=0
11:23:36.862 - Video/4.H264 : MPEG2_VIDEO s={0,0,1920,1080}, t={0,0,1920,1080}, bmp=1920x1088, r=30/17, br=0,frametime=40ms, IF=0x0, CF=0x0)
11:23:36.869 - Add video codec 212690fb-83e5-4526-8fd7-74478b7939cd
11:23:36.885 - OK
11:23:36.892 - CChannelGraph5::CreateRender 10
11:23:36.899 - VR: EVR Custom
11:23:36.906 - VR: create new render
11:23:37.562 - VR: Add video renderer Video Renderer - OK
11:23:37.570 - CreateAudioPartOfGraph
11:23:37.577 - AudioType:AAC/ADTS 
11:23:37.584 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 48000 16bit formatTag= 0x1600)
11:23:37.592 - Add audio codec e1f1a0b8-beee-490d-ba7c-066c40b5e2b9 - OK
11:23:37.604 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
11:23:37.611 - Added audio renderer
11:23:37.664 - Add and connect audio renderer - OK
11:23:37.671 - Graph::AfterRender
11:23:37.678 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
11:23:37.689 - AV:UpdateAudioParamsAfterActive
11:23:37.696 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
11:23:37.703 - GR:UpdateAudioProcessor old=0 new=0
11:23:37.710 - Graph::SetVolume 25% -2500db
11:23:37.719 - Graph::SetAudioChannelMask
11:23:37.726 - Graph::Run
11:23:37.873 - Graph::Run 1
11:23:37.895 - Graph::SetPictureParams
11:23:37.902 - Graph::SetVideoRect {24 16 1896 1068}
11:23:37.910 - Graph::SetVideoWindowRect {20 0 1585 887}
11:23:37.946 - 
11:23:37.953 - [0]########################### Mark of finish channel changing. (4.422ms) #############
11:23:37.963 - 
11:23:37.987 - OSDManager::Window_Add
11:23:38.003 - OSDManager::Window_Show
11:23:38.044 - * s:100 q:100 tr=7470180 (0) Playing
11:23:38.107 - OSDManager::Window_Show
11:23:38.123 - OSDManager::Window_Show
11:23:38.391 - CChannelGraph5::HideSubtitles
11:23:38.950 - * s:100 q:100 tr=6113384 (0) Playing
11:23:39.491 - * s:100 q:100 tr=4431348 (0) Playing
11:23:39.622 - 
11:23:39.631 - [0]########################### First video frame. (6.110ms) #############
11:23:39.640 - 
11:23:40.287 - changed ratio to 1920/1080
11:23:40.296 - Graph::SetVideoRect {24 16 1896 1068}
11:23:40.305 - Graph::SetVideoWindowRect {10 0 1596 887}
11:23:40.492 - * s:100 q:100 tr=5874624 (0) Playing
11:23:41.500 - * s:100 q:100 tr=6191028 (0) Playing
11:23:42.498 - * s:100 q:100 tr=6646928 (0) Playing
11:23:43.489 - OSDManager::Window_Show
11:23:43.496 - OSDManager::Window_Delete
11:23:43.524 - * s:100 q:100 tr=7171824 (0) Playing
11:23:44.495 - * s:100 q:100 tr=6036492 (0) Playing
11:23:45.493 - * s:100 q:100 tr=5134656 (0) Playing
11:23:46.498 - * s:100 q:100 tr=0 (0) Playing
11:23:47.501 - * s:100 q:100 tr=0 (0) Playing
11:23:47.601 - 
11:23:47.609 - Stop engine
11:23:47.617 - DevicesManager::Stop
11:23:47.631 - ChannelGraph5::StopChannel 
11:23:47.640 - PreScanner.Stop
11:23:47.648 - GraphState: Undef by PreScanner.Stop
11:23:47.662 - PlayTimePmtParser::StopParser
11:23:47.669 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
11:23:47.676 - Prereader::ReaderCursor.. OK
11:23:47.690 - ReaderCursor::SetPosition 0 (w=264368465568071680)
11:23:47.697 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
11:23:47.704 - Prereader.StartPlayback after lock
11:23:47.711 - subsm.StopChannel
11:23:47.718 - Graph::Stop
11:23:47.864 - Before Stop ...11:23:47.880 - OnGraphStop ...11:23:47.963 - VR: Disconnect
11:23:47.978 - Graph::ReleaseAllFilters
11:23:47.985 - release: Prog Audio renderer - RR - OK.
11:23:48.082 - release: Video Renderer - RR - OK.
11:23:48.168 - release: Microsoft DTV-DVD Video Decoder - RR - OK.
11:23:48.185 - release: Microsoft DTV-DVD Audio Decoder - RR - OK.
11:23:48.198 - FilterGraph: 1
11:23:48.207 - remove graph idx=0 count=1
11:23:48.214 - ChannelGraph5.~CChannelGraph5
11:23:48.221 - PreScanner.Stop
11:23:48.228 - GraphState: Undef by PreScanner.Stop
11:23:48.235 - PlayTimePmtParser::StopParser
11:23:48.241 - subsm.StopChannel
11:23:48.248 - Graph::ReleaseAllFilters
11:23:48.294 - ChannelGraph5.~CChannelGraph5 finish
11:23:48.323 - TransponderManager::CloseChannel
11:23:48.330 - TsInputTrafficProcessor.RemoveChannel 1
11:23:48.337 - ~TransponderChannelSource
11:23:48.375 - TimeShift.DestroyReadingCursor
11:23:48.389 - Prereader.Exit11:23:48.397 - Api2BaseModule.UpdateAllOpenedChannels 0
11:23:48.410 - Api2BaseModule::CloseFilter 1 pid 18
11:23:48.424 - Api2BaseModule::CloseFilter 2 pid 211
11:23:48.443 - Api2BaseModule::CloseFilter 3 pid 4095
11:23:48.463 - Api2BaseModule::CloseFilter 4 pid 221
11:23:48.483 - Api2BaseModule::CloseFilter 5 pid 222
11:23:48.502 - Api2BaseModule::CloseFilter 6 pid 0
11:23:48.523 - Api2BaseModule::GetCurrentDeviceInfo
11:23:48.530 - Destroy TSTS filter pid=0
11:23:48.537 - PlayTimePmtParser::StopParser
11:23:48.544 - Destroy TSTS filter pid=4095
11:23:48.551 - DevicesManager::DestroyTransponderManager
11:23:48.557 - Api2Device::SetChannel - None
11:23:48.620 - Api2Device::SetChannel result OK
11:23:48.626 - SetOwner N -> 0
11:23:48.633 - SetOwner SetTransponder null
11:23:48.645 - ~TransponderManager
11:23:48.652 - SetOwner N -> 0
11:23:48.658 - SetOwner SetTransponder null
11:23:48.684 - TimeShift.~TimeShift
11:23:48.691 - HugeMemoryBlocksManager::Free
11:23:48.698 - ModuleList::Free
11:23:48.784 - DevicesManager::Free devices
11:23:48.791 - SDP:Destroy netclient.0 own=00000000
11:23:48.810 - SDP:after destroy device
11:23:48.817 - DevicesManager::Free RC
11:23:48.825 - Engine stopped
11:23:48.857 - 
11:23:48.864 - Stop engine
11:23:48.872 - DevicesManager::Stop
11:23:48.885 - DevicesManager::Free devices
11:23:48.892 - Engine stopped
11:23:49.060 - HugeMemoryBlocksManager::FreeAll
