﻿16:16:39.211 - Start logging...
16:16:39.217 - ExceptionFilter::Init. restart=1
16:16:39.500 - DevicesManager::EnableCISupport
16:16:39.501 - CAVManager::SetSettings
16:16:39.501 - DevicesManager::DestroyAllTransponderManager
16:16:39.531 - SetDefaultNullCodecs
16:16:39.570 - IsWin8WithoutMpeg2Codecs 0
16:16:39.571 - IsWin8WithoutMpeg2Codecs 1
16:16:39.572 - IsWin8WithoutMpeg2Codecs 2
16:16:39.600 - SetDefaultNullCodecs
16:16:39.620 - IsWin8WithoutMpeg2Codecs 0
16:16:39.622 - IsWin8WithoutMpeg2Codecs 1
16:16:39.622 - IsWin8WithoutMpeg2Codecs 2
16:16:39.645 - DevicesManager::Start
16:16:39.646 - AVManager::Init
16:16:39.654 - VR: GUI
16:16:39.660 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:16:39.694 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:16:39.694 - AV:UpdateAudioParamsAfterActive
16:16:39.695 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:16:39.697 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:16:39.760 - DevicesManager::StartDevices...
16:16:39.761 - device bda.21687 16:16:43.637 - dev: Created  bda.54b7 0BA0BD00
OK
16:16:43.639 - device netclient.0 16:16:43.643 - dev: Created  netclient.0 00CA3058
OK
16:16:43.647 - Api2BaseModule.GetAdditionInfo
16:16:43.648 - Api2BaseModule.GetAdditionInfo
16:16:44.207 - 
16:16:44.208 - 
16:16:44.208 - ########################### Mark of start channel changing.###########################
16:16:44.209 - 
16:16:44.210 - GraphManager::MainChangeChannel 1+1  1 provs
16:16:44.211 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
16:16:44.212 - SetChannelLogic::SetChannel 0
16:16:44.212 - SetChannelLogic::SetNormalChannel
16:16:44.213 - TransponderManager
16:16:44.214 - CTransponderManager::InitOnNewDevice 0BAA37D4
16:16:44.215 - SetOwner { -> Incoming Stream Cache
16:16:44.216 - TrafficProcessingScheme_CreateForNewEngineTransport 1 ss=0
16:16:44.217 - Normal TsInputTrafficProcessor.
16:16:44.219 - FilterManager::InitOnNewDevice 1
16:16:44.220 - TS router+MarkerFinder -> InputTrafficProcessor
16:16:44.221 - Incoming Stream Cache -> InputTrafficProcessor
16:16:44.222 - InputTrafficProcessor -> Router to timeshift
16:16:44.223 - InputTrafficProcessor(FM) -> FilterManager
16:16:44.223 - ModuleList::Free
16:16:44.225 - Api2BaseModule::GetCurrentDeviceInfo
16:16:44.226 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\PidRecorder.module OK
16:16:44.227 - Api2BaseModule::GetCurrentDeviceInfo
16:16:44.229 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\ProgMediaServer.Module OK
16:16:44.230 - ChannelGraph5.CChannelGraph5
16:16:44.231 - TransponderManager::AddChildChannel
16:16:44.232 - TimeShift.TimeShift
16:16:44.233 - TimeShift.Create 40 mbytes 
16:16:44.234 - ts:Disabled
16:16:44.235 - HugeMemoryBlocksManager::GetBlock 40 mbytes OK
16:16:44.236 - TransponderManager::CreateTimeshiftBuffer OK
16:16:44.244 - MDPlugin::Loaded C:\Program Files (x86)\ProgDVB\CnxCAM.dll OK
16:16:44.248 - TimeShift.CreateReadingCursor
16:16:44.250 - TransponderChannelSource.Plugins 0D9996A0 csa 0DBF9650
16:16:44.251 - TsInputTrafficProcessor.AddChannel 0
16:16:44.253 - SetChannelLogic::LookDeviceWithoutChannelsOrCloneAndMakeGraph
16:16:44.254 - ChannelGraph5.SetActiveState 1
16:16:44.255 - TransponderManager::SelectChannel
16:16:44.256 - TsInputTrafficProcessor.SelectChannel 0
16:16:44.257 - Api2BaseModule.UpdateAllOpenedChannels 0
16:16:44.260 - AV:UpdateAudioParamsAfterActive
16:16:44.261 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:16:44.262 - Graph::SetAudioChannelMask
16:16:44.263 - 
16:16:44.265 - TransponderManager::SetTransponder (CH) 354000 1+1
16:16:44.266 - *Transport TS
16:16:44.267 - Api2Device::SetChannel 354000Khz sid=12103
16:16:55.260 - Api2Device::SetChannel result OK
16:16:55.261 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=12103
16:16:55.262 - TsInputTrafficProcessor.OpenTransponder 1
16:16:55.264 - FilterManager::OnSetTransponder SetChannel
16:16:55.265 - TimeShift.Reset
16:16:55.266 - TimeShift.Cursor reset
16:16:55.267 - ReaderCursor::Reset.. OK
16:16:55.269 - Prereader.Reset ...-OK
16:16:55.272 - Create EPGparser on SetChannel
16:16:55.273 - DvbEpgParser::SetChannel ID=800154b7.566d0.2f47
16:16:55.276 - DvbEpgParser::mode normal pos=0
16:16:55.277 - ModuleList::ChangeChannel 354000
16:16:55.288 - Api2BaseModule::GetCurrentDeviceInfo
16:16:55.294 - Api2BaseModule::GetCurrentDeviceInfo
16:16:55.295 - CChannelGraph5::StartChannel 1+1
16:16:55.296 - 
16:16:55.298 -        #################### Start stream. (11.078ms) #######################
16:16:55.299 - 
16:16:55.306 - TimeShift.Cursor SetChannel pidmask=0DBECEC4 first=1
16:16:55.307 - TimeShift.Cursor SetChannel::v 0 (0)
16:16:55.308 - ReaderCursor::SetChannel.. OK
16:16:55.311 - ReaderCursor::SetPosition 0 (w=0)
16:16:55.312 - Prereader.SetChannel..
16:16:55.313 - PMT convertor
16:16:55.314 - Prereader.SetChannel mask. SimplePatPmtConvertor
16:16:55.316 - PPC.by mask. onlyV1A=0 No change PMT ,0,1203,1231,1232
16:16:55.317 - Plugin::SetChannel 12103
16:16:55.640 - TransponderManager::SelectChannel
16:16:55.642 - TsInputTrafficProcessor.SelectChannel 12103
16:16:55.643 - Api2BaseModule.UpdateAllOpenedChannels 1
16:16:55.645 - Api2BaseModule::GetCurrentDeviceInfo
16:16:55.647 - Api2BaseModule::OpenFilter 18 OK
16:16:55.649 - Api2BaseModule::OpenFilter 1231 OK
16:16:55.651 - Api2BaseModule::OpenFilter 1203 OK
16:16:55.653 - Api2BaseModule::OpenFilter 140 OK
16:16:55.654 - Api2BaseModule::OpenFilter 1232 OK
16:16:55.656 - Api2BaseModule::OpenFilter 0 OK
16:16:55.657 - TsInputTrafficProcessor.UpdateChannel 12103
16:16:55.658 - GraphState: Undef by StartChannelIsReady
16:16:55.659 - PreScanner.StartChannelIsReady net=0 parseall=0
16:16:55.661 - LngDefaultSelector.try select audio pid=1232 type=1 lng=0-(nar,nar,nar) l=99
16:16:55.662 - ChannelGraph5::AfterDetectChannelParams
16:16:55.663 - VideoMediaTypeDetection: mpeg2
16:16:55.664 - SetMarkerAudioLngStream Gen New stream
16:16:55.665 - SimpleTsDemux::Init apid=1232, vpid=1231
16:16:55.666 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
16:16:55.667 - demux: ProgDemux
16:16:55.671 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
16:16:55.672 - Prereader::ReaderCursor.. OK
16:16:55.674 - ReaderCursor::SetPosition 0 (w=0)
16:16:55.675 - Prereader.StartPlayback Push buffering=0 recv=0DBE2D10 [StartChannelHelperBase(sl)]
16:16:55.676 - Prereader.StartPlayback after lock
16:16:55.677 - 
16:16:55.678 -        #################### First traffic. (11.469ms) #######################
16:16:55.677 - PreScanner.StartPmtParserIfNeed
16:16:55.679 - 
16:16:55.680 - PlayTimePmtParser::OpenParser SID=12103 PMT=1203 unknow channel=0
16:16:55.683 - Open TSTS filter pid=1203 data=2
16:16:55.684 - TSTS cur size=21056
16:16:55.685 - Graph::SetVideoRect {0 0 720 576}
16:16:55.686 - ChannelGraph5.SetActiveState 1
16:16:55.693 - Graph::SetVideoWindowRect {33 0 166 100}
16:16:55.695 - Graph::UpdateRenderMode
16:16:55.741 - GraphManager::MultiChannelRendering
16:16:55.742 - ChannelGraph5.SetActiveState 1
16:16:55.746 - Graph::SetVideoWindowRect {0 7 625 475}
16:16:55.770 - * s:43 q:73 tr=2406212 (376) 
16:16:55.778 - OK. 102
16:16:55.916 - OSDManager::Window_Add
16:16:55.918 - OSDManager::Window_Show
16:16:55.960 - OSDManager::Window_Show
16:16:55.962 - OSDManager::Window_Show
16:16:56.006 - OSDManager::Window_Show
16:16:56.009 - OSDManager::Window_Show
16:16:56.017 - Api2BaseModule.OpenFilter 1203 OK
16:16:56.086 - c:key 0
16:16:56.089 - c:key 1
16:16:56.158 - Api2BaseModule.CloseFilter 1 pid 1203
16:16:56.179 - VideoParser::First packet 3512 mpeg2
16:16:56.199 - VideoParser::packet 14256
16:16:56.239 - VideoParser::packet 39136
16:16:56.280 - VideoParser::packet 64008
16:16:56.282 - AudioParser::First packet 3840
16:16:56.283 - AudioParser::MPG12 detected
16:16:56.320 - VideoParser::packet 88888
16:16:56.360 - VideoParser::packet 113760
16:16:56.400 - VideoParser::packet 138640
16:16:56.440 - VideoParser::packet 163512
16:16:56.481 - VideoParser::packet 188392
16:16:56.500 - VideoParser::packet 213264
16:16:56.561 - VideoParser::packet 238144
16:16:56.642 - VideoParser::packet 298552
16:16:56.644 - VideoParser::mpeg2::Sequence header detected. len76
16:16:56.645 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
16:16:56.646 - PreScanner.Post_InitRender [ReceiveTraffic]
16:16:56.648 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
16:16:56.649 - CalculBufferingSize prov=0BAA4C14 marker=0 request=1
16:16:56.650 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
16:16:56.651 - Prereader::ReaderCursor.. OK
16:16:56.653 - ReaderCursor::SetPosition 0 (w=6377270520315904)
16:16:56.655 - Prereader.StartPlayback Pull buffering=0 recv=00000000 [EnablePullModeAndStartPlayback]
16:16:56.656 - Prereader.StartPlayback after lock
16:16:56.657 - ------sGetVideoParams
16:16:56.658 - ChannelGraph5.CreateInterfacesAndRenderGraph
16:16:56.660 - subsm.StartChannel demux=ProgDemux tr=TS
16:16:56.661 - subsm.RecreateSubtitlesParsers 0D882110 ts=1 subindex=-1
16:16:56.663 - subsm.Set Teletext parser 0
16:16:56.664 - subsm.RecreateSubtitlesParsers end
16:16:56.665 - subs: OnSetChannel
16:16:56.666 - CreateCustomGraph
16:16:56.667 - VideoType:MPEG2
16:16:56.669 - Video/MPEG2_VIDEO : MPEG2_VIDEO s={0,720,720,0}, t={0,720,720,0}, bmp=720x576, r=16/9, br=15305200,frametime=40ms, IF=0x0, CF=0x0)
16:16:56.671 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f - OK
16:16:56.672 - CChannelGraph5::CreateRender 10
16:16:56.673 - VR: EVR Custom
16:16:56.674 - VR: create new render
16:16:56.740 - VR: Add video renderer Video Renderer - OK
16:16:56.742 - CreateAudioPartOfGraph
16:16:56.743 - AudioType:MPG
16:16:56.744 - Audio/MPEG1AudioPayload : WaveFormatEx (2ch 48000 0bit formatTag= 0x50)
16:16:56.746 - Add audio codec e1f1a0b8-beee-490d-ba7c-066c40b5e2b9 - OK
16:16:56.758 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
16:16:56.767 - Add and connect audio renderer - OK
16:16:56.769 - Graph::AfterRender
16:16:56.770 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
16:16:56.771 - AV:UpdateAudioParamsAfterActive
16:16:56.772 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:16:56.774 - Graph::SetVolume 90% -190db
16:16:56.776 - Graph::SetAudioChannelMask
16:16:56.778 - Graph::Run
16:16:56.797 - Graph::Run 1
16:16:56.799 - Graph::SetPictureParams
16:16:56.801 - Graph::SetVideoRect {0 0 720 576}
16:16:56.802 - Graph::SetVideoWindowRect {0 66 625 417}
16:16:56.811 - CChannelGraph5::HideSubtitles
16:16:56.829 - * s:43 q:74 tr=5101568 (0) 
16:16:57.092 - 
16:16:57.093 - ########################### Mark of finish channel changing. (12.875ms) #############
16:16:57.095 - 
16:16:57.432 - 
16:16:57.433 - ########################### First video frame. (13.219ms) #############
16:16:57.435 - 
16:16:58.020 - * s:43 q:74 tr=5679104 (0) 
16:16:59.822 - * s:43 q:74 tr=8663040 (0) 
16:17:01.023 - * s:43 q:74 tr=5775360 (0) 
16:17:02.008 - OSDManager::Window_Show
16:17:02.010 - OSDManager::Window_Delete
16:17:02.034 - * s:43 q:75 tr=4812800 (0) 
16:17:04.021 - * s:43 q:75 tr=9529344 (0) 
16:17:05.604 - c:key 0
16:17:05.608 - c:key 1
16:17:06.025 - * s:43 q:74 tr=9625600 (0) 
16:17:08.024 - * s:43 q:74 tr=9529344 (0) 
16:17:10.022 - * s:43 q:74 tr=9625600 (0) 
16:17:12.020 - * s:43 q:74 tr=9529344 (0) 
16:17:14.020 - * s:43 q:74 tr=9625600 (0) 
16:17:15.619 - c:key 0
16:17:15.622 - c:key 1
16:17:16.018 - * s:43 q:74 tr=9529344 (0) 
16:17:17.737 - EPG Parser - CRC error! pid=18
16:17:18.019 - * s:43 q:74 tr=9625600 (0) 
16:17:20.021 - * s:43 q:74 tr=9529344 (0) 
16:17:22.018 - * s:43 q:75 tr=9625600 (0) 
16:17:24.018 - * s:43 q:75 tr=9529344 (0) 
16:17:25.632 - c:key 0
16:17:25.635 - c:key 1
16:17:26.023 - * s:43 q:74 tr=9625600 (0) 
16:17:28.022 - * s:44 q:74 tr=9529344 (0) 
16:17:29.868 - 
16:17:29.869 - DevicesManager::SetTransponder 354000
16:17:29.871 - ChannelGraph5.~CChannelGraph5
16:17:29.872 - Graph::Stop
16:17:29.878 - Before Stop ...16:17:29.879 - OnGraphStop ...16:17:29.881 - PreScanner.Stop
16:17:29.883 - GraphState: Undef by PreScanner.Stop
16:17:29.884 - PlayTimePmtParser::StopParser
16:17:29.885 - subsm.StopChannel
16:17:29.886 - VR: Disconnect
16:17:29.902 - Graph::ReleaseAllFilters
16:17:29.903 - release: Prog Audio renderer - RR - OK.
16:17:29.919 - release: Video Renderer - RR - OK.
16:17:29.922 - release: Video decoder  - RR - OK.
16:17:29.925 - release: Microsoft DTV-DVD Audio Decoder - RR - OK.
16:17:29.927 - FilterGraph: 1
16:17:29.931 - ChannelGraph5.~CChannelGraph5 finish
16:17:29.944 - TransponderManager::CloseChannel
16:17:29.946 - TsInputTrafficProcessor.RemoveChannel 12103
16:17:29.947 - ~TransponderChannelSource
16:17:29.951 - TimeShift.DestroyReadingCursor
16:17:29.954 - Api2BaseModule.UpdateAllOpenedChannels 0
16:17:29.957 - Api2BaseModule::CloseFilter 1 pid 18
16:17:29.959 - Api2BaseModule::CloseFilter 2 pid 1231
16:17:29.962 - Api2BaseModule::CloseFilter 3 pid 1203
16:17:29.965 - Api2BaseModule::CloseFilter 4 pid 140
16:17:29.968 - Api2BaseModule::CloseFilter 5 pid 1232
16:17:29.970 - Api2BaseModule::CloseFilter 6 pid 0
16:17:29.973 - Api2BaseModule::GetCurrentDeviceInfo
16:17:29.975 - PlayTimePmtParser::StopParser
16:17:29.976 - Destroy TSTS filter pid=1203
16:17:29.978 - 
16:17:29.980 - TransponderManager::SetTransponder (TR) 354000
16:17:29.981 - --SwitchEngineTransport TS > TS
16:17:29.982 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=41943040
16:17:29.983 - --SwitchEngineTransport end
16:17:29.984 - Api2Device::SetTransponder 354000KHz
16:17:32.191 - Api2Device::SetTransponder result OK delay 0 ms
16:17:32.192 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=0
16:17:32.194 - TransponderManager::DestroyTimeshiftBuffer
16:17:32.195 - TimeShift.~TimeShift
16:17:32.196 - HugeMemoryBlocksManager::Free
16:17:32.197 - TsInputTrafficProcessor.OpenTransponder 0
16:17:32.198 - FilterManager::OnSetTransponder SetTransponder
16:17:32.202 - ModuleList::ChangeChannel 0
16:17:32.320 - 
16:17:32.321 - DevicesManager::SetTransponder 354000
16:17:32.322 - 
16:17:32.323 - TransponderManager::SetTransponder (TR) 354000
16:17:32.324 - --SwitchEngineTransport TS > TS
16:17:32.326 - --SwitchEngineTransport end
16:17:32.327 - Api2Device::SetTransponder 354000KHz
16:17:34.546 - Api2Device::SetTransponder result OK delay 0 ms
16:17:34.547 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=0
16:17:34.549 - TsInputTrafficProcessor.OpenTransponder 0
16:17:34.550 - FilterManager::OnSetTransponder SetTransponder
16:17:34.551 - ModuleList::ChangeChannel 0
16:17:34.592 - * s:43 q:75 tr=192324 (0) 
16:17:35.752 - * s:43 q:75 tr=5582848 (0) 
16:17:37.254 - * s:43 q:74 tr=7219200 (0) 
16:17:38.752 - * s:43 q:75 tr=7122944 (0) 
16:17:40.253 - * s:43 q:75 tr=7219200 (0) 
16:17:41.753 - * s:43 q:74 tr=7219200 (0) 
16:17:43.252 - * s:43 q:74 tr=7122944 (0) 
16:17:44.753 - * s:43 q:75 tr=7219200 (0) 
16:17:45.187 - VR: GUI
16:17:45.193 - GraphManager::MultiChannelRendering
16:17:45.226 - VR: GUI
16:17:45.232 - GraphManager::MultiChannelRendering
16:17:45.253 - DevicesManager::DestroyAllTransponderManager
16:17:45.254 - DevicesManager::DestroyTransponderManager
16:17:45.255 - Api2Device::SetChannel - None
16:17:45.262 - Api2Device::SetChannel result OK
16:17:45.264 - SetOwner { -> 0
16:17:45.265 - SetOwner SetTransponder null
16:17:45.268 - ~TransponderManager
16:17:45.269 - SetOwner { -> 0
16:17:45.270 - SetOwner SetTransponder null
16:17:45.275 - ModuleList::Free
16:17:45.283 - ASW: device bda.54b7 (800154b7)
16:17:45.284 - TransponderManager
16:17:45.285 - CTransponderManager::InitOnNewDevice 0BAA37D4
16:17:45.286 - SetOwner { -> Incoming Stream Cache
16:17:45.288 - TrafficProcessingScheme_CreateForNewEngineTransport 1 ss=0
16:17:45.289 - Normal TsInputTrafficProcessor.
16:17:45.290 - FilterManager::InitOnNewDevice 1
16:17:45.292 - TS router+MarkerFinder -> InputTrafficProcessor
16:17:45.293 - Incoming Stream Cache -> InputTrafficProcessor
16:17:45.294 - InputTrafficProcessor -> Router to timeshift
16:17:45.295 - InputTrafficProcessor(FM) -> FilterManager
16:17:45.296 - ModuleList::Free
16:17:45.298 - Api2BaseModule::GetCurrentDeviceInfo
16:17:45.299 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\PidRecorder.module OK
16:17:45.301 - Api2BaseModule::GetCurrentDeviceInfo
16:17:45.303 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\ProgMediaServer.Module OK
16:17:45.313 - FilterManager::OnSetTransponder CScannerManager::CreateEnvironment
16:17:45.325 - 
16:17:45.326 - DevicesManager::SetTransponder 354000
16:17:45.327 - 
16:17:45.328 - TransponderManager::SetTransponder (TR) 354000
16:17:45.329 - --SwitchEngineTransport TS > TS
16:17:45.331 - --SwitchEngineTransport end
16:17:45.333 - Api2Device::SetTransponder 354000KHz
16:17:47.752 - Api2Device::SetTransponder result OK delay 0 ms
16:17:47.753 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=0
16:17:47.755 - TsInputTrafficProcessor.OpenTransponder 0
16:17:47.756 - FilterManager::OnSetTransponder SetTransponder
16:17:47.757 - ModuleList::ChangeChannel 0
16:17:47.764 - 
16:17:47.765 - TransponderManager::SetTransponder (TR) 354000
16:17:47.766 - --SwitchEngineTransport TS > TS
16:17:47.768 - --SwitchEngineTransport end
16:17:47.770 - Api2Device::SetTransponder 354000KHz
16:17:49.984 - Api2Device::SetTransponder result OK delay 0 ms
16:17:49.985 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=0
16:17:49.987 - TsInputTrafficProcessor.OpenTransponder 0
16:17:49.988 - FilterManager::OnSetTransponder SetTransponder
16:17:49.989 - ModuleList::ChangeChannel 0
16:17:50.011 - * s:44 q:74 tr=192324 (0) 
16:17:50.038 - FilterManager::OnSetTransponder for ScannerFilterManaer
16:17:50.041 - FilterManager::OnSetTransponder ScanTrasponderParseTS - 354Mhz mis/plp=0
16:17:51.253 - * s:43 q:75 tr=5871616 (0) 
16:17:52.535 - FilterManager::OnSetTransponder ScanTrasponderParseTS - 354Mhz mis/plp=0
16:17:52.751 - * s:43 q:75 tr=7219200 (0) 
16:17:53.752 - * s:43 q:75 tr=4812800 (0) 
16:17:55.539 - * s:43 q:74 tr=8566784 (0) 
16:17:56.288 - 
16:17:56.289 - DevicesManager::SetTransponder 266000
16:17:56.290 - 
16:17:56.292 - TransponderManager::SetTransponder (TR) 266000
16:17:56.293 - --SwitchEngineTransport TS > TS
16:17:56.294 - --SwitchEngineTransport end
16:17:56.295 - Api2Device::SetTransponder 266000KHz
16:17:58.511 - Api2Device::SetTransponder result OK delay 0 ms
16:17:58.512 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=0
16:17:58.514 - TsInputTrafficProcessor.OpenTransponder 0
16:17:58.515 - FilterManager::OnSetTransponder SetTransponder
16:17:58.516 - ModuleList::ChangeChannel 0
16:17:58.535 - * s:45 q:74 tr=96068 (0) 
16:17:59.279 - VR: GUI
16:17:59.285 - GraphManager::MultiChannelRendering
16:17:59.316 - VR: GUI
16:17:59.322 - GraphManager::MultiChannelRendering
16:17:59.340 - DevicesManager::DestroyAllTransponderManager
16:17:59.342 - DevicesManager::DestroyTransponderManager
16:17:59.343 - Api2Device::SetChannel - None
16:17:59.350 - Api2Device::SetChannel result OK
16:17:59.352 - SetOwner { -> 0
16:17:59.353 - SetOwner SetTransponder null
16:17:59.356 - ~TransponderManager
16:17:59.358 - SetOwner { -> 0
16:17:59.359 - SetOwner SetTransponder null
16:17:59.364 - ModuleList::Free
16:17:59.371 - ASW: device bda.54b7 (800154b7)
16:17:59.372 - TransponderManager
16:17:59.373 - CTransponderManager::InitOnNewDevice 0BAA37D4
16:17:59.375 - SetOwner { -> Incoming Stream Cache
16:17:59.376 - TrafficProcessingScheme_CreateForNewEngineTransport 1 ss=0
16:17:59.377 - Normal TsInputTrafficProcessor.
16:17:59.378 - FilterManager::InitOnNewDevice 1
16:17:59.380 - TS router+MarkerFinder -> InputTrafficProcessor
16:17:59.381 - Incoming Stream Cache -> InputTrafficProcessor
16:17:59.382 - InputTrafficProcessor -> Router to timeshift
16:17:59.384 - InputTrafficProcessor(FM) -> FilterManager
16:17:59.385 - ModuleList::Free
16:17:59.386 - Api2BaseModule::GetCurrentDeviceInfo
16:17:59.388 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\PidRecorder.module OK
16:17:59.389 - Api2BaseModule::GetCurrentDeviceInfo
16:17:59.392 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\ProgMediaServer.Module OK
16:17:59.402 - FilterManager::OnSetTransponder CScannerManager::CreateEnvironment
16:17:59.413 - 
16:17:59.414 - DevicesManager::SetTransponder 266000
16:17:59.415 - 
16:17:59.417 - TransponderManager::SetTransponder (TR) 266000
16:17:59.418 - --SwitchEngineTransport TS > TS
16:17:59.420 - --SwitchEngineTransport end
16:17:59.422 - Api2Device::SetTransponder 266000KHz
16:18:01.833 - Api2Device::SetTransponder result OK delay 0 ms
16:18:01.834 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=0
16:18:01.836 - TsInputTrafficProcessor.OpenTransponder 0
16:18:01.837 - FilterManager::OnSetTransponder SetTransponder
16:18:01.838 - ModuleList::ChangeChannel 0
16:18:01.848 - 
16:18:01.849 - TransponderManager::SetTransponder (TR) 266000
16:18:01.851 - --SwitchEngineTransport TS > TS
16:18:01.853 - --SwitchEngineTransport end
16:18:01.854 - Api2Device::SetTransponder 266000KHz
16:18:04.064 - Api2Device::SetTransponder result OK delay 0 ms
16:18:04.065 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=0
16:18:04.067 - TsInputTrafficProcessor.OpenTransponder 0
16:18:04.068 - FilterManager::OnSetTransponder SetTransponder
16:18:04.069 - ModuleList::ChangeChannel 0
16:18:04.089 - * s:46 q:74 tr=96068 (0) 
16:18:04.118 - FilterManager::OnSetTransponder for ScannerFilterManaer
16:18:04.122 - FilterManager::OnSetTransponder ScanTrasponderParseTS - 266Mhz mis/plp=0
16:18:04.290 - FilterManager::OnSetTransponder ScanTrasponderParseTS - 266Mhz mis/plp=0
16:18:05.252 - * s:46 q:74 tr=5582848 (0) 
16:18:06.753 - * s:46 q:75 tr=7219200 (0) 
16:18:07.206 - VR: GUI
16:18:07.213 - GraphManager::MultiChannelRendering
16:18:07.242 - VR: GUI
16:18:07.248 - GraphManager::MultiChannelRendering
16:18:07.267 - DevicesManager::DestroyAllTransponderManager
16:18:07.268 - DevicesManager::DestroyTransponderManager
16:18:07.270 - Api2Device::SetChannel - None
16:18:07.277 - Api2Device::SetChannel result OK
16:18:07.278 - SetOwner { -> 0
16:18:07.280 - SetOwner SetTransponder null
16:18:07.283 - ~TransponderManager
16:18:07.284 - SetOwner { -> 0
16:18:07.286 - SetOwner SetTransponder null
16:18:07.290 - ModuleList::Free
16:18:07.297 - ASW: device bda.54b7 (800154b7)
16:18:07.299 - TransponderManager
16:18:07.300 - CTransponderManager::InitOnNewDevice 0BAA37D4
16:18:07.301 - SetOwner { -> Incoming Stream Cache
16:18:07.303 - TrafficProcessingScheme_CreateForNewEngineTransport 1 ss=0
16:18:07.304 - Normal TsInputTrafficProcessor.
16:18:07.305 - FilterManager::InitOnNewDevice 1
16:18:07.307 - TS router+MarkerFinder -> InputTrafficProcessor
16:18:07.308 - Incoming Stream Cache -> InputTrafficProcessor
16:18:07.309 - InputTrafficProcessor -> Router to timeshift
16:18:07.311 - InputTrafficProcessor(FM) -> FilterManager
16:18:07.312 - ModuleList::Free
16:18:07.314 - Api2BaseModule::GetCurrentDeviceInfo
16:18:07.315 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\PidRecorder.module OK
16:18:07.316 - Api2BaseModule::GetCurrentDeviceInfo
16:18:07.319 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\ProgMediaServer.Module OK
16:18:07.329 - FilterManager::OnSetTransponder CScannerManager::CreateEnvironment
16:18:07.340 - 
16:18:07.342 - DevicesManager::SetTransponder 266000
16:18:07.343 - 
16:18:07.344 - TransponderManager::SetTransponder (TR) 266000
16:18:07.345 - --SwitchEngineTransport TS > TS
16:18:07.348 - --SwitchEngineTransport end
16:18:07.349 - Api2Device::SetTransponder 266000KHz
16:18:09.768 - Api2Device::SetTransponder result OK delay 0 ms
16:18:09.769 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=0
16:18:09.771 - TsInputTrafficProcessor.OpenTransponder 0
16:18:09.772 - FilterManager::OnSetTransponder SetTransponder
16:18:09.773 - ModuleList::ChangeChannel 0
16:18:09.781 - 
16:18:09.782 - TransponderManager::SetTransponder (TR) 266000
16:18:09.783 - --SwitchEngineTransport TS > TS
16:18:09.786 - --SwitchEngineTransport end
16:18:09.787 - Api2Device::SetTransponder 266000KHz
16:18:12.002 - Api2Device::SetTransponder result OK delay 0 ms
16:18:12.003 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=0
16:18:12.005 - TsInputTrafficProcessor.OpenTransponder 0
16:18:12.006 - FilterManager::OnSetTransponder SetTransponder
16:18:12.007 - ModuleList::ChangeChannel 0
16:18:12.028 - * s:46 q:74 tr=96068 (0) 
16:18:12.052 - FilterManager::OnSetTransponder for ScannerFilterManaer
16:18:12.056 - FilterManager::OnSetTransponder ScanTrasponderParseTS - 266Mhz mis/plp=0
16:18:13.253 - * s:46 q:74 tr=5871616 (0) 
16:18:13.626 - FilterManager::OnSetTransponder ScanTrasponderParseTS - 266Mhz mis/plp=0
16:18:14.752 - * s:46 q:74 tr=7122944 (0) 
16:18:16.252 - * s:46 q:74 tr=7219200 (0) 
16:18:17.349 - 
16:18:17.351 - 
16:18:17.352 - ########################### Mark of start channel changing.###########################
16:18:17.353 - 
16:18:17.355 - GraphManager::MainChangeChannel 1+1  1 provs
16:18:17.356 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
16:18:17.357 - Destory
16:18:17.358 - DevicesManager::DestroyTransponderManager
16:18:17.360 - Api2Device::SetChannel - None
16:18:17.367 - Api2Device::SetChannel result OK
16:18:17.368 - SetOwner { -> 0
16:18:17.370 - SetOwner SetTransponder null
16:18:17.373 - ~TransponderManager
16:18:17.375 - SetOwner { -> 0
16:18:17.376 - SetOwner SetTransponder null
16:18:17.381 - ModuleList::Free
16:18:17.388 - SetChannelLogic::SetChannel 0
16:18:17.389 - SetChannelLogic::SetNormalChannel
16:18:17.390 - CreateGraphOfReturnCheckvalue::LowDestroyGraph
16:18:17.392 - TransponderManager
16:18:17.394 - CTransponderManager::InitOnNewDevice 0BAA37D4
16:18:17.395 - SetOwner { -> Incoming Stream Cache
16:18:17.396 - TrafficProcessingScheme_CreateForNewEngineTransport 1 ss=0
16:18:17.398 - Normal TsInputTrafficProcessor.
16:18:17.399 - FilterManager::InitOnNewDevice 1
16:18:17.400 - TS router+MarkerFinder -> InputTrafficProcessor
16:18:17.402 - Incoming Stream Cache -> InputTrafficProcessor
16:18:17.403 - InputTrafficProcessor -> Router to timeshift
16:18:17.404 - InputTrafficProcessor(FM) -> FilterManager
16:18:17.405 - ModuleList::Free
16:18:17.407 - Api2BaseModule::GetCurrentDeviceInfo
16:18:17.409 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\PidRecorder.module OK
16:18:17.410 - Api2BaseModule::GetCurrentDeviceInfo
16:18:17.413 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\ProgMediaServer.Module OK
16:18:17.414 - ChannelGraph5.CChannelGraph5
16:18:17.415 - TransponderManager::AddChildChannel
16:18:17.417 - TimeShift.TimeShift
16:18:17.418 - TimeShift.Create 40 mbytes 
16:18:17.419 - ts:Disabled
16:18:17.420 - HugeMemoryBlocksManager::GetBlock 40 mbytes OK
16:18:17.422 - TransponderManager::CreateTimeshiftBuffer OK
16:18:17.424 - TimeShift.CreateReadingCursor
16:18:17.425 - TransponderChannelSource.Plugins 0D9996A0 csa 0DBB9660
16:18:17.426 - TsInputTrafficProcessor.AddChannel 0
16:18:17.429 - SetChannelLogic::LookDeviceWithoutChannelsOrCloneAndMakeGraph
16:18:17.430 - ChannelGraph5.SetActiveState 1
16:18:17.431 - TransponderManager::SelectChannel
16:18:17.433 - TsInputTrafficProcessor.SelectChannel 0
16:18:17.434 - Api2BaseModule.UpdateAllOpenedChannels 0
16:18:17.437 - AV:UpdateAudioParamsAfterActive
16:18:17.438 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:18:17.439 - Graph::SetAudioChannelMask
16:18:17.441 - 
16:18:17.442 - TransponderManager::SetTransponder (CH) 354000 1+1
16:18:17.443 - *Transport TS
16:18:17.445 - Api2Device::SetChannel 354000Khz sid=12103
16:18:17.862 - Api2Device::SetChannel result OK
16:18:17.864 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=12103
16:18:17.866 - TsInputTrafficProcessor.OpenTransponder 1
16:18:17.867 - FilterManager::OnSetTransponder SetChannel
16:18:17.869 - TimeShift.Reset
16:18:17.870 - TimeShift.Cursor reset
16:18:17.872 - ReaderCursor::Reset.. OK
16:18:17.875 - Prereader.Reset ...-OK
16:18:17.878 - Create EPGparser on SetChannel
16:18:17.880 - DvbEpgParser::SetChannel ID=800154b7.566d0.2f47
16:18:17.884 - DvbEpgParser::mode normal pos=0
16:18:17.886 - ModuleList::ChangeChannel 354000
16:18:17.898 - Api2BaseModule::GetCurrentDeviceInfo
16:18:17.903 - Api2BaseModule::GetCurrentDeviceInfo
16:18:17.905 - CChannelGraph5::StartChannel 1+1
16:18:17.907 - 
16:18:17.909 -        #################### Start stream. (0.563ms) #######################
16:18:17.910 - 
16:18:17.920 - TimeShift.Cursor SetChannel pidmask=19777A5C first=1
16:18:17.921 - TimeShift.Cursor SetChannel::v 0 (0)
16:18:17.923 - ReaderCursor::SetChannel.. OK
16:18:17.926 - ReaderCursor::SetPosition 0 (w=0)
16:18:17.928 - Prereader.SetChannel..
16:18:17.929 - PMT convertor
16:18:17.931 - Prereader.SetChannel mask. SimplePatPmtConvertor
16:18:17.932 - PPC.by mask. onlyV1A=0 No change PMT ,0,1203,1231,1232
16:18:17.935 - Plugin::SetChannel 12103
16:18:18.352 - TransponderManager::SelectChannel
16:18:18.353 - TsInputTrafficProcessor.SelectChannel 12103
16:18:18.355 - Api2BaseModule.UpdateAllOpenedChannels 1
16:18:18.358 - Api2BaseModule::GetCurrentDeviceInfo
16:18:18.361 - Api2BaseModule::OpenFilter 18 OK
16:18:18.363 - Api2BaseModule::OpenFilter 1231 OK
16:18:18.366 - Api2BaseModule::OpenFilter 1203 OK
16:18:18.368 - Api2BaseModule::OpenFilter 140 OK
16:18:18.371 - Api2BaseModule::OpenFilter 1232 OK
16:18:18.373 - Api2BaseModule::OpenFilter 0 OK
16:18:18.375 - TsInputTrafficProcessor.UpdateChannel 12103
16:18:18.376 - GraphState: Undef by StartChannelIsReady
16:18:18.378 - PreScanner.StartChannelIsReady net=0 parseall=0
16:18:18.379 - LngDefaultSelector.try select audio pid=1232 type=1 lng=0-(nar,nar,nar) l=99
16:18:18.380 - ChannelGraph5::AfterDetectChannelParams
16:18:18.382 - VideoMediaTypeDetection: mpeg2
16:18:18.383 - SetMarkerAudioLngStream Gen New stream
16:18:18.383 - 
16:18:18.385 - SimpleTsDemux::Init apid=1232, vpid=1231
16:18:18.386 -        #################### First traffic. (1.032ms) #######################
16:18:18.388 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
16:18:18.389 - 
16:18:18.391 - demux: ProgDemux
16:18:18.397 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
16:18:18.398 - Prereader::ReaderCursor.. OK
16:18:18.401 - ReaderCursor::SetPosition 0 (w=107391362269184)
16:18:18.403 - Prereader.StartPlayback Push buffering=0 recv=19B29210 [StartChannelHelperBase(sl)]
16:18:18.404 - Prereader.StartPlayback after lock
16:18:18.406 - PreScanner.StartPmtParserIfNeed
16:18:18.407 - PlayTimePmtParser::OpenParser SID=12103 PMT=1203 unknow channel=0
16:18:18.409 - Open TSTS filter pid=1203 data=2
16:18:18.410 - TSTS cur size=50008
16:18:18.411 - Graph::SetVideoRect {0 0 720 576}
16:18:18.413 - ChannelGraph5.SetActiveState 1
16:18:18.424 - Graph::SetVideoWindowRect {33 0 166 100}
16:18:18.426 - Graph::UpdateRenderMode
16:18:18.471 - GraphManager::MultiChannelRendering
16:18:18.473 - ChannelGraph5.SetActiveState 1
16:18:18.485 - Graph::SetVideoWindowRect {0 7 625 475}
16:18:18.515 - * s:44 q:74 tr=3080004 (3948) 
16:18:18.525 - OK. 110
16:18:18.628 - OSDManager::Window_Add
16:18:18.630 - OSDManager::Window_Show
16:18:18.647 - OSDManager::Window_Show
16:18:18.649 - OSDManager::Window_Show
16:18:18.686 - OSDManager::Window_Show
16:18:18.690 - OSDManager::Window_Show
16:18:18.692 - Api2BaseModule.OpenFilter 1203 OK
16:18:18.765 - c:key 0
16:18:18.768 - c:key 1
16:18:18.826 - VideoParser::First packet 24872 mpeg2
16:18:18.866 - VideoParser::packet 49752
16:18:18.906 - VideoParser::packet 74624
16:18:18.956 - Api2BaseModule.CloseFilter 1 pid 1203
16:18:18.957 - VideoParser::packet 99504
16:18:18.967 - AudioParser::First packet 3840
16:18:18.969 - AudioParser::MPG12 detected
16:18:19.067 - VideoParser::packet 167600
16:18:19.069 - VideoParser::mpeg2::Sequence header detected. len76
16:18:19.070 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
16:18:19.072 - PreScanner.Post_InitRender [ReceiveTraffic]
16:18:19.073 - ChannelGraph5.uiThread_CreateGraphAfterDetectOfMediaTypes
16:18:19.075 - CalculBufferingSize prov=0BAA4C14 marker=0 request=1
16:18:19.076 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
16:18:19.077 - Prereader::ReaderCursor.. OK
16:18:19.080 - ReaderCursor::SetPosition 0 (w=4716337947475968)
16:18:19.081 - Prereader.StartPlayback Pull buffering=0 recv=00000000 [EnablePullModeAndStartPlayback]
16:18:19.083 - Prereader.StartPlayback after lock
16:18:19.084 - ------sGetVideoParams
16:18:19.085 - ChannelGraph5.CreateInterfacesAndRenderGraph
16:18:19.088 - subsm.StartChannel demux=ProgDemux tr=TS
16:18:19.090 - subsm.RecreateSubtitlesParsers 0DB892D0 ts=1 subindex=-1
16:18:19.091 - subsm.Set Teletext parser 0
16:18:19.092 - subsm.RecreateSubtitlesParsers end
16:18:19.094 - subs: OnSetChannel
16:18:19.095 - CreateCustomGraph
16:18:19.096 - VideoType:MPEG2
16:18:19.098 - Video/MPEG2_VIDEO : MPEG2_VIDEO s={0,720,720,0}, t={0,720,720,0}, bmp=720x576, r=16/9, br=15305200,frametime=40ms, IF=0x0, CF=0x0)
16:18:19.100 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f - OK
16:18:19.102 - CChannelGraph5::CreateRender 10
16:18:19.103 - VR: EVR Custom
16:18:19.104 - VR: create new render
16:18:19.160 - VR: Add video renderer Video Renderer - OK
16:18:19.162 - CreateAudioPartOfGraph
16:18:19.163 - AudioType:MPG
16:18:19.164 - Audio/MPEG1AudioPayload : WaveFormatEx (2ch 48000 0bit formatTag= 0x50)
16:18:19.167 - Add audio codec e1f1a0b8-beee-490d-ba7c-066c40b5e2b9 - OK
16:18:19.175 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
16:18:19.181 - Add and connect audio renderer - OK
16:18:19.185 - Graph::AfterRender
16:18:19.186 - GraphState: GraphStarted by CreateInterfacesAndRenderGraph
16:18:19.188 - AV:UpdateAudioParamsAfterActive
16:18:19.189 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:18:19.190 - Graph::SetVolume 90% -190db
16:18:19.192 - Graph::SetAudioChannelMask
16:18:19.194 - Graph::Run
16:18:19.216 - Graph::Run 1
16:18:19.218 - Graph::SetPictureParams
16:18:19.219 - Graph::SetVideoRect {0 0 720 576}
16:18:19.221 - Graph::SetVideoWindowRect {0 66 625 417}
16:18:19.229 - CChannelGraph5::HideSubtitles
16:18:19.569 - * s:43 q:74 tr=5101568 (0) 
16:18:19.745 - 
16:18:19.746 - ########################### Mark of finish channel changing. (2.391ms) #############
16:18:19.748 - 
16:18:19.913 - 
16:18:19.915 - ########################### First video frame. (2.563ms) #############
16:18:19.916 - 
16:18:20.755 - * s:43 q:74 tr=5679104 (0) 
16:18:22.019 - * s:43 q:74 tr=5967872 (0) 
16:18:23.252 - * s:43 q:75 tr=5967872 (0) 
16:18:24.003 - OSDManager::Window_Show
16:18:24.004 - OSDManager::Window_Delete
16:18:24.252 - * s:43 q:75 tr=4812800 (0) 
16:18:25.660 - c:key 0
16:18:25.663 - c:key 1
16:18:25.753 - * s:43 q:74 tr=7122944 (0) 
16:18:27.020 - * s:43 q:74 tr=6064128 (0) 
16:18:28.253 - * s:43 q:75 tr=5967872 (0) 
16:18:29.752 - * s:43 q:74 tr=7122944 (0) 
16:18:31.019 - * s:43 q:75 tr=6064128 (0) 
16:18:32.253 - * s:43 q:74 tr=5967872 (0) 
16:18:33.753 - * s:43 q:75 tr=7122944 (0) 
16:18:35.019 - * s:43 q:75 tr=6160384 (0) 
16:18:35.674 - c:key 0
16:18:35.678 - c:key 1
16:18:36.253 - * s:43 q:74 tr=5871616 (0) 
16:18:37.752 - * s:43 q:74 tr=7122944 (0) 
16:18:39.019 - * s:43 q:74 tr=6160384 (0) 
16:18:39.261 - Api2BaseModule.GetDialogSettings
16:18:40.253 - * s:43 q:74 tr=5871616 (0) 
16:18:41.753 - * s:43 q:74 tr=7219200 (0) 
