﻿22:44:40.340 - Start logging...
22:44:40.391 - ExceptionFilter::Init. restart=1
22:44:41.198 - DevicesManager::EnableCISupport
22:44:41.203 - CAVManager::SetSettings
22:44:41.209 - DevicesManager::DestroyAllTransponderManager
22:44:41.284 - SetDefaultNullCodecs
22:44:41.320 - SetDefaultNullCodecs
22:44:41.346 - DevicesManager::Start
22:44:41.353 - AVManager::Init
22:44:41.359 - RemoveAllCreateBlank needBlank1
22:44:41.365 - add graph 070E8460 101
22:44:41.371 - [101]OnChangeCurrentGraph2 -RemoveAllBlank
22:44:41.408 - VR: GUI
22:44:41.434 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
22:44:41.511 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
22:44:41.517 - AV:UpdateAudioParamsAfterActive
22:44:41.522 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
22:44:41.534 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
22:44:41.652 - DevicesManager::StartDevices...
22:44:41.660 - device netclient.0 22:44:41.679 - dev: UpdateNetworkRecommendations  962x571 -1x-1
22:44:41.690 - dev: Created  netclient.0 0709BC58
OK
22:44:41.715 - Api2BaseModule.GetAdditionInfo
22:44:41.721 - Api2BaseModule.GetAdditionInfo OK
22:44:41.913 - Api2BaseModule.OnDisplaySize
22:44:41.920 - dev: UpdateNetworkRecommendations  1920x1047 -1x-1
22:44:42.176 - * s:0 q:0 tr=0 (0) offline
22:44:42.303 - 
22:44:42.310 - 
22:44:42.317 - ########################### Mark of start channel changing.###########################
22:44:42.323 - 
22:44:42.329 - GraphManager::MainChangeChannel СТС  1 provs
22:44:42.335 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
22:44:42.342 - SetChannelLogic::SetChannel 0
22:44:42.349 - SetChannelLogic::SetNormalChannel
22:44:42.357 - DevicesManager::CreateCloneDevice
22:44:42.363 - DevicesManager::CreateCloneDevice OK - founded in list
22:44:42.370 - TransponderManager
22:44:42.376 - CTransponderManager::InitOnNewDevice 0E3D8834
22:44:42.383 - SetOwner N -> Incoming Stream Cache
22:44:42.391 - TrafficProcessingScheme_CreateForNewEngineTransport 1 ss=0
22:44:42.397 - Normal TsInputTrafficProcessor.
22:44:42.404 - FilterManager::InitOnNewDevice 1
22:44:42.411 - TS router+MarkerFinder -> InputTrafficProcessor
22:44:42.418 - Incoming Stream Cache -> TS router+MarkerFinder
22:44:42.424 - InputTrafficProcessor -> Router to timeshift
22:44:42.431 - InputTrafficProcessor(FM) -> FilterManager
22:44:42.437 - ModuleList::Free
22:44:42.445 - Api2BaseModule::GetCurrentDeviceInfo
22:44:42.452 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\PidRecorder.module OK
22:44:42.459 - Api2BaseModule::GetCurrentDeviceInfo
22:44:42.472 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\ProgMediaServer.Module OK
22:44:42.478 - ChannelGraph5.CChannelGraph5
22:44:42.485 - TransponderManager::AddChildChannel
22:44:42.491 - TimeShift.TimeShift
22:44:42.499 - TimeShift.Create 400 mbytes 
22:44:42.505 - ts:One channel
22:44:42.512 - HugeMemoryBlocksManager::GetBlock 400 mbytes OK
22:44:42.518 - TransponderManager::CreateTimeshiftBuffer OK
22:44:42.543 - TimeShift.CreateReadingCursor
22:44:42.551 - TransponderChannelSource.Plugins 0E68A008 csa 00000000
22:44:42.557 - TsInputTrafficProcessor.AddChannel 0
22:44:42.564 - SetChannelLogic::LookDeviceWithoutChannelsOrCloneAndMakeGraph
22:44:42.571 - add graph 0E66D0FC 102
22:44:42.591 - ChannelGraph5.SetActiveState 1 render=1
22:44:42.597 - TransponderManager::SelectChannel
22:44:42.604 - TsInputTrafficProcessor.SelectChannel 0
22:44:42.611 - Api2BaseModule.UpdateAllOpenedChannels 0
22:44:42.623 - AV:UpdateAudioParamsAfterActive
22:44:42.629 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
22:44:42.636 - GR:UpdateAudioProcessor old=0 new=0
22:44:42.643 - Graph::SetAudioChannelMask
22:44:42.649 - **** StopChannel time 0.343ms
22:44:42.656 - 
22:44:42.663 - TransponderManager::SetTransponder (CH) 0 СТС
22:44:42.670 - *Transport TS
22:44:42.677 - Api2Device::SetChannel http://cf3e5210.rossteleccom.net/iptv/392XTEQ7L49GFY/506/index.m3u8
22:44:42.719 - Api2Device::SetChannel result OK
22:44:42.726 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
22:44:42.733 - TsInputTrafficProcessor.OpenTransponder 1
22:44:42.732 - Api2BaseModule.OnTunerStateChanged Connecting
22:44:42.740 - FilterManager::OnSetTransponder SetChannel
22:44:42.754 - TimeShift.Reset
22:44:42.761 - TimeShift.Cursor reset
22:44:42.747 - Api2BaseModule.OnTunerStateChanged  -3
22:44:42.768 - ReaderCursor::Reset.. OK
22:44:42.789 - Prereader.Reset ...-OK
22:44:42.803 - Create EPGparser on SetChannel
22:44:42.811 - DvbEpgParser::SetChannel ID=10018.860bcb618c71d7ec.1
22:44:42.829 - DvbEpgParser::mode normal pos=0
22:44:42.836 - **** SetTransponder time 0.188ms
22:44:42.844 - [102]ChannelGraph5::StartChannel СТС
22:44:42.851 - 
22:44:42.858 - [102]       #################### Start stream. (0.546ms) #######################
22:44:42.865 - 
22:44:42.919 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
22:44:42.926 - TimeShift.Cursor SetChannel::v 0 (0)
22:44:42.932 - ReaderCursor::SetChannel.. OK
22:44:42.946 - ReaderCursor::SetPosition 0 (w=0)
22:44:42.919 - Api2BaseModule.OnTunerStateChanged Preparing
22:44:42.953 - Prereader.SetChannel..
22:44:42.968 - Prereader.SetChannel unmask 1
22:44:42.976 - Plugin::SetChannel 1
22:44:42.983 - TransponderManager::SelectChannel
22:44:42.989 - TsInputTrafficProcessor.SelectChannel 1
22:44:42.996 - Api2BaseModule.UpdateAllOpenedChannels 1
22:44:42.960 - Api2BaseModule.OnTunerStateChanged  -4
22:44:43.010 - TsInputTrafficProcessor.UpdateChannel 1
22:44:43.018 - GraphState: Undef by StartChannelIsReady
22:44:43.025 - PreScanner.StartChannelIsReady net=1 parseall=1
22:44:43.032 - VideoMediaTypeDetection: h.264
22:44:43.040 - SetMarkerAudioLngStream Gen New stream
22:44:43.040 - Api2BaseModule.OnTunerStateChanged Playing
22:44:43.055 - Api2BaseModule.OnTunerStateChanged  -4
22:44:43.048 - SimpleTsDemux::Init apid=221, vpid=211
22:44:43.068 - GraphState: RequestPATScan by StartChannelIsReady TS
22:44:43.075 - Api2BaseModule.Filters_EnabledFullTS 1
22:44:43.088 - PlayTimePATParser.OpenParser 1
22:44:43.095 - Open TSTS filter pid=0 data=0
22:44:43.102 - TSTS cur size=0
22:44:43.108 - Graph::SetVideoRect {8 8 712 568}
22:44:43.115 - **** StartChanbnel time 0.281ms
22:44:43.122 - [102]OnChangeCurrentGraph2 -endOfSetChannel
22:44:43.130 - ChannelGraph5.SetActiveState 1 render=1
22:44:43.182 - * s:0 q:0 tr=0 (0) Preparing
22:44:43.190 - Graph::SetVideoWindowRect {33 0 166 100}
22:44:43.198 - Graph::UpdateRenderMode
22:44:43.337 - GraphManager::MultiChannelRendering
22:44:43.344 - ChannelGraph5.SetActiveState 1 render=1
22:44:43.362 - Graph::SetVideoWindowRect {194 0 1412 914}
22:44:43.389 - Graph::SetVideoWindowRect {194 0 1412 914}
22:44:43.404 - Api2BaseModule.OnDisplaySize
22:44:43.411 - dev: UpdateNetworkRecommendations  1921x1047 -1x-1
22:44:43.447 - Graph::SetVideoWindowRect {194 0 1412 914}
22:44:43.462 - Api2BaseModule.OnDisplaySize
22:44:43.469 - dev: UpdateNetworkRecommendations  1920x1047 -1x-1
22:44:43.552 - [102]**** SetChannel is finished (OK). Duration 1.234ms
22:44:43.893 - TransportMarker: TS
22:44:43.903 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=419430400
22:44:43.917 - 
22:44:43.925 -        #################### First traffic. (1.609ms) #######################
22:44:43.935 - 
22:44:43.943 - PlayTimePATParser.EndTask
22:44:43.998 - --SwitchEngineTransport TS > TS
22:44:44.006 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=419430400
22:44:44.013 - PreScanner.OnTransportMarker TS
22:44:44.023 - --SwitchEngineTransport end
22:44:44.031 - PreScanner.OnAfterScanPat count=2 {1;4095}
22:44:44.040 - Api2BaseModule.Filters_EnabledFullTS 0
22:44:44.053 - GraphState: RequestPMTScan by OnAfterScanPat
22:44:44.061 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=1
22:44:44.068 - Open TSTS filter pid=4095 data=2
22:44:44.076 - TSTS cur size=2162752
22:44:44.084 - TSTS quick finish
22:44:44.119 - PreScanner.OnAfterScanPmt pmt=4095
22:44:44.127 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
22:44:44.134 - PlayTimePmtParser::StopParser
22:44:44.184 - * s:100 q:100 tr=4328888 (0) Preparing
22:44:44.238 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
22:44:44.246 - TimeShift.Cursor SetChannel::v 4322496 (4322496)
22:44:44.254 - Prereader.SetChannel unmask 1
22:44:44.261 - Plugin::SetChannel 1
22:44:44.269 - TransponderManager::SelectChannel
22:44:44.277 - TsInputTrafficProcessor.SelectChannel 1
22:44:44.284 - Api2BaseModule.UpdateAllOpenedChannels 1
22:44:44.297 - TsInputTrafficProcessor.UpdateChannel 1
22:44:44.304 - PreScanner.StartChannelIsReady net=1 parseall=0
22:44:44.312 - LngDefaultSelector.try select audio pid=221 type=1 lng=0-(goh,goh,ang) l=99
22:44:44.319 - ChannelGraph5::AfterDetectChannelParams
22:44:44.327 - VideoMediaTypeDetection: h.264
22:44:44.334 - SimpleTsDemux::Init apid=221, vpid=211
22:44:44.341 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
22:44:44.348 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
22:44:44.356 - Prereader::ReaderCursor.. OK
22:44:44.372 - ReaderCursor::SetPosition 0 (w=18564978957090816)
22:44:44.380 - Prereader.StartPlayback Push buffering=0 recv=0E66E0A4 [StartChannelHelperBase(sl)]
22:44:44.387 - Prereader.StartPlayback after lock
22:44:44.395 - PreScanner.StartPmtParserIfNeed
22:44:44.403 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=0
22:44:44.410 - Open TSTS filter pid=4095 data=2
22:44:44.417 - TSTS cur size=4400704
22:44:44.395 - AudioParser::First packet 383
22:44:44.433 - VideoParser::First packet 23244 h.264
22:44:44.440 - h264 detected 0 ms
22:44:44.448 - AudioParser::packet 319
22:44:44.456 - AudioParser::packet 340
22:44:44.466 - AudioParser::packet 323
22:44:44.475 - AudioParser::packet 351
22:44:44.483 - AudioParser::packet 367
22:44:44.492 - AudioParser::packet 406
22:44:44.500 - AudioParser::packet 318
22:44:44.507 - AudioParser::packet 328
22:44:44.515 - AudioParser::packet 350
22:44:44.523 - AudioParser::packet 370
22:44:44.530 - AudioParser::packet 355
22:44:44.538 - AudioParser::AAC detected
22:44:44.545 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
22:44:44.553 - PreScanner.Post_InitRender [ReceiveTraffic]
22:44:44.561 - [102]sm: TvInitRenderer res=1
22:44:44.569 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
22:44:44.577 - CalculBufferingSize prov=0E3D9C74 marker=1 request=1
22:44:44.584 - CalculBuffering 2000ms br=2000kb to 500 kbytes. By type
22:44:44.592 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
22:44:44.599 - Prereader::ReaderCursor.. OK
22:44:44.615 - ReaderCursor::SetPosition 0 (w=19202060046041088)
22:44:44.622 - Prereader.StartPlayback Pull buffering=512000 recv=00000000 [EnablePullModeAndStartPlayback]
22:44:44.630 - Prereader.StartPlayback after lock
22:44:44.637 - Buffering/prereader size 500/3906 kbytes
22:44:44.645 - demux: ProgDemux
22:44:44.674 - ------sGetVideoParams
22:44:44.682 - ChannelGraph5.CreateInterfacesAndRenderGraph
22:44:44.696 - subsm.StartChannel demux=ProgDemux tr=TS
22:44:44.704 - subsm.RecreateSubtitlesParsers 070B0DE8 ts=1 subindex=-1 st=-1
22:44:44.712 - subsm.Stop teletext parser
22:44:44.719 - subsm.RecreateSubtitlesParsers end
22:44:44.727 - subs: OnSetChannel
22:44:44.734 - CreateCustomGraph
22:44:44.742 - VideoType:H.264/AVC ffmpeg=0
22:44:44.749 - 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)
22:44:44.757 - Add video codec 212690fb-83e5-4526-8fd7-74478b7939cd
22:44:44.782 - OK
22:44:44.790 - CChannelGraph5::CreateRender 10
22:44:44.798 - VR: EVR Custom
22:44:44.806 - VR: create new render
22:44:45.195 - * s:100 q:100 tr=4871644 (0) Preparing
22:44:45.420 - VR: Add video renderer Video Renderer - OK
22:44:45.428 - CreateAudioPartOfGraph
22:44:45.436 - AudioType:AAC/ADTS 
22:44:45.444 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 48000 16bit formatTag= 0x1600)
22:44:45.453 - Add audio codec e1f1a0b8-beee-490d-ba7c-066c40b5e2b9 - OK
22:44:45.472 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
22:44:45.480 - Added audio renderer
22:44:45.528 - Add and connect audio renderer - OK
22:44:45.537 - Graph::AfterRender
22:44:45.545 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
22:44:45.552 - AV:UpdateAudioParamsAfterActive
22:44:45.560 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
22:44:45.567 - GR:UpdateAudioProcessor old=0 new=0
22:44:45.575 - Graph::SetVolume 40% -1652db
22:44:45.583 - Graph::SetAudioChannelMask
22:44:45.591 - Graph::Run
22:44:45.702 - Graph::Run 1
22:44:45.722 - Graph::SetPictureParams
22:44:45.730 - Graph::SetVideoRect {8 8 712 568}
22:44:45.739 - Graph::SetVideoWindowRect {0 18 1606 896}
22:44:45.773 - 
22:44:45.785 - [0]########################### Mark of finish channel changing. (3.468ms) #############
22:44:45.795 - 
22:44:45.944 - CChannelGraph5::HideSubtitles
22:44:45.999 - 
22:44:46.008 - [0]########################### First video frame. (3.703ms) #############
22:44:46.020 - 
22:44:46.181 - * s:100 q:100 tr=1011816 (0) Playing
22:44:47.197 - * s:100 q:100 tr=7189684 (0) Playing
22:44:48.198 - * s:100 q:100 tr=0 (0) Playing
22:44:49.197 - * s:100 q:100 tr=0 (0) Playing
22:44:50.208 - * s:100 q:100 tr=0 (0) Playing
22:44:51.208 - * s:100 q:100 tr=0 (0) Playing
22:44:52.207 - * s:0 q:0 tr=0 (0) Playing
22:44:53.225 - * s:0 q:0 tr=0 (0) Playing
22:44:54.223 - * s:0 q:0 tr=0 (0) Playing
22:44:55.224 - * s:0 q:0 tr=0 (0) Playing
22:44:56.078 - 
22:44:56.086 - 
22:44:56.095 - ########################### Mark of start channel changing.###########################
22:44:56.104 - 
22:44:56.116 - GraphManager::MainChangeChannel СТС HD  1 provs
22:44:56.124 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
22:44:56.132 - SetChannelLogic::SetChannel 0
22:44:56.140 - SetChannelLogic::SetNormalChannel
22:44:56.163 - ChannelGraph5::StopChannel СТС HD
22:44:56.172 - PreScanner.Stop
22:44:56.180 - GraphState: Undef by PreScanner.Stop
22:44:56.199 - PlayTimePmtParser::StopParser
22:44:56.208 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
22:44:56.216 - Prereader::ReaderCursor.. OK
22:44:56.224 - * s:0 q:0 tr=0 (0) PreparingButTooLong
22:44:56.238 - ReaderCursor::SetPosition 0 (w=56069595458437120)
22:44:56.255 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
22:44:56.263 - Prereader.StartPlayback after lock
22:44:56.272 - subsm.StopChannel
22:44:56.280 - Graph::Stop
22:44:56.388 - Before Stop ...22:44:56.406 - OnGraphStop ...22:44:56.489 - VR: Disconnect
22:44:56.504 - Graph::ReleaseAllFilters
22:44:56.511 - release: Prog Audio renderer - RR - OK.
22:44:56.546 - release: Video Renderer - RR - OK.
22:44:56.635 - release: Microsoft DTV-DVD Video Decoder - RR - OK.
22:44:56.653 - release: Microsoft DTV-DVD Audio Decoder - RR - OK.
22:44:56.668 - FilterGraph: 1
22:44:56.676 - **** StopChannel time 0.578ms
22:44:56.684 - 
22:44:56.692 - TransponderManager::SetTransponder (CH) 0 СТС HD
22:44:56.699 - *Transport TS
22:44:56.707 - Api2Device::SetChannel http://cf3e5210.rossteleccom.net/iptv/392XTEQ7L49GFY/6303/index.m3u8
22:44:56.770 - Api2BaseModule.OnTunerStateChanged Connecting
22:44:56.779 - Api2BaseModule.OnTunerStateChanged  -3
22:44:56.828 - Api2Device::SetChannel result OK
22:44:56.835 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
22:44:56.842 - TsInputTrafficProcessor.OpenTransponder 1
22:44:56.850 - FilterManager::OnSetTransponder SetChannel
22:44:56.858 - TimeShift.Reset
22:44:56.866 - TimeShift.Cursor reset
22:44:56.873 - ReaderCursor::Reset.. OK
22:44:56.872 - Api2BaseModule.OnTunerStateChanged Preparing
22:44:56.896 - Api2BaseModule.OnTunerStateChanged  -4
22:44:56.889 - Prereader.Reset ...-OK
22:44:56.919 - Create EPGparser on SetChannel
22:44:56.929 - Api2BaseModule.OnTunerStateChanged Playing
22:44:56.937 - Api2BaseModule.OnTunerStateChanged  -4
22:44:56.929 - DvbEpgParser::SetChannel ID=10018.a216330c00dd5d69.1
22:44:56.976 - DvbEpgParser::mode normal pos=0
22:44:56.984 - **** SetTransponder time 0.312ms
22:44:56.992 - [102]ChannelGraph5::StartChannel СТС HD
22:44:56.999 - 
22:44:57.007 - [102]       #################### Start stream. (0.922ms) #######################
22:44:57.015 - 
22:44:57.117 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
22:44:57.125 - TimeShift.Cursor SetChannel::v 0 (0)
22:44:57.132 - ReaderCursor::SetChannel.. OK
22:44:57.148 - ReaderCursor::SetPosition 0 (w=0)
22:44:57.156 - Prereader.SetChannel..
22:44:57.164 - Prereader.SetChannel unmask 1
22:44:57.172 - Plugin::SetChannel 1
22:44:57.180 - TransponderManager::SelectChannel
22:44:57.187 - TsInputTrafficProcessor.SelectChannel 1
22:44:57.195 - Api2BaseModule.UpdateAllOpenedChannels 1
22:44:57.207 - TsInputTrafficProcessor.UpdateChannel 1
22:44:57.215 - GraphState: Undef by StartChannelIsReady
22:44:57.223 - PreScanner.StartChannelIsReady net=1 parseall=1
22:44:57.225 - * s:0 q:0 tr=0 (0) Preparing
22:44:57.230 - VideoMediaTypeDetection: h.264
22:44:57.245 - SetMarkerAudioLngStream Gen New stream
22:44:57.253 - SimpleTsDemux::Init apid=221, vpid=211
22:44:57.260 - GraphState: RequestPATScan by StartChannelIsReady TS
22:44:57.268 - Api2BaseModule.Filters_EnabledFullTS 1
22:44:57.281 - PlayTimePATParser.OpenParser 1
22:44:57.289 - Open TSTS filter pid=0 data=0
22:44:57.296 - TSTS cur size=0
22:44:57.304 - Graph::UpdateRenderMode
22:44:57.311 - Graph::SetVideoRect {8 8 712 568}
22:44:57.318 - Graph::SetVideoWindowRect {0 18 1606 896}
22:44:57.326 - **** StartChanbnel time 0.344ms
22:44:57.333 - [102]OnChangeCurrentGraph2 -endOfSetChannel
22:44:57.342 - ChannelGraph5.SetActiveState 1 render=1
22:44:57.635 - [102]**** SetChannel is finished (OK). Duration 1.547ms
22:44:58.237 - * s:0 q:0 tr=0 (0) Preparing
22:44:58.374 - 
22:44:58.384 -        #################### First traffic. (2.297ms) #######################
22:44:58.392 - 
22:44:58.400 - PlayTimePATParser.EndTask
22:44:58.408 - TransportMarker: TS
22:44:58.417 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=419430400
22:44:58.532 - PreScanner.OnAfterScanPat count=2 {1;4095}
22:44:58.539 - Api2BaseModule.Filters_EnabledFullTS 0
22:44:58.553 - GraphState: RequestPMTScan by OnAfterScanPat
22:44:58.561 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=1
22:44:58.568 - Open TSTS filter pid=4095 data=2
22:44:58.575 - TSTS cur size=1411316
22:44:58.583 - TSTS quick finish
22:44:58.590 - --SwitchEngineTransport TS > TS
22:44:58.597 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=419430400
22:44:58.605 - PreScanner.OnTransportMarker TS
22:44:58.612 - --SwitchEngineTransport end
22:44:58.619 - PreScanner.OnAfterScanPmt pmt=4095
22:44:58.626 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
22:44:58.634 - PlayTimePmtParser::StopParser
22:44:58.735 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
22:44:58.743 - TimeShift.Cursor SetChannel::v 2715096 (2715096)
22:44:58.751 - Prereader.SetChannel unmask 1
22:44:58.759 - Plugin::SetChannel 1
22:44:58.767 - TransponderManager::SelectChannel
22:44:58.775 - TsInputTrafficProcessor.SelectChannel 1
22:44:58.783 - Api2BaseModule.UpdateAllOpenedChannels 1
22:44:58.797 - TsInputTrafficProcessor.UpdateChannel 1
22:44:58.806 - PreScanner.StartChannelIsReady net=1 parseall=0
22:44:58.814 - LngDefaultSelector.try select audio pid=221 type=1 lng=7566706-rus(goh,goh,ang) l=10
22:44:58.821 - LngDefaultSelector. selected audio pid=221
22:44:58.830 - ChannelGraph5::AfterDetectChannelParams
22:44:58.838 - VideoMediaTypeDetection: h.264
22:44:58.845 - SimpleTsDemux::Init apid=221, vpid=211
22:44:58.853 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
22:44:58.860 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
22:44:58.867 - Prereader::ReaderCursor.. OK
22:44:58.882 - ReaderCursor::SetPosition 0 (w=15950443385454592)
22:44:58.889 - Prereader.StartPlayback Push buffering=0 recv=0E66E0A4 [StartChannelHelperBase(sl)]
22:44:58.896 - Prereader.StartPlayback after lock
22:44:58.904 - PreScanner.StartPmtParserIfNeed
22:44:58.904 - AudioParser::First packet 440
22:44:58.912 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=0
22:44:58.927 - Open TSTS filter pid=4095 data=2
22:44:58.919 - VideoParser::First packet 36307 h.264
22:44:58.942 - h264 detected 0 ms
22:44:58.935 - TSTS cur size=4115132
22:44:58.951 - AudioParser::packet 435
22:44:58.967 - AudioParser::packet 447
22:44:58.975 - AudioParser::packet 436
22:44:58.985 - AudioParser::packet 430
22:44:58.993 - AudioParser::packet 418
22:44:59.001 - AudioParser::packet 510
22:44:59.010 - AudioParser::AAC detected
22:44:59.020 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
22:44:59.029 - PreScanner.Post_InitRender [ReceiveTraffic]
22:44:59.150 - * s:100 q:100 tr=5010952 (0) Preparing
22:44:59.208 - [102]sm: TvInitRenderer res=1
22:44:59.215 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
22:44:59.223 - CalculBufferingSize prov=0E3D9C74 marker=1 request=1
22:44:59.231 - CalculBuffering 2000ms br=2000kb to 500 kbytes. By type
22:44:59.239 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
22:44:59.246 - Prereader::ReaderCursor.. OK
22:44:59.261 - ReaderCursor::SetPosition 0 (w=28974674012536832)
22:44:59.269 - Prereader.StartPlayback Pull buffering=512000 recv=00000000 [EnablePullModeAndStartPlayback]
22:44:59.277 - Prereader.StartPlayback after lock
22:44:59.284 - Buffering/prereader size 500/3906 kbytes
22:44:59.292 - ------sGetVideoParams
22:44:59.301 - ChannelGraph5.CreateInterfacesAndRenderGraph
22:44:59.313 - subsm.StartChannel demux=ProgDemux tr=TS
22:44:59.322 - subsm.RecreateSubtitlesParsers 070B0DE8 ts=1 subindex=-1 st=-1
22:44:59.329 - subsm.Stop teletext parser
22:44:59.337 - subsm.RecreateSubtitlesParsers end
22:44:59.344 - subs: OnSetChannel
22:44:59.353 - CreateCustomGraph
22:44:59.362 - VideoType:H.264/AVC ffmpeg=0
22:44:59.372 - 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)
22:44:59.380 - Add video codec 212690fb-83e5-4526-8fd7-74478b7939cd
22:44:59.398 - OK
22:44:59.407 - CChannelGraph5::CreateRender 10
22:44:59.415 - VR: EVR Custom
22:44:59.424 - VR: create new render
22:45:00.051 - VR: Add video renderer Video Renderer - OK
22:45:00.059 - CreateAudioPartOfGraph
22:45:00.067 - AudioType:AAC/ADTS 
22:45:00.075 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 48000 16bit formatTag= 0x1600)
22:45:00.084 - Add audio codec e1f1a0b8-beee-490d-ba7c-066c40b5e2b9 - OK
22:45:00.098 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
22:45:00.107 - Added audio renderer
22:45:00.164 - Add and connect audio renderer - OK
22:45:00.172 - Graph::AfterRender
22:45:00.179 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
22:45:00.188 - AV:UpdateAudioParamsAfterActive
22:45:00.196 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
22:45:00.204 - GR:UpdateAudioProcessor old=0 new=0
22:45:00.212 - Graph::SetVolume 40% -1652db
22:45:00.221 - Graph::SetAudioChannelMask
22:45:00.227 - * s:100 q:100 tr=9280432 (0) Playing
22:45:00.230 - Graph::Run
22:45:00.419 - Graph::Run 1
22:45:00.440 - Graph::SetPictureParams
22:45:00.448 - Graph::SetVideoRect {24 16 1896 1068}
22:45:00.457 - Graph::SetVideoWindowRect {0 2 1606 912}
22:45:00.504 - 
22:45:00.512 - [0]########################### Mark of finish channel changing. (4.422ms) #############
22:45:00.520 - 
22:45:00.706 - CChannelGraph5::HideSubtitles
22:45:00.788 - * s:100 q:100 tr=5779872 (0) Playing
22:45:01.435 - 
22:45:01.445 - [0]########################### First video frame. (5.359ms) #############
22:45:01.455 - 
22:45:01.607 - changed ratio to 1920/1080
22:45:01.616 - Graph::SetVideoRect {24 16 1896 1068}
22:45:01.624 - Graph::SetVideoWindowRect {0 8 1606 905}
22:45:01.701 - * s:100 q:100 tr=14333872 (0) Playing
22:45:02.253 - * s:100 q:100 tr=4600360 (0) Playing
22:45:03.254 - * s:100 q:100 tr=6300068 (0) Playing
22:45:04.253 - * s:100 q:100 tr=2695356 (0) Playing
22:45:05.256 - * s:100 q:100 tr=499328 (0) Playing
22:45:06.257 - * s:100 q:100 tr=575280 (0) Playing
22:45:07.256 - * s:100 q:100 tr=2768112 (0) Playing
22:45:08.256 - * s:100 q:100 tr=3575572 (0) Playing
22:45:09.273 - * s:100 q:100 tr=1928692 (0) Playing
22:45:10.270 - * s:100 q:100 tr=0 (0) Playing
22:45:10.422 - 
22:45:10.430 - 
22:45:10.438 - ########################### Mark of start channel changing.###########################
22:45:10.446 - 
22:45:10.458 - GraphManager::MainChangeChannel СТС HD  1 provs
22:45:10.466 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
22:45:10.475 - SetChannelLogic::SetChannel 0
22:45:10.483 - SetChannelLogic::SetNormalChannel
22:45:10.507 - ChannelGraph5::StopChannel СТС HD
22:45:10.516 - PreScanner.Stop
22:45:10.524 - GraphState: Undef by PreScanner.Stop
22:45:10.540 - PlayTimePmtParser::StopParser
22:45:10.547 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
22:45:10.556 - Prereader::ReaderCursor.. OK
22:45:10.576 - ReaderCursor::SetPosition 0 (w=246150691767189504)
22:45:10.583 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
22:45:10.592 - Prereader.StartPlayback after lock
22:45:10.601 - subsm.StopChannel
22:45:10.609 - Graph::Stop
22:45:10.735 - Before Stop ...22:45:10.756 - OnGraphStop ...22:45:10.848 - VR: Disconnect
22:45:10.865 - Graph::ReleaseAllFilters
22:45:10.872 - release: Prog Audio renderer - RR - OK.
22:45:10.916 - release: Video Renderer - RR - OK.
22:45:11.027 - release: Microsoft DTV-DVD Video Decoder - RR - OK.
22:45:11.045 - release: Microsoft DTV-DVD Audio Decoder - RR - OK.
22:45:11.060 - FilterGraph: 1
22:45:11.069 - **** StopChannel time 0.640ms
22:45:11.076 - 
22:45:11.084 - TransponderManager::SetTransponder (CH) 0 СТС HD
22:45:11.091 - *Transport TS
22:45:11.099 - Api2Device::SetChannel http://cf3e5210.rossteleccom.net/iptv/392XTEQ7L49GFY/6303/index.m3u8
22:45:11.150 - Api2Device::SetChannel result OK
22:45:11.158 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
22:45:11.166 - TsInputTrafficProcessor.OpenTransponder 1
22:45:11.173 - FilterManager::OnSetTransponder SetChannel
22:45:11.180 - TimeShift.Reset
22:45:11.188 - TimeShift.Cursor reset
22:45:11.195 - ReaderCursor::Reset.. OK
22:45:11.210 - Prereader.Reset ...-OK
22:45:11.226 - Create EPGparser on SetChannel
22:45:11.233 - DvbEpgParser::SetChannel ID=10018.a216330c00dd5d69.1
22:45:11.265 - DvbEpgParser::mode normal pos=0
22:45:11.272 - * s:100 q:100 tr=-57347896 (0) Connecting
22:45:11.273 - **** SetTransponder time 0.203ms
22:45:11.289 - [102]ChannelGraph5::StartChannel СТС HD
22:45:11.297 - 
22:45:11.305 - [102]       #################### Start stream. (0.875ms) #######################
22:45:11.312 - 
22:45:11.433 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
22:45:11.441 - TimeShift.Cursor SetChannel::v 0 (0)
22:45:11.450 - ReaderCursor::SetChannel.. OK
22:45:11.465 - ReaderCursor::SetPosition 0 (w=0)
22:45:11.473 - Prereader.SetChannel..
22:45:11.481 - Prereader.SetChannel unmask 1
22:45:11.489 - Plugin::SetChannel 1
22:45:11.496 - TransponderManager::SelectChannel
22:45:11.504 - TsInputTrafficProcessor.SelectChannel 1
22:45:11.511 - Api2BaseModule.UpdateAllOpenedChannels 1
22:45:11.524 - TsInputTrafficProcessor.UpdateChannel 1
22:45:11.528 - TransportMarker: TS
22:45:11.533 - GraphState: Undef by StartChannelIsReady
22:45:11.540 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=419430400
22:45:11.548 - PreScanner.StartChannelIsReady net=1 parseall=1
22:45:11.555 - 
22:45:11.570 -        #################### First traffic. (1.140ms) #######################
22:45:11.578 - 
22:45:11.563 - VideoMediaTypeDetection: h.264
22:45:11.594 - SetMarkerAudioLngStream Gen New stream
22:45:11.602 - SimpleTsDemux::Init apid=221, vpid=211
22:45:11.610 - GraphState: RequestPATScan by StartChannelIsReady TS
22:45:11.617 - Api2BaseModule.Filters_EnabledFullTS 1
22:45:11.631 - PlayTimePATParser.OpenParser 1
22:45:11.639 - Open TSTS filter pid=0 data=0
22:45:11.646 - TSTS cur size=4701316
22:45:11.655 - PlayTimePATParser.EndTask
22:45:11.663 - TSTS quick finish
22:45:11.673 - Graph::UpdateRenderMode
22:45:11.681 - Graph::SetVideoRect {8 8 712 568}
22:45:11.688 - Graph::SetVideoWindowRect {0 8 1606 905}
22:45:11.696 - **** StartChanbnel time 0.422ms
22:45:11.703 - [102]OnChangeCurrentGraph2 -endOfSetChannel
22:45:11.712 - ChannelGraph5.SetActiveState 1 render=1
22:45:11.790 - * s:100 q:100 tr=5642444 (0) Preparing
22:45:12.048 - [102]**** SetChannel is finished (OK). Duration 1.609ms
22:45:12.121 - --SwitchEngineTransport TS > TS
22:45:12.130 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=419430400
22:45:12.139 - PreScanner.OnTransportMarker TS
22:45:12.147 - --SwitchEngineTransport end
22:45:12.155 - PreScanner.OnAfterScanPat count=2 {1;4095}
22:45:12.163 - Api2BaseModule.Filters_EnabledFullTS 0
22:45:12.178 - GraphState: RequestPMTScan by OnAfterScanPat
22:45:12.186 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=1
22:45:12.194 - Open TSTS filter pid=4095 data=2
22:45:12.202 - TSTS cur size=11521768
22:45:12.210 - TSTS quick finish
22:45:12.247 - PreScanner.OnAfterScanPmt pmt=4095
22:45:12.254 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
22:45:12.263 - PlayTimePmtParser::StopParser
22:45:12.372 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
22:45:12.379 - TimeShift.Cursor SetChannel::v 14311876 (14311876)
22:45:12.387 - Prereader.SetChannel unmask 1
22:45:12.395 - Plugin::SetChannel 1
22:45:12.403 - TransponderManager::SelectChannel
22:45:12.411 - TsInputTrafficProcessor.SelectChannel 1
22:45:12.418 - Api2BaseModule.UpdateAllOpenedChannels 1
22:45:12.432 - TsInputTrafficProcessor.UpdateChannel 1
22:45:12.440 - PreScanner.StartChannelIsReady net=1 parseall=0
22:45:12.447 - LngDefaultSelector.try select audio pid=221 type=1 lng=7566706-rus(goh,goh,ang) l=10
22:45:12.454 - LngDefaultSelector. selected audio pid=221
22:45:12.462 - ChannelGraph5::AfterDetectChannelParams
22:45:12.470 - VideoMediaTypeDetection: h.264
22:45:12.477 - SimpleTsDemux::Init apid=221, vpid=211
22:45:12.485 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
22:45:12.493 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
22:45:12.500 - Prereader::ReaderCursor.. OK
22:45:12.515 - ReaderCursor::SetPosition 0 (w=71035752598732800)
22:45:12.524 - Prereader.StartPlayback Push buffering=0 recv=0E66E0A4 [StartChannelHelperBase(sl)]
22:45:12.531 - Prereader.StartPlayback after lock
22:45:12.540 - PreScanner.StartPmtParserIfNeed
22:45:12.540 - AudioParser::First packet 381
22:45:12.547 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=0
22:45:12.555 - AudioParser::packet 426
22:45:12.571 - AudioParser::packet 426
22:45:12.563 - Open TSTS filter pid=4095 data=2
22:45:12.579 - VideoParser::First packet 16747 h.264
22:45:12.594 - AudioParser::packet 443
22:45:12.587 - TSTS cur size=17596236
22:45:12.602 - AudioParser::packet 405
22:45:12.619 - VideoParser::packet 32011
22:45:12.628 - AudioParser::packet 423
22:45:12.637 - AudioParser::packet 454
22:45:12.646 - VideoParser::packet 52687
22:45:12.656 - AudioParser::packet 463
22:45:12.664 - AudioParser::packet 826
22:45:12.671 - VideoParser::packet 72375
22:45:12.680 - AudioParser::packet 411
22:45:12.688 - VideoParser::packet 90155
22:45:12.700 - AudioParser::packet 433
22:45:12.711 - AudioParser::packet 411
22:45:12.720 - VideoParser::packet 106777
22:45:12.728 - AudioParser::packet 454
22:45:12.736 - AudioParser::packet 416
22:45:12.744 - VideoParser::packet 125925
22:45:12.752 - AudioParser::packet 871
22:45:12.761 - AudioParser::AAC detected
22:45:12.772 - VideoParser::packet 145702
22:45:12.784 - VideoParser::packet 178282
22:45:12.792 - VideoParser::packet 185121
22:45:12.801 - VideoParser::packet 194476
22:45:12.809 - VideoParser::packet 204466
22:45:12.818 - VideoParser::packet 218021
22:45:12.827 - VideoParser::packet 231941
22:45:12.838 - VideoParser::packet 249623
22:45:12.848 - VideoParser::packet 266029
22:45:12.857 - VideoParser::packet 285509
22:45:12.866 - VideoParser::packet 299690
22:45:12.874 - VideoParser::packet 315989
22:45:12.882 - VideoParser::packet 332956
22:45:12.890 - VideoParser::packet 352436
22:45:12.900 - VideoParser::packet 370262
22:45:12.910 - VideoParser::packet 388431
22:45:12.922 - VideoParser::packet 404643
22:45:12.931 - VideoParser::packet 421659
22:45:12.939 - VideoParser::packet 436750
22:45:12.947 - VideoParser::packet 452061
22:45:12.956 - VideoParser::packet 466449
22:45:12.964 - VideoParser::packet 484264
22:45:12.974 - VideoParser::packet 498834
22:45:12.983 - VideoParser::packet 516168
22:45:12.989 - * s:100 q:100 tr=23926008 (0) Preparing
22:45:12.991 - VideoParser::packet 533423
22:45:13.006 - VideoParser::packet 552984
22:45:13.016 - VideoParser::packet 569347
22:45:13.025 - VideoParser::packet 586575
22:45:13.034 - VideoParser::packet 602099
22:45:13.042 - VideoParser::packet 619762
22:45:13.052 - VideoParser::packet 633511
22:45:13.061 - VideoParser::packet 647896
22:45:13.070 - VideoParser::packet 661749
22:45:13.079 - VideoParser::packet 683269
22:45:13.090 - VideoParser::packet 697522
22:45:13.099 - VideoParser::packet 714023
22:45:13.108 - VideoParser::packet 729084
22:45:13.116 - VideoParser::packet 747507
22:45:13.124 - VideoParser::packet 761031
22:45:13.133 - VideoParser::packet 775596
22:45:13.141 - VideoParser::packet 833977
22:45:13.150 - h264 detected 562 ms
22:45:13.158 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
22:45:13.165 - PreScanner.Post_InitRender [ReceiveTraffic]
22:45:13.173 - [102]sm: TvInitRenderer res=1
22:45:13.182 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
22:45:13.191 - CalculBufferingSize prov=0E3D9C74 marker=1 request=1
22:45:13.199 - CalculBuffering 2000ms br=2000kb to 500 kbytes. By type
22:45:13.206 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
22:45:13.214 - Prereader::ReaderCursor.. OK
22:45:13.229 - ReaderCursor::SetPosition 0 (w=112032607008456704)
22:45:13.237 - Prereader.StartPlayback Pull buffering=512000 recv=00000000 [EnablePullModeAndStartPlayback]
22:45:13.245 - Prereader.StartPlayback after lock
22:45:13.253 - Buffering/prereader size 500/3906 kbytes
22:45:13.260 - ------sGetVideoParams
22:45:13.269 - ChannelGraph5.CreateInterfacesAndRenderGraph
22:45:13.279 - subsm.StartChannel demux=ProgDemux tr=TS
22:45:13.287 - subsm.RecreateSubtitlesParsers 070B0DE8 ts=1 subindex=-1 st=-1
22:45:13.295 - subsm.Stop teletext parser
22:45:13.303 - subsm.RecreateSubtitlesParsers end
22:45:13.311 - subs: OnSetChannel
22:45:13.318 - CreateCustomGraph
22:45:13.325 - VideoType:H.264/AVC ffmpeg=0
22:45:13.335 - 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)
22:45:13.343 - Add video codec 212690fb-83e5-4526-8fd7-74478b7939cd
22:45:13.361 - OK
22:45:13.369 - CChannelGraph5::CreateRender 10
22:45:13.376 - VR: EVR Custom
22:45:13.384 - VR: create new render
22:45:14.066 - VR: Add video renderer Video Renderer - OK
22:45:14.074 - CreateAudioPartOfGraph
22:45:14.083 - AudioType:AAC/ADTS 
22:45:14.091 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 48000 16bit formatTag= 0x1600)
22:45:14.103 - Add audio codec e1f1a0b8-beee-490d-ba7c-066c40b5e2b9 - OK
22:45:14.118 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
22:45:14.125 - Added audio renderer
22:45:14.181 - Add and connect audio renderer - OK
22:45:14.188 - Graph::AfterRender
22:45:14.196 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
22:45:14.204 - AV:UpdateAudioParamsAfterActive
22:45:14.212 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
22:45:14.220 - GR:UpdateAudioProcessor old=0 new=0
22:45:14.228 - Graph::SetVolume 40% -1652db
22:45:14.236 - Graph::SetAudioChannelMask
22:45:14.244 - Graph::Run
22:45:14.274 - * s:100 q:100 tr=14336128 (0) Playing
22:45:14.435 - Graph::Run 1
22:45:14.457 - Graph::SetPictureParams
22:45:14.466 - Graph::SetVideoRect {24 16 1896 1068}
22:45:14.475 - Graph::SetVideoWindowRect {0 2 1606 912}
22:45:14.511 - 
22:45:14.520 - [0]########################### Mark of finish channel changing. (4.078ms) #############
22:45:14.528 - 
22:45:14.642 - CChannelGraph5::HideSubtitles
22:45:14.796 - * s:100 q:100 tr=215636 (0) Playing
22:45:15.743 - * s:100 q:100 tr=254176 (0) Playing
22:45:16.306 - * s:100 q:100 tr=181044 (0) Playing
22:45:17.176 - 
22:45:17.186 - [0]########################### First video frame. (6.750ms) #############
22:45:17.195 - 
22:45:17.317 - * s:100 q:100 tr=280308 (0) Playing
22:45:17.600 - changed ratio to 1920/1080
22:45:17.610 - Graph::SetVideoRect {24 16 1896 1068}
22:45:17.619 - Graph::SetVideoWindowRect {0 8 1606 905}
22:45:18.319 - * s:100 q:100 tr=321104 (0) Playing
22:45:19.318 - * s:100 q:100 tr=432212 (0) Playing
22:45:20.321 - * s:100 q:100 tr=391228 (0) Playing
22:45:21.323 - * s:100 q:100 tr=744668 (0) Playing
22:45:22.324 - * s:100 q:100 tr=4585696 (0) Playing
22:45:23.321 - * s:100 q:100 tr=5220760 (0) Playing
22:45:24.338 - * s:100 q:100 tr=1712304 (0) Playing
22:45:25.338 - * s:100 q:100 tr=0 (0) Playing
22:45:26.334 - * s:100 q:100 tr=0 (0) Playing
22:45:27.350 - * s:100 q:100 tr=0 (0) Playing
22:45:28.353 - * s:100 q:100 tr=2767736 (0) Playing
22:45:29.369 - * s:100 q:100 tr=1924744 (0) Playing
22:45:30.380 - * s:100 q:100 tr=0 (0) Playing
22:45:31.381 - * s:100 q:100 tr=0 (0) Playing
22:45:32.383 - * s:100 q:100 tr=0 (0) Playing
22:45:33.382 - * s:100 q:100 tr=0 (0) Playing
22:45:34.395 - * s:0 q:0 tr=0 (0) Playing
22:45:35.397 - * s:0 q:0 tr=0 (0) Playing
22:45:36.398 - * s:0 q:0 tr=0 (0) Playing
22:45:37.398 - * s:0 q:0 tr=0 (0) Playing
22:45:38.399 - * s:100 q:100 tr=1888836 (0) Playing
22:45:39.398 - * s:100 q:100 tr=2969084 (0) Playing
22:45:40.398 - * s:100 q:100 tr=0 (0) Playing
22:45:41.400 - * s:100 q:100 tr=0 (0) Playing
22:45:42.410 - * s:100 q:100 tr=0 (0) Playing
22:45:43.410 - * s:100 q:100 tr=0 (0) Playing
22:45:44.412 - * s:0 q:0 tr=0 (0) Playing
22:45:45.426 - * s:0 q:0 tr=0 (0) Playing
22:45:46.428 - * s:0 q:0 tr=0 (0) Playing
22:45:47.427 - * s:0 q:0 tr=0 (0) Playing
22:45:48.442 - * s:100 q:100 tr=2036416 (0) Playing
22:45:49.444 - * s:100 q:100 tr=0 (0) Playing
22:45:50.447 - * s:100 q:100 tr=0 (0) Playing
22:45:51.445 - * s:100 q:100 tr=0 (0) Playing
22:45:52.447 - * s:100 q:100 tr=0 (0) Playing
22:45:53.458 - * s:0 q:0 tr=0 (0) Playing
22:45:54.459 - * s:0 q:0 tr=0 (0) Playing
22:45:55.459 - * s:0 q:0 tr=0 (0) Playing
22:45:56.458 - * s:0 q:0 tr=0 (0) Playing
22:45:57.474 - * s:0 q:0 tr=0 (0) Playing
22:45:58.476 - * s:100 q:100 tr=3173628 (0) Playing
22:45:59.478 - * s:100 q:100 tr=1563972 (0) Playing
22:46:00.476 - * s:100 q:100 tr=0 (0) Playing
22:46:01.476 - * s:100 q:100 tr=0 (0) Playing
22:46:02.488 - * s:100 q:100 tr=0 (0) Playing
22:46:03.492 - * s:100 q:100 tr=0 (0) Playing
22:46:04.493 - * s:0 q:0 tr=0 (0) Playing
22:46:05.491 - * s:0 q:0 tr=0 (0) Playing
22:46:06.492 - * s:0 q:0 tr=0 (0) Playing
22:46:07.492 - * s:0 q:0 tr=0 (0) Playing
22:46:08.493 - * s:100 q:100 tr=2131168 (0) Playing
22:46:09.497 - * s:100 q:100 tr=2669600 (0) Playing
22:46:10.507 - * s:100 q:100 tr=0 (0) Playing
22:46:11.507 - * s:100 q:100 tr=0 (0) Playing
22:46:12.522 - * s:100 q:100 tr=0 (0) Playing
22:46:13.523 - * s:100 q:100 tr=0 (0) Playing
22:46:14.522 - * s:0 q:0 tr=0 (0) Playing
22:46:15.523 - * s:0 q:0 tr=0 (0) Playing
22:46:16.523 - * s:0 q:0 tr=0 (0) Playing
22:46:17.523 - * s:0 q:0 tr=0 (0) Playing
22:46:18.522 - * s:100 q:100 tr=2659824 (0) Playing
22:46:19.523 - * s:100 q:100 tr=2213136 (0) Playing
22:46:20.537 - * s:100 q:100 tr=0 (0) Playing
22:46:21.537 - * s:100 q:100 tr=0 (0) Playing
22:46:22.537 - * s:100 q:100 tr=0 (0) Playing
22:46:23.540 - * s:100 q:100 tr=0 (0) Playing
22:46:24.440 - * s:0 q:0 tr=0 (0) Playing
22:46:25.540 - * s:0 q:0 tr=0 (0) Playing
22:46:26.554 - * s:0 q:0 tr=0 (0) Playing
22:46:27.554 - * s:0 q:0 tr=0 (0) Playing
22:46:28.555 - * s:100 q:100 tr=2840868 (0) Playing
22:46:29.553 - * s:100 q:100 tr=1839580 (0) Playing
