﻿19:56:22.605 - Start logging...
19:56:22.605 - 
19:56:22.605 - Start engine 6.210
19:56:22.605 - ExceptionFilter::Init. restart=1
19:56:26.489 - DevicesManager::Start
19:56:26.489 - CAVManager::Init
19:56:26.538 - AV settings loaded
19:56:26.569 - VR: GUI
19:56:26.585 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
19:56:26.679 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
19:56:26.679 - AV:UpdateAudioParamsAfterActive
19:56:26.679 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
19:56:26.679 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
19:56:27.490 - DevicesManager::StartDevices...
19:56:27.490 - device netclient.0 19:56:27.490 - dev: Created  netclient.0 00000000267C9D90
OK
19:56:27.505 - Api2BaseModule.GetAdditionInfo
19:56:28.722 - 
19:56:28.722 - 
19:56:28.722 - ########################### Mark of start channel changing.###########################
19:56:28.722 - 
19:56:28.722 - GraphManager::MainChangeChannel BE - EEN HD  1 provs
19:56:28.722 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
19:56:28.722 - SetChannelLogic::SetChannel 0
19:56:28.722 - SetChannelLogic::SetNormalChannel
19:56:28.722 - DevicesManager::CreateCloneDevice
19:56:28.722 - DevicesManager::CreateCloneDevice OK - founded in list
19:56:28.722 - TransponderManager
19:56:28.722 - CTransponderManager::InitOnNewDevice 00000000267F0FF8
19:56:28.738 - N -> Incoming Stream Cache
19:56:28.738 - TrafficProcessingScheme_CreateForNewEngineTransport 1 ss=0
19:56:28.738 - Normal TsInputTrafficProcessor.
19:56:28.738 - FilterManager::InitOnNewDevice 1
19:56:28.738 - TS router+MarkerFinder -> InputTrafficProcessor
19:56:28.738 - Incoming Stream Cache -> TS router+MarkerFinder
19:56:28.738 - InputTrafficProcessor -> Router to timeshift
19:56:28.738 - InputTrafficProcessor(FM) -> FilterManager
19:56:28.738 - ModuleList::Free
19:56:28.738 - ChannelGraph5.CChannelGraph5
19:56:28.738 - TransponderManager::AddChildChannel
19:56:28.738 - TimeShift.TimeShift
19:56:28.738 - TimeShift.Create 200 mbytes 
19:56:28.738 - ts:One channel
19:56:28.738 - HugeMemoryBlocksManager::GetBlock 200 mbytes OK
19:56:28.738 - TransponderManager::CreateTimeshiftBuffer OK
19:56:28.753 - TimeShift.CreateReadingCursor
19:56:28.753 - TsInputTrafficProcessor.AddChannel 0
19:56:28.769 - SetChannelLogic::LookDeviceWithoutChannelsOrCloneAndMakeGraph
19:56:28.769 - ChannelGraph5.SetActiveState 1
19:56:28.769 - TransponderManager::SelectChannel
19:56:28.769 - TsInputTrafficProcessor.SelectChannel 0
19:56:28.769 - Api2BaseModule.UpdateAllOpenedChannels 0
19:56:28.769 - AV:UpdateAudioParamsAfterActive
19:56:28.769 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
19:56:28.769 - Graph::SetAudioChannelMask
19:56:28.769 - 
19:56:28.769 - TransponderManager::SetTransponder (CH) 0 BE - EEN HD
19:56:28.769 - *Transport TS
19:56:28.769 - Api2Device::SetChannel http://tektv.co:80/mick-order649/FahgNTyvQo/34981
19:56:28.769 - Api2BaseModule.OnTunerStateChanged Connecting
19:56:28.769 - Api2Device::SetChannel result OK
19:56:28.769 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
19:56:28.769 - TsInputTrafficProcessor.OpenTransponder 1
19:56:28.769 - FilterManager::OnSetTransponder SetChannel
19:56:28.769 - TimeShift.Reset
19:56:28.769 - TimeShift.Cursor reset
19:56:28.769 - ReaderCursor::Reset.. OK
19:56:28.785 - Prereader.Reset ...-OK
19:56:28.785 - Create EPGparser on SetChannel
19:56:28.785 - DvbEpgParser::SetChannel ID=69c80002.da1f26d2b963aefb.1
19:56:28.785 - ModuleList::ChangeChannel 0
19:56:28.785 - CChannelGraph5::StartChannel BE - EEN HD
19:56:28.785 - 
19:56:28.785 -        #################### Start stream. (0.062ms) #######################
19:56:28.785 - 
19:56:28.800 - TimeShift.Cursor SetChannel pidmask=0000000000000000 first=1
19:56:28.800 - TimeShift.Cursor SetChannel::v 0 (0)
19:56:28.800 - ReaderCursor::SetChannel.. OK
19:56:28.800 - ReaderCursor::SetPosition 0 (w=0)
19:56:28.800 - Prereader.SetChannel..
19:56:28.800 - Prereader.SetChannel unmask 1
19:56:28.800 - Plugin::SetChannel 1
19:56:28.800 - TransponderManager::SelectChannel
19:56:28.800 - TsInputTrafficProcessor.SelectChannel 1
19:56:28.800 - Api2BaseModule.UpdateAllOpenedChannels 1
19:56:28.800 - TsInputTrafficProcessor.UpdateChannel 1
19:56:28.800 - GraphState: Undef by StartChannelIsReady
19:56:28.800 - PreScanner.StartChannelIsReady net=1 parseall=1
19:56:28.800 - VideoMediaTypeDetection: h.264
19:56:28.800 - SetMarkerAudioLngStream Gen New stream
19:56:28.800 - SimpleTsDemux::Init apid=257, vpid=256
19:56:28.800 - GraphState: RequestPATScan by StartChannelIsReady TS
19:56:28.800 - Api2BaseModule.Filters_EnabledFullTS 1
19:56:28.800 - PlayTimePATParser.OpenParser 1
19:56:28.800 - Open TSTS filter pid=0 data=0
19:56:28.800 - TSTS cur size=0
19:56:28.800 - Graph::SetVideoRect {8 8 712 568}
19:56:28.800 - ChannelGraph5.SetActiveState 1
19:56:28.816 - Graph::SetVideoWindowRect {33 0 166 100}
19:56:28.816 - Graph::UpdateRenderMode
19:56:28.831 - GraphManager::MultiChannelRendering
19:56:28.831 - ChannelGraph5.SetActiveState 1
19:56:28.847 - Api2BaseModule.OnTunerStateChanged Preparing
19:56:28.847 - Graph::SetVideoWindowRect {40 0 452 309}
19:56:28.930 - OK. 102
19:56:28.982 - Api2BaseModule.OnTunerStateChanged Playing
19:56:29.095 - OSDManager::Window_Add
19:56:29.097 - OSDManager::Window_Show
19:56:29.123 - * s:0 q:0 tr=0 (0) Preparing
19:56:29.149 - OSDManager::Window_Show
19:56:29.152 - OSDManager::Window_Show
19:56:29.298 - Api2BaseModule.OnTunerStateChanged Connecting
19:56:29.332 - Api2BaseModule.OnTunerStateChanged Preparing
19:56:29.474 - Api2BaseModule.OnTunerStateChanged Playing
19:56:29.481 - TransportMarker: TS
19:56:29.482 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
19:56:29.483 - --SwitchEngineTransport TS > TS
19:56:29.483 - 
19:56:29.486 -        #################### First traffic. (0.764ms) #######################
19:56:29.487 - 
19:56:29.488 - PlayTimePATParser.EndTask
19:56:29.490 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
19:56:29.491 - PreScanner.OnTransportMarker TS
19:56:29.492 - --SwitchEngineTransport end
19:56:29.494 - PreScanner.OnAfterScanPat count=2 {1;4096}
19:56:29.495 - Api2BaseModule.Filters_EnabledFullTS 0
19:56:29.497 - GraphState: RequestPMTScan by OnAfterScanPat
19:56:29.499 - PlayTimePmtParser::OpenParser SID=1 PMT=4096 unknow channel=1
19:56:29.500 - Open TSTS filter pid=4096 data=2
19:56:29.502 - TSTS cur size=159048
19:56:29.503 - TSTS quick finish
19:56:29.529 - OSDManager::Window_Show
19:56:29.530 - PreScanner.OnAfterScanPmt pmt=4096
19:56:29.531 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
19:56:29.531 - PlayTimePmtParser::StopParser
19:56:29.543 - TimeShift.Cursor SetChannel pidmask=0000000000000000 first=0
19:56:29.544 - TimeShift.Cursor SetChannel::v 401004 (401004)
19:56:29.545 - Prereader.SetChannel unmask 1
19:56:29.546 - Plugin::SetChannel 1
19:56:29.547 - TransponderManager::SelectChannel
19:56:29.548 - TsInputTrafficProcessor.SelectChannel 1
19:56:29.549 - Api2BaseModule.UpdateAllOpenedChannels 1
19:56:29.549 - TsInputTrafficProcessor.UpdateChannel 1
19:56:29.550 - PreScanner.StartChannelIsReady net=1 parseall=0
19:56:29.551 - LngDefaultSelector.try select audio pid=257 type=1 lng=0-(goh,goh,rus) l=99
19:56:29.552 - ChannelGraph5::AfterDetectChannelParams
19:56:29.553 - VideoMediaTypeDetection: h.264
19:56:29.554 - SimpleTsDemux::Init apid=257, vpid=256
19:56:29.555 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
19:56:29.556 - demux: ProgDemux
19:56:29.561 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
19:56:29.562 - Prereader::ReaderCursor.. OK
19:56:29.564 - ReaderCursor::SetPosition 0 (w=542756)
19:56:29.564 - Prereader.StartPlayback Push buffering=0 recv=000000002AD69418 [StartChannelHelperBase(sl)]
19:56:29.565 - Prereader.StartPlayback after lock
19:56:29.565 - PreScanner.StartPmtParserIfNeed
19:56:29.566 - PlayTimePmtParser::OpenParser SID=1 PMT=4096 unknow channel=0
19:56:29.567 - VideoParser::First packet 44879 h.264
19:56:29.568 - h264 detected 0 ms
19:56:29.567 - Open TSTS filter pid=4096 data=2
19:56:29.569 - TSTS cur size=577348
19:56:29.568 - AudioParser::First packet 2805
19:56:29.570 - AudioParser::AAC detected
19:56:29.572 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
19:56:29.572 - PreScanner.Post_InitRender [ReceiveTraffic]
19:56:29.758 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
19:56:29.758 - CalculBufferingSize prov=00000000267F2474 marker=1 request=1
19:56:29.759 - CalculBuffering 1000ms br=2000kb to 250 kbytes. By type
19:56:29.760 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
19:56:29.760 - Prereader::ReaderCursor.. OK
19:56:29.761 - ReaderCursor::SetPosition 0 (w=1866652)
19:56:29.762 - Prereader.StartPlayback Pull buffering=256000 recv=0000000000000000 [EnablePullModeAndStartPlayback]
19:56:29.763 - Prereader.StartPlayback after lock
19:56:29.763 - Buffering/prereader size 250/3906 kbytes
19:56:29.764 - ------sGetVideoParams
19:56:29.765 - ChannelGraph5.CreateInterfacesAndRenderGraph
19:56:29.765 - * s:100 q:100 tr=1907636 (0) Preparing
19:56:29.788 - subsm.StartChannel demux=ProgDemux tr=TS
19:56:29.789 - subsm.RecreateSubtitlesParsers 00000000268B3230 ts=1 subindex=-1
19:56:29.789 - subsm.Set Teletext parser 0
19:56:29.790 - subsm.RecreateSubtitlesParsers end
19:56:29.791 - subs: OnSetChannel
19:56:29.791 - CreateCustomGraph
19:56:29.792 - VideoType:H.264/AVC
19:56:29.792 - Video/4.H264 : MPEG2_VIDEO s={0,840,0,0}, t={0,840,0,0}, bmp=1920x1088, r=30/17, br=0,frametime=40ms, IF=0x0, CF=0x0)
19:56:29.803 - Add video codec 212690fb-83e5-4526-8fd7-74478b7939cd - OK
19:56:29.804 - CChannelGraph5::CreateRender 10
19:56:29.804 - VR: EVR Custom
19:56:29.805 - VR: create new render
19:56:30.000 - VR: Add video renderer Video Renderer - OK
19:56:30.001 - CreateAudioPartOfGraph
19:56:30.002 - AudioType:AAC/ADTS
19:56:30.003 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 44100 16bit formatTag= 0x1600)
19:56:30.008 - Add audio codec e1f1a0b8-beee-490d-ba7c-066c40b5e2b9 - OK
19:56:30.025 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK
19:56:30.026 - AP: created
19:56:30.028 - Added audio processor
19:56:30.034 - Connect codec to AP - OK
19:56:30.043 - Add and connect audio renderer - OK
19:56:30.044 - Graph::AfterRender
19:56:30.044 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
19:56:30.045 - AV:UpdateAudioParamsAfterActive
19:56:30.046 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
19:56:30.046 - Graph::SetVolume 100% 0db
19:56:30.048 - Graph::SetAudioChannelMask
19:56:30.048 - AudioProcessor::SetAudioChannelsMask
19:56:30.049 - AudioProcessor::Equalizer_SetBands
19:56:30.050 - Graph::Run
19:56:30.557 - Graph::Run 1
19:56:30.557 - Graph::SetPictureParams
19:56:30.558 - Graph::SetVideoRect {24 16 1896 1076}
19:56:30.559 - Graph::SetVideoWindowRect {0 15 493 294}
19:56:30.559 - AfterRenderInit
19:56:30.561 - ARI
19:56:30.562 - CChannelGraph5::HideSubtitles
19:56:30.577 - * s:100 q:100 tr=5626840 (0) Playing
19:56:30.609 - 
19:56:30.611 - ########################### Mark of finish channel changing. (1.888ms) #############
19:56:30.612 - 
19:56:30.995 - 
19:56:30.996 - ########################### First video frame. (2.278ms) #############
19:56:30.997 - 
19:56:31.008 - changed ratio to 1920/1080
19:56:31.009 - Graph::SetVideoRect {24 16 1896 1076}
19:56:31.010 - Graph::SetVideoWindowRect {0 17 493 292}
19:56:31.318 - * s:100 q:100 tr=4746812 (0) Playing
19:56:32.042 - * s:100 q:100 tr=4663152 (0) Playing
19:56:33.215 - * s:100 q:100 tr=1355104 (0) Playing
19:56:33.354 - OSDManager::Window_Show
19:56:33.357 - OSDManager::Window_Delete
19:56:34.360 - * s:100 q:100 tr=261884 (0) Playing
19:56:35.373 - * s:100 q:100 tr=523768 (0) Playing
19:56:36.387 - * s:100 q:100 tr=261884 (0) Playing
19:56:37.401 - * s:100 q:100 tr=523768 (0) Playing
19:56:38.415 - * s:100 q:100 tr=523768 (0) Playing
19:56:39.429 - * s:100 q:100 tr=261884 (0) Playing
19:56:40.443 - * s:100 q:100 tr=538056 (0) Playing
19:56:41.457 - * s:100 q:100 tr=262072 (0) Playing
19:56:42.471 - * s:100 q:100 tr=523768 (0) Playing
19:56:43.486 - * s:100 q:100 tr=523768 (0) Playing
19:56:44.500 - * s:100 q:100 tr=523768 (0) Playing
19:56:45.514 - * s:100 q:100 tr=261884 (0) Playing
19:56:46.237 - 
19:56:46.238 - Stop engine
19:56:46.238 - DevicesManager::Stop
19:56:46.239 - ChannelGraph5::StopChannel 
19:56:46.239 - PreScanner.Stop
19:56:46.240 - GraphState: Undef by PreScanner.Stop
19:56:46.241 - PlayTimePmtParser::StopParser
19:56:46.241 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
19:56:46.242 - Prereader::ReaderCursor.. OK
19:56:46.243 - ReaderCursor::SetPosition 0 (w=23699468)
19:56:46.243 - Prereader.StartPlayback Disable buffering=0 recv=0000000000000000 [Engine5ChannelBase.StopChannel]
19:56:46.244 - Prereader.StartPlayback after lock
19:56:46.244 - subsm.StopChannel
19:56:46.245 - Graph::Stop
19:56:46.317 - Before Stop ...19:56:46.319 - OnGraphStop ...19:56:46.323 - VR: Disconnect
19:56:46.324 - Graph::ReleaseAllFilters
19:56:46.325 - release: Prog Audio renderer - RR - OK.
19:56:46.343 - release: Video Renderer - RR - OK.
19:56:46.357 - release: Microsoft DTV-DVD Video Decoder - RR - OK.
19:56:46.360 - release: Audio Processor - RR - OK.
19:56:46.361 - release: Microsoft DTV-DVD Audio Decoder - RR - OK.
19:56:46.362 - FilterGraph: 1
19:56:46.365 - ChannelGraph5.~CChannelGraph5
19:56:46.366 - PreScanner.Stop
19:56:46.366 - GraphState: Undef by PreScanner.Stop
19:56:46.367 - PlayTimePmtParser::StopParser
19:56:46.367 - subsm.StopChannel
19:56:46.368 - Graph::ReleaseAllFilters
19:56:46.373 - ChannelGraph5.~CChannelGraph5 finish
19:56:46.423 - TransponderManager::CloseChannel
19:56:46.423 - TsInputTrafficProcessor.RemoveChannel 1
19:56:46.423 - ~TransponderChannelSource
19:56:46.439 - TimeShift.DestroyReadingCursor
19:56:46.455 - Api2BaseModule.UpdateAllOpenedChannels 0
19:56:46.455 - Destroy TSTS filter pid=0
19:56:46.455 - PlayTimePmtParser::StopParser
19:56:46.455 - Destroy TSTS filter pid=4096
19:56:46.455 - DevicesManager::DestroyTransponderManager
19:56:46.455 - Api2Device::SetChannel - None
19:56:46.501 - Api2Device::SetChannel result OK
19:56:46.501 - N -> 0
19:56:46.501 - ~TransponderManager
19:56:46.501 - N -> 0
19:56:46.501 - TimeShift.~TimeShift
19:56:46.501 - HugeMemoryBlocksManager::Free
19:56:46.501 - ModuleList::Free
19:56:46.501 - DevicesManager::Free devices
19:56:46.501 - SDP:Destroy netclient.0 own=0000000000000000
19:56:46.501 - SDP:after destroy device
19:56:46.501 - DevicesManager::Free RC
19:56:46.501 - Engine stopped
19:56:46.704 - HugeMemoryBlocksManager::FreeAll
