﻿17:57:03.678 - Start logging...
17:57:03.682 - ExceptionFilter::Init. restart=1
17:57:24.177 - DevicesManager::EnableCISupport
17:57:24.177 - CAVManager::SetSettings
17:57:24.177 - DevicesManager::DestroyAllTransponderManager
17:57:24.203 - SetDefaultNullCodecs
17:57:24.255 - SetDefaultNullCodecs
17:57:24.289 - DevicesManager::Start
17:57:24.289 - AVManager::Init
17:57:24.290 - RemoveAllCreateBlank needBlank1
17:57:24.291 - [101]OnChangeCurrentGraph2 -RemoveAllBlank
17:57:24.297 - VR: GUI
17:57:24.300 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
17:57:24.325 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
17:57:24.325 - AV:UpdateAudioParamsAfterActive
17:57:24.325 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
17:57:24.326 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
17:57:24.534 - DevicesManager::StartDevices...
17:57:24.534 - device netclient.0 17:57:24.538 - dev: Created  netclient.0 095DFBE0
OK
17:57:24.539 - Api2BaseModule.GetAdditionInfo
17:57:25.586 - 
17:57:25.587 - 
17:57:25.587 - ########################### Mark of start channel changing.###########################
17:57:25.587 - 
17:57:25.587 - GraphManager::MainChangeChannel Rotana Cinema EGY HD  1 provs
17:57:25.587 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
17:57:25.587 - SetChannelLogic::SetChannel 0
17:57:25.587 - SetChannelLogic::SetNormalChannel
17:57:25.588 - DevicesManager::CreateCloneDevice
17:57:25.588 - DevicesManager::CreateCloneDevice OK - founded in list
17:57:25.588 - TransponderManager
17:57:25.588 - CTransponderManager::InitOnNewDevice 096DF3A4
17:57:25.589 - SetOwner N -> Incoming Stream Cache
17:57:25.589 - TrafficProcessingScheme_CreateForNewEngineTransport 1 ss=0
17:57:25.589 - Normal TsInputTrafficProcessor.
17:57:25.590 - FilterManager::InitOnNewDevice 1
17:57:25.592 - TS router+MarkerFinder -> InputTrafficProcessor
17:57:25.592 - Incoming Stream Cache -> TS router+MarkerFinder
17:57:25.592 - InputTrafficProcessor -> Router to timeshift
17:57:25.592 - InputTrafficProcessor(FM) -> FilterManager
17:57:25.592 - ModuleList::Free
17:57:25.593 - Api2BaseModule::GetCurrentDeviceInfo
17:57:25.593 - ModuleList::Load F:\ProgDVB Professional 43.5\Modules\PidRecorder.module OK
17:57:25.594 - Api2BaseModule::GetCurrentDeviceInfo
17:57:25.595 - ModuleList::Load F:\ProgDVB Professional 43.5\Modules\ProgMediaServer.Module OK
17:57:25.595 - ChannelGraph5.CChannelGraph5
17:57:25.595 - TransponderManager::AddChildChannel
17:57:25.596 - TimeShift.TimeShift
17:57:25.596 - TimeShift.Create 200 mbytes 
17:57:25.596 - ts:One channel
17:57:25.597 - HugeMemoryBlocksManager::GetBlock 200 mbytes OK
17:57:25.597 - TransponderManager::CreateTimeshiftBuffer OK
17:57:25.606 - TimeShift.CreateReadingCursor
17:57:25.607 - TransponderChannelSource.Plugins 0C8895E0 csa 00000000
17:57:25.607 - TsInputTrafficProcessor.AddChannel 0
17:57:25.608 - SetChannelLogic::LookDeviceWithoutChannelsOrCloneAndMakeGraph
17:57:25.609 - ChannelGraph5.SetActiveState 1
17:57:25.609 - TransponderManager::SelectChannel
17:57:25.609 - TsInputTrafficProcessor.SelectChannel 0
17:57:25.609 - Api2BaseModule.UpdateAllOpenedChannels 0
17:57:25.610 - AV:UpdateAudioParamsAfterActive
17:57:25.610 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
17:57:25.610 - GR:UpdateAudioProcessor old=0 new=0
17:57:25.610 - Graph::SetAudioChannelMask
17:57:25.610 - 
17:57:25.610 - TransponderManager::SetTransponder (CH) 11230000 Rotana Cinema EGY HD
17:57:25.610 - *Transport TS
17:57:25.611 - Api2Device::SetChannel http://192.168.159.2:10999/id/8001BCB1.0104000380AB5B30.019E
17:57:25.627 - Api2Device::SetChannel result OK
17:57:25.627 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=414
17:57:25.627 - TsInputTrafficProcessor.OpenTransponder 1
17:57:25.628 - FilterManager::OnSetTransponder SetChannel
17:57:25.628 - Api2BaseModule.OnTunerStateChanged Connecting
17:57:25.628 - TimeShift.Reset
17:57:25.628 - TimeShift.Cursor reset
17:57:25.629 - ReaderCursor::Reset.. OK
17:57:25.629 - Prereader.Reset ...-OK
17:57:25.629 - ModuleList::ChangeChannel 11230000
17:57:25.632 - Api2BaseModule.OnTunerStateChanged Preparing
17:57:25.643 - Api2BaseModule::GetCurrentDeviceInfo
17:57:25.645 - Api2BaseModule::GetCurrentDeviceInfo
17:57:25.647 - [102]ChannelGraph5::StartChannel Rotana Cinema EGY HD
17:57:25.647 - 
17:57:25.648 - [102]       #################### Start stream. (0.062ms) #######################
17:57:25.648 - 
17:57:25.650 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
17:57:25.650 - TimeShift.Cursor SetChannel::v 0 (0)
17:57:25.651 - ReaderCursor::SetChannel.. OK
17:57:25.651 - ReaderCursor::SetPosition 0 (w=0)
17:57:25.651 - Api2BaseModule.OnTunerStateChanged Playing
17:57:25.652 - Prereader.SetChannel..
17:57:25.652 - Prereader.SetChannel unmask 1
17:57:25.652 - Plugin::SetChannel 414
17:57:25.653 - TransponderManager::SelectChannel
17:57:25.653 - TsInputTrafficProcessor.SelectChannel 414
17:57:25.653 - Api2BaseModule.UpdateAllOpenedChannels 1
17:57:25.653 - TransportMarker: TS
17:57:25.653 - Api2BaseModule::GetCurrentDeviceInfo
17:57:25.653 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
17:57:25.654 - Api2BaseModule::OpenFilter 18 OK
17:57:25.654 - Api2BaseModule::OpenFilter 541 OK
17:57:25.655 - Api2BaseModule::OpenFilter 540 OK
17:57:25.655 - Api2BaseModule::OpenFilter 542 OK
17:57:25.655 - Api2BaseModule::OpenFilter 0 OK
17:57:25.655 - TsInputTrafficProcessor.UpdateChannel 414
17:57:25.656 - GraphState: Undef by StartChannelIsReady
17:57:25.656 - PreScanner.StartChannelIsReady net=1 parseall=1
17:57:25.656 - VideoMediaTypeDetection: h.264
17:57:25.656 - SetMarkerAudioLngStream Gen New stream
17:57:25.656 - SimpleTsDemux::Init apid=542, vpid=541
17:57:25.656 - GraphState: RequestPATScan by StartChannelIsReady TS
17:57:25.657 - Api2BaseModule.Filters_EnabledFullTS 1
17:57:25.657 - PlayTimePATParser.OpenParser 414
17:57:25.657 - Open TSTS filter pid=0 data=0
17:57:25.657 - TSTS cur size=0
17:57:25.657 - Graph::SetVideoRect {8 8 712 568}
17:57:25.658 - [102]OnChangeCurrentGraph2 -endOfSetChannel
17:57:25.658 - ChannelGraph5.SetActiveState 1
17:57:25.661 - Graph::SetVideoWindowRect {33 0 166 100}
17:57:25.662 - Graph::UpdateRenderMode
17:57:25.673 - 
17:57:25.673 -        #################### First traffic. (0.078ms) #######################
17:57:25.673 - 
17:57:25.702 - GraphManager::MultiChannelRendering
17:57:25.702 - ChannelGraph5.SetActiveState 1
17:57:25.710 - Graph::SetVideoWindowRect {108 0 569 346}
17:57:25.728 - Graph::SetVideoWindowRect {44 0 456 309}
17:57:25.797 - Graph::SetVideoWindowRect {111 0 551 330}
17:57:25.822 - Graph::SetVideoWindowRect {108 0 569 346}
17:57:25.831 - OK. 102
17:57:25.860 - --SwitchEngineTransport TS > TS
17:57:25.864 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
17:57:25.864 - PreScanner.OnTransportMarker TS
17:57:25.865 - --SwitchEngineTransport end
17:57:26.044 - PlayTimePATParser.EndTask
17:57:26.045 - PreScanner.OnAfterScanPat count=2 {414;540}
17:57:26.045 - Api2BaseModule.Filters_EnabledFullTS 0
17:57:26.045 - GraphState: RequestPMTScan by OnAfterScanPat
17:57:26.046 - PlayTimePmtParser::OpenParser SID=414 PMT=540 unknow channel=1
17:57:26.046 - Open TSTS filter pid=540 data=2
17:57:26.046 - TSTS cur size=294220
17:57:26.046 - TSTS quick finish
17:57:26.047 - PreScanner.OnAfterScanPmt pmt=540
17:57:26.048 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
17:57:26.048 - PlayTimePmtParser::StopParser
17:57:26.051 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
17:57:26.051 - TimeShift.Cursor SetChannel::v 294220 (294220)
17:57:26.051 - Prereader.SetChannel unmask 1
17:57:26.051 - Plugin::SetChannel 414
17:57:26.051 - TransponderManager::SelectChannel
17:57:26.052 - TsInputTrafficProcessor.SelectChannel 414
17:57:26.052 - Api2BaseModule.UpdateAllOpenedChannels 1
17:57:26.052 - Api2BaseModule::CloseFilter 1 pid 18
17:57:26.053 - Api2BaseModule::CloseFilter 2 pid 541
17:57:26.053 - Api2BaseModule::CloseFilter 3 pid 540
17:57:26.054 - Api2BaseModule::CloseFilter 4 pid 542
17:57:26.054 - Api2BaseModule::CloseFilter 5 pid 0
17:57:26.054 - Api2BaseModule::GetCurrentDeviceInfo
17:57:26.055 - Api2BaseModule::OpenFilter 18 OK
17:57:26.055 - Api2BaseModule::OpenFilter 541 OK
17:57:26.056 - Api2BaseModule::OpenFilter 540 OK
17:57:26.056 - Api2BaseModule::OpenFilter 542 OK
17:57:26.056 - Api2BaseModule::OpenFilter 0 OK
17:57:26.057 - TsInputTrafficProcessor.UpdateChannel 414
17:57:26.057 - PreScanner.StartChannelIsReady net=1 parseall=0
17:57:26.057 - LngDefaultSelector.try select audio pid=542 type=1 lng=6778469-eng(deu,deu,rus) l=99
17:57:26.057 - ChannelGraph5::AfterDetectChannelParams
17:57:26.058 - VideoMediaTypeDetection: h.264
17:57:26.058 - SimpleTsDemux::Init apid=542, vpid=541
17:57:26.058 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
17:57:26.058 - demux: ProgDemux
17:57:26.073 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
17:57:26.074 - Prereader::ReaderCursor.. OK
17:57:26.074 - ReaderCursor::SetPosition 0 (w=1333913762922496)
17:57:26.074 - Prereader.StartPlayback Push buffering=0 recv=0C876140 [StartChannelHelperBase(sl)]
17:57:26.074 - Prereader.StartPlayback after lock
17:57:26.074 - PreScanner.StartPmtParserIfNeed
17:57:26.075 - PlayTimePmtParser::OpenParser SID=414 PMT=540 unknow channel=0
17:57:26.075 - Open TSTS filter pid=540 data=2
17:57:26.075 - TSTS cur size=310576
17:57:26.078 - VideoParser::First packet 19282 h.264
17:57:26.079 - AudioParser::First packet 288
17:57:26.079 - AudioParser::packet 288
17:57:26.079 - AudioParser::MPG12 detected
17:57:26.079 - VideoParser::packet 39152
17:57:26.080 - VideoParser::packet 75569
17:57:26.080 - VideoParser::packet 99787
17:57:26.080 - VideoParser::packet 123382
17:57:26.081 - VideoParser::packet 162601
17:57:26.081 - VideoParser::packet 188922
17:57:26.082 - VideoParser::packet 215931
17:57:26.089 - VideoParser::packet 297127
17:57:26.089 - h264 detected 16 ms
17:57:26.090 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
17:57:26.090 - PreScanner.Post_InitRender [ReceiveTraffic]
17:57:26.090 - [102]sm: TvInitRenderer 1
17:57:26.091 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
17:57:26.091 - CalculBufferingSize prov=096E07E4 marker=1 request=1
17:57:26.091 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
17:57:26.092 - Prereader::ReaderCursor.. OK
17:57:26.092 - ReaderCursor::SetPosition 0 (w=1404162248015872)
17:57:26.092 - Prereader.StartPlayback Pull buffering=0 recv=00000000 [EnablePullModeAndStartPlayback]
17:57:26.093 - Prereader.StartPlayback after lock
17:57:26.093 - ------sGetVideoParams
17:57:26.094 - ChannelGraph5.CreateInterfacesAndRenderGraph
17:57:26.100 - subsm.StartChannel demux=ProgDemux tr=TS
17:57:26.100 - subsm.RecreateSubtitlesParsers 096B6008 ts=1 subindex=-1
17:57:26.101 - subsm.Set Teletext parser 0
17:57:26.101 - subsm.RecreateSubtitlesParsers end
17:57:26.101 - subs: OnSetChannel
17:57:26.101 - CreateCustomGraph
17:57:26.102 - VideoType:H.264/AVC ffmpeg=0
17:57:26.102 - Video/4.H264 : MPEG2_VIDEO s={0,0,1920,1080}, t={0,0,1920,1080}, bmp=1920x1088, r=30/17, br=0,frametime=40ms, IF=0x0, CF=0x0)
17:57:26.102 - Add video codec 04fe9017-f873-410e-871e-ab91661a4ef7
17:57:26.135 - OK
17:57:26.135 - CChannelGraph5::CreateRender 10
17:57:26.136 - VR: EVR Custom
17:57:26.136 - VR: create new render
17:57:26.315 - VR: Add video renderer Video Renderer - OK
17:57:26.316 - CreateAudioPartOfGraph
17:57:26.316 - AudioType:MPG 
17:57:26.317 - Audio/MPEG1AudioPayload : WaveFormatEx (2ch 48000 0bit formatTag= 0x50)
17:57:26.320 - Add audio codec e1f1a0b8-beee-490d-ba7c-066c40b5e2b9 - OK
17:57:26.335 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
17:57:26.336 - Added audio renderer
17:57:26.336 - AP: created
17:57:26.337 - Added audio processor
17:57:26.340 - Connect codec to AP - OK
17:57:26.344 - Add and connect audio renderer - OK
17:57:26.345 - Graph::AfterRender
17:57:26.345 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
17:57:26.345 - AV:UpdateAudioParamsAfterActive
17:57:26.346 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
17:57:26.346 - GR:UpdateAudioProcessor old=1 new=0
17:57:26.346 - Destroy Audio Processor udate
17:57:26.347 - Graph::SetVolume 45% -1440db
17:57:26.349 - Graph::SetAudioChannelMask
17:57:26.349 - Graph::Run
17:57:26.693 - Graph::Run 1
17:57:26.694 - Graph::SetPictureParams
17:57:26.694 - Graph::SetVideoRect {24 16 1896 1068}
17:57:26.695 - Graph::SetVideoWindowRect {34 0 644 346}
17:57:26.705 - CChannelGraph5::HideSubtitles
17:57:26.765 - 
17:57:26.765 - [0]########################### Mark of finish channel changing. (1.170ms) #############
17:57:26.765 - 
17:57:26.855 - * s:100 q:100 tr=884164 (0) Playing
17:57:27.630 - changed ratio to 1920/1080
17:57:27.631 - Graph::SetVideoRect {24 16 1896 1068}
17:57:27.631 - Graph::SetVideoWindowRect {30 0 648 346}
17:57:27.903 - * s:100 q:100 tr=784336 (0) Playing
17:57:28.252 - 
17:57:28.252 - [0]########################### First video frame. (2.667ms) #############
17:57:28.253 - 
17:57:28.880 - * s:100 q:100 tr=735644 (0) Playing
17:57:29.885 - * s:100 q:100 tr=751812 (0) Playing
17:57:31.132 - * s:100 q:100 tr=931540 (0) Playing
17:57:31.914 - * s:100 q:100 tr=588440 (0) Playing
17:57:33.859 - * s:100 q:100 tr=1442524 (0) Playing
17:57:35.405 - * s:100 q:100 tr=1160336 (0) Playing
17:57:35.969 - * s:100 q:100 tr=425068 (0) Playing
17:57:36.997 - * s:100 q:100 tr=768168 (0) Playing
17:57:38.004 - * s:100 q:100 tr=757640 (0) Playing
17:57:39.016 - * s:100 q:100 tr=751812 (0) Playing
17:57:40.027 - * s:100 q:100 tr=751812 (0) Playing
17:57:41.043 - * s:100 q:100 tr=768168 (0) Playing
17:57:42.057 - * s:100 q:100 tr=755008 (0) Playing
17:57:43.239 - * s:100 q:100 tr=882472 (0) Playing
17:57:44.082 - * s:100 q:100 tr=637508 (0) Playing
17:57:45.107 - * s:100 q:100 tr=751812 (0) Playing
17:57:46.218 - * s:100 q:100 tr=833592 (0) Playing
17:57:47.133 - * s:100 q:100 tr=686388 (0) Playing
17:57:48.138 - * s:100 q:100 tr=751812 (0) Playing
17:57:48.870 - 
17:57:48.871 - 
17:57:48.871 - ########################### Mark of start channel changing.###########################
17:57:48.871 - 
17:57:48.872 - GraphManager::MainChangeChannel Rotana Classic  1 provs
17:57:48.872 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
17:57:48.872 - SetChannelLogic::SetChannel 0
17:57:48.872 - SetChannelLogic::SetNormalChannel
17:57:48.873 - ChannelGraph5::StopChannel Rotana Classic
17:57:48.873 - PreScanner.Stop
17:57:48.873 - GraphState: Undef by PreScanner.Stop
17:57:48.874 - PlayTimePmtParser::StopParser
17:57:48.874 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
17:57:48.874 - Prereader::ReaderCursor.. OK
17:57:48.882 - ReaderCursor::SetPosition 0 (w=74536065045626880)
17:57:48.882 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
17:57:48.882 - Prereader.StartPlayback after lock
17:57:48.882 - subsm.StopChannel
17:57:48.883 - Graph::Stop
17:57:48.890 - Before Stop ...17:57:48.890 - OnGraphStop ...17:57:48.899 - VR: Disconnect
17:57:48.911 - Graph::ReleaseAllFilters
17:57:48.911 - release: Prog Audio renderer - RR - OK.
17:57:48.919 - release: Video Renderer - RR - OK.
17:57:48.942 - release: Video decoder  - RR - OK.
17:57:48.978 - release: Audio Processor - RR - OK.
17:57:48.979 - release: Microsoft DTV-DVD Audio Decoder - RR - OK.
17:57:48.980 - FilterGraph: 1
17:57:48.981 - 
17:57:48.982 - TransponderManager::SetTransponder (CH) 11843000 Rotana Classic
17:57:48.982 - *Transport TS
17:57:48.982 - Api2Device::SetChannel http://192.168.159.2:10999/id/8001BCB1.0104000300B4B5B8.0838
17:57:48.986 - Api2Device::SetChannel result OK
17:57:48.987 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=2104
17:57:48.987 - TsInputTrafficProcessor.OpenTransponder 1
17:57:48.987 - FilterManager::OnSetTransponder SetChannel
17:57:48.987 - TimeShift.Reset
17:57:48.988 - TimeShift.Cursor reset
17:57:48.988 - ReaderCursor::Reset.. OK
17:57:48.988 - Prereader.Reset ...-OK
17:57:48.989 - ModuleList::ChangeChannel 11843000
17:57:48.989 - [102]ChannelGraph5::StartChannel Rotana Classic
17:57:48.989 - Api2BaseModule.OnTunerStateChanged Connecting
17:57:48.989 - 
17:57:48.990 - [102]       #################### Start stream. (0.109ms) #######################
17:57:48.990 - 
17:57:48.992 - Api2BaseModule.OnTunerStateChanged Preparing
17:57:48.992 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
17:57:48.993 - TimeShift.Cursor SetChannel::v 0 (0)
17:57:48.993 - ReaderCursor::SetChannel.. OK
17:57:48.993 - ReaderCursor::SetPosition 0 (w=0)
17:57:48.993 - Prereader.SetChannel..
17:57:48.994 - Prereader.SetChannel unmask 1
17:57:48.994 - Plugin::SetChannel 2104
17:57:48.994 - TransponderManager::SelectChannel
17:57:48.994 - TsInputTrafficProcessor.SelectChannel 2104
17:57:48.994 - Api2BaseModule.UpdateAllOpenedChannels 1
17:57:48.995 - Api2BaseModule::CloseFilter 1 pid 18
17:57:48.995 - Api2BaseModule::CloseFilter 2 pid 541
17:57:48.995 - Api2BaseModule::CloseFilter 3 pid 540
17:57:48.996 - Api2BaseModule::CloseFilter 4 pid 542
17:57:48.996 - Api2BaseModule::CloseFilter 5 pid 0
17:57:48.997 - Api2BaseModule::GetCurrentDeviceInfo
17:57:48.997 - Api2BaseModule::OpenFilter 18 OK
17:57:48.997 - Api2BaseModule::OpenFilter 683 OK
17:57:48.998 - Api2BaseModule::OpenFilter 109 OK
17:57:48.998 - Api2BaseModule::OpenFilter 5614 OK
17:57:48.999 - Api2BaseModule::OpenFilter 0 OK
17:57:48.999 - TsInputTrafficProcessor.UpdateChannel 2104
17:57:48.999 - GraphState: Undef by StartChannelIsReady
17:57:48.999 - PreScanner.StartChannelIsReady net=1 parseall=1
17:57:48.999 - VideoMediaTypeDetection: h.264
17:57:48.999 - SetMarkerAudioLngStream Gen New stream
17:57:49.000 - SimpleTsDemux::Init apid=5614, vpid=683
17:57:49.076 - GraphState: RequestPATScan by StartChannelIsReady TS
17:57:49.076 - Api2BaseModule.Filters_EnabledFullTS 1
17:57:49.077 - PlayTimePATParser.OpenParser 2104
17:57:49.077 - Open TSTS filter pid=0 data=0
17:57:49.077 - TSTS cur size=0
17:57:49.077 - Graph::UpdateRenderMode
17:57:49.078 - Graph::SetVideoRect {8 8 712 568}
17:57:49.078 - Graph::SetVideoWindowRect {30 0 648 346}
17:57:49.078 - [102]OnChangeCurrentGraph2 -endOfSetChannel
17:57:49.078 - ChannelGraph5.SetActiveState 1
17:57:49.084 - OK. 102
17:57:49.152 - * s:0 q:0 tr=0 (0) Connecting
17:57:49.211 - Api2BaseModule.OnTunerStateChanged Playing
17:57:50.166 - * s:0 q:0 tr=0 (0) Preparing
17:57:50.327 - OSDManager::Window_Add
17:57:50.327 - OSDManager::Window_Show
17:57:50.336 - OSDManager::Window_Show
17:57:50.337 - OSDManager::Window_Show
17:57:50.349 - TransportMarker: TS
17:57:50.350 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
17:57:50.350 - 
17:57:50.350 -        #################### First traffic. (1.466ms) #######################
17:57:50.350 - 
17:57:50.375 - PlayTimePATParser.EndTask
17:57:50.451 - --SwitchEngineTransport TS > TS
17:57:50.451 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
17:57:50.451 - PreScanner.OnTransportMarker TS
17:57:50.451 - --SwitchEngineTransport end
17:57:50.452 - PreScanner.OnAfterScanPat count=2 {2104;109}
17:57:50.452 - Api2BaseModule.Filters_EnabledFullTS 0
17:57:50.452 - GraphState: RequestPMTScan by OnAfterScanPat
17:57:50.452 - PlayTimePmtParser::OpenParser SID=2104 PMT=109 unknow channel=1
17:57:50.452 - Open TSTS filter pid=109 data=2
17:57:50.453 - TSTS cur size=51136
17:57:50.455 - OSDManager::Window_Show
17:57:50.491 - PreScanner.OnAfterScanPmt pmt=109
17:57:50.491 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
17:57:50.491 - PlayTimePmtParser::StopParser
17:57:50.493 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
17:57:50.493 - TimeShift.Cursor SetChannel::v 71064 (71064)
17:57:50.493 - Prereader.SetChannel unmask 1
17:57:50.493 - Plugin::SetChannel 2104
17:57:50.493 - TransponderManager::SelectChannel
17:57:50.493 - TsInputTrafficProcessor.SelectChannel 2104
17:57:50.493 - Api2BaseModule.UpdateAllOpenedChannels 1
17:57:50.494 - Api2BaseModule::CloseFilter 1 pid 18
17:57:50.494 - Api2BaseModule::CloseFilter 2 pid 683
17:57:50.495 - Api2BaseModule::CloseFilter 3 pid 109
17:57:50.495 - Api2BaseModule::CloseFilter 4 pid 5614
17:57:50.495 - Api2BaseModule::CloseFilter 5 pid 0
17:57:50.496 - Api2BaseModule::GetCurrentDeviceInfo
17:57:50.496 - Api2BaseModule::OpenFilter 18 OK
17:57:50.497 - Api2BaseModule::OpenFilter 683 OK
17:57:50.497 - Api2BaseModule::OpenFilter 109 OK
17:57:50.497 - Api2BaseModule::OpenFilter 5614 OK
17:57:50.498 - Api2BaseModule::OpenFilter 0 OK
17:57:50.498 - TsInputTrafficProcessor.UpdateChannel 2104
17:57:50.498 - PreScanner.StartChannelIsReady net=1 parseall=0
17:57:50.498 - LngDefaultSelector.try select audio pid=5614 type=1 lng=6778469-eng(deu,deu,rus) l=99
17:57:50.498 - ChannelGraph5::AfterDetectChannelParams
17:57:50.499 - VideoMediaTypeDetection: mpeg2
17:57:50.499 - SimpleTsDemux::Init apid=5614, vpid=683
17:57:50.499 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
17:57:50.499 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
17:57:50.499 - Prereader::ReaderCursor.. OK
17:57:50.500 - ReaderCursor::SetPosition 0 (w=315714455994368)
17:57:50.500 - Prereader.StartPlayback Push buffering=0 recv=0C876140 [StartChannelHelperBase(sl)]
17:57:50.500 - Prereader.StartPlayback after lock
17:57:50.500 - PreScanner.StartPmtParserIfNeed
17:57:50.500 - PlayTimePmtParser::OpenParser SID=2104 PMT=109 unknow channel=0
17:57:50.500 - Open TSTS filter pid=109 data=2
17:57:50.500 - TSTS cur size=73508
17:57:50.502 - VideoParser::First packet 37311 mpeg2
17:57:50.502 - VideoParser::packet 50476
17:57:50.502 - AudioParser::First packet 1920
17:57:50.502 - Audio detection conflict!!! AAC and MPG12 detected. Selected MPG12
17:57:50.503 - AudioParser::MPG12 detected
17:57:50.503 - VideoParser::packet 64022
17:57:50.531 - VideoParser::packet 76741
17:57:50.623 - VideoParser::packet 118621
17:57:50.624 - VideoParser::mpeg2::Sequence header detected. len76
17:57:50.624 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
17:57:50.624 - PreScanner.Post_InitRender [ReceiveTraffic]
17:57:50.624 - [102]sm: TvInitRenderer 1
17:57:50.625 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
17:57:50.625 - CalculBufferingSize prov=096E07E4 marker=1 request=1
17:57:50.625 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
17:57:50.625 - Prereader::ReaderCursor.. OK
17:57:50.626 - ReaderCursor::SetPosition 0 (w=577329503928320)
17:57:50.626 - Prereader.StartPlayback Pull buffering=0 recv=00000000 [EnablePullModeAndStartPlayback]
17:57:50.626 - Prereader.StartPlayback after lock
17:57:50.626 - ------sGetVideoParams
17:57:50.626 - ChannelGraph5.CreateInterfacesAndRenderGraph
17:57:50.631 - subsm.StartChannel demux=ProgDemux tr=TS
17:57:50.631 - subsm.RecreateSubtitlesParsers 096B6008 ts=1 subindex=-1
17:57:50.631 - subsm.Set Teletext parser 0
17:57:50.631 - subsm.RecreateSubtitlesParsers end
17:57:50.631 - subs: OnSetChannel
17:57:50.632 - CreateCustomGraph
17:57:50.632 - VideoType:MPEG2 ffmpeg=0
17:57:50.632 - Video/MPEG2_VIDEO : MPEG2_VIDEO s={0,0,720,576}, t={0,0,720,576}, bmp=720x576, r=4/3, br=15305200,frametime=40ms, IF=0x0, CF=0x0)
17:57:50.632 - Add video codec 04fe9017-f873-410e-871e-ab91661a4ef7
17:57:50.639 - Pin for connection not found! 0x80040207
17:57:50.639 - CChannelGraph5::CreateRender 10
17:57:50.639 - VR: EVR Custom
17:57:50.640 - VR: create new render
17:57:51.138 - Video pin founded. Try to founded any good codec... OK.
17:57:51.138 - CreateAudioPartOfGraph
17:57:51.138 - AudioType:MPG 
17:57:51.138 - Audio/MPEG1AudioPayload : WaveFormatEx (2ch 48000 0bit formatTag= 0x50)
17:57:51.140 - Add audio codec e1f1a0b8-beee-490d-ba7c-066c40b5e2b9 - OK
17:57:51.150 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
17:57:51.151 - Added audio renderer
17:57:51.151 - AP: created
17:57:51.152 - Added audio processor
17:57:51.154 - Connect codec to AP - OK
17:57:51.158 - Add and connect audio renderer - OK
17:57:51.159 - Graph::AfterRender
17:57:51.159 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
17:57:51.159 - AV:UpdateAudioParamsAfterActive
17:57:51.159 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
17:57:51.159 - GR:UpdateAudioProcessor old=1 new=0
17:57:51.160 - Destroy Audio Processor udate
17:57:51.160 - Graph::SetVolume 45% -1440db
17:57:51.161 - Graph::SetAudioChannelMask
17:57:51.161 - Graph::Run
17:57:51.293 - Graph::Run 1
17:57:51.293 - Graph::SetPictureParams
17:57:51.293 - Graph::SetVideoRect {8 8 712 568}
17:57:51.293 - Graph::SetVideoWindowRect {108 0 569 346}
17:57:51.313 - CChannelGraph5::HideSubtitles
17:57:51.315 - * s:100 q:100 tr=475452 (0) Playing
17:57:51.358 - 
17:57:51.358 - [0]########################### Mark of finish channel changing. (2.480ms) #############
17:57:51.358 - 
17:57:51.491 - 
17:57:51.491 - [0]########################### First video frame. (2.621ms) #############
17:57:51.491 - 
17:57:52.198 - * s:100 q:100 tr=432964 (0) Playing
17:57:53.222 - * s:100 q:100 tr=504404 (0) Playing
17:57:54.223 - * s:100 q:100 tr=490868 (0) Playing
17:57:55.240 - * s:100 q:100 tr=498952 (0) Playing
17:57:55.681 - ChannelGraph5.SetRatio c87ffff
17:57:55.681 - Graph::SetVideoRect {8 8 712 568}
17:57:55.681 - Graph::SetVideoWindowRect {0 0 678 346}
17:57:55.682 - Graph::SetVideoRect {8 8 712 568}
17:57:55.682 - Graph::SetVideoWindowRect {0 0 678 346}
17:57:56.261 - * s:100 q:100 tr=498012 (0) Playing
17:57:56.544 - Graph::SetVideoWindowRect {0 0 911 490}
17:57:56.545 - Graph::SetVideoWindowRect {0 0 200 100}
17:57:56.546 - Graph::SetVideoWindowRect {0 0 911 490}
17:57:56.651 - Graph::SetVideoWindowRect {0 0 911 512}
17:57:57.264 - OSDManager::Window_Show
17:57:57.265 - OSDManager::Window_Delete
17:57:57.268 - * s:100 q:100 tr=499892 (0) Playing
17:57:57.387 - Graph::SetVideoWindowRect {0 0 911 490}
17:57:57.389 - Graph::SetVideoWindowRect {0 0 678 368}
17:57:57.390 - Graph::SetVideoWindowRect {0 0 678 346}
17:57:57.395 - Graph::SetVideoWindowRect {0 0 678 368}
17:57:57.441 - Graph::SetVideoWindowRect {0 0 678 346}
17:57:58.283 - * s:100 q:100 tr=494816 (0) Playing
17:57:59.292 - * s:100 q:100 tr=497448 (0) Playing
17:58:00.306 - * s:100 q:100 tr=500268 (0) Playing
17:58:01.320 - * s:100 q:100 tr=497824 (0) Playing
17:58:02.337 - * s:100 q:100 tr=497448 (0) Playing
17:58:03.357 - * s:100 q:100 tr=499516 (0) Playing
17:58:04.373 - * s:100 q:100 tr=502712 (0) Playing
17:58:05.378 - * s:100 q:100 tr=492936 (0) Playing
17:58:06.398 - * s:100 q:100 tr=497072 (0) Playing
17:58:07.405 - * s:100 q:100 tr=500456 (0) Playing
17:58:08.418 - * s:100 q:100 tr=497448 (0) Playing
17:58:09.432 - * s:100 q:100 tr=497448 (0) Playing
17:58:10.449 - * s:100 q:100 tr=497260 (0) Playing
17:58:11.460 - * s:100 q:100 tr=498012 (0) Playing
17:58:12.484 - * s:100 q:100 tr=497824 (0) Playing
17:58:13.489 - * s:100 q:100 tr=499892 (0) Playing
17:58:13.851 - 
17:58:13.851 - Stop engine
17:58:13.851 - DevicesManager::Stop
17:58:13.851 - ChannelGraph5::StopChannel 
17:58:13.851 - PreScanner.Stop
17:58:13.852 - GraphState: Undef by PreScanner.Stop
17:58:13.852 - PlayTimePmtParser::StopParser
17:58:13.852 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
17:58:13.852 - Prereader::ReaderCursor.. OK
17:58:13.853 - ReaderCursor::SetPosition 0 (w=48811392785973248)
17:58:13.853 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
17:58:13.853 - Prereader.StartPlayback after lock
17:58:13.853 - subsm.StopChannel
17:58:13.853 - Graph::Stop
17:58:13.860 - Before Stop ...17:58:13.860 - OnGraphStop ...17:58:13.866 - VR: Disconnect
17:58:13.892 - Graph::ReleaseAllFilters
17:58:13.893 - release: Prog Audio renderer - RR - OK.
17:58:13.900 - release: Video Renderer - RR - OK.
17:58:13.910 - release: NVIDIA Video Decoder - RR - OK.
17:58:13.911 - release: Audio Processor - RR - OK.
17:58:13.912 - release: Microsoft DTV-DVD Audio Decoder - RR - OK.
17:58:13.913 - FilterGraph: 1
17:58:13.915 - ChannelGraph5.~CChannelGraph5
17:58:13.915 - PreScanner.Stop
17:58:13.915 - GraphState: Undef by PreScanner.Stop
17:58:13.916 - PlayTimePmtParser::StopParser
17:58:13.916 - subsm.StopChannel
17:58:13.916 - Graph::ReleaseAllFilters
17:58:13.921 - ChannelGraph5.~CChannelGraph5 finish
17:58:13.930 - TransponderManager::CloseChannel
17:58:13.930 - TsInputTrafficProcessor.RemoveChannel 2104
17:58:13.931 - ~TransponderChannelSource
17:58:13.932 - TimeShift.DestroyReadingCursor
17:58:13.933 - Prereader.Exit17:58:13.934 - Api2BaseModule.UpdateAllOpenedChannels 0
17:58:13.934 - Api2BaseModule::CloseFilter 1 pid 18
17:58:13.935 - Api2BaseModule::CloseFilter 2 pid 683
17:58:13.935 - Api2BaseModule::CloseFilter 3 pid 109
17:58:13.936 - Api2BaseModule::CloseFilter 4 pid 5614
17:58:13.936 - Api2BaseModule::CloseFilter 5 pid 0
17:58:13.937 - Api2BaseModule::GetCurrentDeviceInfo
17:58:13.937 - Destroy TSTS filter pid=0
17:58:13.937 - PlayTimePmtParser::StopParser
17:58:13.937 - Destroy TSTS filter pid=109
17:58:13.937 - DevicesManager::DestroyTransponderManager
17:58:13.938 - Api2Device::SetChannel - None
17:58:13.938 - skip old generation traffic!
17:58:13.941 - Api2Device::SetChannel result OK
17:58:13.941 - SetOwner N -> 0
17:58:13.942 - SetOwner SetTransponder null
17:58:13.942 - ~TransponderManager
17:58:13.942 - SetOwner N -> 0
17:58:13.942 - SetOwner SetTransponder null
17:58:13.945 - TimeShift.~TimeShift
17:58:13.945 - HugeMemoryBlocksManager::Free
17:58:13.946 - ModuleList::Free
17:58:13.966 - DevicesManager::Free devices
17:58:13.966 - SDP:Destroy netclient.0 own=00000000
17:58:13.967 - SDP:after destroy device
17:58:13.967 - DevicesManager::Free RC
17:58:13.968 - Engine stopped
17:58:13.969 - 
17:58:13.969 - Stop engine
17:58:13.969 - DevicesManager::Stop
17:58:13.969 - DevicesManager::Free devices
17:58:13.970 - Engine stopped
17:58:14.027 - HugeMemoryBlocksManager::FreeAll
