﻿15:08:50.685 - Start logging...
15:08:50.685 - DevicesManager::Start
15:08:50.685 - AVManager::Init
15:08:50.715 - SetDefaultNullCodecs
15:08:50.735 - IsWin8WithoutMpeg2Codecs 0
15:08:50.735 - IsWin8WithoutMpeg2Codecs 1
15:08:50.735 - IsWin8WithoutMpeg2Codecs 2
15:08:50.745 - add graph 0E93C750 101
15:08:50.745 - DevicesManager::EnableCISupport
15:08:50.745 - CAVManager::SetSettings
15:08:50.745 - remove graph idx=0 count=1
15:08:50.745 - DevicesManager::DestroyAllTransponderManager
15:08:50.745 - SetDefaultNullCodecs
15:08:50.755 - IsWin8WithoutMpeg2Codecs 0
15:08:50.755 - IsWin8WithoutMpeg2Codecs 1
15:08:50.765 - IsWin8WithoutMpeg2Codecs 2
15:08:50.819 - SetDefaultNullCodecs
15:08:50.829 - IsWin8WithoutMpeg2Codecs 0
15:08:50.829 - IsWin8WithoutMpeg2Codecs 1
15:08:50.829 - IsWin8WithoutMpeg2Codecs 2
15:08:50.865 - DevicesManager::StartDevices...
15:08:50.865 - device bda.2002 15:08:51.529 - dev: Created  bda.7d2 06007010
OK
15:08:51.529 - device bda.2003 15:08:52.165 - dev: Created  bda.7d3 060070C8
OK
15:08:52.166 - device netclient.0 15:08:52.168 - dev: Created  netclient.0 0EAB7170
OK
15:08:52.170 - Api2BaseModule.GetAdditionInfo
15:08:52.170 - Api2BaseModule.GetAdditionInfo
15:08:52.170 - Api2BaseModule.GetAdditionInfo
15:08:52.175 - AV:UpdateAudioParamsAfterActive
15:08:52.436 - 
15:08:52.436 - 
15:08:52.436 - ########################### Mark of start channel changing.########################### Delyed
15:08:52.436 - 
15:08:52.436 - GraphManager::MainChangeChannel Ani  1 provs
15:08:52.436 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
15:08:52.436 - SetChannelLogic::SetChannel 0
15:08:52.436 - SetChannelLogic::SetNormalChannel
15:08:52.436 - DevicesManager::CreateCloneDevice
15:08:52.436 - DevicesManager::CreateCloneDevice OK - founded in list
15:08:52.437 - TransponderManager
15:08:52.437 - CTransponderManager::InitOnNewDevice 0EABDEDC
15:08:52.437 - SetOwner N -> Incoming Stream Cache
15:08:52.437 - TrafficProcessingScheme_CreateForNewEngineTransport 1 ss=0
15:08:52.437 - Normal TsInputTrafficProcessor.
15:08:52.438 - FilterManager::InitOnNewDevice 1
15:08:52.438 - TS router+MarkerFinder -> InputTrafficProcessor
15:08:52.438 - Incoming Stream Cache -> TS router+MarkerFinder
15:08:52.438 - InputTrafficProcessor -> Router to timeshift
15:08:52.438 - InputTrafficProcessor(FM) -> FilterManager
15:08:52.438 - ModuleList::Free
15:08:52.439 - ChannelGraph5.CChannelGraph5
15:08:52.439 - TransponderManager::AddChildChannel
15:08:52.439 - TimeShift.TimeShift
15:08:52.439 - TimeShift.Create 40 mbytes 
15:08:52.439 - ts:Disabled
15:08:52.439 - HugeMemoryBlocksManager::GetBlock 40 mbytes OK
15:08:52.439 - TransponderManager::CreateTimeshiftBuffer OK
15:08:52.446 - TimeShift.CreateReadingCursor
15:08:52.446 - TransponderChannelSource.Plugins 0EB43168 csa 00000000
15:08:52.446 - TsInputTrafficProcessor.AddChannel 0
15:08:52.446 - SetChannelLogic::LookDeviceWithoutChannelsOrCloneAndMakeGraph
15:08:52.446 - add graph 16052824 102
15:08:52.446 - ChannelGraph5.SetActiveState 1
15:08:52.447 - TransponderManager::SelectChannel
15:08:52.447 - TsInputTrafficProcessor.SelectChannel 0
15:08:52.447 - Api2BaseModule.UpdateAllOpenedChannels 0
15:08:52.447 - AV:UpdateAudioParamsAfterActive
15:08:52.447 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
15:08:52.447 - Graph::SetAudioChannelMask
15:08:52.447 - 
15:08:52.447 - TransponderManager::SetTransponder (CH) 0 Ani
15:08:52.447 - *Transport TS
15:08:52.447 - Api2Device::SetChannel CHANNEL_DELAYED_URL
15:08:52.448 - Api2Device::SetChannel result OK
15:08:52.448 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
15:08:52.449 - TsInputTrafficProcessor.OpenTransponder 1
15:08:52.449 - FilterManager::OnSetTransponder SetChannel
15:08:52.449 - TimeShift.Reset
15:08:52.449 - TimeShift.Cursor reset
15:08:52.449 - ReaderCursor::Reset.. OK
15:08:52.449 - Prereader.Reset ...-OK
15:08:52.449 - ModuleList::ChangeChannel 0
15:08:52.449 - CChannelGraph5::StartChannel Ani
15:08:52.450 - 
15:08:52.450 -        #################### Start stream. (0.016ms) #######################
15:08:52.450 - 
15:08:52.449 - Api2BaseModule.OnTunerStateChanged Preparing
15:08:52.450 - Api2BaseModule.OnTunerStateChanged 0
15:08:52.450 - Api2BaseModule.OnTunerStateChanged 1
15:08:52.450 - Api2BaseModule.OnTunerStateChanged 2
15:08:52.450 - Api2BaseModule.OnTunerStateChanged 3
15:08:52.451 - TimeShift.Cursor SetChannel pidmask=1605D184 first=1
15:08:52.451 - TimeShift.Cursor SetChannel::v 0 (0)
15:08:52.451 - ReaderCursor::SetChannel.. OK
15:08:52.451 - ReaderCursor::SetPosition 0 (w=0)
15:08:52.451 - Prereader.SetChannel..
15:08:52.451 - PMT convertor
15:08:52.452 - Prereader.SetChannel mask. SimplePatPmtConvertor
15:08:52.452 - PPC.by mask. onlyV1A=0 No change PMT ,0,100,101,110
15:08:52.452 - Plugin::SetChannel 1
15:08:52.452 - TransponderManager::SelectChannel
15:08:52.452 - TsInputTrafficProcessor.SelectChannel 1
15:08:52.452 - Api2BaseModule.UpdateAllOpenedChannels 1
15:08:52.452 - TsInputTrafficProcessor.UpdateChannel 1
15:08:52.452 - GraphState: Undef by StartChannelIsReady
15:08:52.452 - PreScanner.StartChannelIsReady net=1 parseall=1
15:08:52.452 - VideoMediaTypeDetection: h.264
15:08:52.452 - SetMarkerAudioLngStream Gen New stream
15:08:52.453 - SimpleTsDemux::Init apid=110, vpid=101
15:08:52.453 - GraphState: RequestPATScan by StartChannelIsReady TS
15:08:52.453 - Api2BaseModule.Filters_EnabledFullTS 1
15:08:52.453 - PlayTimePATParser.OpenParser 1
15:08:52.453 - Open TSTS filter pid=0 data=0
15:08:52.453 - TSTS cur size=0
15:08:52.453 - ChannelGraph5.CreateGraphForOsdOnly
15:08:52.454 - CChannelGraph5::CreateRender 11
15:08:52.455 - Api2BaseModule.OnTunerStateChanged Playing
15:08:52.455 - Graph::SetVideoRect {0 0 720 576}
15:08:52.455 - Api2BaseModule.OnTunerStateChanged 0
15:08:52.455 - Api2BaseModule.OnTunerStateChanged 1
15:08:52.455 - Api2BaseModule.OnTunerStateChanged 2
15:08:52.455 - ChannelGraph5.SetActiveState 1
15:08:52.455 - Api2BaseModule.OnTunerStateChanged 3
15:08:52.565 - OK. 102
15:08:52.590 - Graph::SetVideoWindowRect {0 0 1930 1090}
15:08:52.590 - Graph::UpdateRenderMode
15:08:52.590 - Set delayed channel after surface
15:08:52.590 - 
15:08:52.590 - 
15:08:52.590 - ########################### Apply url .###########################
15:08:52.590 - 
15:08:52.591 - GraphManager::MainChangeChannel Ani  1 provs
15:08:52.591 - Api2Device::SetChannel http://192.168.1.5:7181/play/aHR0cDovL3phYmF2YS1odGxpdmUuY2RuLm5nZW5peC5uZXQvaGxzL0NIX0FOSS9idzIwMDAwMDAvdmFyaWFudC5tM3U4/
15:08:52.591 - Api2Device::SetChannel result OK
15:08:52.595 - Api2BaseModule.OnTunerStateChanged Connecting
15:08:52.595 - Api2BaseModule.OnTunerStateChanged 0
15:08:52.595 - Api2BaseModule.OnTunerStateChanged 1
15:08:52.595 - Api2BaseModule.OnTunerStateChanged 2
15:08:52.595 - Api2BaseModule.OnTunerStateChanged 3
15:08:52.597 - Api2BaseModule.OnTunerStateChanged Preparing
15:08:52.597 - Api2BaseModule.OnTunerStateChanged 0
15:08:52.597 - Api2BaseModule.OnTunerStateChanged 1
15:08:52.597 - Api2BaseModule.OnTunerStateChanged 2
15:08:52.597 - Api2BaseModule.OnTunerStateChanged 3
15:08:52.781 - Api2BaseModule.OnTunerStateChanged Playing
15:08:52.782 - Api2BaseModule.OnTunerStateChanged 0
15:08:52.782 - Api2BaseModule.OnTunerStateChanged 1
15:08:52.782 - Api2BaseModule.OnTunerStateChanged 2
15:08:52.782 - Api2BaseModule.OnTunerStateChanged 3
15:08:52.935 - TransportMarker: TS
15:08:52.935 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=41943040
15:08:52.936 - PlayTimePATParser.EndTask
15:08:53.000 - --SwitchEngineTransport TS > TS
15:08:53.000 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=41943040
15:08:53.000 - PreScanner.OnTransportMarker TS
15:08:53.000 - --SwitchEngineTransport end
15:08:53.000 - PreScanner.OnAfterScanPat count=2 {1;100}
15:08:53.000 - Api2BaseModule.Filters_EnabledFullTS 0
15:08:53.001 - GraphState: RequestPMTScan by OnAfterScanPat
15:08:53.001 - PlayTimePmtParser::OpenParser SID=1 PMT=100 unknow channel=1
15:08:53.001 - Open TSTS filter pid=100 data=2
15:08:53.001 - TSTS cur size=3220064
15:08:53.001 - TSTS quick finish
15:08:53.007 - PreScanner.OnAfterScanPmt pmt=100
15:08:53.007 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
15:08:53.007 - PlayTimePmtParser::StopParser
15:08:53.009 - TimeShift.Cursor SetChannel pidmask=1605D184 first=0
15:08:53.009 - TimeShift.Cursor SetChannel::v 3220064 (3220064)
15:08:53.009 - Prereader.SetChannel mask. SimplePatPmtConvertor
15:08:53.009 - PPC.by mask. onlyV1A=0 No change PMT ,0,100,101,110
15:08:53.009 - Plugin::SetChannel 1
15:08:53.009 - TransponderManager::SelectChannel
15:08:53.009 - TsInputTrafficProcessor.SelectChannel 1
15:08:53.009 - Api2BaseModule.UpdateAllOpenedChannels 1
15:08:53.009 - TsInputTrafficProcessor.UpdateChannel 1
15:08:53.010 - PreScanner.StartChannelIsReady net=1 parseall=0
15:08:53.010 - LngDefaultSelector.try select audio pid=110 type=1 lng=7566706-rus(deu,deu,rus) l=10
15:08:53.010 - LngDefaultSelector. selected audio pid=110
15:08:53.010 - ChannelGraph5::AfterDetectChannelParams
15:08:53.010 - VideoMediaTypeDetection: h.264
15:08:53.010 - SimpleTsDemux::Init apid=110, vpid=101
15:08:53.010 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
15:08:53.010 - demux: ProgDemux
15:08:53.014 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
15:08:53.014 - Prereader::ReaderCursor.. OK
15:08:53.015 - ReaderCursor::SetPosition 0 (w=13830069571026944)
15:08:53.015 - Prereader.StartPlayback Push buffering=0 recv=160537C0 [StartChannelHelperBase(sl)]
15:08:53.015 - Prereader.StartPlayback after lock
15:08:53.015 - PreScanner.StartPmtParserIfNeed
15:08:53.015 - PlayTimePmtParser::OpenParser SID=1 PMT=100 unknow channel=0
15:08:53.015 - Open TSTS filter pid=100 data=2
15:08:53.015 - TSTS cur size=3220064
15:08:53.017 - VideoParser::First packet 70124 h.264
15:08:53.017 - h264 detected 0 ms
15:08:53.017 - AudioParser::First packet 2739
15:08:53.017 - AudioParser::AAC detected
15:08:53.018 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
15:08:53.018 - PreScanner.Post_InitRender [ReceiveTraffic]
15:08:53.027 - Graph::SetVideoWindowRect {0 0 1 1}
15:08:53.061 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
15:08:53.062 - CalculBufferingSize prov=0EABF31C marker=1 request=1
15:08:53.062 - CalculBuffering 2000ms br=2000kb to 500 kbytes. By type
15:08:53.062 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
15:08:53.062 - Prereader::ReaderCursor.. OK
15:08:53.062 - ReaderCursor::SetPosition 0 (w=13830069571026944)
15:08:53.062 - Prereader.StartPlayback Pull buffering=512000 recv=00000000 [EnablePullModeAndStartPlayback]
15:08:53.062 - Prereader.StartPlayback after lock
15:08:53.062 - Buffer 1000160KB too small for buffering
15:08:53.063 - Buffering/prereader size 500/1000 kbytes
15:08:53.063 - ------sGetVideoParams
15:08:53.063 - ChannelGraph5.CreateInterfacesAndRenderGraph
15:08:53.063 - subsm.StartChannel demux=ProgDemux tr=TS
15:08:53.063 - subsm.RecreateSubtitlesParsers 0EB37110 ts=1 subindex=-1
15:08:53.063 - subsm.Set Teletext parser 0
15:08:53.063 - subsm.RecreateSubtitlesParsers end
15:08:53.063 - * s:100 q:100 tr=3237172 (4512) Preparing
15:08:53.064 - subs: OnSetChannel
15:08:53.064 - CreateCustomGraph
15:08:53.064 - VideoType:H.264/AVC
15:08:53.064 - Video/4.H264 : MPEG2_VIDEO s={0,180,0,0}, t={0,180,0,0}, bmp=720x544, r=45/34, br=0,frametime=40ms, IF=0x0, CF=0x0)
15:08:53.107 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f - OK
15:08:53.107 - CChannelGraph5::CreateRender 11
15:08:53.107 - VR: madVR
15:08:53.107 - VR: create new render
15:08:53.167 - VR: Add video renderer Video Renderer - OK
15:08:53.167 - CreateAudioPartOfGraph
15:08:53.167 - AudioType:AAC/ADTS
15:08:53.167 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 48000 16bit formatTag= 0x1600)
15:08:53.179 - Add audio codec e8e73b6b-4cb3-44a4-be99-4f7bcb96e491 - OK
15:08:53.244 - IMyGraphBuilder::CreateAudioRenderFilter::ReClock Audio Renderer OK (normal)
15:08:53.245 - AP: created
15:08:53.246 - Added audio processor
15:08:53.246 - Connect codec to AP - OK
15:08:53.255 - Add and connect audio renderer - OK
15:08:53.255 - Graph::AfterRender
15:08:53.262 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
15:08:53.262 - AV:UpdateAudioParamsAfterActive
15:08:53.262 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
15:08:53.262 - Graph::SetVolume 100% 0db
15:08:53.262 - Graph::SetAudioChannelMask
15:08:53.262 - AudioProcessor::SetAudioChannelsMask
15:08:53.262 - AudioProcessor::Equalizer_SetBands
15:08:53.262 - Graph::Run
15:08:53.277 - Graph::Run 1
15:08:53.277 - Graph::SetPictureParams
15:08:53.277 - Graph::SetVideoRect {0 0 720 540}
15:08:53.277 - Graph::SetVideoWindowRect {0 0 1 1}
15:08:53.281 - Graph::SetVideoWindowRect {0 0 1473 1113}
15:08:53.296 - CChannelGraph5::HideSubtitles
15:08:54.202 - * s:100 q:100 tr=1673576 (2632) Playing
15:08:55.215 - * s:100 q:100 tr=0 (0) Playing
15:08:56.215 - * s:100 q:100 tr=0 (0) Playing
15:08:57.215 - * s:100 q:100 tr=0 (0) Playing
15:08:58.217 - * s:100 q:100 tr=0 (0) Playing
15:08:59.218 - * s:0 q:0 tr=0 (0) Playing
15:09:00.230 - * s:100 q:100 tr=1780360 (7144) Playing
15:09:01.230 - * s:100 q:100 tr=0 (0) Playing
15:09:02.231 - * s:100 q:100 tr=0 (0) Playing
15:09:03.246 - * s:100 q:100 tr=0 (0) Playing
15:09:04.248 - * s:100 q:100 tr=0 (0) Playing
15:09:05.262 - * s:0 q:0 tr=0 (0) Playing
15:09:06.262 - * s:0 q:0 tr=0 (0) Playing
15:09:07.263 - * s:0 q:0 tr=0 (0) Playing
15:09:08.264 - * s:100 q:100 tr=1486140 (0) Playing
15:09:09.264 - * s:100 q:100 tr=0 (0) Playing
15:09:10.278 - * s:100 q:100 tr=0 (0) Playing
15:09:11.278 - * s:100 q:100 tr=0 (0) Playing
15:09:12.278 - * s:100 q:100 tr=0 (0) Playing
15:09:13.279 - * s:0 q:0 tr=0 (0) Playing
15:09:14.293 - * s:100 q:100 tr=1482568 (4136) Playing
15:09:15.294 - * s:100 q:100 tr=12220 (0) Playing
15:09:16.294 - * s:100 q:100 tr=0 (0) Playing
15:09:17.294 - * s:100 q:100 tr=0 (0) Playing
15:09:18.294 - * s:100 q:100 tr=0 (0) Playing
15:09:19.294 - * s:100 q:100 tr=0 (0) Playing
15:09:20.295 - * s:0 q:0 tr=0 (0) Playing
15:09:21.309 - * s:0 q:0 tr=0 (0) Playing
15:09:22.309 - * s:0 q:0 tr=0 (0) Playing
15:09:23.324 - * s:0 q:0 tr=0 (0) Playing
15:09:24.325 - * s:0 q:0 tr=0 (0) Buffering
15:09:24.847 - * s:100 q:100 tr=573400 (3384) Playing
15:09:26.340 - * s:100 q:100 tr=2388540 (1128) Playing
15:09:27.341 - * s:100 q:100 tr=0 (0) Playing
15:09:28.341 - * s:100 q:100 tr=0 (0) Playing
15:09:29.341 - * s:100 q:100 tr=0 (0) Playing
15:09:30.341 - * s:100 q:100 tr=0 (0) Playing
15:09:31.341 - * s:0 q:0 tr=0 (0) Playing
15:09:32.341 - * s:100 q:100 tr=1317504 (5640) Playing
15:09:33.355 - * s:100 q:100 tr=0 (0) Playing
15:09:34.355 - * s:100 q:100 tr=0 (0) Playing
15:09:35.356 - * s:100 q:100 tr=0 (0) Playing
15:09:36.357 - * s:100 q:100 tr=0 (0) Playing
15:09:37.357 - * s:0 q:0 tr=0 (0) Playing
15:09:38.357 - * s:0 q:0 tr=0 (0) Playing
15:09:39.372 - * s:0 q:0 tr=0 (0) Playing
15:09:40.372 - * s:0 q:0 tr=0 (0) Playing
15:09:41.382 - * s:0 q:0 tr=0 (0) Buffering
15:09:42.386 - * s:0 q:0 tr=0 (0) Buffering
15:09:43.387 - * s:100 q:100 tr=3310116 (4512) Playing
15:09:43.974 - ChannelGraph5.~CChannelGraph5
15:09:43.974 - Graph::Stop
15:09:43.998 - Before Stop ...15:09:43.999 - OnGraphStop ...15:09:44.001 - PreScanner.Stop
15:09:44.001 - GraphState: Undef by PreScanner.Stop
15:09:44.001 - PlayTimePmtParser::StopParser
15:09:44.001 - subsm.StopChannel
15:09:44.001 - VR: Disconnect
15:09:44.027 - Graph::ReleaseAllFilters
15:09:44.027 - release: Audio Renderer - RR - OK.
15:09:44.083 - release: Video Renderer - RR - OK.
15:09:44.148 - release: Video decoder  - RR - OK.
15:09:44.151 - release: Audio Processor - RR - OK.
15:09:44.152 - release: Audio decoder - RR - OK.
15:09:44.157 - FilterGraph: 1
15:09:44.160 - ChannelGraph5.~CChannelGraph5 finish
15:09:44.161 - TransponderManager::CloseChannel
15:09:44.161 - TsInputTrafficProcessor.RemoveChannel 1
15:09:44.161 - ~TransponderChannelSource
15:09:44.162 - TimeShift.DestroyReadingCursor
15:09:44.162 - Api2BaseModule.UpdateAllOpenedChannels 0
15:09:44.162 - Destroy TSTS filter pid=0
15:09:44.163 - PlayTimePmtParser::StopParser
15:09:44.163 - Destroy TSTS filter pid=100
15:09:44.163 - DevicesManager::DestroyTransponderManager
15:09:44.163 - Api2Device::SetChannel - None
15:09:44.180 - Api2Device::SetChannel result OK
15:09:44.180 - SetOwner N -> 0
15:09:44.181 - SetOwner SetTransponder null
15:09:44.181 - ~TransponderManager
15:09:44.181 - SetOwner N -> 0
15:09:44.181 - SetOwner SetTransponder null
15:09:44.182 - TimeShift.~TimeShift
15:09:44.182 - HugeMemoryBlocksManager::Free
15:09:44.182 - ModuleList::Free
15:09:44.182 - remove graph idx=0 count=1
15:09:44.183 - add graph 00F567B0 103
15:09:44.186 - VR: GUI
15:09:44.193 - 
15:09:44.193 - Stop engine
15:09:44.193 - DevicesManager::Stop
15:09:44.193 - remove graph idx=0 count=1
15:09:44.193 - DevicesManager::Free devices
15:09:44.193 - SDP:Destroy bda.7d2 own=00000000
15:09:44.196 - SDP:after destroy device
15:09:44.197 - SDP:Destroy bda.7d3 own=00000000
15:09:44.200 - SDP:after destroy device
15:09:44.200 - SDP:Destroy netclient.0 own=00000000
15:09:44.201 - SDP:after destroy device
15:09:44.201 - DevicesManager::Free RC
15:09:44.201 - Engine stopped
15:09:44.305 - HugeMemoryBlocksManager::FreeAll
