﻿10:55:10.105 - Start logging...
10:55:10.153 - ExceptionFilter::Init. restart=1
10:55:10.980 - DevicesManager::EnableCISupport
10:55:10.981 - CAVManager::SetSettings
10:55:10.986 - DevicesManager::DestroyAllTransponderManager
10:55:11.010 - SetDefaultNullCodecs
10:55:11.033 - SetDefaultNullCodecs
10:55:11.048 - DevicesManager::Start
10:55:11.049 - AVManager::Init
10:55:11.085 - RemoveAllCreateBlank needBlank1
10:55:11.093 - add graph 0AC2C040 101
10:55:11.098 - [101]OnChangeCurrentGraph2 -RemoveAllBlank
10:55:11.126 - VR: GUI
10:55:11.143 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
10:55:11.202 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
10:55:11.203 - AV:UpdateAudioParamsAfterActive
10:55:11.208 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
10:55:11.213 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
10:55:11.304 - DevicesManager::StartDevices...
10:55:11.304 - device netclient.0 10:55:11.314 - dev: UpdateNetworkRecommendations  962x571 -1x-1
10:55:11.318 - dev: Created  netclient.0 0AB53FD8
OK
10:55:11.328 - Api2BaseModule.GetAdditionInfo
10:55:11.334 - Api2BaseModule.GetAdditionInfo OK
10:55:11.467 - Api2BaseModule.OnDisplaySize
10:55:11.467 - dev: UpdateNetworkRecommendations  2280x1227 -1x-1
10:55:11.745 - 
10:55:11.745 - 
10:55:11.752 - ########################### Mark of start channel changing.###########################
10:55:11.757 - 
10:55:11.763 - GraphManager::MainChangeChannel UZ Фантастика HD  1 provs
10:55:11.768 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
10:55:11.773 - SetChannelLogic::SetChannel 0
10:55:11.777 - SetChannelLogic::SetNormalChannel
10:55:11.782 - DevicesManager::CreateCloneDevice
10:55:11.787 - DevicesManager::CreateCloneDevice OK - founded in list
10:55:11.794 - TransponderManager
10:55:11.799 - CTransponderManager::InitOnNewDevice 0D4F6ABC
10:55:11.804 - SetOwner N -> Incoming Stream Cache
10:55:11.810 - TrafficProcessingScheme_CreateForNewEngineTransport 1 ss=0
10:55:11.815 - Normal TsInputTrafficProcessor.
10:55:11.820 - FilterManager::InitOnNewDevice 1
10:55:11.826 - TS router+MarkerFinder -> InputTrafficProcessor
10:55:11.832 - Incoming Stream Cache -> TS router+MarkerFinder
10:55:11.837 - InputTrafficProcessor -> Router to timeshift
10:55:11.842 - InputTrafficProcessor(FM) -> FilterManager
10:55:11.847 - ModuleList::Free
10:55:11.854 - Api2BaseModule::GetCurrentDeviceInfo
10:55:11.859 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\PidRecorder.module OK
10:55:11.867 - Api2BaseModule::GetCurrentDeviceInfo
10:55:11.874 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\ProgMediaServer.Module OK
10:55:11.878 - ChannelGraph5.CChannelGraph5
10:55:11.884 - TransponderManager::AddChildChannel
10:55:11.890 - TimeShift.TimeShift
10:55:11.895 - TimeShift.Create 200 mbytes 
10:55:11.900 - ts:One channel
10:55:11.906 - HugeMemoryBlocksManager::GetBlock 200 mbytes OK
10:55:11.911 - TransponderManager::CreateTimeshiftBuffer OK
10:55:11.929 - TimeShift.CreateReadingCursor
10:55:11.929 - TransponderChannelSource.Plugins 08F6E210 csa 00000000
10:55:11.935 - TsInputTrafficProcessor.AddChannel 0
10:55:11.941 - SetChannelLogic::LookDeviceWithoutChannelsOrCloneAndMakeGraph
10:55:11.946 - add graph 0D717BB4 102
10:55:11.952 - * s:0 q:0 tr=0 (0) offline
10:55:11.959 - ChannelGraph5.SetActiveState 1 render=1
10:55:11.966 - TransponderManager::SelectChannel
10:55:11.972 - TsInputTrafficProcessor.SelectChannel 0
10:55:11.977 - Api2BaseModule.UpdateAllOpenedChannels 0
10:55:11.984 - AV:UpdateAudioParamsAfterActive
10:55:11.990 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
10:55:11.996 - GR:UpdateAudioProcessor old=0 new=0
10:55:12.002 - Graph::SetAudioChannelMask
10:55:12.008 - **** StopChannel time 0.250ms
10:55:12.014 - 
10:55:12.019 - TransponderManager::SetTransponder (CH) 0 UZ Фантастика HD
10:55:12.026 - *Transport TS
10:55:12.033 - Api2Device::SetChannel http://cf3e5210.rossteleccom.net/iptv/392XTEQ7L49GFY/13065/index.m3u8
10:55:12.065 - Api2Device::SetChannel result OK
10:55:12.065 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
10:55:12.071 - TsInputTrafficProcessor.OpenTransponder 1
10:55:12.076 - Api2BaseModule.OnTunerStateChanged Connecting
10:55:12.077 - FilterManager::OnSetTransponder SetChannel
10:55:12.088 - TimeShift.Reset
10:55:12.094 - TimeShift.Cursor reset
10:55:12.099 - ReaderCursor::Reset.. OK
10:55:12.111 - Prereader.Reset ...-OK
10:55:12.121 - Create EPGparser on SetChannel
10:55:12.082 - Api2BaseModule.OnTunerStateChanged  -3
10:55:12.127 - DvbEpgParser::SetChannel ID=4eec0002.4d2fd2195e0af17b.1
10:55:12.144 - DvbEpgParser::mode normal pos=0
10:55:12.148 - ModuleList::ChangeChannel 0
10:55:12.154 - **** SetTransponder time 0.157ms
10:55:12.160 - [102]ChannelGraph5::StartChannel UZ Фантастика HD
10:55:12.165 - 
10:55:12.171 - [102]       #################### Start stream. (0.422ms) #######################
10:55:12.176 - 
10:55:12.205 - Api2BaseModule.OnTunerStateChanged Preparing
10:55:12.206 - Api2BaseModule.OnTunerStateChanged  -4
10:55:12.221 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
10:55:12.222 - TimeShift.Cursor SetChannel::v 0 (0)
10:55:12.230 - ReaderCursor::SetChannel.. OK
10:55:12.244 - ReaderCursor::SetPosition 0 (w=0)
10:55:12.250 - Prereader.SetChannel..
10:55:12.255 - Prereader.SetChannel unmask 1
10:55:12.263 - Plugin::SetChannel 1
10:55:12.270 - TransponderManager::SelectChannel
10:55:12.276 - TsInputTrafficProcessor.SelectChannel 1
10:55:12.282 - Api2BaseModule.UpdateAllOpenedChannels 1
10:55:12.264 - Api2BaseModule.OnTunerStateChanged Playing
10:55:12.294 - Api2BaseModule.OnTunerStateChanged  -4
10:55:12.287 - TsInputTrafficProcessor.UpdateChannel 1
10:55:12.306 - GraphState: Undef by StartChannelIsReady
10:55:12.312 - PreScanner.StartChannelIsReady net=1 parseall=1
10:55:12.318 - VideoMediaTypeDetection: h.264
10:55:12.324 - SetMarkerAudioLngStream Gen New stream
10:55:12.330 - SimpleTsDemux::Init apid=221, vpid=211
10:55:12.335 - GraphState: RequestPATScan by StartChannelIsReady TS
10:55:12.342 - Api2BaseModule.Filters_EnabledFullTS 1
10:55:12.348 - PlayTimePATParser.OpenParser 1
10:55:12.354 - Open TSTS filter pid=0 data=0
10:55:12.360 - TSTS cur size=0
10:55:12.366 - Graph::SetVideoRect {8 8 712 568}
10:55:12.372 - **** StartChanbnel time 0.218ms
10:55:12.378 - [102]OnChangeCurrentGraph2 -endOfSetChannel
10:55:12.383 - ChannelGraph5.SetActiveState 1 render=1
10:55:12.424 - Graph::SetVideoWindowRect {33 0 166 100}
10:55:12.425 - Graph::UpdateRenderMode
10:55:12.467 - GraphManager::MultiChannelRendering
10:55:12.467 - ChannelGraph5.SetActiveState 1 render=1
10:55:12.477 - Graph::SetVideoWindowRect {234 0 1692 1094}
10:55:12.497 - Graph::SetVideoWindowRect {235 0 1693 1094}
10:55:12.502 - Api2BaseModule.OnDisplaySize
10:55:12.502 - dev: UpdateNetworkRecommendations  2281x1227 -1x-1
10:55:12.534 - Graph::SetVideoWindowRect {234 0 1692 1094}
10:55:12.539 - Api2BaseModule.OnDisplaySize
10:55:12.540 - dev: UpdateNetworkRecommendations  2280x1227 -1x-1
10:55:12.618 - [102]**** SetChannel is finished (OK). Duration 0.860ms
10:55:12.711 - * s:0 q:0 tr=0 (0) Preparing
10:55:12.931 - TransportMarker: TS
10:55:12.931 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
10:55:12.939 - 
10:55:12.946 -        #################### First traffic. (1.188ms) #######################
10:55:12.953 - 
10:55:12.960 - --SwitchEngineTransport TS > TS
10:55:12.962 - PlayTimePATParser.EndTask
10:55:12.978 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
10:55:12.984 - PreScanner.OnTransportMarker TS
10:55:12.990 - --SwitchEngineTransport end
10:55:13.000 - PreScanner.OnAfterScanPat count=2 {1;4095}
10:55:13.006 - Api2BaseModule.Filters_EnabledFullTS 0
10:55:13.013 - GraphState: RequestPMTScan by OnAfterScanPat
10:55:13.021 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=1
10:55:13.029 - Open TSTS filter pid=4095 data=2
10:55:13.035 - TSTS cur size=406832
10:55:13.041 - TSTS quick finish
10:55:13.067 - PreScanner.OnAfterScanPmt pmt=4095
10:55:13.067 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
10:55:13.073 - PlayTimePmtParser::StopParser
10:55:13.151 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
10:55:13.151 - TimeShift.Cursor SetChannel::v 907664 (907664)
10:55:13.157 - Prereader.SetChannel unmask 1
10:55:13.164 - Plugin::SetChannel 1
10:55:13.170 - TransponderManager::SelectChannel
10:55:13.176 - TsInputTrafficProcessor.SelectChannel 1
10:55:13.183 - Api2BaseModule.UpdateAllOpenedChannels 1
10:55:13.189 - TsInputTrafficProcessor.UpdateChannel 1
10:55:13.195 - PreScanner.StartChannelIsReady net=1 parseall=0
10:55:13.201 - LngDefaultSelector.try select audio pid=221 type=1 lng=0-(deu,deu,rus) l=99
10:55:13.207 - ChannelGraph5::AfterDetectChannelParams
10:55:13.214 - VideoMediaTypeDetection: h.264
10:55:13.221 - SimpleTsDemux::Init apid=221, vpid=211
10:55:13.227 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
10:55:13.234 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
10:55:13.240 - Prereader::ReaderCursor.. OK
10:55:13.255 - ReaderCursor::SetPosition 0 (w=6143108903337984)
10:55:13.261 - Prereader.StartPlayback Push buffering=0 recv=0D718B5C [StartChannelHelperBase(sl)]
10:55:13.267 - Prereader.StartPlayback after lock
10:55:13.274 - PreScanner.StartPmtParserIfNeed
10:55:13.280 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=0
10:55:13.286 - Open TSTS filter pid=4095 data=2
10:55:13.294 - TSTS cur size=1495916
10:55:13.274 - VideoParser::First packet 149238 h.264
10:55:13.306 - h264 detected 0 ms
10:55:13.313 - AudioParser::First packet 296
10:55:13.321 - AudioParser::packet 308
10:55:13.328 - AudioParser::AAC detected
10:55:13.336 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
10:55:13.342 - PreScanner.Post_InitRender [ReceiveTraffic]
10:55:13.436 - [102]sm: TvInitRenderer res=1
10:55:13.436 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
10:55:13.443 - CalculBufferingSize prov=0D4F7EFC marker=1 request=1
10:55:13.449 - CalculBuffering 2000ms br=2000kb to 500 kbytes. By type
10:55:13.454 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
10:55:13.462 - Prereader::ReaderCursor.. OK
10:55:13.475 - ReaderCursor::SetPosition 0 (w=8048699993227264)
10:55:13.481 - Prereader.StartPlayback Pull buffering=512000 recv=00000000 [EnablePullModeAndStartPlayback]
10:55:13.487 - Prereader.StartPlayback after lock
10:55:13.494 - Buffering/prereader size 500/3906 kbytes
10:55:13.500 - demux: ProgDemux
10:55:13.523 - ------sGetVideoParams
10:55:13.523 - ChannelGraph5.CreateInterfacesAndRenderGraph
10:55:13.536 - subsm.StartChannel demux=ProgDemux tr=TS
10:55:13.537 - subsm.RecreateSubtitlesParsers 0743F8F0 ts=1 subindex=-1 st=-1
10:55:13.543 - subsm.Stop teletext parser
10:55:13.549 - subsm.RecreateSubtitlesParsers end
10:55:13.555 - subs: OnSetChannel
10:55:13.561 - CreateCustomGraph
10:55:13.567 - VideoType:H.264/AVC ffmpeg=0
10:55:13.574 - Video/4.H264 : MPEG2_VIDEO s={0,0,1920,1080}, t={0,0,1920,1080}, bmp=1920x1088, r=30/17, br=0,frametime=33ms, IF=0x0, CF=0x0)
10:55:13.580 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f
10:55:13.591 - OK
10:55:13.594 - CChannelGraph5::CreateRender 10
10:55:13.600 - VR: EVR Custom
10:55:13.606 - VR: create new render
10:55:13.722 - VR: Add video renderer Video Renderer - OK
10:55:13.722 - CreateAudioPartOfGraph
10:55:13.728 - AudioType:AAC/ADTS 
10:55:13.735 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 44100 16bit formatTag= 0x1600)
10:55:13.744 - Add audio codec e1f1a0b8-beee-490d-ba7c-066c40b5e2b9 - OK
10:55:13.764 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
10:55:13.765 - Added audio renderer
10:55:13.773 - AP: created
10:55:13.780 - Added audio processor
10:55:13.804 - Connect codec to AP - OK
10:55:13.807 - * s:100 q:100 tr=3609036 (0) Preparing
10:55:13.815 - OnBuffering.OnTunerStateChanged  4
10:55:13.831 - Add and connect audio renderer - OK
10:55:13.831 - Graph::AfterRender
10:55:13.839 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
10:55:13.845 - AV:UpdateAudioParamsAfterActive
10:55:13.852 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
10:55:13.858 - GR:UpdateAudioProcessor old=1 new=0
10:55:13.864 - Destroy Audio Processor udate
10:55:13.871 - Graph::SetVolume 0% -10000db
10:55:13.879 - Graph::SetAudioChannelMask
10:55:13.885 - Graph::Run
10:55:13.973 - Graph::Run 1
10:55:13.978 - Graph::SetPictureParams
10:55:13.979 - Graph::SetVideoRect {24 16 1896 1068}
10:55:13.986 - Graph::SetVideoWindowRect {0 1 1927 1092}
10:55:14.069 - 
10:55:14.069 - [0]########################### Mark of finish channel changing. (2.313ms) #############
10:55:14.084 - 
10:55:14.134 - CChannelGraph5::HideSubtitles
10:55:14.484 - changed ratio to 1920/1080
10:55:14.485 - Graph::SetVideoRect {24 16 1896 1068}
10:55:14.496 - Graph::SetVideoWindowRect {0 8 1927 1085}
10:55:14.656 - 
10:55:14.659 - [0]########################### First video frame. (2.907ms) #############
10:55:14.675 - 
10:55:14.705 - * s:100 q:100 tr=3572752 (0) Playing
10:55:15.829 - * s:100 q:100 tr=3904008 (0) Playing
10:55:16.827 - * s:100 q:100 tr=4472520 (0) Playing
10:55:17.808 - * s:100 q:100 tr=4295236 (0) Playing
10:55:18.823 - * s:100 q:100 tr=4451464 (0) Playing
10:55:19.864 - * s:100 q:100 tr=3520300 (0) Playing
10:55:20.124 - 
10:55:20.124 - 
10:55:20.132 - ########################### Mark of start channel changing.###########################
10:55:20.140 - 
10:55:20.148 - GraphManager::MainChangeChannel VIP Premiere HD  1 provs
10:55:20.157 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
10:55:20.166 - SetChannelLogic::SetChannel 0
10:55:20.176 - SetChannelLogic::SetNormalChannel
10:55:20.194 - ChannelGraph5::StopChannel VIP Premiere HD
10:55:20.194 - PreScanner.Stop
10:55:20.205 - GraphState: Undef by PreScanner.Stop
10:55:20.213 - PlayTimePmtParser::StopParser
10:55:20.223 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
10:55:20.233 - Prereader::ReaderCursor.. OK
10:55:20.250 - ReaderCursor::SetPosition 0 (w=127738391876861952)
10:55:20.260 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
10:55:20.270 - Prereader.StartPlayback after lock
10:55:20.278 - subsm.StopChannel
10:55:20.288 - Graph::Stop
10:55:20.387 - Before Stop ...10:55:20.399 - OnGraphStop ...10:55:20.491 - VR: Disconnect
10:55:20.494 - Graph::ReleaseAllFilters
10:55:20.499 - release: Prog Audio renderer - RR - OK.
10:55:20.517 - release: Video Renderer - RR - OK.
10:55:20.565 - release: Video decoder  - RR - OK.
10:55:20.581 - release: Audio Processor - RR - OK.
10:55:20.596 - release: Microsoft DTV-DVD Audio Decoder - RR - OK.
10:55:20.612 - FilterGraph: 1
10:55:20.623 - **** StopChannel time 0.500ms
10:55:20.628 - 
10:55:20.636 - TransponderManager::SetTransponder (CH) 0 VIP Premiere HD
10:55:20.643 - *Transport TS
10:55:20.652 - Api2Device::SetChannel http://cf3e5210.rossteleccom.net/iptv/392XTEQ7L49GFY/202/index.m3u8
10:55:20.669 - skip old generation traffic!
10:55:20.669 - skip old generation traffic!
10:55:20.676 - skip old generation traffic!
10:55:20.684 - skip old generation traffic!
10:55:20.693 - skip old generation traffic!
10:55:20.710 - Api2BaseModule.OnTunerStateChanged Connecting
10:55:20.712 - Api2BaseModule.OnTunerStateChanged  -3
10:55:20.739 - Api2Device::SetChannel result OK
10:55:20.739 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
10:55:20.747 - TsInputTrafficProcessor.OpenTransponder 1
10:55:20.755 - FilterManager::OnSetTransponder SetChannel
10:55:20.763 - TimeShift.Reset
10:55:20.771 - TimeShift.Cursor reset
10:55:20.779 - ReaderCursor::Reset.. OK
10:55:20.794 - Prereader.Reset ...-OK
10:55:20.809 - Create EPGparser on SetChannel
10:55:20.817 - DvbEpgParser::SetChannel ID=4eec0002.11cc8a64d379ee4b.1
10:55:20.801 - Api2BaseModule.OnTunerStateChanged Preparing
10:55:20.831 - Api2BaseModule.OnTunerStateChanged  -4
10:55:20.844 - DvbEpgParser::mode normal pos=0
10:55:20.847 - ModuleList::ChangeChannel 0
10:55:20.854 - **** SetTransponder time 0.235ms
10:55:20.862 - [102]ChannelGraph5::StartChannel VIP Premiere HD
10:55:20.869 - 
10:55:20.877 - Api2BaseModule.OnTunerStateChanged Playing
10:55:20.879 - [102]       #################### Start stream. (0.750ms) #######################
10:55:20.893 - 
10:55:20.886 - Api2BaseModule.OnTunerStateChanged  -4
10:55:21.002 - * s:100 q:100 tr=-27825316 (0) Preparing
10:55:21.009 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
10:55:21.010 - TimeShift.Cursor SetChannel::v 0 (0)
10:55:21.017 - ReaderCursor::SetChannel.. OK
10:55:21.032 - ReaderCursor::SetPosition 0 (w=0)
10:55:21.040 - Prereader.SetChannel..
10:55:21.047 - Prereader.SetChannel unmask 1
10:55:21.055 - Plugin::SetChannel 1
10:55:21.062 - TransponderManager::SelectChannel
10:55:21.069 - TsInputTrafficProcessor.SelectChannel 1
10:55:21.078 - Api2BaseModule.UpdateAllOpenedChannels 1
10:55:21.086 - TsInputTrafficProcessor.UpdateChannel 1
10:55:21.093 - GraphState: Undef by StartChannelIsReady
10:55:21.101 - PreScanner.StartChannelIsReady net=1 parseall=1
10:55:21.108 - VideoMediaTypeDetection: h.264
10:55:21.115 - SetMarkerAudioLngStream Gen New stream
10:55:21.122 - SimpleTsDemux::Init apid=221, vpid=211
10:55:21.128 - GraphState: RequestPATScan by StartChannelIsReady TS
10:55:21.136 - Api2BaseModule.Filters_EnabledFullTS 1
10:55:21.143 - PlayTimePATParser.OpenParser 1
10:55:21.151 - Open TSTS filter pid=0 data=0
10:55:21.158 - TSTS cur size=0
10:55:21.164 - Graph::UpdateRenderMode
10:55:21.172 - Graph::SetVideoRect {8 8 712 568}
10:55:21.179 - Graph::SetVideoWindowRect {0 8 1927 1085}
10:55:21.186 - **** StartChanbnel time 0.328ms
10:55:21.192 - [102]OnChangeCurrentGraph2 -endOfSetChannel
10:55:21.199 - ChannelGraph5.SetActiveState 1 render=1
10:55:21.723 - [102]**** SetChannel is finished (OK). Duration 1.594ms
10:55:21.958 - TransportMarker: TS
10:55:21.958 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
10:55:21.966 - 
10:55:21.975 -        #################### First traffic. (1.844ms) #######################
10:55:21.982 - 
10:55:21.991 - PlayTimePATParser.EndTask
10:55:22.010 - * s:100 q:100 tr=230676 (0) Preparing
10:55:22.104 - --SwitchEngineTransport TS > TS
10:55:22.104 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
10:55:22.112 - PreScanner.OnTransportMarker TS
10:55:22.120 - --SwitchEngineTransport end
10:55:22.164 - PreScanner.OnAfterScanPat count=2 {1;4095}
10:55:22.171 - Api2BaseModule.Filters_EnabledFullTS 0
10:55:22.178 - GraphState: RequestPMTScan by OnAfterScanPat
10:55:22.185 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=1
10:55:22.191 - Open TSTS filter pid=4095 data=2
10:55:22.198 - TSTS cur size=1050544
10:55:22.205 - TSTS quick finish
10:55:22.232 - PreScanner.OnAfterScanPmt pmt=4095
10:55:22.232 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
10:55:22.239 - PlayTimePmtParser::StopParser
10:55:22.346 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
10:55:22.346 - TimeShift.Cursor SetChannel::v 1456624 (1456624)
10:55:22.353 - Prereader.SetChannel unmask 1
10:55:22.360 - Plugin::SetChannel 1
10:55:22.366 - TransponderManager::SelectChannel
10:55:22.373 - TsInputTrafficProcessor.SelectChannel 1
10:55:22.379 - Api2BaseModule.UpdateAllOpenedChannels 1
10:55:22.386 - TsInputTrafficProcessor.UpdateChannel 1
10:55:22.393 - PreScanner.StartChannelIsReady net=1 parseall=0
10:55:22.399 - LngDefaultSelector.try select audio pid=221 type=1 lng=7566706-rus(deu,deu,rus) l=10
10:55:22.405 - LngDefaultSelector.try select audio pid=222 type=1 lng=7566706-rus(deu,deu,rus) l=10
10:55:22.412 - LngDefaultSelector. selected audio pid=221
10:55:22.419 - ChannelGraph5::AfterDetectChannelParams
10:55:22.426 - VideoMediaTypeDetection: h.264
10:55:22.432 - SimpleTsDemux::Init apid=221, vpid=211
10:55:22.439 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
10:55:22.446 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
10:55:22.453 - Prereader::ReaderCursor.. OK
10:55:22.466 - ReaderCursor::SetPosition 0 (w=8902178714419200)
10:55:22.474 - Prereader.StartPlayback Push buffering=0 recv=0D718B5C [StartChannelHelperBase(sl)]
10:55:22.480 - Prereader.StartPlayback after lock
10:55:22.488 - PreScanner.StartPmtParserIfNeed
10:55:22.495 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=0
10:55:22.501 - Open TSTS filter pid=4095 data=2
10:55:22.508 - TSTS cur size=2266904
10:55:22.488 - AudioParser::First packet 800
10:55:22.521 - VideoParser::First packet 28486 h.264
10:55:22.531 - h264 detected 0 ms
10:55:22.539 - AudioParser::packet 409
10:55:22.546 - AudioParser::packet 443
10:55:22.554 - AudioParser::AAC detected
10:55:22.560 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
10:55:22.601 - PreScanner.Post_InitRender [ReceiveTraffic]
10:55:22.607 - [102]sm: TvInitRenderer res=1
10:55:22.615 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
10:55:22.622 - CalculBufferingSize prov=0D4F7EFC marker=1 request=1
10:55:22.628 - CalculBuffering 2000ms br=2000kb to 500 kbytes. By type
10:55:22.635 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
10:55:22.641 - Prereader::ReaderCursor.. OK
10:55:22.655 - ReaderCursor::SetPosition 0 (w=13015348634714112)
10:55:22.662 - Prereader.StartPlayback Pull buffering=512000 recv=00000000 [EnablePullModeAndStartPlayback]
10:55:22.668 - Prereader.StartPlayback after lock
10:55:22.675 - Buffering/prereader size 500/3906 kbytes
10:55:22.682 - ------sGetVideoParams
10:55:22.690 - ChannelGraph5.CreateInterfacesAndRenderGraph
10:55:22.699 - subsm.StartChannel demux=ProgDemux tr=TS
10:55:22.704 - subsm.RecreateSubtitlesParsers 0743F8F0 ts=1 subindex=-1 st=-1
10:55:22.711 - subsm.Stop teletext parser
10:55:22.717 - subsm.RecreateSubtitlesParsers end
10:55:22.723 - subs: OnSetChannel
10:55:22.730 - CreateCustomGraph
10:55:22.737 - VideoType:H.264/AVC ffmpeg=0
10:55:22.744 - Video/4.H264 : MPEG2_VIDEO s={0,0,1920,1080}, t={0,0,1920,1080}, bmp=1920x1088, r=30/17, br=0,frametime=33ms, IF=0x0, CF=0x0)
10:55:22.751 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f
10:55:22.761 - OK
10:55:22.765 - CChannelGraph5::CreateRender 10
10:55:22.772 - VR: EVR Custom
10:55:22.779 - VR: create new render
10:55:22.929 - VR: Add video renderer Video Renderer - OK
10:55:22.930 - CreateAudioPartOfGraph
10:55:22.937 - AudioType:AAC/ADTS 
10:55:22.945 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 48000 16bit formatTag= 0x1600)
10:55:22.953 - Add audio codec e1f1a0b8-beee-490d-ba7c-066c40b5e2b9 - OK
10:55:22.973 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
10:55:22.973 - Added audio renderer
10:55:22.982 - AP: created
10:55:22.989 - Added audio processor
10:55:23.013 - Connect codec to AP - OK
10:55:23.045 - Add and connect audio renderer - OK
10:55:23.046 - Graph::AfterRender
10:55:23.054 - * s:100 q:100 tr=5137288 (0) Preparing
10:55:23.055 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
10:55:23.069 - AV:UpdateAudioParamsAfterActive
10:55:23.077 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
10:55:23.084 - GR:UpdateAudioProcessor old=1 new=0
10:55:23.091 - Destroy Audio Processor udate
10:55:23.098 - Graph::SetVolume 0% -10000db
10:55:23.105 - Graph::SetAudioChannelMask
10:55:23.112 - Graph::Run
10:55:23.213 - Graph::Run 1
10:55:23.220 - Graph::SetPictureParams
10:55:23.222 - Graph::SetVideoRect {24 16 1896 1068}
10:55:23.230 - Graph::SetVideoWindowRect {0 1 1927 1092}
10:55:23.288 - 
10:55:23.288 - [0]########################### Mark of finish channel changing. (3.157ms) #############
10:55:23.298 - 
10:55:23.402 - CChannelGraph5::HideSubtitles
10:55:23.948 - * s:100 q:100 tr=3743268 (0) Playing
10:55:24.891 - * s:100 q:100 tr=4069072 (0) Playing
10:55:25.024 - 
10:55:25.027 - [0]########################### First video frame. (4.907ms) #############
10:55:25.051 - 
10:55:25.046 - changed ratio to 1920/1080
10:55:25.076 - Graph::SetVideoRect {24 16 1896 1068}
10:55:25.092 - Graph::SetVideoWindowRect {0 8 1927 1085}
10:55:25.866 - * s:100 q:100 tr=3414644 (0) Playing
10:55:26.734 - 
10:55:26.734 - 
10:55:26.744 - ########################### Mark of start channel changing.###########################
10:55:26.759 - 
10:55:26.769 - GraphManager::MainChangeChannel UZ Фантастика HD  1 provs
10:55:26.780 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
10:55:26.794 - SetChannelLogic::SetChannel 0
10:55:26.806 - SetChannelLogic::SetNormalChannel
10:55:26.827 - ChannelGraph5::StopChannel UZ Фантастика HD
10:55:26.827 - PreScanner.Stop
10:55:26.843 - GraphState: Undef by PreScanner.Stop
10:55:26.856 - PlayTimePmtParser::StopParser
10:55:26.868 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
10:55:26.884 - Prereader::ReaderCursor.. OK
10:55:26.911 - ReaderCursor::SetPosition 0 (w=85893710922907648)
10:55:26.922 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
10:55:26.930 - Prereader.StartPlayback after lock
10:55:26.940 - subsm.StopChannel
10:55:26.950 - Graph::Stop
10:55:27.042 - Before Stop ...10:55:27.050 - * s:100 q:100 tr=4073396 (0) PreparingButTooLong
10:55:27.057 - OnGraphStop ...10:55:27.149 - VR: Disconnect
10:55:27.153 - Graph::ReleaseAllFilters
10:55:27.161 - release: Prog Audio renderer - RR - OK.
10:55:27.179 - release: Video Renderer - RR - OK.
10:55:27.229 - release: Video decoder  - RR - OK.
10:55:27.247 - release: Audio Processor - RR - OK.
10:55:27.311 - release: Microsoft DTV-DVD Audio Decoder - RR - OK.
10:55:27.328 - FilterGraph: 1
10:55:27.338 - **** StopChannel time 0.609ms
10:55:27.343 - 
10:55:27.351 - TransponderManager::SetTransponder (CH) 0 UZ Фантастика HD
10:55:27.358 - *Transport TS
10:55:27.365 - Api2Device::SetChannel http://cf3e5210.rossteleccom.net/iptv/392XTEQ7L49GFY/13065/index.m3u8?utc=1667379328&lutc=1667379328
10:55:27.376 - skip old generation traffic!
10:55:27.380 - skip old generation traffic!
10:55:27.396 - skip old generation traffic!
10:55:27.396 - skip old generation traffic!
10:55:27.405 - skip old generation traffic!
10:55:27.421 - Api2BaseModule.OnTunerStateChanged Connecting
10:55:27.422 - Api2BaseModule.OnTunerStateChanged  -3
10:55:27.449 - Api2Device::SetChannel result OK
10:55:27.449 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
10:55:27.457 - TsInputTrafficProcessor.OpenTransponder 1
10:55:27.464 - FilterManager::OnSetTransponder SetChannel
10:55:27.472 - TimeShift.Reset
10:55:27.478 - TimeShift.Cursor reset
10:55:27.486 - ReaderCursor::Reset.. OK
10:55:27.500 - Prereader.Reset ...-OK
10:55:27.509 - Api2BaseModule.OnTunerStateChanged Preparing
10:55:27.514 - Create EPGparser on SetChannel
10:55:27.522 - Api2BaseModule.OnTunerStateChanged  -4
10:55:27.529 - DvbEpgParser::SetChannel ID=4eec0002.4d2fd2195e0af17b.1
10:55:27.563 - DvbEpgParser::mode normal pos=0
10:55:27.564 - ModuleList::ChangeChannel 0
10:55:27.572 - **** SetTransponder time 0.219ms
10:55:27.579 - [102]ChannelGraph5::StartChannel UZ Фантастика HD
10:55:27.587 - 
10:55:27.594 - [102]       #################### Start stream. (0.859ms) #######################
10:55:27.601 - 
10:55:27.565 - Api2BaseModule.OnTunerStateChanged Playing
10:55:27.615 - Api2BaseModule.OnTunerStateChanged  -4
10:55:27.658 - Api2BaseModule.OnTunerStateChanged ResourceNotFounded404
10:55:27.659 - Api2BaseModule.OnTunerStateChanged  --109
10:55:27.725 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
10:55:27.725 - TimeShift.Cursor SetChannel::v 0 (0)
10:55:27.732 - ReaderCursor::SetChannel.. OK
10:55:27.746 - ReaderCursor::SetPosition 0 (w=0)
10:55:27.753 - Prereader.SetChannel..
10:55:27.760 - Prereader.SetChannel unmask 1
10:55:27.766 - Plugin::SetChannel 1
10:55:27.773 - TransponderManager::SelectChannel
10:55:27.780 - TsInputTrafficProcessor.SelectChannel 1
10:55:27.787 - Api2BaseModule.UpdateAllOpenedChannels 1
10:55:27.795 - TsInputTrafficProcessor.UpdateChannel 1
10:55:27.802 - GraphState: Undef by StartChannelIsReady
10:55:27.809 - PreScanner.StartChannelIsReady net=1 parseall=1
10:55:27.815 - VideoMediaTypeDetection: h.264
10:55:27.822 - SetMarkerAudioLngStream Gen New stream
10:55:27.829 - SimpleTsDemux::Init apid=221, vpid=211
10:55:27.836 - GraphState: RequestPATScan by StartChannelIsReady TS
10:55:27.843 - Api2BaseModule.Filters_EnabledFullTS 1
10:55:27.849 - PlayTimePATParser.OpenParser 1
10:55:27.857 - Open TSTS filter pid=0 data=0
10:55:27.863 - TSTS cur size=0
10:55:27.870 - Graph::UpdateRenderMode
10:55:27.877 - Graph::SetVideoRect {8 8 712 568}
10:55:27.884 - Graph::SetVideoWindowRect {0 8 1927 1085}
10:55:27.890 - **** StartChanbnel time 0.328ms
10:55:27.897 - [102]OnChangeCurrentGraph2 -endOfSetChannel
10:55:27.904 - ChannelGraph5.SetActiveState 1 render=1
10:55:28.053 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:28.368 - [102]**** SetChannel is finished (OK). Duration 1.625ms
10:55:28.512 - Api2BaseModule.OnTunerStateChanged ResourceNotFounded404
10:55:28.512 - Api2BaseModule.OnTunerStateChanged  --109
10:55:28.641 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:29.787 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:30.787 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:31.808 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:32.795 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:33.800 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:34.797 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:35.135 - 
10:55:35.136 - 
10:55:35.142 - ########################### Mark of start channel changing.###########################
10:55:35.149 - 
10:55:35.155 - GraphManager::MainChangeChannel VIP Premiere HD  1 provs
10:55:35.161 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
10:55:35.168 - SetChannelLogic::SetChannel 0
10:55:35.174 - SetChannelLogic::SetNormalChannel
10:55:35.185 - ChannelGraph5::StopChannel VIP Premiere HD
10:55:35.186 - PreScanner.Stop
10:55:35.191 - GraphState: Undef by PreScanner.Stop
10:55:35.198 - PlayTimePmtParser::StopParser
10:55:35.204 - Api2BaseModule.Filters_EnabledFullTS 0
10:55:35.210 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
10:55:35.216 - Prereader::ReaderCursor.. OK
10:55:35.228 - ReaderCursor::SetPosition 0 (w=0)
10:55:35.234 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
10:55:35.239 - Prereader.StartPlayback after lock
10:55:35.245 - subsm.StopChannel
10:55:35.251 - Graph::ReleaseAllFilters
10:55:35.256 - **** StopChannel time 0.109ms
10:55:35.264 - 
10:55:35.270 - TransponderManager::SetTransponder (CH) 0 VIP Premiere HD
10:55:35.276 - *Transport TS
10:55:35.282 - Api2Device::SetChannel http://cf3e5210.rossteleccom.net/iptv/392XTEQ7L49GFY/202/index.m3u8?utc=1667379328&lutc=1667379328
10:55:35.314 - Api2Device::SetChannel result OK
10:55:35.315 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
10:55:35.321 - TsInputTrafficProcessor.OpenTransponder 1
10:55:35.328 - FilterManager::OnSetTransponder SetChannel
10:55:35.334 - TimeShift.Reset
10:55:35.340 - TimeShift.Cursor reset
10:55:35.347 - ReaderCursor::Reset.. OK
10:55:35.362 - Prereader.Reset ...-OK
10:55:35.375 - Create EPGparser on SetChannel
10:55:35.382 - DvbEpgParser::SetChannel ID=4eec0002.11cc8a64d379ee4b.1
10:55:35.326 - Api2BaseModule.OnTunerStateChanged Connecting
10:55:35.395 - Api2BaseModule.OnTunerStateChanged  -3
10:55:35.408 - DvbEpgParser::mode normal pos=0
10:55:35.412 - ModuleList::ChangeChannel 0
10:55:35.419 - **** SetTransponder time 0.172ms
10:55:35.426 - [102]ChannelGraph5::StartChannel VIP Premiere HD
10:55:35.432 - 
10:55:35.439 - [102]       #################### Start stream. (0.297ms) #######################
10:55:35.446 - 
10:55:35.472 - Api2BaseModule.OnTunerStateChanged Preparing
10:55:35.473 - Api2BaseModule.OnTunerStateChanged  -4
10:55:35.530 - Api2BaseModule.OnTunerStateChanged Playing
10:55:35.530 - Api2BaseModule.OnTunerStateChanged  -4
10:55:35.544 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
10:55:35.544 - TimeShift.Cursor SetChannel::v 0 (0)
10:55:35.550 - ReaderCursor::SetChannel.. OK
10:55:35.564 - ReaderCursor::SetPosition 0 (w=0)
10:55:35.566 - Api2BaseModule.OnTunerStateChanged ResourceNotFounded404
10:55:35.570 - Prereader.SetChannel..
10:55:35.584 - Prereader.SetChannel unmask 1
10:55:35.590 - Plugin::SetChannel 1
10:55:35.597 - TransponderManager::SelectChannel
10:55:35.603 - TsInputTrafficProcessor.SelectChannel 1
10:55:35.609 - Api2BaseModule.UpdateAllOpenedChannels 1
10:55:35.577 - Api2BaseModule.OnTunerStateChanged  --109
10:55:35.616 - TsInputTrafficProcessor.UpdateChannel 1
10:55:35.629 - GraphState: Undef by StartChannelIsReady
10:55:35.635 - PreScanner.StartChannelIsReady net=1 parseall=1
10:55:35.641 - VideoMediaTypeDetection: h.264
10:55:35.647 - SetMarkerAudioLngStream Gen New stream
10:55:35.654 - SimpleTsDemux::Init apid=221, vpid=211
10:55:35.660 - GraphState: RequestPATScan by StartChannelIsReady TS
10:55:35.666 - Api2BaseModule.Filters_EnabledFullTS 1
10:55:35.672 - PlayTimePATParser.OpenParser 1
10:55:35.678 - Open TSTS filter pid=0 data=0
10:55:35.684 - TSTS cur size=0
10:55:35.690 - Graph::UpdateRenderMode
10:55:35.696 - Graph::SetVideoRect {8 8 712 568}
10:55:35.702 - Graph::SetVideoWindowRect {0 8 1927 1085}
10:55:35.707 - **** StartChanbnel time 0.281ms
10:55:35.714 - [102]OnChangeCurrentGraph2 -endOfSetChannel
10:55:35.720 - ChannelGraph5.SetActiveState 1 render=1
10:55:36.009 - [102]**** SetChannel is finished (OK). Duration 0.859ms
10:55:36.081 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:36.348 - Api2BaseModule.OnTunerStateChanged ResourceNotFounded404
10:55:36.349 - Api2BaseModule.OnTunerStateChanged  --109
10:55:36.492 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:37.084 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:37.784 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:38.792 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:39.791 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:40.789 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:41.785 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:42.794 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:43.417 - 
10:55:43.418 - 
10:55:43.424 - ########################### Mark of start channel changing.###########################
10:55:43.430 - 
10:55:43.437 - GraphManager::MainChangeChannel UZ Фантастика HD  1 provs
10:55:43.443 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
10:55:43.450 - SetChannelLogic::SetChannel 0
10:55:43.456 - SetChannelLogic::SetNormalChannel
10:55:43.468 - ChannelGraph5::StopChannel UZ Фантастика HD
10:55:43.468 - PreScanner.Stop
10:55:43.473 - GraphState: Undef by PreScanner.Stop
10:55:43.479 - PlayTimePmtParser::StopParser
10:55:43.486 - Api2BaseModule.Filters_EnabledFullTS 0
10:55:43.492 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
10:55:43.498 - Prereader::ReaderCursor.. OK
10:55:43.510 - ReaderCursor::SetPosition 0 (w=0)
10:55:43.517 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
10:55:43.522 - Prereader.StartPlayback after lock
10:55:43.528 - subsm.StopChannel
10:55:43.534 - Graph::ReleaseAllFilters
10:55:43.540 - **** StopChannel time 0.110ms
10:55:43.546 - 
10:55:43.552 - TransponderManager::SetTransponder (CH) 0 UZ Фантастика HD
10:55:43.558 - *Transport TS
10:55:43.564 - Api2Device::SetChannel http://cf3e5210.rossteleccom.net/iptv/392XTEQ7L49GFY/13065/index.m3u8?utc=1667379328&lutc=1667379328
10:55:43.596 - Api2Device::SetChannel result OK
10:55:43.596 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
10:55:43.603 - TsInputTrafficProcessor.OpenTransponder 1
10:55:43.608 - Api2BaseModule.OnTunerStateChanged Connecting
10:55:43.609 - FilterManager::OnSetTransponder SetChannel
10:55:43.621 - TimeShift.Reset
10:55:43.628 - TimeShift.Cursor reset
10:55:43.634 - ReaderCursor::Reset.. OK
10:55:43.646 - Prereader.Reset ...-OK
10:55:43.658 - Create EPGparser on SetChannel
10:55:43.663 - DvbEpgParser::SetChannel ID=4eec0002.4d2fd2195e0af17b.1
10:55:43.615 - Api2BaseModule.OnTunerStateChanged  -3
10:55:43.687 - DvbEpgParser::mode normal pos=0
10:55:43.687 - ModuleList::ChangeChannel 0
10:55:43.694 - **** SetTransponder time 0.156ms
10:55:43.700 - [102]ChannelGraph5::StartChannel UZ Фантастика HD
10:55:43.706 - 
10:55:43.712 - [102]       #################### Start stream. (0.281ms) #######################
10:55:43.718 - 
10:55:43.744 - Api2BaseModule.OnTunerStateChanged Preparing
10:55:43.744 - Api2BaseModule.OnTunerStateChanged  -4
10:55:43.803 - Api2BaseModule.OnTunerStateChanged Playing
10:55:43.803 - Api2BaseModule.OnTunerStateChanged  -4
10:55:43.821 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
10:55:43.822 - TimeShift.Cursor SetChannel::v 0 (0)
10:55:43.828 - ReaderCursor::SetChannel.. OK
10:55:43.841 - ReaderCursor::SetPosition 0 (w=0)
10:55:43.847 - Prereader.SetChannel..
10:55:43.853 - Prereader.SetChannel unmask 1
10:55:43.859 - Plugin::SetChannel 1
10:55:43.840 - Api2BaseModule.OnTunerStateChanged ResourceNotFounded404
10:55:43.874 - Api2BaseModule.OnTunerStateChanged  --109
10:55:43.867 - TransponderManager::SelectChannel
10:55:43.887 - TsInputTrafficProcessor.SelectChannel 1
10:55:43.894 - Api2BaseModule.UpdateAllOpenedChannels 1
10:55:43.901 - TsInputTrafficProcessor.UpdateChannel 1
10:55:43.907 - GraphState: Undef by StartChannelIsReady
10:55:43.913 - PreScanner.StartChannelIsReady net=1 parseall=1
10:55:43.920 - VideoMediaTypeDetection: h.264
10:55:43.927 - SetMarkerAudioLngStream Gen New stream
10:55:43.934 - SimpleTsDemux::Init apid=221, vpid=211
10:55:43.940 - GraphState: RequestPATScan by StartChannelIsReady TS
10:55:43.946 - Api2BaseModule.Filters_EnabledFullTS 1
10:55:43.952 - PlayTimePATParser.OpenParser 1
10:55:43.959 - Open TSTS filter pid=0 data=0
10:55:43.965 - TSTS cur size=0
10:55:43.972 - Graph::UpdateRenderMode
10:55:43.978 - Graph::SetVideoRect {8 8 712 568}
10:55:43.985 - Graph::SetVideoWindowRect {0 8 1927 1085}
10:55:43.991 - **** StartChanbnel time 0.297ms
10:55:43.997 - [102]OnChangeCurrentGraph2 -endOfSetChannel
10:55:44.003 - ChannelGraph5.SetActiveState 1 render=1
10:55:44.147 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:44.388 - [102]**** SetChannel is finished (OK). Duration 0.969ms
10:55:44.526 - Api2BaseModule.OnTunerStateChanged ResourceNotFounded404
10:55:44.526 - Api2BaseModule.OnTunerStateChanged  --109
10:55:44.645 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:45.149 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:45.776 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:46.792 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:47.790 - * s:0 q:0 tr=0 (0) ResourceNotFounded404
10:55:48.069 - 
10:55:48.070 - 
10:55:48.075 - ########################### Mark of start channel changing.###########################
10:55:48.081 - 
10:55:48.088 - GraphManager::MainChangeChannel VIP Premiere HD  1 provs
10:55:48.094 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
10:55:48.100 - SetChannelLogic::SetChannel 0
10:55:48.106 - SetChannelLogic::SetNormalChannel
10:55:48.119 - ChannelGraph5::StopChannel VIP Premiere HD
10:55:48.119 - PreScanner.Stop
10:55:48.151 - GraphState: Undef by PreScanner.Stop
10:55:48.161 - PlayTimePmtParser::StopParser
10:55:48.167 - Api2BaseModule.Filters_EnabledFullTS 0
10:55:48.173 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
10:55:48.180 - Prereader::ReaderCursor.. OK
10:55:48.193 - ReaderCursor::SetPosition 0 (w=0)
10:55:48.199 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
10:55:48.205 - Prereader.StartPlayback after lock
10:55:48.211 - subsm.StopChannel
10:55:48.217 - Graph::ReleaseAllFilters
10:55:48.224 - **** StopChannel time 0.156ms
10:55:48.230 - 
10:55:48.236 - TransponderManager::SetTransponder (CH) 0 VIP Premiere HD
10:55:48.242 - *Transport TS
10:55:48.248 - Api2Device::SetChannel http://cf3e5210.rossteleccom.net/iptv/392XTEQ7L49GFY/202/index.m3u8
10:55:48.281 - Api2Device::SetChannel result OK
10:55:48.281 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
10:55:48.287 - TsInputTrafficProcessor.OpenTransponder 1
10:55:48.292 - Api2BaseModule.OnTunerStateChanged Connecting
10:55:48.293 - FilterManager::OnSetTransponder SetChannel
10:55:48.305 - TimeShift.Reset
10:55:48.311 - TimeShift.Cursor reset
10:55:48.317 - ReaderCursor::Reset.. OK
10:55:48.330 - Prereader.Reset ...-OK
10:55:48.342 - Create EPGparser on SetChannel
10:55:48.349 - DvbEpgParser::SetChannel ID=4eec0002.11cc8a64d379ee4b.1
10:55:48.299 - Api2BaseModule.OnTunerStateChanged  -3
10:55:48.374 - DvbEpgParser::mode normal pos=0
10:55:48.375 - ModuleList::ChangeChannel 0
10:55:48.383 - **** SetTransponder time 0.156ms
10:55:48.389 - [102]ChannelGraph5::StartChannel VIP Premiere HD
10:55:48.396 - 
10:55:48.402 - [102]       #################### Start stream. (0.344ms) #######################
10:55:48.408 - 
10:55:48.432 - Api2BaseModule.OnTunerStateChanged Preparing
10:55:48.432 - Api2BaseModule.OnTunerStateChanged  -4
10:55:48.490 - Api2BaseModule.OnTunerStateChanged Playing
10:55:48.490 - Api2BaseModule.OnTunerStateChanged  -4
10:55:48.548 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
10:55:48.548 - TimeShift.Cursor SetChannel::v 0 (0)
10:55:48.554 - ReaderCursor::SetChannel.. OK
10:55:48.566 - ReaderCursor::SetPosition 0 (w=0)
10:55:48.572 - Prereader.SetChannel..
10:55:48.578 - Prereader.SetChannel unmask 1
10:55:48.584 - Plugin::SetChannel 1
10:55:48.589 - TransponderManager::SelectChannel
10:55:48.595 - TsInputTrafficProcessor.SelectChannel 1
10:55:48.601 - Api2BaseModule.UpdateAllOpenedChannels 1
10:55:48.607 - TsInputTrafficProcessor.UpdateChannel 1
10:55:48.613 - GraphState: Undef by StartChannelIsReady
10:55:48.620 - PreScanner.StartChannelIsReady net=1 parseall=1
10:55:48.626 - VideoMediaTypeDetection: h.264
10:55:48.632 - SetMarkerAudioLngStream Gen New stream
10:55:48.638 - SimpleTsDemux::Init apid=221, vpid=211
10:55:48.644 - GraphState: RequestPATScan by StartChannelIsReady TS
10:55:48.650 - Api2BaseModule.Filters_EnabledFullTS 1
10:55:48.655 - PlayTimePATParser.OpenParser 1
10:55:48.662 - Open TSTS filter pid=0 data=0
10:55:48.667 - TSTS cur size=0
10:55:48.673 - Graph::UpdateRenderMode
10:55:48.679 - Graph::SetVideoRect {8 8 712 568}
10:55:48.685 - Graph::SetVideoWindowRect {0 8 1927 1085}
10:55:48.691 - **** StartChanbnel time 0.313ms
10:55:48.696 - [102]OnChangeCurrentGraph2 -endOfSetChannel
10:55:48.702 - ChannelGraph5.SetActiveState 1 render=1
10:55:49.158 - * s:0 q:0 tr=0 (0) Preparing
10:55:49.170 - [102]**** SetChannel is finished (OK). Duration 1.109ms
10:55:49.444 - TransportMarker: TS
10:55:49.444 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
10:55:49.451 - 
10:55:49.461 -        #################### First traffic. (1.390ms) #######################
10:55:49.470 - 
10:55:49.479 - PlayTimePATParser.EndTask
10:55:49.561 - --SwitchEngineTransport TS > TS
10:55:49.561 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
10:55:49.567 - PreScanner.OnTransportMarker TS
10:55:49.574 - --SwitchEngineTransport end
10:55:49.581 - PreScanner.OnAfterScanPat count=2 {1;4095}
10:55:49.587 - Api2BaseModule.Filters_EnabledFullTS 0
10:55:49.593 - GraphState: RequestPMTScan by OnAfterScanPat
10:55:49.600 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=1
10:55:49.606 - Open TSTS filter pid=4095 data=2
10:55:49.614 - TSTS cur size=669656
10:55:49.621 - TSTS quick finish
10:55:49.650 - PreScanner.OnAfterScanPmt pmt=4095
10:55:49.650 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
10:55:49.656 - PlayTimePmtParser::StopParser
10:55:49.760 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
10:55:49.760 - TimeShift.Cursor SetChannel::v 1047912 (1047912)
10:55:49.767 - Prereader.SetChannel unmask 1
10:55:49.773 - Plugin::SetChannel 1
10:55:49.778 - TransponderManager::SelectChannel
10:55:49.786 - TsInputTrafficProcessor.SelectChannel 1
10:55:49.793 - Api2BaseModule.UpdateAllOpenedChannels 1
10:55:49.799 - TsInputTrafficProcessor.UpdateChannel 1
10:55:49.805 - PreScanner.StartChannelIsReady net=1 parseall=0
10:55:49.813 - LngDefaultSelector.try select audio pid=221 type=1 lng=7566706-rus(deu,deu,rus) l=10
10:55:49.819 - LngDefaultSelector.try select audio pid=222 type=1 lng=7566706-rus(deu,deu,rus) l=10
10:55:49.825 - LngDefaultSelector. selected audio pid=221
10:55:49.831 - ChannelGraph5::AfterDetectChannelParams
10:55:49.838 - VideoMediaTypeDetection: h.264
10:55:49.844 - SimpleTsDemux::Init apid=221, vpid=211
10:55:49.850 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
10:55:49.856 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
10:55:49.862 - Prereader::ReaderCursor.. OK
10:55:49.875 - ReaderCursor::SetPosition 0 (w=6669568814612480)
10:55:49.880 - Prereader.StartPlayback Push buffering=0 recv=0D718B5C [StartChannelHelperBase(sl)]
10:55:49.887 - Prereader.StartPlayback after lock
10:55:49.893 - PreScanner.StartPmtParserIfNeed
10:55:49.899 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=0
10:55:49.905 - Open TSTS filter pid=4095 data=2
10:55:49.911 - TSTS cur size=1687112
10:55:49.893 - VideoParser::First packet 32377 h.264
10:55:49.925 - h264 detected 0 ms
10:55:49.932 - AudioParser::First packet 456
10:55:49.939 - AudioParser::packet 465
10:55:49.947 - AudioParser::packet 440
10:55:49.954 - AudioParser::packet 415
10:55:49.961 - AudioParser::packet 440
10:55:49.967 - AudioParser::packet 421
10:55:49.974 - AudioParser::packet 419
10:55:49.984 - AudioParser::packet 429
10:55:49.997 - AudioParser::packet 430
10:55:50.006 - AudioParser::packet 424
10:55:50.013 - AudioParser::packet 430
10:55:50.020 - AudioParser::packet 422
10:55:50.027 - AudioParser::packet 420
10:55:50.033 - AudioParser::packet 403
10:55:50.044 - AudioParser::packet 410
10:55:50.057 - AudioParser::packet 419
10:55:50.059 - * s:100 q:100 tr=2410536 (0) Preparing
10:55:50.064 - AudioParser::packet 410
10:55:50.077 - AudioParser::packet 413
10:55:50.083 - AudioParser::packet 435
10:55:50.089 - AudioParser::packet 488
10:55:50.096 - AudioParser::packet 480
10:55:50.102 - AudioParser::packet 446
10:55:50.108 - AudioParser::packet 428
10:55:50.115 - AudioParser::packet 452
10:55:50.122 - AudioParser::packet 416
10:55:50.129 - AudioParser::packet 416
10:55:50.136 - AudioParser::packet 442
10:55:50.142 - AudioParser::packet 433
10:55:50.148 - AudioParser::packet 430
10:55:50.154 - AudioParser::packet 418
10:55:50.160 - AudioParser::packet 424
10:55:50.166 - AudioParser::packet 424
10:55:50.172 - AudioParser::packet 430
10:55:50.178 - AudioParser::AAC detected
10:55:50.184 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
10:55:50.190 - PreScanner.Post_InitRender [ReceiveTraffic]
10:55:50.196 - [102]sm: TvInitRenderer res=1
10:55:50.202 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
10:55:50.209 - CalculBufferingSize prov=0D4F7EFC marker=1 request=1
10:55:50.215 - CalculBuffering 2000ms br=2000kb to 500 kbytes. By type
10:55:50.221 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
10:55:50.226 - Prereader::ReaderCursor.. OK
10:55:50.238 - ReaderCursor::SetPosition 0 (w=12739199417450496)
10:55:50.244 - Prereader.StartPlayback Pull buffering=512000 recv=00000000 [EnablePullModeAndStartPlayback]
10:55:50.250 - Prereader.StartPlayback after lock
10:55:50.256 - Buffering/prereader size 500/3906 kbytes
10:55:50.262 - ------sGetVideoParams
10:55:50.268 - ChannelGraph5.CreateInterfacesAndRenderGraph
10:55:50.278 - subsm.StartChannel demux=ProgDemux tr=TS
10:55:50.282 - subsm.RecreateSubtitlesParsers 0743F8F0 ts=1 subindex=-1 st=-1
10:55:50.288 - subsm.Stop teletext parser
10:55:50.294 - subsm.RecreateSubtitlesParsers end
10:55:50.300 - subs: OnSetChannel
10:55:50.307 - CreateCustomGraph
10:55:50.313 - VideoType:H.264/AVC ffmpeg=0
10:55:50.319 - Video/4.H264 : MPEG2_VIDEO s={0,0,1920,1080}, t={0,0,1920,1080}, bmp=1920x1088, r=30/17, br=0,frametime=33ms, IF=0x0, CF=0x0)
10:55:50.326 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f
10:55:50.335 - OK
10:55:50.339 - CChannelGraph5::CreateRender 10
10:55:50.345 - VR: EVR Custom
10:55:50.352 - VR: create new render
10:55:50.473 - VR: Add video renderer Video Renderer - OK
10:55:50.473 - CreateAudioPartOfGraph
10:55:50.479 - AudioType:AAC/ADTS 
10:55:50.485 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 48000 16bit formatTag= 0x1600)
10:55:50.493 - Add audio codec e1f1a0b8-beee-490d-ba7c-066c40b5e2b9 - OK
10:55:50.509 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
10:55:50.509 - Added audio renderer
10:55:50.516 - AP: created
10:55:50.523 - Added audio processor
10:55:50.543 - Connect codec to AP - OK
10:55:50.569 - Add and connect audio renderer - OK
10:55:50.570 - Graph::AfterRender
10:55:50.576 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
10:55:50.582 - AV:UpdateAudioParamsAfterActive
10:55:50.588 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
10:55:50.594 - GR:UpdateAudioProcessor old=1 new=0
10:55:50.600 - Destroy Audio Processor udate
10:55:50.606 - Graph::SetVolume 0% -10000db
10:55:50.613 - Graph::SetAudioChannelMask
10:55:50.619 - Graph::Run
10:55:50.713 - Graph::Run 1
10:55:50.720 - Graph::SetPictureParams
10:55:50.721 - Graph::SetVideoRect {24 16 1896 1068}
10:55:50.728 - Graph::SetVideoWindowRect {0 1 1927 1092}
10:55:50.786 - 
10:55:50.786 - [0]########################### Mark of finish channel changing. (2.719ms) #############
10:55:50.794 - 
10:55:50.875 - CChannelGraph5::HideSubtitles
10:55:51.164 - * s:100 q:100 tr=3489280 (0) Playing
10:55:51.511 - 
10:55:51.512 - [0]########################### First video frame. (3.453ms) #############
10:55:51.528 - 
10:55:51.746 - * s:100 q:100 tr=2052772 (0) Playing
10:55:51.814 - changed ratio to 1920/1080
10:55:51.814 - Graph::SetVideoRect {24 16 1896 1068}
10:55:51.828 - Graph::SetVideoWindowRect {0 8 1927 1085}
10:55:52.868 - * s:100 q:100 tr=5725164 (0) Playing
10:55:53.881 - * s:100 q:100 tr=3597944 (0) Playing
10:55:53.997 - 
10:55:53.997 - 
10:55:54.006 - ########################### Mark of start channel changing.###########################
10:55:54.013 - 
10:55:54.022 - GraphManager::MainChangeChannel UZ Фантастика HD  1 provs
10:55:54.035 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
10:55:54.049 - SetChannelLogic::SetChannel 0
10:55:54.057 - SetChannelLogic::SetNormalChannel
10:55:54.083 - ChannelGraph5::StopChannel UZ Фантастика HD
10:55:54.083 - PreScanner.Stop
10:55:54.092 - GraphState: Undef by PreScanner.Stop
10:55:54.100 - PlayTimePmtParser::StopParser
10:55:54.108 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
10:55:54.124 - Prereader::ReaderCursor.. OK
10:55:54.138 - ReaderCursor::SetPosition 0 (w=79305694947311616)
10:55:54.146 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
10:55:54.154 - Prereader.StartPlayback after lock
10:55:54.168 - subsm.StopChannel
10:55:54.176 - Graph::Stop
10:55:54.366 - Before Stop ...10:55:54.377 - OnGraphStop ...10:55:54.458 - VR: Disconnect
10:55:54.462 - Graph::ReleaseAllFilters
10:55:54.467 - release: Prog Audio renderer - RR - OK.
10:55:54.484 - release: Video Renderer - RR - OK.
10:55:54.534 - release: Video decoder  - RR - OK.
10:55:54.551 - release: Audio Processor - RR - OK.
10:55:54.567 - release: Microsoft DTV-DVD Audio Decoder - RR - OK.
10:55:54.583 - FilterGraph: 1
10:55:54.594 - **** StopChannel time 0.594ms
10:55:54.598 - 
10:55:54.606 - TransponderManager::SetTransponder (CH) 0 UZ Фантастика HD
10:55:54.616 - *Transport TS
10:55:54.624 - Api2Device::SetChannel http://cf3e5210.rossteleccom.net/iptv/392XTEQ7L49GFY/13065/index.m3u8
10:55:54.634 - skip old generation traffic!
10:55:54.638 - skip old generation traffic!
10:55:54.647 - skip old generation traffic!
10:55:54.654 - skip old generation traffic!
10:55:54.662 - skip old generation traffic!
10:55:54.684 - Api2BaseModule.OnTunerStateChanged Connecting
10:55:54.685 - Api2BaseModule.OnTunerStateChanged  -3
10:55:54.710 - Api2Device::SetChannel result OK
10:55:54.710 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
10:55:54.717 - TsInputTrafficProcessor.OpenTransponder 1
10:55:54.726 - FilterManager::OnSetTransponder SetChannel
10:55:54.733 - TimeShift.Reset
10:55:54.740 - TimeShift.Cursor reset
10:55:54.749 - ReaderCursor::Reset.. OK
10:55:54.764 - Prereader.Reset ...-OK
10:55:54.775 - Api2BaseModule.OnTunerStateChanged Preparing
10:55:54.788 - Api2BaseModule.OnTunerStateChanged  -4
10:55:54.780 - Create EPGparser on SetChannel
10:55:54.803 - DvbEpgParser::SetChannel ID=4eec0002.4d2fd2195e0af17b.1
10:55:54.830 - DvbEpgParser::mode normal pos=0
10:55:54.832 - Api2BaseModule.OnTunerStateChanged Playing
10:55:54.840 - Api2BaseModule.OnTunerStateChanged  -4
10:55:54.832 - ModuleList::ChangeChannel 0
10:55:54.854 - **** SetTransponder time 0.266ms
10:55:54.862 - [102]ChannelGraph5::StartChannel UZ Фантастика HD
10:55:54.870 - 
10:55:54.878 - [102]       #################### Start stream. (0.875ms) #######################
10:55:54.885 - 
10:55:55.000 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
10:55:55.000 - TimeShift.Cursor SetChannel::v 0 (0)
10:55:55.008 - ReaderCursor::SetChannel.. OK
10:55:55.022 - ReaderCursor::SetPosition 0 (w=0)
10:55:55.030 - Prereader.SetChannel..
10:55:55.038 - Prereader.SetChannel unmask 1
10:55:55.046 - Plugin::SetChannel 1
10:55:55.053 - TransponderManager::SelectChannel
10:55:55.060 - TsInputTrafficProcessor.SelectChannel 1
10:55:55.067 - Api2BaseModule.UpdateAllOpenedChannels 1
10:55:55.075 - TsInputTrafficProcessor.UpdateChannel 1
10:55:55.082 - GraphState: Undef by StartChannelIsReady
10:55:55.089 - PreScanner.StartChannelIsReady net=1 parseall=1
10:55:55.096 - VideoMediaTypeDetection: h.264
10:55:55.103 - SetMarkerAudioLngStream Gen New stream
10:55:55.109 - SimpleTsDemux::Init apid=221, vpid=211
10:55:55.116 - GraphState: RequestPATScan by StartChannelIsReady TS
10:55:55.123 - Api2BaseModule.Filters_EnabledFullTS 1
10:55:55.131 - PlayTimePATParser.OpenParser 1
10:55:55.138 - Open TSTS filter pid=0 data=0
10:55:55.147 - TSTS cur size=0
10:55:55.155 - Graph::UpdateRenderMode
10:55:55.164 - Graph::SetVideoRect {8 8 712 568}
10:55:55.172 - Graph::SetVideoWindowRect {0 8 1927 1085}
10:55:55.181 - **** StartChanbnel time 0.312ms
10:55:55.188 - [102]OnChangeCurrentGraph2 -endOfSetChannel
10:55:55.196 - ChannelGraph5.SetActiveState 1 render=1
10:55:55.206 - * s:0 q:0 tr=0 (0) Preparing
10:55:55.733 - [102]**** SetChannel is finished (OK). Duration 1.735ms
10:55:56.004 - TransportMarker: TS
10:55:56.005 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
10:55:56.014 - 
10:55:56.023 -        #################### First traffic. (2.016ms) #######################
10:55:56.032 - 
10:55:56.047 - PlayTimePATParser.EndTask
10:55:56.108 - * s:100 q:100 tr=335768 (0) Preparing
10:55:56.152 - --SwitchEngineTransport TS > TS
10:55:56.152 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
10:55:56.161 - PreScanner.OnTransportMarker TS
10:55:56.169 - --SwitchEngineTransport end
10:55:56.177 - PreScanner.OnAfterScanPat count=2 {1;4095}
10:55:56.184 - Api2BaseModule.Filters_EnabledFullTS 0
10:55:56.192 - GraphState: RequestPMTScan by OnAfterScanPat
10:55:56.199 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=1
10:55:56.207 - Open TSTS filter pid=4095 data=2
10:55:56.214 - TSTS cur size=722108
10:55:56.222 - TSTS quick finish
10:55:56.270 - PreScanner.OnAfterScanPmt pmt=4095
10:55:56.270 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
10:55:56.277 - PlayTimePmtParser::StopParser
10:55:56.375 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
10:55:56.375 - TimeShift.Cursor SetChannel::v 1386688 (1386688)
10:55:56.382 - Prereader.SetChannel unmask 1
10:55:56.389 - Plugin::SetChannel 1
10:55:56.396 - TransponderManager::SelectChannel
10:55:56.403 - TsInputTrafficProcessor.SelectChannel 1
10:55:56.410 - Api2BaseModule.UpdateAllOpenedChannels 1
10:55:56.417 - TsInputTrafficProcessor.UpdateChannel 1
10:55:56.424 - PreScanner.StartChannelIsReady net=1 parseall=0
10:55:56.431 - LngDefaultSelector.try select audio pid=221 type=1 lng=0-(deu,deu,rus) l=99
10:55:56.438 - ChannelGraph5::AfterDetectChannelParams
10:55:56.446 - VideoMediaTypeDetection: h.264
10:55:56.453 - SimpleTsDemux::Init apid=221, vpid=211
10:55:56.460 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
10:55:56.467 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
10:55:56.474 - Prereader::ReaderCursor.. OK
10:55:56.488 - ReaderCursor::SetPosition 0 (w=9227582616633344)
10:55:56.495 - Prereader.StartPlayback Push buffering=0 recv=0D718B5C [StartChannelHelperBase(sl)]
10:55:56.502 - Prereader.StartPlayback after lock
10:55:56.509 - PreScanner.StartPmtParserIfNeed
10:55:56.516 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=0
10:55:56.523 - Open TSTS filter pid=4095 data=2
10:55:56.529 - TSTS cur size=2449264
10:55:56.509 - VideoParser::First packet 98098 h.264
10:55:56.544 - h264 detected 0 ms
10:55:56.551 - AudioParser::First packet 315
10:55:56.559 - AudioParser::packet 331
10:55:56.568 - AudioParser::packet 318
10:55:56.574 - AudioParser::AAC detected
10:55:56.583 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
10:55:56.589 - PreScanner.Post_InitRender [ReceiveTraffic]
10:55:56.597 - [102]sm: TvInitRenderer res=1
10:55:56.604 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
10:55:56.612 - CalculBufferingSize prov=0D4F7EFC marker=1 request=1
10:55:56.618 - CalculBuffering 2000ms br=2000kb to 500 kbytes. By type
10:55:56.625 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
10:55:56.632 - Prereader::ReaderCursor.. OK
10:55:56.647 - ReaderCursor::SetPosition 0 (w=13065410773516288)
10:55:56.654 - Prereader.StartPlayback Pull buffering=512000 recv=00000000 [EnablePullModeAndStartPlayback]
10:55:56.661 - Prereader.StartPlayback after lock
10:55:56.667 - Buffering/prereader size 500/3906 kbytes
10:55:56.678 - ------sGetVideoParams
10:55:56.686 - ChannelGraph5.CreateInterfacesAndRenderGraph
10:55:56.698 - subsm.StartChannel demux=ProgDemux tr=TS
10:55:56.705 - subsm.RecreateSubtitlesParsers 0743F8F0 ts=1 subindex=-1 st=-1
10:55:56.713 - subsm.Stop teletext parser
10:55:56.721 - subsm.RecreateSubtitlesParsers end
10:55:56.729 - subs: OnSetChannel
10:55:56.736 - CreateCustomGraph
10:55:56.744 - VideoType:H.264/AVC ffmpeg=0
10:55:56.752 - Video/4.H264 : MPEG2_VIDEO s={0,0,1920,1080}, t={0,0,1920,1080}, bmp=1920x1088, r=30/17, br=0,frametime=33ms, IF=0x0, CF=0x0)
10:55:56.760 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f
10:55:56.770 - OK
10:55:56.775 - CChannelGraph5::CreateRender 10
10:55:56.782 - VR: EVR Custom
10:55:56.790 - VR: create new render
10:55:56.956 - VR: Add video renderer Video Renderer - OK
10:55:56.956 - CreateAudioPartOfGraph
10:55:56.964 - AudioType:AAC/ADTS 
10:55:56.971 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 44100 16bit formatTag= 0x1600)
10:55:56.980 - Add audio codec e1f1a0b8-beee-490d-ba7c-066c40b5e2b9 - OK
10:55:56.998 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
10:55:56.998 - Added audio renderer
10:55:57.006 - AP: created
10:55:57.014 - Added audio processor
10:55:57.048 - Connect codec to AP - OK
10:55:57.097 - Add and connect audio renderer - OK
10:55:57.097 - Graph::AfterRender
10:55:57.104 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
10:55:57.111 - AV:UpdateAudioParamsAfterActive
10:55:57.119 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
10:55:57.126 - GR:UpdateAudioProcessor old=1 new=0
10:55:57.133 - Destroy Audio Processor udate
10:55:57.140 - Graph::SetVolume 0% -10000db
10:55:57.147 - Graph::SetAudioChannelMask
10:55:57.155 - Graph::Run
10:55:57.207 - * s:100 q:100 tr=5765584 (0) Playing
10:55:57.292 - Graph::Run 1
10:55:57.298 - Graph::SetPictureParams
10:55:57.301 - Graph::SetVideoRect {24 16 1896 1068}
10:55:57.310 - Graph::SetVideoWindowRect {0 1 1927 1092}
10:55:57.364 - 
10:55:57.364 - [0]########################### Mark of finish channel changing. (3.360ms) #############
10:55:57.372 - 
10:55:57.749 - CChannelGraph5::HideSubtitles
10:55:58.173 - * s:100 q:100 tr=3123620 (0) Playing
10:55:58.292 - changed ratio to 1920/1080
10:55:58.292 - Graph::SetVideoRect {24 16 1896 1068}
10:55:58.305 - Graph::SetVideoWindowRect {0 8 1927 1085}
10:55:58.355 - 
10:55:58.369 - [0]########################### First video frame. (4.375ms) #############
10:55:58.385 - 
10:55:58.927 - * s:100 q:100 tr=3889344 (0) Playing
10:55:59.896 - * s:100 q:100 tr=3230404 (0) Playing
10:56:00.926 - * s:100 q:100 tr=6786612 (0) Playing
10:56:01.897 - * s:100 q:100 tr=3950444 (0) Playing
10:56:02.923 - * s:100 q:100 tr=5317392 (0) Playing
10:56:03.933 - * s:100 q:100 tr=3160656 (0) Playing
10:56:04.784 - * s:100 q:100 tr=2537060 (0) Playing
10:56:05.784 - * s:100 q:100 tr=4315164 (0) Playing
10:56:06.544 - 
10:56:06.545 - Stop engine
10:56:06.567 - DevicesManager::Stop
10:56:06.583 - ChannelGraph5::StopChannel 
10:56:06.597 - PreScanner.Stop
10:56:06.614 - GraphState: Undef by PreScanner.Stop
10:56:06.628 - PlayTimePmtParser::StopParser
10:56:06.645 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
10:56:06.659 - Prereader::ReaderCursor.. OK
10:56:06.680 - ReaderCursor::SetPosition 0 (w=193394886915915776)
10:56:06.691 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
10:56:06.709 - Prereader.StartPlayback after lock
10:56:06.724 - subsm.StopChannel
10:56:06.739 - Graph::Stop
10:56:07.374 - Before Stop ...10:56:07.383 - OnGraphStop ...10:56:07.480 - VR: Disconnect
10:56:07.484 - Graph::ReleaseAllFilters
10:56:07.489 - release: Prog Audio renderer - RR - OK.
10:56:07.507 - release: Video Renderer - RR - OK.
10:56:07.561 - release: Video decoder  - RR - OK.
10:56:07.580 - release: Audio Processor - RR - OK.
10:56:07.595 - release: Microsoft DTV-DVD Audio Decoder - RR - OK.
10:56:07.611 - FilterGraph: 1
10:56:07.622 - ChannelGraph5.~CChannelGraph5
10:56:07.628 - PreScanner.Stop
10:56:07.635 - GraphState: Undef by PreScanner.Stop
10:56:07.643 - PlayTimePmtParser::StopParser
10:56:07.651 - subsm.StopChannel
10:56:07.659 - Graph::ReleaseAllFilters
10:56:07.684 - ChannelGraph5.~CChannelGraph5 finish
10:56:07.744 - TransponderManager::CloseChannel
10:56:07.744 - TsInputTrafficProcessor.RemoveChannel 1
10:56:07.752 - ~TransponderChannelSource
10:56:07.806 - TimeShift.DestroyReadingCursor
10:56:07.815 - Prereader.Exit10:56:07.817 - Api2BaseModule.UpdateAllOpenedChannels 0
10:56:07.825 - Destroy TSTS filter pid=0
10:56:07.832 - PlayTimePmtParser::StopParser
10:56:07.841 - PlayTimePmtParser::StopParser
10:56:07.849 - Destroy TSTS filter pid=4095
10:56:07.856 - DevicesManager::Free devices
10:56:07.865 - SDP:Destroy netclient.0 own=0ABC86B8
10:56:07.872 - SetOwner N -> 0
10:56:07.880 - SetOwner SetTransponder null
10:56:07.940 - ~TransponderManager
10:56:07.940 - SetOwner N -> 0
10:56:07.948 - SetOwner SetTransponder null
10:56:07.963 - TimeShift.~TimeShift
10:56:07.963 - HugeMemoryBlocksManager::Free
10:56:07.970 - ModuleList::Free
10:56:07.987 - SDP:after tr
10:56:07.994 - SDP:after destroy device
10:56:07.995 - DevicesManager::Free RC
10:56:08.004 - Engine stopped
10:56:08.031 - 
10:56:08.032 - Stop engine
10:56:08.039 - DevicesManager::Stop
10:56:08.047 - DevicesManager::Free devices
10:56:08.054 - Engine stopped
10:56:08.218 - !m_D3DDevices.size()
