﻿18:54:54.535 - Start logging...
18:54:54.816 -   DisableModules    
18:54:54.894 - InterfaceApiManagerWnd CreateWnd
18:54:54.925 - DevicesManager::Start
18:54:54.941 - AVManager::Init
18:54:55.459 - SetDefaultNullCodecs
18:54:56.225 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVAudio.ax 04A5F41C
18:54:56.241 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVAudio.ax 04A5F41C
18:54:56.272 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVAudio.ax 04A5F41C
18:54:56.288 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVAudio.ax 04A5F41C
18:54:57.068 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVVideo.ax 04A619CC
18:54:57.099 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVVideo.ax 04A619CC
18:54:57.114 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVVideo.ax 04A619CC
18:54:57.130 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVVideo.ax 04A619CC
18:54:57.161 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVVideo.ax 04A619CC
18:54:57.177 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVVideo.ax 04A619CC
18:54:57.208 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVVideo.ax 04A619CC
18:54:57.224 - RemoveAllCreateBlank needBlank1
18:54:57.255 - add graph 04A674D8 101
18:54:57.270 - [101]OnChangeCurrentGraph2 -RemoveAllBlank
18:54:57.582 - DevicesManager::EnableCISupport
18:54:57.614 - CAVManager::SetSettings
18:54:57.629 - DevicesManager::DestroyAllTransponderManager
18:54:57.707 - SetDefaultNullCodecs
18:54:57.739 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVAudio.ax 0D2AF93C
18:54:57.757 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVAudio.ax 0D2AF93C
18:54:57.866 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVAudio.ax 0D2AF93C
18:54:57.897 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVAudio.ax 0D2AF93C
18:54:57.913 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVVideo.ax 04A62F54
18:54:57.944 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVVideo.ax 04A62F54
18:54:57.975 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVVideo.ax 04A62F54
18:54:58.007 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVVideo.ax 04A62F54
18:54:58.038 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVVideo.ax 04A62F54
18:54:58.069 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVVideo.ax 04A62F54
18:54:58.100 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVVideo.ax 04A62F54
18:54:58.350 - DevicesManager::StartDevices...
18:54:58.365 - device netclient.0 18:54:58.911 - LoadDll C:\Program Files\ProgTV 2 Professional\Modules\netclient.Device - 513D0000
18:54:59.130 - dev: UpdateNetworkRecommendations  -1x-1 -1x-1
18:54:59.177 - dev: Created  netclient.0 001E3268
OK
18:54:59.317 - Api2BaseModule.GetAdditionInfo
18:54:59.348 - Api2BaseModule.GetAdditionInfo OK
18:54:59.473 - AV:UpdateAudioParamsAfterActive
18:54:59.723 - DevicesManager::EnableCISupport
18:54:59.754 - Api2Device::CI3_EnableCISupport
18:54:59.769 - CAVManager::SetSettings
18:54:59.801 - Api2BaseModule.SetDialogSettings
18:54:59.816 - Api2BaseModule.SetDialogSettings
18:55:01.033 - 
18:55:01.064 - 
18:55:01.080 - ########################### Mark of start channel changing.###########################
18:55:01.111 - 
18:55:01.127 - GraphManager::MainChangeChannel BBC One  1 provs
18:55:01.158 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
18:55:01.189 - SetChannelLogic::SetChannel 0
18:55:01.205 - SetChannelLogic::SetNormalChannel
18:55:01.236 - DevicesManager::CreateCloneDevice
18:55:01.267 - DevicesManager::CreateCloneDevice OK - founded in list
18:55:01.283 - TransponderManager
18:55:01.314 - CTransponderManager::InitOnNewDevice 0D2B0EB4
18:55:01.345 - SetOwner N -> Incoming Stream Cache
18:55:01.361 - TrafficProcessingScheme_CreateForNewEngineTransport 1 ss=0
18:55:01.392 - Normal TsInputTrafficProcessor.
18:55:01.439 - FilterManager::InitOnNewDevice 1
18:55:01.454 - TS router+MarkerFinder -> InputTrafficProcessor
18:55:01.485 - Incoming Stream Cache -> TS router+MarkerFinder
18:55:01.517 - InputTrafficProcessor -> Router to timeshift
18:55:01.532 - InputTrafficProcessor(FM) -> FilterManager
18:55:01.563 - Add timer 1000 BaseTransponderManaer
18:55:01.579 - TransponderManager::AddChildChannel
18:55:01.610 - TimeShift.TimeShift
18:55:01.641 - TimeShift.Create 200 mbytes 
18:55:01.657 - ts:One channel
18:55:01.688 - HugeMemoryBlocksManager::GetBlock 200 mbytes OK
18:55:01.704 - TransponderManager::CreateTimeshiftBuffer OK
18:55:08.225 - TimeShift.CreateReadingCursor
18:55:08.240 - TransponderChannelSource.Plugins 0D31D810 c 00000000
18:55:08.271 - TsInputTrafficProcessor.AddChannel 0
18:55:08.287 - AndroidChannelPlayback created TestMode=0
18:55:08.318 - SetChannelLogic::LookDeviceWithoutChannelsOrCloneAndMakeGraph
18:55:08.349 - add graph 0E86C560 102
18:55:08.412 - ChannelGraph.SetActiveState 1
18:55:08.443 - TransponderManager::SelectChannel
18:55:08.474 - TsInputTrafficProcessor.SelectChannel 0
18:55:08.490 - Api2BaseModule.UpdateAllOpenedChannels 0
18:55:08.521 - **** StopChannel time 7.457ms
18:55:08.552 - 
18:55:08.568 - TransponderManager::SetTransponder (CH) 0 BBC One
18:55:08.599 - *Transport TS
18:55:08.615 - Api2Device::SetChannel https://watchbritishtv.net/get.php?channel=bbcone&user=&pin=0
18:55:08.880 - Api2Device::SetChannel result OK
18:55:08.880 - Api2BaseModule.OnTunerStateChanged Connecting
18:55:08.895 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
18:55:08.958 - TsInputTrafficProcessor.OpenTransponder 1
18:55:08.927 - Api2BaseModule.OnTunerStateChanged  -3
18:55:08.973 - FilterManager::OnSetTransponder SetChannel
18:55:09.036 - TimeShift.Reset
18:55:09.067 - TimeShift.Cursor reset
18:55:09.083 - ReaderCursor::Reset.. OK
18:55:09.145 - Prereader.Reset ...-OK
18:55:09.192 - Create EPGparser on SetChannel
18:55:09.223 - DvbEpgParser::SetChannel ID=19d00002.f605f67e24bc8086.1
18:55:09.348 - DvbEpgParser::mode normal pos=0
18:55:09.379 - ModuleList::ChangeChannel 0
18:55:09.410 - **** SetTransponder time 0.889ms
18:55:09.441 - [102]ChannelGraph5::StartChannel BBC One
18:55:09.473 - AV:UpdateAudioParamsAfterActive
18:55:09.504 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
18:55:09.535 - GR:UpdateAudioProcessor old=0 new=0
18:55:09.566 - CPCG SetVolume 00000000 100
18:55:09.597 - 
18:55:09.629 - [102]       #################### Start stream. (8.564ms) #######################
18:55:09.660 - 
18:55:10.050 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
18:55:10.128 - TimeShift.Cursor SetChannel::v 0 (0)
18:55:10.159 - ReaderCursor::SetChannel.. OK
18:55:10.221 - ReaderCursor::SetPosition 0 (w=0)
18:55:10.237 - Prereader.SetChannel..
18:55:10.268 - Prereader.SetChannel unmask 1
18:55:10.299 - Plugin::SetChannel 1
18:55:10.331 - TransponderManager::SelectChannel
18:55:10.377 - TsInputTrafficProcessor.SelectChannel 1
18:55:10.393 - Api2BaseModule.UpdateAllOpenedChannels 1
18:55:10.424 - TsInputTrafficProcessor.UpdateChannel 1
18:55:10.455 - GraphState: Undef by StartChannelIsReady
18:55:10.487 - PreScanner.StartChannelIsReady net=1 parseall=1
18:55:10.518 - VideoMediaTypeDetection: h.264
18:55:10.549 - SetMarkerAudioLngStream Gen New stream
18:55:10.580 - SimpleTsDemux::Init apid=257, vpid=256
18:55:10.611 - GraphState: RequestPATScan by StartChannelIsReady TS
18:55:10.643 - Api2BaseModule.Filters_EnabledFullTS 1
18:55:10.705 - PlayTimePATParser.OpenParser 1
18:55:10.736 - Open TSTS filter pid=0 data=0
18:55:10.767 - TSTS cur size=0
18:55:10.814 - **** StartChanbnel time 1.404ms
18:55:10.845 - [102]OnChangeCurrentGraph2 -endOfSetChannel
18:55:10.877 - ChannelGraph.SetActiveState 1
18:55:11.111 - Api2BaseModule.OnTunerStateChanged Preparing
18:55:11.126 - Api2BaseModule.OnTunerStateChanged  -4
18:55:11.204 - Api2BaseModule.OnTunerStateChanged Playing
18:55:11.220 - Api2BaseModule.OnTunerStateChanged  -4
18:55:11.423 - [102]**** SetChannel is finished (OK). Duration 10.358ms
18:55:13.404 - Api2BaseModule.OnTunerStateChanged Connecting
18:55:13.419 - Api2BaseModule.OnTunerStateChanged  -3
18:55:13.997 - Api2BaseModule.OnTunerStateChanged Preparing
18:55:14.028 - Api2BaseModule.OnTunerStateChanged  -4
18:55:14.075 - Api2BaseModule.OnTunerStateChanged Playing
18:55:14.106 - Api2BaseModule.OnTunerStateChanged  -4
18:55:14.792 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 Preparing
18:55:15.666 - Add timer 1000 HlsReader
18:55:16.399 - Api2BaseModule.OnDisplaySize
18:55:16.430 - dev: UpdateNetworkRecommendations  1240x696 -1x-1
18:55:16.773 - TransportMarker: TS
18:55:16.805 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
18:55:16.836 - 
18:55:16.851 -        #################### First traffic. (15.787ms) #######################
18:55:16.883 - 
18:55:16.914 - PlayTimePATParser.EndTask
18:55:17.556 - --SwitchEngineTransport TS > TS
18:55:17.587 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
18:55:17.634 - PreScanner.OnTransportMarker TS
18:55:17.665 - --SwitchEngineTransport end
18:55:17.727 - PreScanner.OnAfterScanPat count=2 {1;4097}
18:55:17.759 - Api2BaseModule.Filters_EnabledFullTS 0
18:55:17.852 - GraphState: RequestPMTScan by OnAfterScanPat
18:55:17.899 - PlayTimePmtParser::OpenParser SID=1 PMT=4097 unknow channel=1
18:55:17.915 - Open TSTS filter pid=4097 data=2
18:55:17.946 - TSTS cur size=376376
18:55:17.977 - TSTS quick finish
18:55:18.133 - PreScanner.OnAfterScanPmt pmt=4097
18:55:18.149 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
18:55:18.211 - PlayTimePmtParser::StopParser
18:55:18.663 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
18:55:18.679 - TimeShift.Cursor SetChannel::v 704060 (704060)
18:55:18.710 - Prereader.SetChannel unmask 1
18:55:18.741 - Plugin::SetChannel 1
18:55:18.788 - TransponderManager::SelectChannel
18:55:18.819 - TsInputTrafficProcessor.SelectChannel 1
18:55:18.851 - Api2BaseModule.UpdateAllOpenedChannels 1
18:55:18.882 - TsInputTrafficProcessor.UpdateChannel 1
18:55:18.913 - PreScanner.StartChannelIsReady net=1 parseall=0
18:55:18.944 - LngDefaultSelector.try select audio pid=257 type=1 lng=0-(enm;ang;eng,deu;gmh;goh;ger,rus) l=99
18:55:18.975 - ChannelGraph::AfterDetectChannelParams
18:55:18.991 - VideoMediaTypeDetection: h.264
18:55:19.038 - SimpleTsDemux::Init apid=257, vpid=256
18:55:19.053 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
18:55:19.116 - CalcPositionMinusDeltaTime  0 000000 old 2s new 0s delta 2.000s result 0 000000
18:55:19.147 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
18:55:19.178 - Prereader::ReaderCursor.. OK
18:55:19.381 - ReaderCursor::SetPosition 0 (w=3603666539905024)
18:55:19.428 - Prereader.StartPlayback Push buffering=0 recv=0E86CD2C [StartChannelHelperBase(sl)]
18:55:19.490 - Prereader.StartPlayback after lock
18:55:19.539 - PreScanner.StartPmtParserIfNeed
18:55:19.554 - PlayTimePmtParser::OpenParser SID=1 PMT=4097 unknow channel=0
18:55:19.585 - Open TSTS filter pid=4097 data=2
18:55:19.648 - TSTS cur size=839044
18:55:19.540 - VideoParser::First packet 54036 h.264
18:55:19.772 - h264 detected 0 ms
18:55:19.804 - AudioParser::First packet 339
18:55:19.835 - AudioParser::AAC detected
18:55:19.882 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
18:55:19.882 - ------sGetVideoParams
18:55:19.897 - PreScanner.Post_InitRender [ReceiveTraffic]
18:55:19.975 - * s:100 q:100 tr=839232 (0) - ntt-1 dmx0 -1 Preparing
18:55:20.178 - 
18:55:20.209 - [102]       #################### Init Render. (19.157ms) #######################
18:55:20.256 - 
18:55:20.287 - ------sGetVideoParams
18:55:20.334 - video:h264 HD
18:55:20.350 - selector PlaybackTag=none videocodec=DS/ ts=1
18:55:20.396 - Channel PlaybackWay after check DS
18:55:20.490 - GraphState: GraphStarted by AsyncInitRender
18:55:20.506 - CalculBufferingSize prov=0D2B22F4 marker=1 request=1
18:55:20.537 - CalculBuffering 2000ms br=2000kb to 500 kbytes. By type
18:55:20.568 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
18:55:20.599 - Prereader::ReaderCursor.. OK
18:55:20.646 - ReaderCursor::SetPosition 0 (w=4373977514377216)
18:55:20.677 - Prereader.StartPlayback Pull buffering=512000 recv=00000000 [EnablePullModeAndStartPlayback]
18:55:20.708 - Prereader.StartPlayback after lock
18:55:20.740 - Buffering/prereader size 500/3906 kbytes
18:55:20.755 - Not same player! old 0 new 13 prev 0
18:55:20.786 - ------sGetVideoParams
18:55:21.036 - Add timer 1000 DirectShowPlayer
18:55:21.083 - Graph::SetVideoWindowRect {0 0 1242 698}
18:55:21.114 - Graph::UpdateRenderMode
18:55:21.176 - Graph::SetVideoRect {0 0 720 576}
18:55:21.208 - Graph::SetVideoWindowRect {0 0 1242 698}
18:55:21.239 - demux: ProgDemux
18:55:21.408 - ------sGetVideoParams
18:55:21.465 - ChannelGraph5.CreateInterfacesAndRenderGraph
18:55:21.707 - CreateCustomGraph
18:55:21.774 - VideoType:H.264/AVC ffmpeg=0
18:55:21.831 - Video/4.H264 : MPEG2_VIDEO s={0,0,1280,720}, t={0,0,1280,720}, bmp=1280x720, r=16/9, br=0,frametime=33ms, IF=0x0, CF=0x0)
18:55:21.871 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f
18:55:21.914 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVVideo.ax 0E948CE4
18:55:22.191 - OK
18:55:22.224 - CChannelGraph5::CreateRender 6
18:55:22.285 - VR: EVR
18:55:22.315 - VR: create new render
18:55:22.492 - TS counter checker disabled!
18:55:23.265 - VR: Add video renderer Video Renderer - OK
18:55:23.292 - CreateAudioPartOfGraph
18:55:23.321 - AudioType:AAC/ADTS 
18:55:23.350 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 48000 16bit formatTag= 0x1600)
18:55:23.412 - Codec from file: C:\Program Files\ProgTV 2 Professional\LAVAudio.ax 0EA1D754
18:55:23.547 - Add audio codec e8e73b6b-4cb3-44a4-be99-4f7bcb96e491 - OK
18:55:23.779 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
18:55:23.808 - Added audio renderer
18:55:23.843 - AP: created
18:55:23.893 - Added audio processor
18:55:24.307 - Connect codec to AP - OK
18:55:24.551 - Add and connect audio renderer - OK
18:55:24.583 - Graph::AfterRender
18:55:24.632 - AV:UpdateAudioParamsAfterActive
18:55:24.663 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
18:55:24.730 - GR:UpdateAudioProcessor old=1 new=0
18:55:24.841 - Destroy Audio Processor update
18:55:24.912 - CPCG SetVolume 0EB21B38 100
18:55:25.019 - Graph::SetVolume 100% 0db
18:55:25.221 - Graph::Run
18:55:25.846 - Graph::Run 1
18:55:25.880 - Graph::SetVideoRect {0 0 1280 720}
18:55:25.928 - Graph::SetVideoWindowRect {0 0 1242 698}
18:55:25.968 - AV:UpdateAudioParamsAfterActive
18:55:25.981 - 
18:55:26.007 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
18:55:26.037 - [0]########################### Mark of finish channel changing. (24.976ms) #############
18:55:26.073 - GR:UpdateAudioProcessor old=0 new=0
18:55:26.104 - 
18:55:26.133 - CPCG SetVolume 0EB21B38 100
18:55:26.192 - Graph::SetVolume 100% 0db
18:55:26.483 - Graph::Run
18:55:26.573 - Graph::Run 0
18:55:26.627 - subsm.StartChannel demux=ProgDemux tr=TS
18:55:26.688 - subsm.RecreateSubtitlesParsers 0D3A0C68 ts=1 subindex=-1 st=-1
18:55:26.783 - subsm.Stop teletext parser
