﻿14:51:04.871 - Start logging...
14:51:04.874 - ExceptionFilter::Init. restart=1
14:51:07.035 - DevicesManager::EnableCISupport
14:51:07.035 - CAVManager::SetSettings
14:51:07.035 - DevicesManager::DestroyAllTransponderManager
14:51:07.061 - SetDefaultNullCodecs
14:51:07.102 - IsWin8WithoutMpeg2Codecs 0
14:51:07.102 - IsWin8WithoutMpeg2Codecs 1
14:51:07.102 - IsWin8WithoutMpeg2Codecs 3
14:51:07.171 - SetDefaultNullCodecs
14:51:07.199 - IsWin8WithoutMpeg2Codecs 0
14:51:07.199 - IsWin8WithoutMpeg2Codecs 1
14:51:07.199 - IsWin8WithoutMpeg2Codecs 3
14:51:07.247 - DevicesManager::Start
14:51:07.247 - AVManager::Init
14:51:07.249 - VR: GUI
14:51:07.251 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
14:51:07.269 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
14:51:07.269 - AV:UpdateAudioParamsAfterActive
14:51:07.269 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
14:51:07.269 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
14:51:07.319 - DevicesManager::StartDevices...
14:51:07.319 - device bda.2002 14:51:07.985 - dev: Created  bda.7d2 0163D238
OK
14:51:07.985 - device bda.2003 14:51:08.626 - dev: Created  bda.7d3 0163D2F0
OK
14:51:08.626 - device netclient.0 14:51:08.628 - dev: Created  netclient.0 0BF59598
OK
14:51:08.629 - Api2BaseModule.GetAdditionInfo
14:51:08.629 - Api2BaseModule.GetAdditionInfo
14:51:08.629 - Api2BaseModule.GetAdditionInfo
14:51:08.860 - 
14:51:08.860 - 
14:51:08.860 - ########################### Mark of start channel changing.###########################
14:51:08.860 - 
14:51:08.860 - GraphManager::MainChangeChannel Ani  1 provs
14:51:08.860 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
14:51:08.860 - SetChannelLogic::SetChannel 0
14:51:08.861 - SetChannelLogic::SetNormalChannel
14:51:08.861 - DevicesManager::CreateCloneDevice
14:51:08.861 - DevicesManager::CreateCloneDevice OK - founded in list
14:51:08.861 - TransponderManager
14:51:08.861 - CTransponderManager::InitOnNewDevice 0BE95FF4
14:51:08.861 - SetOwner N -> Incoming Stream Cache
14:51:08.861 - TrafficProcessingScheme_CreateForNewEngineTransport 1 ss=0
14:51:08.862 - Normal TsInputTrafficProcessor.
14:51:08.862 - FilterManager::InitOnNewDevice 1
14:51:08.862 - TS router+MarkerFinder -> InputTrafficProcessor
14:51:08.863 - Incoming Stream Cache -> TS router+MarkerFinder
14:51:08.863 - InputTrafficProcessor -> Router to timeshift
14:51:08.863 - InputTrafficProcessor(FM) -> FilterManager
14:51:08.863 - ModuleList::Free
14:51:08.863 - Api2BaseModule::GetCurrentDeviceInfo
14:51:08.864 - ModuleList::Load C:\Program Files (x86)\ProgDVB Professional\Modules\PidRecorder.module OK
14:51:08.864 - Api2BaseModule::GetCurrentDeviceInfo
14:51:08.865 - ModuleList::Load C:\Program Files (x86)\ProgDVB Professional\Modules\ProgMediaServer.Module OK
14:51:08.865 - ChannelGraph5.CChannelGraph5
14:51:08.865 - TransponderManager::AddChildChannel
14:51:08.865 - TimeShift.TimeShift
14:51:08.865 - TimeShift.Create 40 mbytes 
14:51:08.866 - ts:Disabled
14:51:08.866 - HugeMemoryBlocksManager::GetBlock 40 mbytes OK
14:51:08.866 - TransponderManager::CreateTimeshiftBuffer OK
14:51:08.869 - TimeShift.CreateReadingCursor
14:51:08.869 - TransponderChannelSource.Plugins 0BDB3AB8 csa 00000000
14:51:08.869 - TsInputTrafficProcessor.AddChannel 0
14:51:08.870 - SetChannelLogic::LookDeviceWithoutChannelsOrCloneAndMakeGraph
14:51:08.870 - ChannelGraph5.SetActiveState 1
14:51:08.870 - TransponderManager::SelectChannel
14:51:08.871 - TsInputTrafficProcessor.SelectChannel 0
14:51:08.871 - Api2BaseModule.UpdateAllOpenedChannels 0
14:51:08.871 - AV:UpdateAudioParamsAfterActive
14:51:08.871 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
14:51:08.871 - Graph::SetAudioChannelMask
14:51:08.871 - 
14:51:08.871 - TransponderManager::SetTransponder (CH) 0 Ani
14:51:08.871 - *Transport TS
14:51:08.871 - Api2Device::SetChannel http://192.168.1.5:7181/play/aHR0cDovL3phYmF2YS1odGxpdmUuY2RuLm5nZW5peC5uZXQvaGxzL0NIX0FOSS9idzIwMDAwMDAvdmFyaWFudC5tM3U4/
14:51:08.872 - Api2Device::SetChannel result OK
14:51:08.873 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
14:51:08.873 - TsInputTrafficProcessor.OpenTransponder 1
14:51:08.873 - Api2BaseModule.OnTunerStateChanged Connecting
14:51:08.873 - FilterManager::OnSetTransponder SetChannel
14:51:08.873 - TimeShift.Reset
14:51:08.873 - TimeShift.Cursor reset
14:51:08.873 - ReaderCursor::Reset.. OK
14:51:08.873 - Prereader.Reset ...-OK
14:51:08.874 - Create EPGparser on SetChannel
14:51:08.874 - DvbEpgParser::SetChannel ID=7b640002.425fb783fa949893.1
14:51:08.874 - DvbEpgParser::mode normal pos=0
14:51:08.874 - ModuleList::ChangeChannel 0
14:51:08.875 - Api2BaseModule.OnTunerStateChanged Preparing
14:51:08.883 - Api2BaseModule::GetCurrentDeviceInfo
14:51:08.885 - Api2BaseModule::GetCurrentDeviceInfo
14:51:08.885 - CChannelGraph5::StartChannel Ani
14:51:08.885 - 
14:51:08.885 -        #################### Start stream. (0.016ms) #######################
14:51:08.885 - 
14:51:08.886 - TimeShift.Cursor SetChannel pidmask=0F7F7664 first=1
14:51:08.887 - TimeShift.Cursor SetChannel::v 0 (0)
14:51:08.887 - ReaderCursor::SetChannel.. OK
14:51:08.887 - ReaderCursor::SetPosition 0 (w=0)
14:51:08.887 - Prereader.SetChannel..
14:51:08.887 - PMT convertor
14:51:08.887 - Prereader.SetChannel mask. SimplePatPmtConvertor
14:51:08.887 - PPC.by mask. onlyV1A=0 No change PMT ,0,100,101,110
14:51:08.887 - Plugin::SetChannel 1
14:51:08.887 - TransponderManager::SelectChannel
14:51:08.887 - TsInputTrafficProcessor.SelectChannel 1
14:51:08.888 - Api2BaseModule.UpdateAllOpenedChannels 1
14:51:08.888 - Api2BaseModule::GetCurrentDeviceInfo
14:51:08.888 - Api2BaseModule::OpenFilter 18 OK
14:51:08.888 - Api2BaseModule::OpenFilter 101 OK
14:51:08.888 - Api2BaseModule::OpenFilter 100 OK
14:51:08.889 - Api2BaseModule::OpenFilter 110 OK
14:51:08.889 - Api2BaseModule::OpenFilter 0 OK
14:51:08.889 - TsInputTrafficProcessor.UpdateChannel 1
14:51:08.889 - GraphState: Undef by StartChannelIsReady
14:51:08.889 - PreScanner.StartChannelIsReady net=1 parseall=1
14:51:08.889 - VideoMediaTypeDetection: h.264
14:51:08.889 - SetMarkerAudioLngStream Gen New stream
14:51:08.890 - SimpleTsDemux::Init apid=110, vpid=101
14:51:08.890 - GraphState: RequestPATScan by StartChannelIsReady TS
14:51:08.890 - Api2BaseModule.Filters_EnabledFullTS 1
14:51:08.890 - PlayTimePATParser.OpenParser 1
14:51:08.890 - Open TSTS filter pid=0 data=0
14:51:08.890 - TSTS cur size=0
14:51:08.891 - ChannelGraph5.CreateGraphForOsdOnly
14:51:08.892 - CChannelGraph5::CreateRender 11
14:51:08.892 - Graph::SetVideoRect {0 0 720 576}
14:51:08.892 - ChannelGraph5.SetActiveState 1
14:51:08.894 - Graph::SetVideoWindowRect {0 0 200 100}
14:51:08.894 - Graph::UpdateRenderMode
14:51:08.895 - GraphManager::MultiChannelRendering
14:51:08.895 - ChannelGraph5.SetActiveState 1
14:51:08.915 - Graph::SetVideoWindowRect {0 0 1920 1080}
14:51:08.934 - OK. 102
14:51:08.970 - OSDManager::Window_Add
14:51:08.971 - OSDManager::Window_Show
14:51:08.980 - * s:0 q:0 tr=0 (0) Connecting
14:51:08.982 - OSDManager::Window_Show
14:51:08.987 - OSDManager::Window_Show
14:51:09.047 - OSDManager::Window_Show
14:51:09.049 - OSDManager::Window_Show
14:51:09.149 - Api2BaseModule.OnTunerStateChanged Playing
14:51:09.365 - TransportMarker: TS
14:51:09.365 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=41943040
14:51:09.365 - --SwitchEngineTransport TS > TS
14:51:09.365 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=41943040
14:51:09.365 - PreScanner.OnTransportMarker TS
14:51:09.366 - --SwitchEngineTransport end
14:51:09.366 - 
14:51:09.366 -        #################### First traffic. (0.500ms) #######################
14:51:09.366 - 
14:51:09.366 - PlayTimePATParser.EndTask
14:51:09.367 - OSDManager::Window_Show
14:51:09.367 - PreScanner.OnAfterScanPat count=2 {1;100}
14:51:09.367 - Api2BaseModule.Filters_EnabledFullTS 0
14:51:09.367 - GraphState: RequestPMTScan by OnAfterScanPat
14:51:09.367 - PlayTimePmtParser::OpenParser SID=1 PMT=100 unknow channel=1
14:51:09.368 - Open TSTS filter pid=100 data=2
14:51:09.368 - TSTS cur size=259064
14:51:09.368 - TSTS quick finish
14:51:09.368 - PreScanner.OnAfterScanPmt pmt=100
14:51:09.368 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
14:51:09.368 - PlayTimePmtParser::StopParser
14:51:09.369 - TimeShift.Cursor SetChannel pidmask=0F7F7664 first=0
14:51:09.369 - TimeShift.Cursor SetChannel::v 367916 (367916)
14:51:09.369 - Prereader.SetChannel mask. SimplePatPmtConvertor
14:51:09.369 - PPC.by mask. onlyV1A=0 No change PMT ,0,100,101,110
14:51:09.369 - Plugin::SetChannel 1
14:51:09.370 - TransponderManager::SelectChannel
14:51:09.370 - TsInputTrafficProcessor.SelectChannel 1
14:51:09.370 - Api2BaseModule.UpdateAllOpenedChannels 1
14:51:09.370 - Api2BaseModule::CloseFilter 1 pid 18
14:51:09.370 - Api2BaseModule::CloseFilter 2 pid 101
14:51:09.370 - Api2BaseModule::CloseFilter 3 pid 100
14:51:09.371 - Api2BaseModule::CloseFilter 4 pid 110
14:51:09.371 - Api2BaseModule::CloseFilter 5 pid 0
14:51:09.371 - Api2BaseModule::GetCurrentDeviceInfo
14:51:09.371 - Api2BaseModule::OpenFilter 18 OK
14:51:09.371 - Api2BaseModule::OpenFilter 101 OK
14:51:09.371 - Api2BaseModule::OpenFilter 100 OK
14:51:09.372 - Api2BaseModule::OpenFilter 110 OK
14:51:09.372 - Api2BaseModule::OpenFilter 0 OK
14:51:09.372 - TsInputTrafficProcessor.UpdateChannel 1
14:51:09.372 - PreScanner.StartChannelIsReady net=1 parseall=0
14:51:09.372 - LngDefaultSelector.try select audio pid=110 type=1 lng=7566706-rus(goh,goh,rus) l=10
14:51:09.372 - LngDefaultSelector. selected audio pid=110
14:51:09.372 - ChannelGraph5::AfterDetectChannelParams
14:51:09.373 - VideoMediaTypeDetection: h.264
14:51:09.373 - SimpleTsDemux::Init apid=110, vpid=101
14:51:09.373 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
14:51:09.373 - demux: ProgDemux
14:51:09.376 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
14:51:09.377 - Prereader::ReaderCursor.. OK
14:51:09.377 - ReaderCursor::SetPosition 0 (w=4239132721152000)
14:51:09.377 - Prereader.StartPlayback Push buffering=0 recv=0F7EDCA0 [StartChannelHelperBase(sl)]
14:51:09.377 - Prereader.StartPlayback after lock
14:51:09.377 - PreScanner.StartPmtParserIfNeed
14:51:09.378 - PlayTimePmtParser::OpenParser SID=1 PMT=100 unknow channel=0
14:51:09.378 - Open TSTS filter pid=100 data=2
14:51:09.378 - TSTS cur size=1060696
14:51:09.386 - VideoParser::First packet 13901 h.264
14:51:09.386 - h264 detected 0 ms
14:51:09.386 - AudioParser::First packet 2809
14:51:09.386 - AudioParser::AAC detected
14:51:09.387 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
14:51:09.387 - PreScanner.Post_InitRender [ReceiveTraffic]
14:51:09.387 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
14:51:09.387 - CalculBufferingSize prov=0BE97434 marker=1 request=1
14:51:09.387 - CalculBuffering 2000ms br=2000kb to 500 kbytes. By type
14:51:09.387 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
14:51:09.387 - Prereader::ReaderCursor.. OK
14:51:09.387 - ReaderCursor::SetPosition 0 (w=6835904308051968)
14:51:09.388 - Prereader.StartPlayback Pull buffering=512000 recv=00000000 [EnablePullModeAndStartPlayback]
14:51:09.388 - Prereader.StartPlayback after lock
14:51:09.388 - Buffer 1000160KB too small for buffering
14:51:09.391 - Buffering/prereader size 500/1000 kbytes
14:51:09.391 - ------sGetVideoParams
14:51:09.391 - ChannelGraph5.CreateInterfacesAndRenderGraph
14:51:09.391 - subsm.StartChannel demux=ProgDemux tr=TS
14:51:09.391 - subsm.RecreateSubtitlesParsers 0BDA6AE8 ts=1 subindex=-1
14:51:09.391 - subsm.Set Teletext parser 0
14:51:09.391 - subsm.RecreateSubtitlesParsers end
14:51:09.391 - subs: OnSetChannel
14:51:09.392 - CreateCustomGraph
14:51:09.392 - VideoType:H.264/AVC
14:51:09.392 - * s:100 q:100 tr=1612664 (1880) Preparing
14:51:09.392 - 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)
14:51:09.508 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f - OK
14:51:09.509 - CChannelGraph5::CreateRender 11
14:51:09.509 - VR: madVR
14:51:09.509 - VR: create new render
14:51:09.572 - VR: Add video renderer Video Renderer - OK
14:51:09.572 - CreateAudioPartOfGraph
14:51:09.572 - AudioType:AAC/ADTS
14:51:09.572 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 48000 16bit formatTag= 0x1600)
14:51:09.584 - Add audio codec e8e73b6b-4cb3-44a4-be99-4f7bcb96e491 - OK
14:51:09.650 - IMyGraphBuilder::CreateAudioRenderFilter::ReClock Audio Renderer OK (normal)
14:51:09.651 - AP: created
14:51:09.651 - Added audio processor
14:51:09.652 - Connect codec to AP - OK
14:51:09.661 - Add and connect audio renderer - OK
14:51:09.661 - Graph::AfterRender
14:51:09.662 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
14:51:09.662 - AV:UpdateAudioParamsAfterActive
14:51:09.662 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
14:51:09.663 - Graph::SetVolume 100% 0db
14:51:09.663 - Graph::SetAudioChannelMask
14:51:09.663 - AudioProcessor::SetAudioChannelsMask
14:51:09.663 - AudioProcessor::Equalizer_SetBands
14:51:09.663 - Graph::Run
14:51:09.682 - Graph::Run 1
14:51:09.682 - Graph::SetPictureParams
14:51:09.683 - Graph::SetVideoRect {0 0 720 540}
14:51:09.683 - Graph::SetVideoWindowRect {0 0 1920 1080}
14:51:09.684 - CChannelGraph5::HideSubtitles
14:51:09.760 - 
14:51:09.760 - ########################### Mark of finish channel changing. (0.891ms) #############
14:51:09.760 - 
14:51:09.935 - * s:100 q:100 tr=3067408 (6768) Playing
14:51:10.935 - * s:100 q:100 tr=0 (0) Playing
14:51:11.939 - * s:100 q:100 tr=0 (0) Playing
14:51:12.936 - * s:100 q:100 tr=0 (0) Playing
14:51:13.939 - * s:100 q:100 tr=0 (0) Playing
14:51:14.939 - * s:0 q:0 tr=0 (0) Playing
14:51:15.047 - OSDManager::Window_Show
14:51:15.053 - OSDManager::Window_Delete
14:51:16.052 - * s:0 q:0 tr=0 (0) Playing
14:51:17.049 - * s:100 q:100 tr=1397216 (1880) Playing
14:51:18.053 - * s:100 q:100 tr=0 (0) Playing
14:51:19.048 - * s:100 q:100 tr=0 (0) Playing
14:51:20.045 - * s:100 q:100 tr=0 (0) Playing
14:51:21.049 - * s:100 q:100 tr=0 (0) Playing
14:51:22.048 - * s:0 q:0 tr=0 (0) Playing
14:51:23.049 - * s:0 q:0 tr=0 (0) Playing
14:51:24.049 - * s:100 q:100 tr=2928288 (9776) Playing
14:51:25.050 - * s:100 q:100 tr=0 (0) Playing
14:51:25.345 - Visualization::GetList
14:51:25.456 - Visualization::GetList count=8
14:51:25.456 - Visualization::GetList
14:51:25.456 - Visualization::GetList count=8
14:51:25.456 - Visualization::GetList
14:51:25.473 - Visualization::GetList count=9
14:51:25.474 - Visualization::GetList
14:51:25.474 - Visualization::GetList count=9
14:51:25.474 - Visualization::GetList
14:51:25.474 - Visualization::GetList count=9
14:51:25.474 - Visualization::GetList
14:51:25.474 - Visualization::GetList count=9
14:51:25.475 - Visualization::GetList
14:51:25.475 - Visualization::GetList count=9
14:51:25.475 - Visualization::GetList
14:51:25.475 - Visualization::GetList count=9
14:51:25.475 - Visualization::GetList
14:51:25.476 - Visualization::GetList count=9
14:51:25.476 - Visualization::GetList
14:51:25.476 - Visualization::GetList count=9
14:51:25.476 - Visualization::GetList
14:51:25.476 - Visualization::GetList count=9
14:51:25.476 - Visualization::GetList
14:51:25.499 - Visualization::GetList count=10
14:51:26.053 - * s:100 q:100 tr=0 (0) Playing
14:51:26.734 - ChannelGraph5.~CChannelGraph5
14:51:26.734 - Graph::Stop
14:51:26.757 - Before Stop ...14:51:26.758 - OnGraphStop ...14:51:26.759 - PreScanner.Stop
14:51:26.759 - GraphState: Undef by PreScanner.Stop
14:51:26.760 - PlayTimePmtParser::StopParser
14:51:26.760 - subsm.StopChannel
14:51:26.760 - VR: Disconnect
14:51:26.784 - Graph::ReleaseAllFilters
14:51:26.784 - release: Audio Renderer - RR - OK.
14:51:26.839 - release: Video Renderer - RR - OK.
14:51:26.895 - release: Video decoder  - RR - OK.
14:51:26.898 - release: Audio Processor - RR - OK.
14:51:26.899 - release: Audio decoder - RR - OK.
14:51:26.903 - FilterGraph: 1
14:51:26.911 - ChannelGraph5.~CChannelGraph5 finish
14:51:26.911 - TransponderManager::CloseChannel
14:51:26.911 - TsInputTrafficProcessor.RemoveChannel 1
14:51:26.911 - ~TransponderChannelSource
14:51:26.912 - TimeShift.DestroyReadingCursor
14:51:26.913 - Api2BaseModule.UpdateAllOpenedChannels 0
14:51:26.913 - Api2BaseModule::CloseFilter 1 pid 18
14:51:26.913 - Api2BaseModule::CloseFilter 2 pid 101
14:51:26.914 - Api2BaseModule::CloseFilter 3 pid 100
14:51:26.914 - Api2BaseModule::CloseFilter 4 pid 110
14:51:26.914 - Api2BaseModule::CloseFilter 5 pid 0
14:51:26.915 - Api2BaseModule::GetCurrentDeviceInfo
14:51:26.915 - Destroy TSTS filter pid=0
14:51:26.915 - PlayTimePmtParser::StopParser
14:51:26.915 - Destroy TSTS filter pid=100
14:51:26.915 - DevicesManager::DestroyTransponderManager
14:51:26.915 - Api2Device::SetChannel - None
14:51:26.931 - Api2Device::SetChannel result OK
14:51:26.931 - SetOwner N -> 0
14:51:26.932 - SetOwner SetTransponder null
14:51:26.932 - ~TransponderManager
14:51:26.932 - SetOwner N -> 0
14:51:26.932 - SetOwner SetTransponder null
14:51:26.934 - TimeShift.~TimeShift
14:51:26.934 - HugeMemoryBlocksManager::Free
14:51:26.934 - ModuleList::Free
14:51:26.952 - 
14:51:26.952 - Stop engine
14:51:26.952 - DevicesManager::Stop
14:51:26.952 - DevicesManager::Free devices
14:51:26.952 - SDP:Destroy bda.7d2 own=00000000
14:51:26.955 - SDP:after destroy device
14:51:26.955 - SDP:Destroy bda.7d3 own=00000000
14:51:26.958 - SDP:after destroy device
14:51:26.958 - SDP:Destroy netclient.0 own=00000000
14:51:26.959 - SDP:after destroy device
14:51:26.959 - DevicesManager::Free RC
14:51:26.962 - Engine stopped
14:51:26.962 - 
14:51:26.962 - Stop engine
14:51:26.962 - DevicesManager::Stop
14:51:26.962 - DevicesManager::Free devices
14:51:26.963 - Engine stopped
14:51:27.002 - HugeMemoryBlocksManager::FreeAll
