﻿01:40:44.133 - Start logging...
01:40:44.133 - 
01:40:44.133 - Start engine 6.210
01:40:44.133 - ExceptionFilter::Init. restart=1
01:40:48.236 - DevicesManager::Start
01:40:48.236 - CAVManager::Init
01:40:48.440 - AV settings loaded
01:40:48.457 - VR: GUI
01:40:48.457 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
01:40:48.628 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
01:40:48.628 - AV:UpdateAudioParamsAfterActive
01:40:48.628 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
01:40:48.628 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
01:40:49.237 - DevicesManager::StartDevices...
01:40:49.237 - device bda.10102 01:40:49.689 - dev: Created  bda.2776 007D8620
OK
01:40:49.689 - device netclient.0 01:40:49.705 - dev: Created  netclient.0 00792158
OK
01:40:49.705 - Api2BaseModule.GetAdditionInfo
01:40:49.705 - Api2BaseModule.GetAdditionInfo
01:40:51.031 - 
01:40:51.031 - 
01:40:51.031 - ########################### Mark of start channel changing.###########################
01:40:51.031 - 
01:40:51.031 - GraphManager::MainChangeChannel Ностальгия  1 provs
01:40:51.031 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
01:40:51.031 - SetChannelLogic::SetChannel 0
01:40:51.031 - SetChannelLogic::SetNormalChannel
01:40:51.031 - TransponderManager
01:40:51.031 - CTransponderManager::InitOnNewDevice 0B8A39EC
01:40:51.031 - { -> Incoming Stream Cache
01:40:51.031 - TrafficProcessingScheme_CreateForNewEngineTransport 1 ss=0
01:40:51.031 - Normal TsInputTrafficProcessor.
01:40:51.031 - FilterManager::InitOnNewDevice 1
01:40:51.031 - TS router+MarkerFinder -> InputTrafficProcessor
01:40:51.031 - Incoming Stream Cache -> InputTrafficProcessor
01:40:51.031 - InputTrafficProcessor -> Router to timeshift
01:40:51.031 - InputTrafficProcessor(FM) -> FilterManager
01:40:51.031 - ModuleList::Free
01:40:51.031 - Api2BaseModule::GetCurrentDeviceInfo
01:40:51.031 - ModuleList::Load D:\Programs\ProgDVB Professional\Modules\PidRecorder.module OK
01:40:51.031 - Api2BaseModule::GetCurrentDeviceInfo
01:40:51.031 - ModuleList::Load D:\Programs\ProgDVB Professional\Modules\ProgMediaServer.Module OK
01:40:51.031 - ChannelGraph5.CChannelGraph5
01:40:51.031 - TransponderManager::AddChildChannel
01:40:51.031 - TimeShift.TimeShift
01:40:51.031 - TimeShift.Create 4200 mbytes D:\Programs\ProgDVB Professional\ts\timeshift.dat
01:40:51.031 - ts:One channel
01:40:51.062 - TransponderManager::CreateTimeshiftBuffer OK
01:40:51.265 - MDPlugin::Loaded D:\Programs\ProgDVB Professional\Plugins\ACamd.dll OK
01:40:51.701 - TimeShift.CreateReadingCursor
01:40:51.701 - TsInputTrafficProcessor.AddChannel 0
01:40:51.717 - SetChannelLogic::LookDeviceWithoutChannelsOrCloneAndMakeGraph
01:40:51.717 - ChannelGraph5.SetActiveState 1
01:40:51.717 - TransponderManager::SelectChannel
01:40:51.717 - TsInputTrafficProcessor.SelectChannel 0
01:40:51.717 - Api2BaseModule.UpdateAllOpenedChannels 0
01:40:51.717 - AV:UpdateAudioParamsAfterActive
01:40:51.717 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
01:40:51.717 - Graph::SetAudioChannelMask
01:40:51.717 - 
01:40:51.717 - TransponderManager::SetTransponder (CH) 12322000 Ностальгия
01:40:51.717 - *Transport TS
01:40:51.717 - Api2Device::SetChannel 12322000Khz sid=117
01:40:51.717 - ch:Ностальгия {freq:12322, pol:V, sr:27500}
01:40:52.544 - Api2Device::SetChannel result OK
01:40:52.544 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=117
01:40:52.544 - TsInputTrafficProcessor.OpenTransponder 1
01:40:52.544 - FilterManager::OnSetTransponder SetChannel
01:40:52.544 - TimeShift.Reset
01:40:52.544 - TimeShift.Cursor reset
01:40:52.544 - ReaderCursor::Reset.. OK
01:40:52.544 - Prereader.Reset ...-OK
01:40:52.544 - Create EPGparser on SetChannel
01:40:52.544 - DvbEpgParser::SetChannel ID=80012776.168000080bc04d0.75
01:40:52.544 - ModuleList::ChangeChannel 12322000
01:40:52.544 - CChannelGraph5::StartChannel Ностальгия
01:40:52.544 - 
01:40:52.544 -        #################### Start stream. (1.513ms) #######################
01:40:52.544 - 
01:40:52.544 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
01:40:52.544 - TimeShift.Cursor SetChannel::v 0 (0)
01:40:52.544 - ReaderCursor::SetChannel.. OK
01:40:52.544 - ReaderCursor::SetPosition 0 (w=0)
01:40:52.544 - Prereader.SetChannel..
01:40:52.544 - Prereader.SetChannel unmask 1
01:40:52.544 - Plugin::SetChannel 117
01:40:52.559 - TransponderManager::SelectChannel
01:40:52.559 - TsInputTrafficProcessor.SelectChannel 117
01:40:52.559 - Api2BaseModule.UpdateAllOpenedChannels 1
01:40:52.559 - TsInputTrafficProcessor.UpdateChannel 117
01:40:52.559 - GraphState: Undef by StartChannelIsReady
01:40:52.559 - PreScanner.StartChannelIsReady net=0 parseall=0
01:40:52.559 - LngDefaultSelector.try select audio pid=317 type=1 lng=7566706-rus(ang,ang,fro) l=10
01:40:52.559 - LngDefaultSelector. selected audio pid=317
01:40:52.559 - ChannelGraph5::AfterDetectChannelParams
01:40:52.559 - VideoMediaTypeDetection: h.264
01:40:52.559 - SetMarkerAudioLngStream Gen New stream
01:40:52.559 - SimpleTsDemux::Init apid=317, vpid=217
01:40:52.559 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
01:40:52.559 - demux: ProgDemux
01:40:52.559 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
01:40:52.559 - Prereader::ReaderCursor.. OK
01:40:52.559 - ReaderCursor::SetPosition 0 (w=0)
01:40:52.559 - Prereader.StartPlayback Push buffering=0 recv=0983A728 [StartChannelHelperBase(sl)]
01:40:52.559 - Prereader.StartPlayback after lock
01:40:52.559 - PreScanner.StartPmtParserIfNeed
01:40:52.559 - PlayTimePmtParser::OpenParser SID=117 PMT=117 unknow channel=0
01:40:52.559 - Open TSTS filter pid=117 data=2
01:40:52.559 - TSTS cur size=0
01:40:52.559 - Graph::SetVideoRect {0 0 720 576}
01:40:52.559 - ChannelGraph5.SetActiveState 1
01:40:52.559 - Graph::SetVideoWindowRect {33 0 166 100}
01:40:52.559 - Graph::UpdateRenderMode
01:40:52.575 - 
01:40:52.575 -        #################### First traffic. (1.544ms) #######################
01:40:52.575 - 
01:40:53.116 - GraphManager::MultiChannelRendering
01:40:53.116 - ChannelGraph5.SetActiveState 1
01:40:53.129 - Graph::SetVideoWindowRect {66 0 503 328}
01:40:53.142 - OK. 102
01:40:53.279 - OSDManager::Window_Add
01:40:53.279 - OSDManager::Window_Show
01:40:53.295 - * s:100 q:100 tr=5678916 (0) 
01:40:53.338 - OSDManager::Window_Show
01:40:53.339 - OSDManager::Window_Show
01:40:53.958 - OSDManager::Window_Show
01:40:53.959 - OSDManager::Window_Show
01:40:54.694 - * s:100 q:100 tr=10684416 (0) 
01:40:55.648 - Graph::SetVideoWindowRect {240 0 1680 1080}
01:40:55.659 - c:key 1
01:40:55.660 - c:key 0
01:40:55.786 - VideoParser::First packet 19512 h.264
01:40:55.800 - VideoParser::packet 25844
01:40:55.812 - VideoParser::packet 30597
01:40:55.825 - VideoParser::packet 33091
01:40:55.825 - AudioParser::First packet 3456
01:40:55.826 - AudioParser::MPG12 detected
01:40:55.826 - VideoParser::packet 34631
01:40:55.837 - VideoParser::packet 37261
01:40:55.837 - VideoParser::packet 39079
01:40:55.888 - VideoParser::packet 58444
01:40:55.938 - VideoParser::packet 76076
01:40:55.950 - VideoParser::packet 82188
01:40:55.964 - VideoParser::packet 86728
01:40:55.964 - VideoParser::packet 89658
01:40:55.975 - VideoParser::packet 91594
01:40:55.975 - VideoParser::packet 94598
01:40:55.987 - VideoParser::packet 96832
01:40:56.113 - VideoParser::packet 150290
01:40:56.114 - h264 detected 327 ms
01:40:56.114 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
01:40:56.114 - PreScanner.Post_InitRender [ReceiveTraffic]
01:40:56.114 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
01:40:56.114 - CalculBufferingSize prov=0B8A4E2C marker=0 request=0
01:40:56.114 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
01:40:56.114 - Prereader::ReaderCursor.. OK
01:40:56.115 - ReaderCursor::SetPosition 0 (w=877702336741376)
01:40:56.115 - Prereader.StartPlayback Pull buffering=0 recv=00000000 [EnablePullModeAndStartPlayback]
01:40:56.115 - Prereader.StartPlayback after lock
01:40:56.115 - ------sGetVideoParams
01:40:56.115 - ChannelGraph5.CreateInterfacesAndRenderGraph
01:40:56.116 - subsm.StartChannel demux=ProgDemux tr=TS
01:40:56.116 - subsm.RecreateSubtitlesParsers 0B8CDFF0 ts=1 subindex=-1
01:40:56.116 - subsm.Set Teletext parser 0
01:40:56.116 - subsm.RecreateSubtitlesParsers end
01:40:56.116 - subs: OnSetChannel
01:40:56.116 - CreateCustomGraph
01:40:56.116 - VideoType:H.264/AVC
01:40:56.116 - Video/4.H264 : MPEG2_VIDEO s={0,144,0,0}, t={0,144,0,0}, bmp=720x576, r=254/186, br=0,frametime=40ms, IF=0x0, CF=0x0)
01:40:56.473 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f - OK
01:40:56.473 - CChannelGraph5::CreateRender 10
01:40:56.473 - VR: EVR Custom
01:40:56.473 - VR: create new render
01:40:57.039 - VR: Add video renderer Video Renderer - OK
01:40:57.039 - CreateAudioPartOfGraph
01:40:57.039 - AudioType:MPG
01:40:57.039 - Audio/MPEG1AudioPayload : WaveFormatEx (2ch 48000 0bit formatTag= 0x50)
01:40:57.176 - Add audio codec a753a1ec-973e-4718-af8e-a3f554d45c44 - OK
01:40:57.177 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:WASAPI:5 - RX-V465 (AMD High Definition Audio Device) OK
01:40:57.177 - AP: created
01:40:57.178 - Added audio processor
01:40:57.192 - Connect codec to AP - OK
01:40:57.224 - Add and connect audio renderer - OK
01:40:57.224 - Graph::AfterRender
01:40:57.224 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
01:40:57.224 - AV:UpdateAudioParamsAfterActive
01:40:57.224 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
01:40:57.224 - Graph::SetVolume 100% 0db
01:40:57.224 - AudioProcessor::Equalizer_SetMasterVolume
01:40:57.224 - Graph::SetAudioChannelMask
01:40:57.224 - AudioProcessor::SetAudioChannelsMask
01:40:57.225 - AudioProcessor::Equalizer_SetBands
01:40:57.225 - Graph::Run
01:40:57.289 - Graph::Run 1
01:40:57.289 - Graph::SetPictureParams
01:40:57.289 - Graph::SetVideoRect {0 0 720 576}
01:40:57.289 - Graph::SetVideoWindowRect {223 0 1697 1080}
01:40:57.289 - AfterRenderInit
01:40:57.289 - ARI
01:40:57.289 - CChannelGraph5::HideSubtitles
01:40:57.298 - * s:100 q:100 tr=20021248 (0) 
01:40:57.339 - 
01:40:57.339 - ########################### Mark of finish channel changing. (6.302ms) #############
01:40:57.339 - 
01:40:58.433 - 
01:40:58.433 - ########################### First video frame. (7.394ms) #############
01:40:58.433 - 
01:40:58.817 - * s:100 q:100 tr=11646976 (0) 
01:40:59.738 - c:key 0
01:40:59.831 - * s:100 q:100 tr=7700480 (0) 
01:41:00.845 - * s:100 q:100 tr=7796736 (0) 
01:41:01.851 - OSDManager::Window_Show
01:41:01.852 - OSDManager::Window_Delete
01:41:01.864 - * s:100 q:100 tr=7796736 (0) 
01:41:02.142 - Graph::SetVolume 90% -190db
01:41:02.142 - AudioProcessor::Equalizer_SetMasterVolume
01:41:02.186 - OSDManager::Window_Add
01:41:02.186 - OSDManager::Window_Show
01:41:02.186 - OSDManager::Window_Show
01:41:02.187 - OSDManager::Window_Show
01:41:02.286 - Graph::SetVolume 80% -402db
01:41:02.286 - AudioProcessor::Equalizer_SetMasterVolume
01:41:02.286 - OSDManager::Window_Show
01:41:02.598 - Graph::SetVolume 70% -643db
01:41:02.598 - AudioProcessor::Equalizer_SetMasterVolume
01:41:02.598 - OSDManager::Window_Show
01:41:02.875 - * s:100 q:100 tr=7796736 (0) 
01:41:02.966 - Graph::SetVolume 60% -921db
01:41:02.966 - AudioProcessor::Equalizer_SetMasterVolume
01:41:02.966 - OSDManager::Window_Show
01:41:03.887 - * s:100 q:100 tr=7700480 (0) 
01:41:04.901 - * s:100 q:100 tr=7796736 (0) 
01:41:05.916 - * s:100 q:100 tr=7700480 (0) 
01:41:06.929 - * s:100 q:100 tr=7796736 (0) 
01:41:07.943 - * s:100 q:100 tr=7796736 (0) 
01:41:08.958 - * s:100 q:100 tr=7796736 (0) 
01:41:09.831 - c:key 1
01:41:09.971 - * s:100 q:100 tr=7700480 (0) 
01:41:10.977 - OSDManager::Window_Show
01:41:10.977 - OSDManager::Window_Delete
01:41:10.988 - * s:100 q:100 tr=7796736 (0) 
01:41:12.000 - * s:100 q:100 tr=7796736 (0) 
01:41:13.013 - * s:100 q:100 tr=7700480 (0) 
01:41:14.027 - * s:100 q:100 tr=7796736 (0) 
01:41:15.042 - * s:100 q:100 tr=7700480 (0) 
01:41:16.055 - * s:100 q:100 tr=7796736 (0) 
01:41:17.069 - * s:100 q:100 tr=7796736 (0) 
01:41:18.083 - * s:100 q:100 tr=7796736 (0) 
01:41:19.097 - * s:100 q:100 tr=7700480 (0) 
01:41:19.927 - c:key 0
01:41:20.111 - * s:100 q:100 tr=7796736 (0) 
01:41:21.125 - * s:100 q:100 tr=7700480 (0) 
01:41:22.139 - * s:100 q:100 tr=7796736 (0) 
01:41:23.153 - * s:100 q:100 tr=7700480 (0) 
01:41:24.167 - * s:100 q:100 tr=7796736 (0) 
01:41:25.181 - * s:100 q:100 tr=7796736 (0) 
01:41:26.195 - * s:100 q:100 tr=7796736 (0) 
01:41:27.210 - * s:100 q:100 tr=7700480 (0) 
01:41:28.225 - * s:100 q:100 tr=7796736 (0) 
01:41:29.237 - * s:100 q:100 tr=7700480 (0) 
01:41:30.041 - c:key 1
01:41:30.251 - * s:100 q:100 tr=7796736 (0) 
01:41:31.265 - * s:100 q:100 tr=7892992 (0) 
01:41:32.279 - * s:100 q:100 tr=7700480 (0) 
01:41:33.293 - * s:100 q:100 tr=7796736 (0) 
01:41:34.307 - * s:100 q:100 tr=7796736 (0) 
01:41:35.321 - * s:100 q:100 tr=7700480 (0) 
01:41:36.335 - * s:100 q:100 tr=7796736 (0) 
01:41:37.349 - * s:100 q:100 tr=7796736 (0) 
01:41:38.363 - * s:100 q:100 tr=7700480 (0) 
01:41:39.377 - * s:100 q:100 tr=7796736 (0) 
01:41:40.041 - c:key 0
01:41:40.391 - * s:100 q:100 tr=7796736 (0) 
01:41:41.405 - * s:100 q:100 tr=7700480 (0) 
01:41:42.419 - * s:100 q:100 tr=7796736 (0) 
01:41:43.433 - * s:100 q:100 tr=7796736 (0) 
01:41:44.448 - * s:100 q:100 tr=7700480 (0) 
01:41:45.462 - * s:100 q:100 tr=7796736 (0) 
01:41:46.476 - * s:100 q:100 tr=7796736 (0) 
01:41:47.491 - * s:100 q:100 tr=7796736 (0) 
01:41:48.503 - * s:100 q:100 tr=7700480 (0) 
01:41:49.517 - * s:100 q:100 tr=7796736 (0) 
01:41:49.803 - c:key 1
01:41:50.531 - * s:100 q:100 tr=7700480 (0) 
01:41:51.545 - * s:100 q:100 tr=7796736 (0) 
01:41:52.559 - * s:100 q:100 tr=7796736 (0) 
01:41:53.573 - * s:100 q:100 tr=7796736 (0) 
01:41:54.587 - * s:100 q:100 tr=7700480 (0) 
01:41:55.601 - * s:100 q:100 tr=7796736 (0) 
01:41:56.615 - * s:100 q:100 tr=7796736 (0) 
01:41:57.629 - * s:100 q:100 tr=7700480 (0) 
01:41:58.643 - * s:100 q:100 tr=7796736 (0) 
01:41:59.657 - * s:100 q:100 tr=7796736 (0) 
01:41:59.972 - c:key 0
01:42:00.671 - * s:100 q:100 tr=7700480 (0) 
01:42:01.685 - * s:100 q:100 tr=7796736 (0) 
01:42:02.700 - * s:100 q:100 tr=7796736 (0) 
01:42:03.714 - * s:100 q:100 tr=7700480 (0) 
01:42:04.728 - * s:100 q:100 tr=7796736 (0) 
01:42:05.742 - * s:100 q:100 tr=7796736 (0) 
01:42:06.767 - * s:100 q:100 tr=7796736 (0) 
01:42:08.783 - * s:100 q:100 tr=15400960 (0) 
01:42:09.390 - Graph::Pause
01:42:09.409 - OSDManager::Window_Add
01:42:09.409 - OSDManager::Window_Show
01:42:09.410 - OSDManager::Window_Show
01:42:10.462 - c:key 1
01:42:20.025 - c:key 0
01:42:30.425 - c:key 1
01:42:40.114 - c:key 0
01:42:50.511 - c:key 1
01:43:00.192 - c:key 0
01:43:10.665 - c:key 1
01:43:20.356 - c:key 0
01:43:30.851 - c:key 1
01:43:40.769 - c:key 0
01:43:50.427 - c:key 1
01:44:00.966 - c:key 0
01:44:10.539 - c:key 1
01:44:20.960 - c:key 0
01:44:30.602 - c:key 1
01:44:40.687 - c:key 0
01:44:51.157 - c:key 1
01:45:01.233 - c:key 0
01:45:11.046 - c:key 1
01:45:21.181 - c:key 0
01:45:31.243 - c:key 1
01:45:41.208 - c:key 0
01:45:51.345 - c:key 1
01:46:01.472 - c:key 0
01:46:11.499 - c:key 1
01:46:21.533 - c:key 0
01:46:31.565 - c:key 1
01:46:41.644 - c:key 0
01:46:51.669 - c:key 1
01:47:01.673 - c:key 0
01:47:11.759 - c:key 1
01:47:21.827 - c:key 0
01:47:31.482 - c:key 1
01:47:41.950 - c:key 0
01:47:52.002 - c:key 1
01:48:02.183 - c:key 0
01:48:12.137 - c:key 1
01:48:22.276 - c:key 0
01:48:32.331 - c:key 1
01:48:42.584 - c:key 0
01:48:52.664 - c:key 1
01:49:02.659 - c:key 0
