﻿13:40:08.842 - Start logging...
13:40:08.858 - 
13:40:08.858 - Start engine 6.210
13:40:08.858 - ExceptionFilter::Init. restart=1
13:40:17.385 - DevicesManager::Start
13:40:17.385 - CAVManager::Init
13:40:18.326 - AV settings loaded
13:40:18.326 - VR: GUI
13:40:18.341 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
13:40:18.412 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
13:40:18.412 - AV:UpdateAudioParamsAfterActive
13:40:18.427 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
13:40:18.427 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
13:40:18.709 - DevicesManager::StartDevices...
13:40:18.709 - device bda.52394 13:40:18.984 - dev: Created  bda.ccaa 012F3F58
OK
13:40:18.986 - device bda.52393 13:40:19.066 - dev: Created  bda.cca9 012F3320
OK
13:40:19.067 - device netclient.0 13:40:19.114 - dev: Created  netclient.0 058EC430
OK
13:40:19.115 - Api2BaseModule.GetAdditionInfo
13:40:19.116 - Api2BaseModule.GetAdditionInfo
13:40:19.117 - Api2BaseModule.GetAdditionInfo
13:40:19.927 - 
13:40:19.928 - 
13:40:19.929 - ########################### Mark of start channel changing.###########################
13:40:19.930 - 
13:40:19.931 - GraphManager::MainChangeChannel BBC NEWS HD  1 provs
13:40:19.932 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
13:40:19.933 - SetChannelLogic::SetChannel 0
13:40:19.934 - SetChannelLogic::SetNormalChannel
13:40:19.935 - TransponderManager
13:40:19.936 - CTransponderManager::InitOnNewDevice 0C061F3C
13:40:19.937 - { -> Incoming Stream Cache
13:40:19.938 - TrafficProcessingScheme_CreateForNewEngineTransport 1 ss=0
13:40:19.939 - Normal TsInputTrafficProcessor.
13:40:19.944 - FilterManager::InitOnNewDevice 1
13:40:19.946 - TS router+MarkerFinder -> InputTrafficProcessor
13:40:19.947 - Incoming Stream Cache -> InputTrafficProcessor
13:40:19.947 - InputTrafficProcessor -> Router to timeshift
13:40:19.948 - InputTrafficProcessor(FM) -> FilterManager
13:40:19.949 - ModuleList::Free
13:40:19.952 - Api2BaseModule::GetCurrentDeviceInfo
13:40:19.953 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\PidRecorder.Module OK
13:40:19.955 - Api2BaseModule::GetCurrentDeviceInfo
13:40:19.958 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\ProgMediaServer.Module OK
13:40:19.958 - ChannelGraph5.CChannelGraph5
13:40:19.959 - TransponderManager::AddChildChannel
13:40:19.960 - TimeShift.TimeShift
13:40:19.961 - TimeShift.Create 200 mbytes 
13:40:19.961 - ts:One channel
13:40:19.963 - HugeMemoryBlocksManager::GetBlock 200 mbytes OK
13:40:19.964 - TransponderManager::CreateTimeshiftBuffer OK
13:40:20.142 - MDPlugin::Loaded C:\Program Files (x86)\ProgDVB\Plugins\ACamd.dll OK
13:40:27.308 - TimeShift.CreateReadingCursor
13:40:27.309 - TsInputTrafficProcessor.AddChannel 0
13:40:27.314 - SetChannelLogic::LookDeviceWithoutChannelsOrCloneAndMakeGraph
13:40:27.314 - ChannelGraph5.SetActiveState 1
13:40:27.315 - TransponderManager::SelectChannel
13:40:27.315 - TsInputTrafficProcessor.SelectChannel 0
13:40:27.316 - Api2BaseModule.UpdateAllOpenedChannels 0
13:40:27.318 - AV:UpdateAudioParamsAfterActive
13:40:27.318 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
13:40:27.319 - Graph::SetAudioChannelMask
13:40:27.319 - 
13:40:27.320 - TransponderManager::SetTransponder (CH) 11023000 BBC NEWS HD
13:40:27.321 - *Transport TS
13:40:27.321 - Api2Device::SetChannel 11023000Khz sid=8921
13:40:27.322 - ch:BBC NEWS HD {freq:11023, pol:H, sr:23000}
13:40:29.842 - Api2Device::SetChannel result OK
13:40:29.843 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=8921
13:40:29.843 - TsInputTrafficProcessor.OpenTransponder 1
13:40:29.844 - FilterManager::OnSetTransponder SetChannel
13:40:29.845 - TimeShift.Reset
13:40:29.846 - TimeShift.Cursor reset
13:40:29.846 - ReaderCursor::Reset.. OK
13:40:29.847 - Prereader.Reset ...-OK
13:40:29.848 - Create EPGparser on SetChannel
13:40:29.850 - DvbEpgParser::SetChannel ID=8001ccaa.11a000000a83298.22d9
13:40:29.852 - ModuleList::ChangeChannel 11023000
13:40:29.853 - CChannelGraph5::StartChannel BBC NEWS HD
13:40:29.853 - 
13:40:29.854 -        #################### Start stream. (9.938ms) #######################
13:40:29.855 - 
13:40:29.869 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
13:40:29.870 - TimeShift.Cursor SetChannel::v 0 (0)
13:40:29.871 - ReaderCursor::SetChannel.. OK
13:40:29.872 - ReaderCursor::SetPosition 0 (w=0)
13:40:29.873 - Prereader.SetChannel..
13:40:29.873 - Prereader.SetChannel unmask 1
13:40:29.875 - Plugin::SetChannel 8921
13:40:29.887 - TransponderManager::SelectChannel
13:40:29.888 - TsInputTrafficProcessor.SelectChannel 8921
13:40:29.888 - Api2BaseModule.UpdateAllOpenedChannels 1
13:40:29.891 - TsInputTrafficProcessor.UpdateChannel 8921
13:40:29.891 - GraphState: Undef by StartChannelIsReady
13:40:29.892 - PreScanner.StartChannelIsReady net=0 parseall=0
13:40:29.893 - ChannelGraph5::AfterDetectChannelParams
13:40:29.893 - VideoMediaTypeDetection: h.264
13:40:29.894 - SetMarkerAudioLngStream Gen New stream
13:40:29.895 - SimpleTsDemux::Init apid=5001, vpid=5000
13:40:29.895 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
13:40:29.896 - demux: ProgDemux
13:40:29.901 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
13:40:29.902 - Prereader::ReaderCursor.. OK
13:40:29.903 - ReaderCursor::SetPosition 0 (w=0)
13:40:29.904 - Prereader.StartPlayback Push buffering=0 recv=0C316168 [StartChannelHelperBase(sl)]
13:40:29.904 - Prereader.StartPlayback after lock
13:40:29.905 - PreScanner.StartPmtParserIfNeed
13:40:29.906 - PlayTimePmtParser::OpenParser SID=8921 PMT=258 unknow channel=0
13:40:29.905 - 
13:40:29.906 - Open TSTS filter pid=258 data=2
13:40:29.907 -        #################### First traffic. (9.985ms) #######################
13:40:29.908 - 
13:40:29.909 - TSTS cur size=5640
13:40:29.909 - Graph::SetVideoRect {8 8 712 568}
13:40:29.910 - ChannelGraph5.SetActiveState 1
13:40:29.913 - Graph::SetVideoWindowRect {33 0 166 100}
13:40:29.915 - Graph::UpdateRenderMode
13:40:29.920 - VideoParser::First packet 2266 h.264
13:40:29.921 - VideoParser::packet 3902
13:40:29.922 - VideoParser::packet 7523
13:40:29.935 - VideoParser::packet 8984
13:40:29.936 - VideoParser::packet 10312
13:40:29.981 - VideoParser::packet 32488
13:40:30.011 - VideoParser::packet 40383
13:40:30.013 - VideoParser::packet 43830
13:40:30.014 - VideoParser::packet 45131
13:40:30.026 - VideoParser::packet 46919
13:40:30.041 - VideoParser::packet 54698
13:40:30.042 - VideoParser::packet 57564
13:40:30.056 - VideoParser::packet 61048
13:40:30.071 - AudioParser::First packet 3840
13:40:30.072 - Audio detection conflict!!! AC3 and MPG12 detected. Selected AC3
13:40:30.073 - AudioParser::AC3 detected
13:40:30.083 - GraphManager::MultiChannelRendering
13:40:30.084 - ChannelGraph5.SetActiveState 1
13:40:30.094 - Graph::SetVideoWindowRect {0 304 445 637}
13:40:30.097 - OK. 102
13:40:30.117 - VideoParser::packet 87525
13:40:30.119 - Api2BaseModule.OpenFilter 258 OK
13:40:30.146 - VideoParser::packet 99341
13:40:30.177 - VideoParser::packet 109652
13:40:30.192 - VideoParser::packet 114465
13:40:30.193 - VideoParser::packet 119342
13:40:30.207 - VideoParser::packet 125782
13:40:30.222 - VideoParser::packet 128662
13:40:30.223 - VideoParser::packet 131272
13:40:30.845 - VideoParser::packet 318970
13:40:30.847 - h264 detected 922 ms
13:40:30.848 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
13:40:30.848 - PreScanner.Post_InitRender [ReceiveTraffic]
13:40:30.850 - Api2BaseModule.CloseFilter 1 pid 258
13:40:30.852 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
13:40:30.853 - CalculBufferingSize prov=0C06337C marker=0 request=1
13:40:30.853 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
13:40:30.854 - Prereader::ReaderCursor.. OK
13:40:30.855 - ReaderCursor::SetPosition 0 (w=1753789765779456)
13:40:30.856 - Prereader.StartPlayback Pull buffering=0 recv=00000000 [EnablePullModeAndStartPlayback]
13:40:30.857 - Prereader.StartPlayback after lock
13:40:30.857 - ------sGetVideoParams
13:40:30.858 - ChannelGraph5.CreateInterfacesAndRenderGraph
13:40:30.861 - subsm.StartChannel demux=ProgDemux tr=TS
13:40:30.862 - subsm.RecreateSubtitlesParsers 0BF41190 ts=1 subindex=2
13:40:30.863 - SSTeletext: SetChannel page=888 lngeng
13:40:30.863 - subsm.Set Teletext parser 5003
13:40:30.864 - subsm.RecreateSubtitlesParsers end
13:40:30.865 - subs: OnSetChannel
13:40:30.865 - CreateCustomGraph
13:40:30.866 - VideoType:H.264/AVC
13:40:30.866 - 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)
13:40:30.917 - Add video codec 212690fb-83e5-4526-8fd7-74478b7939cd - OK
13:40:30.918 - CChannelGraph5::CreateRender 10
13:40:30.918 - VR: EVR Custom
13:40:30.919 - VR: create new render
13:40:30.979 - Graph::SetVideoWindowRect {128 0 1152 768}
13:40:31.124 - VR: Add video renderer Video Renderer - OK
13:40:31.125 - CreateAudioPartOfGraph
13:40:31.126 - AudioType:AC3
13:40:31.126 - Audio/AC3 : WaveFormatEx (2ch 48000 0bit formatTag= 0x0)
13:40:31.149 - Add audio codec a753a1ec-973e-4718-af8e-a3f554d45c44 - OK
13:40:31.237 - IMyGraphBuilder::CreateAudioRenderFilter::Default DirectSound Device OK
13:40:31.383 - Add and connect audio renderer - OK
13:40:31.384 - Graph::AfterRender
13:40:31.385 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
13:40:31.385 - AV:UpdateAudioParamsAfterActive
13:40:31.386 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
13:40:31.387 - Graph::SetVolume 100% 0db
13:40:31.398 - Graph::SetAudioChannelMask
13:40:31.399 - Graph::Run
13:40:34.511 - Graph::Run 1
13:40:34.512 - Graph::SetPictureParams
13:40:34.513 - Graph::SetVideoRect {24 16 1896 1076}
13:40:34.513 - Graph::SetVideoWindowRect {0 21 1280 746}
13:40:34.514 - AfterRenderInit
13:40:34.515 - ARI
13:40:34.515 - CChannelGraph5::HideSubtitles
13:40:34.540 - * s:55 q:80 tr=29839172 (9964) 
13:40:34.573 - 
13:40:34.573 - ########################### Mark of finish channel changing. (14.657ms) #############
13:40:34.574 - 
13:40:35.836 - 
13:40:35.836 - ########################### First video frame. (15.922ms) #############
13:40:35.837 - 
13:40:36.121 - * s:55 q:80 tr=10106880 (0) 
13:40:36.379 - changed ratio to 1920/1080
13:40:36.381 - Graph::SetVideoRect {24 16 1896 1076}
13:40:36.382 - Graph::SetVideoWindowRect {0 26 1280 741}
13:40:38.118 - * s:55 q:80 tr=12032000 (5076) 
13:40:40.125 - * s:55 q:78 tr=12802048 (188) 
13:40:42.118 - * s:55 q:78 tr=12705792 (0) 
13:40:44.117 - * s:55 q:78 tr=12802048 (0) 
13:40:45.129 - * s:55 q:80 tr=6449152 (0) 
13:40:46.541 - Graph::SetPictureParams
13:40:46.542 - Graph::SetPictureParams
13:40:46.542 - Graph::SetPictureParams
13:40:46.543 - Graph::SetPictureParams
13:40:46.645 - * s:55 q:78 tr=9625600 (0) 
13:40:48.140 - * s:55 q:80 tr=9529344 (0) 
13:40:49.243 - EPG Parser - CRC error! pid=18
13:40:49.287 - PMT Parse SID=8921, TID=2061 - CRC error! pid=258
13:40:49.564 - EnumDsFilters 1
13:40:49.565 - EnumPresetFilters
13:40:49.566 - EnumPresetFilters OK
13:40:49.566 - EnumDirectShowFilters
13:40:53.411 - EPG Parser - CRC error! pid=18
13:41:01.976 - EPG Parser - CRC error! pid=18
