﻿17:06:03.480 - Start logging...
17:06:03.589 - ExceptionFilter::Init. restart=0
17:06:04.308 - DevicesManager::EnableCISupport
17:06:04.308 - CAVManager::SetSettings
17:06:04.324 - DevicesManager::DestroyAllTransponderManager
17:06:04.371 - SetDefaultNullCodecs
17:06:04.449 - SetDefaultNullCodecs
17:06:04.496 - DevicesManager::Start
17:06:04.496 - AVManager::Init
17:06:04.512 - RemoveAllCreateBlank needBlank1
17:06:04.543 - add graph 00000258F5C530A0 101
17:06:04.559 - [101]OnChangeCurrentGraph2 -RemoveAllBlank
17:06:04.621 - VR: GUI
17:06:04.652 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
17:06:04.730 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
17:06:04.730 - AV:UpdateAudioParamsAfterActive
17:06:04.746 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
17:06:04.762 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
17:06:06.058 - remove graph idx=0 count=1
17:06:06.058 - DevicesManager::StartDevices...
17:06:06.074 - device netclient.0 17:06:06.090 - dev: Created  netclient.0 00000258F5C16E40
OK
17:06:06.121 - Api2BaseModule.GetAdditionInfo
17:06:13.120 - 
17:06:13.120 - 
17:06:13.136 - ########################### Mark of start channel changing.###########################
17:06:13.152 - 
17:06:13.167 - GraphManager::MainChangeChannel ALBA XXX 1  1 provs
17:06:13.183 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
17:06:13.183 - SetChannelLogic::SetChannel 0
17:06:13.199 - SetChannelLogic::SetNormalChannel
17:06:13.214 - DevicesManager::CreateCloneDevice
17:06:13.214 - DevicesManager::CreateCloneDevice OK - founded in list
17:06:13.230 - TransponderManager
17:06:13.230 - CTransponderManager::InitOnNewDevice 00000258F5C9E118
17:06:13.245 - SetOwner N -> Incoming Stream Cache
17:06:13.245 - TrafficProcessingScheme_CreateForNewEngineTransport 1 ss=0
17:06:13.261 - Normal TsInputTrafficProcessor.
17:06:13.277 - FilterManager::InitOnNewDevice 1
17:06:13.277 - TS router+MarkerFinder -> InputTrafficProcessor
17:06:13.277 - Incoming Stream Cache -> TS router+MarkerFinder
17:06:13.277 - InputTrafficProcessor -> Router to timeshift
17:06:13.277 - InputTrafficProcessor(FM) -> FilterManager
17:06:13.277 - ModuleList::Free
17:06:13.292 - ChannelGraph5.CChannelGraph5
17:06:13.308 - TransponderManager::AddChildChannel
17:06:13.324 - TimeShift.TimeShift
17:06:13.339 - TimeShift.Create 200 mbytes 
17:06:13.355 - ts:One channel
17:06:13.370 - HugeMemoryBlocksManager::GetBlock 200 mbytes OK
17:06:13.370 - TransponderManager::CreateTimeshiftBuffer OK
17:06:13.417 - TimeShift.CreateReadingCursor
17:06:13.417 - TransponderChannelSource.Plugins 00000258FAFD7840 csa 0000000000000000
17:06:13.433 - TsInputTrafficProcessor.AddChannel 0
17:06:13.464 - SetChannelLogic::LookDeviceWithoutChannelsOrCloneAndMakeGraph
17:06:13.464 - add graph 00000258FAFC2FA8 102
17:06:13.495 - ChannelGraph5.SetActiveState 1
17:06:13.511 - TransponderManager::SelectChannel
17:06:13.511 - TsInputTrafficProcessor.SelectChannel 0
17:06:13.511 - Api2BaseModule.UpdateAllOpenedChannels 0
17:06:13.527 - AV:UpdateAudioParamsAfterActive
17:06:13.542 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
17:06:13.558 - GR:UpdateAudioProcessor old=0 new=0
17:06:13.574 - Graph::SetAudioChannelMask
17:06:13.589 - 
17:06:13.605 - TransponderManager::SetTransponder (CH) 0 ALBA XXX 1
17:06:13.620 - *Transport TS
17:06:13.620 - Api2Device::SetChannel http://am01.spr24.net/22444/mpegts?token=4u6VY92quYvYVm
17:06:13.683 - Api2Device::SetChannel result OK
17:06:13.683 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
17:06:13.699 - TsInputTrafficProcessor.OpenTransponder 1
17:06:13.714 - FilterManager::OnSetTransponder SetChannel
17:06:13.730 - TimeShift.Reset
17:06:13.745 - TimeShift.Cursor reset
17:06:13.730 - Api2BaseModule.OnTunerStateChanged Connecting
17:06:13.777 - Api2BaseModule.OnTunerStateChanged  -3
17:06:13.761 - ReaderCursor::Reset.. OK
17:06:13.808 - Prereader.Reset ...-OK
17:06:13.808 - Create EPGparser on SetChannel
17:06:13.808 - DvbEpgParser::SetChannel ID=4fd40002.c12d7c1c4351735a.1
17:06:13.855 - DvbEpgParser::mode normal pos=0
17:06:13.855 - ModuleList::ChangeChannel 0
17:06:13.855 - [102]ChannelGraph5::StartChannel ALBA XXX 1
17:06:13.870 - 
17:06:13.870 - [102]       #################### Start stream. (0.750ms) #######################
17:06:13.870 - 
17:06:13.949 - Api2BaseModule.OnTunerStateChanged Preparing
17:06:13.949 - Api2BaseModule.OnTunerStateChanged  -4
17:06:13.980 - Api2BaseModule.OnTunerStateChanged Playing
17:06:13.980 - Api2BaseModule.OnTunerStateChanged  -4
17:06:13.995 - TimeShift.Cursor SetChannel pidmask=0000000000000000 first=1
17:06:14.027 - TimeShift.Cursor SetChannel::v 0 (0)
17:06:14.042 - ReaderCursor::SetChannel.. OK
17:06:14.074 - ReaderCursor::SetPosition 0 (w=0)
17:06:14.074 - Prereader.SetChannel..
17:06:14.089 - Prereader.SetChannel unmask 1
17:06:14.105 - Plugin::SetChannel 1
17:06:14.120 - TransponderManager::SelectChannel
17:06:14.136 - TsInputTrafficProcessor.SelectChannel 1
17:06:14.152 - Api2BaseModule.UpdateAllOpenedChannels 1
17:06:14.152 - TsInputTrafficProcessor.UpdateChannel 1
17:06:14.152 - GraphState: Undef by StartChannelIsReady
17:06:14.152 - PreScanner.StartChannelIsReady net=1 parseall=1
17:06:14.167 - VideoMediaTypeDetection: h.264
17:06:14.183 - SetMarkerAudioLngStream Gen New stream
17:06:14.199 - SimpleTsDemux::Init apid=221, vpid=211
17:06:14.214 - GraphState: RequestPATScan by StartChannelIsReady TS
17:06:14.230 - Api2BaseModule.Filters_EnabledFullTS 1
17:06:14.230 - PlayTimePATParser.OpenParser 1
17:06:14.245 - Open TSTS filter pid=0 data=0
17:06:14.277 - TSTS cur size=0
17:06:14.292 - ChannelGraph5.CreateGraphForOsdOnly
17:06:14.308 - CChannelGraph5::CreateRender 1
17:06:14.323 - Graph::SetVideoRect {8 8 712 568}
17:06:14.339 - [102]OnChangeCurrentGraph2 -endOfSetChannel
17:06:14.339 - ChannelGraph5.SetActiveState 1
17:06:14.448 - Graph::SetVideoWindowRect {33 0 166 100}
17:06:14.448 - Graph::UpdateRenderMode
17:06:14.480 - GraphManager::MultiChannelRendering
17:06:14.480 - ChannelGraph5.SetActiveState 1
17:06:14.511 - Graph::SetVideoWindowRect {235 0 1344 832}
17:06:14.573 - Graph::SetVideoWindowRect {2 0 388 290}
17:06:14.652 - Graph::SetVideoWindowRect {199 0 1359 870}
17:06:14.808 - Graph::SetVideoWindowRect {235 0 1344 832}
17:06:14.980 - OK. 102
17:06:15.167 - Api2BaseModule.OnTunerStateChanged Playing
17:06:15.167 - Api2BaseModule.OnTunerStateChanged  -4
17:06:15.214 - Api2BaseModule.OnTunerStateChanged Connecting
17:06:15.214 - Api2BaseModule.OnTunerStateChanged  -3
17:06:15.386 - * s:0 q:0 tr=0 (0) Connecting
17:06:15.464 - Api2BaseModule.OnTunerStateChanged Preparing
17:06:15.480 - Api2BaseModule.OnTunerStateChanged  -4
17:06:15.542 - Api2BaseModule.OnTunerStateChanged Playing
17:06:15.542 - Api2BaseModule.OnTunerStateChanged  -4
17:06:15.636 - TransportMarker: TS
17:06:15.636 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
17:06:15.667 - --SwitchEngineTransport TS > TS
17:06:15.683 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
17:06:15.698 - PreScanner.OnTransportMarker TS
17:06:15.714 - --SwitchEngineTransport end
17:06:16.370 - * s:100 q:100 tr=376 (0) Preparing
17:06:17.339 - * s:0 q:0 tr=0 (0) Preparing
17:06:18.339 - * s:100 q:100 tr=188 (0) Preparing
17:06:18.354 - 
17:06:18.370 -        #################### First traffic. (5.250ms) #######################
17:06:18.386 - 
17:06:18.401 - PlayTimePATParser.EndTask
17:06:18.479 - PreScanner.OnAfterScanPat count=2 {1;4095}
17:06:18.479 - Api2BaseModule.Filters_EnabledFullTS 0
17:06:18.495 - GraphState: RequestPMTScan by OnAfterScanPat
17:06:18.495 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=1
17:06:18.511 - Open TSTS filter pid=4095 data=2
17:06:18.526 - TSTS cur size=205296
17:06:18.542 - TSTS quick finish
17:06:18.558 - PreScanner.OnAfterScanPmt pmt=4095
17:06:18.573 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
17:06:18.589 - PlayTimePmtParser::StopParser
17:06:18.886 - TimeShift.Cursor SetChannel pidmask=0000000000000000 first=0
17:06:18.886 - TimeShift.Cursor SetChannel::v 205296 (205296)
17:06:18.901 - Prereader.SetChannel unmask 1
17:06:18.917 - Plugin::SetChannel 1
17:06:18.933 - TransponderManager::SelectChannel
17:06:18.948 - TsInputTrafficProcessor.SelectChannel 1
17:06:18.948 - Api2BaseModule.UpdateAllOpenedChannels 1
17:06:18.964 - TsInputTrafficProcessor.UpdateChannel 1
17:06:18.979 - PreScanner.StartChannelIsReady net=1 parseall=0
17:06:18.995 - LngDefaultSelector.try select audio pid=221 type=1 lng=6778469-eng(ang,ang,rus) l=99
17:06:19.011 - ChannelGraph5::AfterDetectChannelParams
17:06:19.026 - VideoMediaTypeDetection: h.264
17:06:19.042 - SimpleTsDemux::Init apid=221, vpid=211
17:06:19.042 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
17:06:19.058 - demux: ProgDemux
17:06:19.112 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
17:06:19.113 - Prereader::ReaderCursor.. OK
17:06:19.140 - ReaderCursor::SetPosition 0 (w=205296)
17:06:19.154 - Prereader.StartPlayback Push buffering=0 recv=00000258FAFC3F60 [StartChannelHelperBase(sl)]
17:06:19.155 - Prereader.StartPlayback after lock
17:06:19.156 - PreScanner.StartPmtParserIfNeed
17:06:19.157 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=0
17:06:19.158 - Open TSTS filter pid=4095 data=2
17:06:19.159 - TSTS cur size=205296
17:06:19.164 - AudioParser::First packet 340
17:06:19.173 - VideoParser::First packet 128888 h.264
17:06:19.174 - h264 detected 0 ms
17:06:19.176 - AudioParser::packet 349
17:06:19.177 - AudioParser::AAC detected
17:06:19.179 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
17:06:19.180 - PreScanner.Post_InitRender [ReceiveTraffic]
17:06:19.220 - [102]sm: TvInitRenderer 1
17:06:19.220 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
17:06:19.235 - CalculBufferingSize prov=00000258F5C9F594 marker=1 request=1
17:06:19.249 - CalculBuffering 3800ms br=2000kb to 950 kbytes. By type
17:06:19.264 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
17:06:19.277 - Prereader::ReaderCursor.. OK
17:06:19.306 - ReaderCursor::SetPosition 0 (w=467932)
17:06:19.320 - Prereader.StartPlayback Pull buffering=972800 recv=0000000000000000 [EnablePullModeAndStartPlayback]
17:06:19.334 - Prereader.StartPlayback after lock
17:06:19.348 - Buffering/prereader size 950/3906 kbytes
17:06:19.361 - ------sGetVideoParams
17:06:19.375 - ChannelGraph5.CreateInterfacesAndRenderGraph
17:06:19.389 - subsm.StartChannel demux=ProgDemux tr=TS
17:06:19.403 - subsm.RecreateSubtitlesParsers 00000258FF645590 ts=1 subindex=-1
17:06:19.417 - subsm.Set Teletext parser 0
17:06:19.431 - subsm.RecreateSubtitlesParsers end
17:06:19.445 - subs: OnSetChannel
17:06:19.459 - CreateCustomGraph
17:06:19.473 - VideoType:H.264/AVC ffmpeg=0
17:06:19.487 - Video/4.H264 : MPEG2_VIDEO s={0,0,1920,1080}, t={0,0,1920,1080}, bmp=1920x1088, r=30/17, br=0,frametime=41ms, IF=0x0, CF=0x0)
17:06:19.501 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f
17:06:19.550 - OK
17:06:19.550 - CChannelGraph5::CreateRender 1
17:06:19.574 - VR: VMR7
17:06:19.589 - VR: create new render
17:06:19.760 - VR: Add video renderer Video Renderer - OK
17:06:19.761 - CreateAudioPartOfGraph
17:06:19.778 - AudioType:AAC/ADTS 
17:06:19.793 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 48000 16bit formatTag= 0x1600)
17:06:19.808 - Add audio codec e1f1a0b8-beee-490d-ba7c-066c40b5e2b9 - Create filter error (Audio decoder) - 0x8007007e!
17:06:19.840 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Первичный звуковой драйвер OK (normal)
17:06:19.841 - Added audio renderer
17:06:19.972 - Try to found any codec before renderer... OK.
17:06:19.972 - Graph::AfterRender
17:06:19.989 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
17:06:20.005 - AV:UpdateAudioParamsAfterActive
17:06:20.023 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
17:06:20.037 - GR:UpdateAudioProcessor old=0 new=0
17:06:20.053 - Graph::SetVolume 67% -722db
17:06:20.072 - Graph::SetAudioChannelMask
17:06:20.086 - Graph::Run
17:06:20.247 - Graph::Run 1
17:06:20.248 - Graph::SetPictureParams
17:06:20.262 - Graph::SetVideoRect {24 16 1896 1068}
17:06:20.278 - Graph::SetVideoWindowRect {56 0 1524 832}
17:06:20.520 - CChannelGraph5::HideSubtitles
17:06:20.521 - Graph::OnVideoWindowPositionChanged
17:06:20.582 - * s:73 q:100 tr=726244 (0) Buffering
17:06:21.365 - * s:100 q:100 tr=289332 (0) Playing
17:06:21.365 - OnBuffering.OnTunerStateChanged  7
17:06:21.390 - OnBuffering.OnTunerStateChanged  0
17:06:21.406 - * s:7 q:100 tr=72944 (0) Buffering
17:06:21.498 - 
17:06:21.603 - [0]########################### Mark of finish channel changing. (8.484ms) #############
17:06:21.604 - 
17:06:22.367 - * s:45 q:100 tr=376376 (0) Buffering
17:06:23.401 - * s:69 q:100 tr=237256 (0) Buffering
17:06:24.283 - * s:100 q:100 tr=375248 (0) Playing
17:06:24.298 - OnBuffering.OnTunerStateChanged  7
17:06:24.469 - OnBuffering.OnTunerStateChanged  0
17:06:25.402 - * s:26 q:100 tr=262072 (0) Buffering
17:06:26.417 - * s:42 q:100 tr=159424 (0) Buffering
17:06:27.422 - * s:67 q:100 tr=245904 (0) Buffering
17:06:28.448 - * s:100 q:100 tr=543884 (0) Playing
17:06:28.608 - OnBuffering.OnTunerStateChanged  7
17:06:29.234 - * s:100 q:100 tr=13348 (0) Playing
17:06:30.401 - * s:100 q:100 tr=508540 (0) Playing
17:06:31.447 - * s:100 q:100 tr=241392 (0) Playing
17:06:32.439 - * s:100 q:100 tr=229548 (0) Playing
17:06:36.871 - * s:100 q:100 tr=1657032 (0) Playing
17:06:37.419 - * s:100 q:100 tr=159424 (0) Playing
17:06:38.420 - * s:100 q:100 tr=443492 (0) Playing
17:06:39.424 - * s:100 q:100 tr=271096 (0) Playing
17:06:40.420 - * s:100 q:100 tr=624348 (0) Playing
17:06:41.427 - * s:100 q:100 tr=159424 (0) Playing
17:06:42.418 - * s:100 q:100 tr=908980 (0) Playing
17:06:44.826 - remove graph idx=0 count=1
17:06:44.850 - add graph 00000258FAD3D710 103
17:06:44.880 - ChannelGraph5.~CChannelGraph5
17:06:44.881 - Graph::Stop
17:06:58.300 - Before Stop ...17:06:58.324 - OnGraphStop ...17:06:58.421 - PreScanner.Stop
17:06:58.422 - GraphState: Undef by PreScanner.Stop
17:06:58.437 - PlayTimePmtParser::StopParser
17:06:58.451 - subsm.StopChannel
17:06:58.465 - VR: Disconnect
17:06:58.496 - Graph::ReleaseAllFilters
17:06:58.496 - release: Prog Audio renderer - RR - OK.
17:06:58.526 - release: Video Renderer - RR - OK.
17:06:58.557 - release: Video decoder  - RR - OK.
17:06:58.601 - release: LAV Audio Decoder - RR - OK.
17:06:58.640 - FilterGraph: 1
17:06:58.684 - ChannelGraph5.~CChannelGraph5 finish
17:06:58.684 - TransponderManager::CloseChannel
17:06:58.698 - TsInputTrafficProcessor.RemoveChannel 1
17:06:58.712 - ~TransponderChannelSource
17:06:58.833 - TimeShift.DestroyReadingCursor
17:06:58.833 - Prereader.Exit17:06:58.853 - Api2BaseModule.UpdateAllOpenedChannels 0
17:06:58.862 - Destroy TSTS filter pid=0
17:06:58.867 - PlayTimePmtParser::StopParser
17:06:58.867 - Destroy TSTS filter pid=4095
17:06:58.893 - DevicesManager::DestroyTransponderManager
17:06:58.893 - Api2Device::SetChannel - None
17:06:59.062 - Api2Device::SetChannel result OK
17:06:59.062 - SetOwner N -> 0
17:06:59.084 - SetOwner SetTransponder null
17:06:59.100 - ~TransponderManager
17:06:59.116 - SetOwner N -> 0
17:06:59.116 - SetOwner SetTransponder null
17:06:59.162 - TimeShift.~TimeShift
17:06:59.162 - HugeMemoryBlocksManager::Free
17:06:59.185 - ModuleList::Free
17:06:59.200 - [103]OnChangeCurrentGraph2 -CloseGraph
17:06:59.263 - VR: GUI
17:06:59.285 - GraphManager::MultiChannelRendering
17:06:59.463 - OSDManager::Window_Add
17:06:59.485 - OSDManager::Window_Show
17:06:59.532 - * s:100 q:100 tr=16084340 (0) Playing
17:06:59.564 - OSDManager::Window_Show
17:06:59.586 - OSDManager::Window_Show
17:06:59.847 - remove graph idx=0 count=1
17:06:59.858 - add graph 00000258FAD3D7D0 104
17:06:59.880 - [104]OnChangeCurrentGraph2 -CloseGraph
17:06:59.960 - VR: GUI
17:07:00.061 - GraphManager::MultiChannelRendering
17:07:00.344 - * s:0 q:0 tr=0 (0) Playing
17:07:01.331 - * s:0 q:0 tr=0 (0) Playing
17:07:02.334 - * s:0 q:0 tr=0 (0) Playing
17:07:03.337 - * s:0 q:0 tr=0 (0) Playing
17:07:04.356 - * s:0 q:0 tr=0 (0) Playing
17:07:05.375 - * s:0 q:0 tr=0 (0) Playing
17:07:52.678 - DevicesManager::EnableCISupport
17:07:52.678 - Api2Device::CI3_EnableCISupport
17:07:52.709 - CAVManager::SetSettings
17:07:52.724 - Api2BaseModule.SetDialogSettings
17:07:52.762 - SetDefaultNullCodecs
17:07:52.825 - SetDefaultNullCodecs
17:07:53.041 - DevicesManager::EnableCISupport
17:07:53.041 - Api2Device::CI3_EnableCISupport
17:07:53.063 - CAVManager::SetSettings
17:07:53.063 - Api2BaseModule.SetDialogSettings
17:07:53.110 - SetDefaultNullCodecs
17:07:53.179 - SetDefaultNullCodecs
17:07:55.454 - 
17:07:55.454 - Stop engine
17:07:55.474 - DevicesManager::Stop
17:07:55.492 - remove graph idx=0 count=1
17:07:55.513 - DevicesManager::Free devices
17:07:55.525 - SDP:Destroy netclient.0 own=0000000000000000
17:07:55.575 - SDP:after destroy device
17:07:55.575 - DevicesManager::Free RC
17:07:55.595 - Engine stopped
17:07:55.656 - 
17:07:55.656 - Stop engine
17:07:55.676 - DevicesManager::Stop
17:07:55.696 - DevicesManager::Free devices
17:07:55.705 - Engine stopped
17:07:55.931 - HugeMemoryBlocksManager::FreeAll
