﻿16:31:07.015 -  ProgDVBVideoWindow    NotForceAPforRadio WinGetStateInMainThread
16:31:07.028 - InterfaceApiManagerWnd CreateWnd
16:31:07.030 - DevicesManager::Start
16:31:07.032 - AVManager::Init
16:31:07.045 - SetDefaultNullCodecs
16:31:07.046 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVAudio.ax 0E80AEDC
16:31:07.050 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVAudio.ax 0E80AEDC
16:31:07.054 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVAudio.ax 0E80AEDC
16:31:07.058 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVAudio.ax 0E80AEDC
16:31:07.063 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 0E814B24
16:31:07.067 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 0E814B24
16:31:07.071 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 0E814B24
16:31:07.075 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 0E814B24
16:31:07.079 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 0E814B24
16:31:07.084 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 0E814B24
16:31:07.088 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 0E814B24
16:31:07.092 - RemoveAllCreateBlank needBlank0
16:31:07.098 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\PidRecorder.module - 0E240000
16:31:07.105 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\ProgMediaServer.Module - 10D60000
16:31:07.140 - DevicesManager::EnableCISupport
16:31:07.142 - CAVManager::SetSettings
16:31:07.146 - DevicesManager::DestroyAllTransponderManager
16:31:07.156 - SetDefaultNullCodecs
16:31:07.156 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVAudio.ax 0E810DEC
16:31:07.161 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVAudio.ax 0E810DEC
16:31:07.165 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVAudio.ax 0E810DEC
16:31:07.170 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVAudio.ax 0E810DEC
16:31:07.175 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 0E815B84
16:31:07.180 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 0E815B84
16:31:07.184 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 0E815B84
16:31:07.189 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 0E815B84
16:31:07.194 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 0E815B84
16:31:07.198 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 0E815B84
16:31:07.202 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 0E815B84
16:31:07.585 - DevicesManager::StartDevices...
16:31:07.585 - DevicesManager::Before start:
16:31:07.590 - device netclient.0 16:31:07.596 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\netclient.Device - 79980000
16:31:07.601 - dev: UpdateNetworkRecommendations  752x500 -1x-1
16:31:07.605 - dev: Created  netclient.0 0E0EA090
OK
16:31:07.615 - Api2BaseModule.GetAdditionInfo
16:31:07.619 - Api2BaseModule.GetAdditionInfo OK
16:31:07.629 - AV:UpdateAudioParamsAfterActive
16:31:07.671 - DevicesManager::EnableCISupport
16:31:07.671 - Api2Device::CI3_EnableCISupport
16:31:07.675 - CAVManager::SetSettings
16:31:07.680 - Api2BaseModule.SetDialogSettings
16:31:07.686 - Api2BaseModule.SetDialogSettings
16:31:08.094 - Api2BaseModule.OnDisplaySize
16:31:08.094 - dev: UpdateNetworkRecommendations  1595x876 -1x-1
16:31:08.192 - Api2BaseModule.OnDisplaySize
16:31:08.192 - dev: UpdateNetworkRecommendations  1596x876 -1x-1
16:31:08.204 - Api2BaseModule.OnDisplaySize
16:31:08.204 - dev: UpdateNetworkRecommendations  1595x876 -1x-1
16:31:09.042 - * s:0 q:0 tr=0 (0)  offline
16:31:10.041 - * s:0 q:0 tr=0 (0)  offline
16:31:11.046 - * s:0 q:0 tr=0 (0)  offline
16:31:12.048 - * s:0 q:0 tr=0 (0)  offline
16:31:13.051 - * s:0 q:0 tr=0 (0)  offline
16:31:14.056 - * s:0 q:0 tr=0 (0)  offline
16:31:15.064 - * s:0 q:0 tr=0 (0)  offline
16:31:16.067 - * s:0 q:0 tr=0 (0)  offline
16:31:17.071 - * s:0 q:0 tr=0 (0)  offline
16:31:18.075 - * s:0 q:0 tr=0 (0)  offline
16:31:18.838 - Load: bda ...16:31:18.840 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\bda.Device - 79AF0000
OK
16:31:18.893 - Load: netclient ...16:31:18.893 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\netclient.Device - 79980000
OK
16:31:18.904 - Load: nova_pci ...16:31:18.918 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_pci.Device - 10F40000
OK
16:31:18.925 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_pci.Device - 10F40000
16:31:18.928 - Load: nova_usb ...16:31:18.934 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb.Device - 10F40000
OK
16:31:18.944 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb.Device - 10F40000
16:31:18.947 - Load: nova_usb2 ...16:31:18.954 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb2.Device - 10F40000
OK
16:31:18.963 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb2.Device - 10F40000
16:31:18.968 - Load: skystar2 ...16:31:18.972 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\skystar2.Device - 10F40000
OK
16:31:18.981 - Load: streamreaderwrp ...16:31:18.991 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\streamreaderwrp.Device - 50030000
OK
16:31:18.997 - Load: tsreader ...16:31:19.002 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\tsreader.Device - 79FE0000
OK
16:31:19.012 - DevicesManager::GetFullList 7
16:31:19.032 - Load: bda ...16:31:19.032 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\bda.Device - 79AF0000
OK
16:31:19.076 - * s:0 q:0 tr=0 (0)  offline
16:31:19.085 - Load: netclient ...16:31:19.085 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\netclient.Device - 79980000
OK
16:31:19.095 - Load: nova_pci ...16:31:19.101 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_pci.Device - 11450000
OK
16:31:19.110 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_pci.Device - 11450000
16:31:19.115 - Load: nova_usb ...16:31:19.120 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb.Device - 11450000
OK
16:31:19.129 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb.Device - 11450000
16:31:19.132 - Load: nova_usb2 ...16:31:19.138 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb2.Device - 11450000
OK
16:31:19.147 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb2.Device - 11450000
16:31:19.152 - Load: skystar2 ...16:31:19.155 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\skystar2.Device - 10F40000
OK
16:31:19.165 - Load: streamreaderwrp ...16:31:19.169 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\streamreaderwrp.Device - 50030000
OK
16:31:19.179 - Load: tsreader ...16:31:19.183 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\tsreader.Device - 79FE0000
OK
16:31:19.193 - DevicesManager::GetFullList 7
16:31:19.202 - Load: bda ...16:31:19.202 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\bda.Device - 79AF0000
OK
16:31:19.256 - Load: netclient ...16:31:19.256 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\netclient.Device - 79980000
OK
16:31:19.267 - Load: nova_pci ...16:31:19.272 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_pci.Device - 11450000
OK
16:31:19.282 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_pci.Device - 11450000
16:31:19.285 - Load: nova_usb ...16:31:19.291 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb.Device - 11450000
OK
16:31:19.300 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb.Device - 11450000
16:31:19.304 - Load: nova_usb2 ...16:31:19.310 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb2.Device - 11450000
OK
16:31:19.319 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb2.Device - 11450000
16:31:19.323 - Load: skystar2 ...16:31:19.328 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\skystar2.Device - 10F40000
OK
16:31:19.337 - Load: streamreaderwrp ...16:31:19.342 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\streamreaderwrp.Device - 50030000
OK
16:31:19.351 - Load: tsreader ...16:31:19.356 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\tsreader.Device - 79FE0000
OK
16:31:19.365 - DevicesManager::GetFullList 7
16:31:20.079 - * s:0 q:0 tr=0 (0)  offline
16:31:21.107 - * s:0 q:0 tr=0 (0)  offline
16:31:22.109 - * s:0 q:0 tr=0 (0)  offline
16:31:23.121 - * s:0 q:0 tr=0 (0)  offline
16:31:24.135 - * s:0 q:0 tr=0 (0)  offline
16:31:25.140 - * s:0 q:0 tr=0 (0)  offline
16:31:26.153 - * s:0 q:0 tr=0 (0)  offline
16:31:27.171 - * s:0 q:0 tr=0 (0)  offline
16:31:28.169 - * s:0 q:0 tr=0 (0)  offline
16:31:29.171 - * s:0 q:0 tr=0 (0)  offline
16:31:30.172 - * s:0 q:0 tr=0 (0)  offline
16:31:31.186 - * s:0 q:0 tr=0 (0)  offline
16:31:32.189 - * s:0 q:0 tr=0 (0)  offline
16:31:33.190 - * s:0 q:0 tr=0 (0)  offline
16:31:34.194 - * s:0 q:0 tr=0 (0)  offline
16:31:35.197 - * s:0 q:0 tr=0 (0)  offline
16:31:36.198 - * s:0 q:0 tr=0 (0)  offline
16:31:37.215 - * s:0 q:0 tr=0 (0)  offline
16:31:38.218 - * s:0 q:0 tr=0 (0)  offline
16:31:39.233 - * s:0 q:0 tr=0 (0)  offline
16:31:39.243 - * s:0 q:0 tr=0 (0)  offline
16:31:40.241 - * s:0 q:0 tr=0 (0)  offline
16:31:40.247 - * s:0 q:0 tr=0 (0)  offline
16:31:40.525 - Load: bda ...16:31:40.525 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\bda.Device - 79AF0000
OK
16:31:40.586 - Load: netclient ...16:31:40.586 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\netclient.Device - 79980000
OK
16:31:40.597 - Load: nova_pci ...16:31:40.603 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_pci.Device - 0BD10000
OK
16:31:40.612 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_pci.Device - 0BD10000
16:31:40.617 - Load: nova_usb ...16:31:40.623 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb.Device - 0BD10000
OK
16:31:40.633 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb.Device - 0BD10000
16:31:40.636 - Load: nova_usb2 ...16:31:40.642 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb2.Device - 0BD10000
OK
16:31:40.651 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb2.Device - 0BD10000
16:31:40.655 - Load: skystar2 ...16:31:40.659 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\skystar2.Device - 10F40000
OK
16:31:40.668 - Load: streamreaderwrp ...16:31:40.673 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\streamreaderwrp.Device - 50030000
OK
16:31:40.683 - Load: tsreader ...16:31:40.688 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\tsreader.Device - 79FE0000
OK
16:31:40.698 - DevicesManager::GetFullList 7
16:31:40.708 - Load: bda ...16:31:40.708 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\bda.Device - 79AF0000
OK
16:31:40.764 - Load: netclient ...16:31:40.764 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\netclient.Device - 79980000
OK
16:31:40.773 - Load: nova_pci ...16:31:40.780 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_pci.Device - 0BD10000
OK
16:31:40.790 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_pci.Device - 0BD10000
16:31:40.793 - Load: nova_usb ...16:31:40.798 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb.Device - 0BD10000
OK
16:31:40.809 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb.Device - 0BD10000
16:31:40.812 - Load: nova_usb2 ...16:31:40.819 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb2.Device - 0BD10000
OK
16:31:40.828 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb2.Device - 0BD10000
16:31:40.831 - Load: skystar2 ...16:31:40.836 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\skystar2.Device - 10F40000
OK
16:31:40.845 - Load: streamreaderwrp ...16:31:40.850 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\streamreaderwrp.Device - 50030000
OK
16:31:40.860 - Load: tsreader ...16:31:40.865 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\tsreader.Device - 79FE0000
OK
16:31:40.875 - DevicesManager::GetFullList 7
16:31:40.886 - Load: bda ...16:31:40.886 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\bda.Device - 79AF0000
OK
16:31:40.940 - Load: netclient ...16:31:40.940 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\netclient.Device - 79980000
OK
16:31:40.950 - Load: nova_pci ...16:31:40.957 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_pci.Device - 0BD10000
OK
16:31:40.967 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_pci.Device - 0BD10000
16:31:40.970 - Load: nova_usb ...16:31:40.976 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb.Device - 0BD10000
OK
16:31:40.986 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb.Device - 0BD10000
16:31:40.990 - Load: nova_usb2 ...16:31:40.996 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb2.Device - 0BD10000
OK
16:31:41.005 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb2.Device - 0BD10000
16:31:41.009 - Load: skystar2 ...16:31:41.013 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\skystar2.Device - 10F40000
OK
16:31:41.023 - Load: streamreaderwrp ...16:31:41.028 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\streamreaderwrp.Device - 50030000
OK
16:31:41.038 - Load: tsreader ...16:31:41.042 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\tsreader.Device - 79FE0000
OK
16:31:41.053 - DevicesManager::GetFullList 7
16:31:41.083 - Load: bda ...16:31:41.083 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\bda.Device - 79AF0000
OK
16:31:41.140 - Load: netclient ...16:31:41.140 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\netclient.Device - 79980000
OK
16:31:41.151 - Load: nova_pci ...16:31:41.157 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_pci.Device - 0BD10000
OK
16:31:41.167 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_pci.Device - 0BD10000
16:31:41.170 - Load: nova_usb ...16:31:41.176 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb.Device - 0BD10000
OK
16:31:41.186 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb.Device - 0BD10000
16:31:41.189 - Load: nova_usb2 ...16:31:41.196 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb2.Device - 0BD10000
OK
16:31:41.206 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\nova_usb2.Device - 0BD10000
16:31:41.208 - Load: skystar2 ...16:31:41.213 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\skystar2.Device - 10F40000
OK
16:31:41.222 - Load: streamreaderwrp ...16:31:41.227 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\streamreaderwrp.Device - 50030000
OK
16:31:41.237 - Load: tsreader ...16:31:41.241 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\tsreader.Device - 79FE0000
OK
16:31:41.251 - DevicesManager::GetFullList 7
16:31:41.265 - * s:0 q:0 tr=0 (0)  offline
16:31:42.235 - * s:0 q:0 tr=0 (0)  offline
16:31:43.240 - * s:0 q:0 tr=0 (0)  offline
16:31:44.235 - * s:0 q:0 tr=0 (0)  offline
16:31:45.239 - * s:0 q:0 tr=0 (0)  offline
16:31:46.238 - * s:0 q:0 tr=0 (0)  offline
16:31:47.236 - * s:0 q:0 tr=0 (0)  offline
16:31:48.236 - * s:0 q:0 tr=0 (0)  offline
16:31:49.237 - * s:0 q:0 tr=0 (0)  offline
16:31:50.235 - * s:0 q:0 tr=0 (0)  offline
16:31:51.236 - * s:0 q:0 tr=0 (0)  offline
16:31:52.238 - * s:0 q:0 tr=0 (0)  offline
16:31:53.239 - * s:0 q:0 tr=0 (0)  offline
16:31:54.235 - * s:0 q:0 tr=0 (0)  offline
16:31:55.246 - * s:0 q:0 tr=0 (0)  offline
16:31:56.237 - * s:0 q:0 tr=0 (0)  offline
16:31:57.237 - * s:0 q:0 tr=0 (0)  offline
16:31:58.238 - * s:0 q:0 tr=0 (0)  offline
16:31:59.239 - * s:0 q:0 tr=0 (0)  offline
16:32:00.236 - * s:0 q:0 tr=0 (0)  offline
16:32:01.236 - * s:0 q:0 tr=0 (0)  offline
16:32:02.236 - * s:0 q:0 tr=0 (0)  offline
16:32:03.238 - * s:0 q:0 tr=0 (0)  offline
16:32:04.236 - * s:0 q:0 tr=0 (0)  offline
16:32:05.238 - * s:0 q:0 tr=0 (0)  offline
16:32:06.234 - * s:0 q:0 tr=0 (0)  offline
16:32:07.233 - * s:0 q:0 tr=0 (0)  offline
16:32:08.238 - * s:0 q:0 tr=0 (0)  offline
16:32:09.250 - * s:0 q:0 tr=0 (0)  offline
16:32:10.235 - * s:0 q:0 tr=0 (0)  offline
16:32:11.239 - * s:0 q:0 tr=0 (0)  offline
16:32:12.236 - * s:0 q:0 tr=0 (0)  offline
16:32:13.239 - * s:0 q:0 tr=0 (0)  offline
16:32:14.238 - * s:0 q:0 tr=0 (0)  offline
16:32:15.235 - * s:0 q:0 tr=0 (0)  offline
16:32:16.250 - * s:0 q:0 tr=0 (0)  offline
16:32:17.236 - * s:0 q:0 tr=0 (0)  offline
16:32:18.236 - * s:0 q:0 tr=0 (0)  offline
16:32:19.235 - * s:0 q:0 tr=0 (0)  offline
16:32:20.239 - * s:0 q:0 tr=0 (0)  offline
16:32:21.237 - * s:0 q:0 tr=0 (0)  offline
16:32:22.239 - * s:0 q:0 tr=0 (0)  offline
16:32:23.251 - * s:0 q:0 tr=0 (0)  offline
16:32:24.253 - * s:0 q:0 tr=0 (0)  offline
16:32:25.253 - * s:0 q:0 tr=0 (0)  offline
16:32:26.254 - * s:0 q:0 tr=0 (0)  offline
16:32:27.254 - * s:0 q:0 tr=0 (0)  offline
16:32:28.253 - * s:0 q:0 tr=0 (0)  offline
16:32:29.262 - * s:0 q:0 tr=0 (0)  offline
16:32:30.254 - * s:0 q:0 tr=0 (0)  offline
16:32:31.250 - * s:0 q:0 tr=0 (0)  offline
16:32:32.253 - * s:0 q:0 tr=0 (0)  offline
16:32:33.253 - * s:0 q:0 tr=0 (0)  offline
16:32:34.253 - * s:0 q:0 tr=0 (0)  offline
16:32:35.253 - * s:0 q:0 tr=0 (0)  offline
16:32:36.252 - * s:0 q:0 tr=0 (0)  offline
16:32:37.253 - * s:0 q:0 tr=0 (0)  offline
16:32:38.254 - * s:0 q:0 tr=0 (0)  offline
16:32:39.253 - * s:0 q:0 tr=0 (0)  offline
16:32:40.254 - * s:0 q:0 tr=0 (0)  offline
16:32:41.253 - * s:0 q:0 tr=0 (0)  offline
16:32:42.253 - * s:0 q:0 tr=0 (0)  offline
16:32:43.265 - * s:0 q:0 tr=0 (0)  offline
16:32:44.252 - * s:0 q:0 tr=0 (0)  offline
16:32:44.752 - * s:0 q:0 tr=0 (0)  offline
16:32:45.252 - * s:0 q:0 tr=0 (0)  offline
16:32:45.754 - * s:0 q:0 tr=0 (0)  offline
16:32:46.254 - * s:0 q:0 tr=0 (0)  offline
16:32:46.756 - * s:0 q:0 tr=0 (0)  offline
16:32:47.253 - * s:0 q:0 tr=0 (0)  offline
16:32:47.758 - * s:0 q:0 tr=0 (0)  offline
16:32:48.254 - * s:0 q:0 tr=0 (0)  offline
16:32:48.630 - 
16:32:48.630 - 
16:32:48.634 - ########################### Mark of start channel changing.###########################
16:32:48.639 - 
16:32:48.645 - GraphManager::MainChangeChannel Рен ТВ  1 provs
16:32:48.650 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
16:32:48.654 - SetChannelLogic::SetChannel 0
16:32:48.659 - SetChannelLogic::SetNormalChannel
16:32:48.664 - DevicesManager::CreateCloneDevice
16:32:48.669 - DevicesManager::CreateCloneDevice OK - founded in list
16:32:48.673 - TransponderManager
16:32:48.679 - CTransponderManager::InitOnNewDevice 15670DC4
16:32:48.683 - SetOwner N -> Incoming Stream Cache
16:32:48.688 - TrafficProcessingScheme_CreateForNewEngineTransport 1 ss=0
16:32:48.694 - Normal TsInputTrafficProcessor.
16:32:48.699 - FilterManager::InitOnNewDevice 1
16:32:48.703 - TS router+MarkerFinder -> InputTrafficProcessor
16:32:48.708 - Incoming Stream Cache -> TS router+MarkerFinder
16:32:48.713 - InputTrafficProcessor -> Router to timeshift
16:32:48.718 - InputTrafficProcessor(FM) -> FilterManager
16:32:48.723 - ModuleList::Free
16:32:48.729 - LoadDll C:\Program Files (x86)\ProgDVB\Modules\PidRecorder.module - 0E240000
16:32:48.733 - Api2BaseModule::GetCurrentDeviceInfo
16:32:48.739 - ModuleList::Load C:\Program Files (x86)\ProgDVB\Modules\PidRecorder.module OK
16:32:48.743 - Add timer 1000 BaseTransponderManaer
16:32:48.749 - TransponderManager::AddChildChannel
16:32:48.753 - TimeShift.TimeShift
16:32:48.758 - TimeShift.Create 200 mbytes 
16:32:48.761 - * s:0 q:0 tr=0 (0)  offline
16:32:48.763 - ts:One channel
16:32:48.773 - HugeMemoryBlocksManager::GetBlock 200 mbytes OK
16:32:48.777 - TransponderManager::CreateTimeshiftBuffer OK
16:32:48.790 - TimeShift.CreateReadingCursor
16:32:48.790 - TransponderChannelSource.Plugins 0E96BD40 c 00000000
16:32:48.794 - TsInputTrafficProcessor.AddChannel 0
16:32:48.800 - AndroidChannelPlayback created TestMode=0
16:32:48.804 - SetChannelLogic::LookDeviceWithoutChannelsOrCloneAndMakeGraph
16:32:48.809 - add graph 0E8E8090 101
16:32:48.819 - ChannelGraph.SetActiveState 1
16:32:48.819 - TransponderManager::SelectChannel
16:32:48.825 - TsInputTrafficProcessor.SelectChannel 0
16:32:48.829 - Api2BaseModule.UpdateAllOpenedChannels 0
16:32:48.834 - **** StopChannel time 0.203ms
16:32:48.838 - 
16:32:48.844 - TransponderManager::SetTransponder (CH) 0 Рен ТВ
16:32:48.848 - *Transport TS
16:32:48.853 - Api2Device::SetChannel http://91.234.108.44:8886/udp/237.0.1.167:10000
16:32:48.894 - Api2BaseModule.EngineApi_ChList_SendSubChannels 0/8
16:32:48.894 - Api2BaseModule.OnTunerStateChanged Connecting
16:32:48.899 - Api2Device::SetChannel result OK
16:32:48.904 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=43981
16:32:48.909 - TsInputTrafficProcessor.OpenTransponder 1
16:32:48.904 - Api2BaseModule.OnTunerStateChanged  -3
16:32:48.914 - FilterManager::OnSetTransponder SetChannel
16:32:48.924 - TimeShift.Reset
16:32:48.929 - TimeShift.Cursor reset
16:32:48.934 - ReaderCursor::Reset.. OK
16:32:48.945 - Prereader.Reset ...-OK
16:32:48.955 - ModuleList::ChangeChannel 0
16:32:48.959 - **** SetTransponder time 0.125ms
16:32:48.965 - [101]ChannelGraph5::StartChannel Рен ТВ
16:32:48.969 - AV:UpdateAudioParamsAfterActive
16:32:48.975 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:32:48.980 - GR:UpdateAudioProcessor old=0 new=0
16:32:48.986 - CPCG SetVolume 00000000 50
16:32:48.990 - 
16:32:48.995 - [101]       #################### Start stream. (0.375ms) #######################
16:32:49.000 - 
16:32:49.011 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
16:32:49.011 - TimeShift.Cursor SetChannel::v 0 (0)
16:32:49.016 - ReaderCursor::SetChannel.. OK
16:32:49.026 - ReaderCursor::SetPosition 0 (w=0)
16:32:49.031 - Prereader.SetChannel..
16:32:49.037 - Prereader.SetChannel unmask 1
16:32:49.041 - Plugin::SetChannel 43981
16:32:49.047 - TransponderManager::SelectChannel
16:32:49.051 - TsInputTrafficProcessor.SelectChannel 43981
16:32:49.056 - Api2BaseModule.UpdateAllOpenedChannels 1
16:32:49.061 - TsInputTrafficProcessor.UpdateChannel 43981
16:32:49.066 - GraphState: Undef by StartChannelIsReady
16:32:49.071 - PreScanner.StartChannelIsReady net=1 parseall=1
16:32:49.076 - SimpleTsDemux::Init apid=0, vpid=0
16:32:49.082 - GraphState: RequestPATScan by StartChannelIsReady TS
16:32:49.087 - Api2BaseModule.Filters_EnabledFullTS 1
16:32:49.092 - PlayTimePATParser.OpenParser 43981
16:32:49.098 - Open TSTS filter pid=0 data=0
16:32:49.102 - TSTS cur size=0
16:32:49.107 - **** StartChannel time 0.156ms
16:32:49.112 - [101]OnChangeCurrentGraph2 -endOfSetChannel
16:32:49.117 - ChannelGraph.SetActiveState 1
16:32:49.138 - CPCG SetVolume 00000000 50
16:32:49.193 - ------sGetVideoParams
16:32:49.274 - [101]**** SetChannel is finished (OK). Duration 0.640ms
16:32:49.332 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 Connecting
16:32:50.266 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 Connecting
16:32:50.779 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 Connecting
16:32:51.784 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 Connecting
16:32:52.788 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 Connecting
16:32:53.792 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 Connecting
16:32:54.802 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 Connecting
16:32:55.807 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 Connecting
16:32:56.818 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 Connecting
16:32:57.358 - 
16:32:57.358 - 
16:32:57.364 - ########################### Mark of start channel changing.###########################
16:32:57.369 - 
16:32:57.375 - GraphManager::MainChangeChannel Россия 1  1 provs
16:32:57.379 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
16:32:57.385 - SetChannelLogic::SetChannel 0
16:32:57.390 - SetChannelLogic::SetNormalChannel
16:32:57.402 - [101]Stop channel
16:32:57.402 - PreScanner.Stop
16:32:57.406 - GraphState: Undef by PreScanner.Stop
16:32:57.411 - Api2BaseModule.Filters_EnabledFullTS 0
16:32:57.417 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
16:32:57.422 - Prereader::ReaderCursor.. OK
16:32:57.432 - ReaderCursor::SetPosition 0 (w=0)
16:32:57.437 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
16:32:57.443 - Prereader.StartPlayback after lock
16:32:57.447 - subsm.StopChannel
16:32:57.452 - **** StopChannel time 0.094ms
16:32:57.458 - 
16:32:57.463 - TransponderManager::SetTransponder (CH) 0 Россия 1
16:32:57.467 - *Transport TS
16:32:57.472 - Api2Device::SetChannel http://92.53.64.197:5050/Rossiya_1/video.m3u8?token=m3VIth-Rou_bM1
16:32:57.527 - Api2BaseModule.EngineApi_ChList_SendSubChannels 0/9
16:32:57.527 - Api2BaseModule.OnTunerStateChanged Connecting
16:32:57.532 - Api2Device::SetChannel result OK
16:32:57.538 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=43981
16:32:57.542 - TsInputTrafficProcessor.OpenTransponder 1
16:32:57.538 - Api2BaseModule.OnTunerStateChanged  -3
16:32:57.547 - FilterManager::OnSetTransponder SetChannel
16:32:57.558 - TimeShift.Reset
16:32:57.563 - TimeShift.Cursor reset
16:32:57.568 - ReaderCursor::Reset.. OK
16:32:57.578 - Prereader.Reset ...-OK
16:32:57.589 - ModuleList::ChangeChannel 0
16:32:57.595 - **** SetTransponder time 0.141ms
16:32:57.599 - [101]ChannelGraph5::StartChannel Россия 1
16:32:57.605 - AV:UpdateAudioParamsAfterActive
16:32:57.609 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:32:57.614 - GR:UpdateAudioProcessor old=0 new=0
16:32:57.620 - CPCG SetVolume 00000000 50
16:32:57.624 - 
16:32:57.625 - Api2BaseModule.OnTunerStateChanged Preparing
16:32:57.630 - [101]       #################### Start stream. (0.266ms) #######################
16:32:57.640 - 
16:32:57.640 - Api2BaseModule.OnTunerStateChanged  -4
16:32:57.659 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
16:32:57.659 - TimeShift.Cursor SetChannel::v 0 (0)
16:32:57.663 - ReaderCursor::SetChannel.. OK
16:32:57.673 - ReaderCursor::SetPosition 0 (w=0)
16:32:57.678 - Prereader.SetChannel..
16:32:57.683 - Prereader.SetChannel unmask 1
16:32:57.679 - Api2BaseModule.OnTunerStateChanged Playing
16:32:57.688 - Plugin::SetChannel 43981
16:32:57.698 - TransponderManager::SelectChannel
16:32:57.698 - Api2BaseModule.OnTunerStateChanged  -4
16:32:57.703 - TsInputTrafficProcessor.SelectChannel 43981
16:32:57.713 - Api2BaseModule.UpdateAllOpenedChannels 1
16:32:57.718 - TsInputTrafficProcessor.UpdateChannel 43981
16:32:57.723 - GraphState: Undef by StartChannelIsReady
16:32:57.728 - PreScanner.StartChannelIsReady net=1 parseall=1
16:32:57.733 - SimpleTsDemux::Init apid=0, vpid=0
16:32:57.739 - GraphState: RequestPATScan by StartChannelIsReady TS
16:32:57.744 - Api2BaseModule.Filters_EnabledFullTS 1
16:32:57.748 - PlayTimePATParser.OpenParser 43981
16:32:57.753 - Open TSTS filter pid=0 data=0
16:32:57.758 - TSTS cur size=0
16:32:57.764 - **** StartChannel time 0.171ms
16:32:57.768 - [101]OnChangeCurrentGraph2 -endOfSetChannel
16:32:57.773 - ChannelGraph.SetActiveState 1
16:32:57.800 - ------sGetVideoParams
16:32:57.862 - [101]**** SetChannel is finished (OK). Duration 0.500ms
16:32:57.947 - Add timer 1000 HlsReader
16:32:57.967 - Api2BaseModule.EngineApi_ChList_SendSubChannels 1/10
16:32:58.252 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 Preparing
16:32:58.840 - * s:0 q:0 tr=0 (0) - ntt-1 dmx0 -1 Preparing
16:32:58.846 - TransportMarker: TS
16:32:58.847 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
16:32:58.851 - 
16:32:58.851 - --SwitchEngineTransport TS > TS
16:32:58.856 -        #################### First traffic. (1.500ms) #######################
16:32:58.867 - 
16:32:58.872 - PlayTimePATParser.EndTask
16:32:58.876 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
16:32:58.882 - PreScanner.OnTransportMarker TS
16:32:58.903 - --SwitchEngineTransport end
16:32:58.903 - PreScanner.OnAfterScanPat count=2 {1;4095}
16:32:58.909 - Api2BaseModule.Filters_EnabledFullTS 0
16:32:58.913 - GraphState: RequestPMTScan by OnAfterScanPat
16:32:58.919 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=1
16:32:58.924 - Open TSTS filter pid=4095 data=2
16:32:58.930 - TSTS cur size=28576
16:32:58.936 - TSTS quick finish
16:32:58.940 - PreScanner.OnAfterScanPmt pmt=4095
16:32:58.948 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
16:32:58.955 - PlayTimePmtParser::StopParser
16:32:59.009 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
16:32:59.009 - TimeShift.Cursor SetChannel::v 48880 (48880)
16:32:59.014 - Prereader.SetChannel unmask 1
16:32:59.019 - Plugin::SetChannel 1
16:32:59.024 - TransponderManager::SelectChannel
16:32:59.030 - TsInputTrafficProcessor.SelectChannel 1
16:32:59.034 - Api2BaseModule.UpdateAllOpenedChannels 1
16:32:59.039 - TsInputTrafficProcessor.UpdateChannel 1
16:32:59.044 - PreScanner.StartChannelIsReady net=1 parseall=0
16:32:59.049 - LngDefaultSelector.try select audio pid=221 type=1 lng=7566706-rus(enm;ang;eng,deu;gmh;goh;ger,rus) l=12
16:32:59.053 - LngDefaultSelector. selected audio pid=221
16:32:59.059 - ChannelGraph::AfterDetectChannelParams
16:32:59.063 - VideoMediaTypeDetection: h.264
16:32:59.069 - SimpleTsDemux::Init apid=221, vpid=211
16:32:59.073 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
16:32:59.079 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
16:32:59.084 - Prereader::ReaderCursor.. OK
16:32:59.094 - ReaderCursor::SetPosition 0 (w=329441171472384)
16:32:59.098 - Prereader.StartPlayback Push buffering=0 recv=0E8E8A44 [StartChannelHelperBase(sl)]
16:32:59.103 - Prereader.StartPlayback after lock
16:32:59.108 - PreScanner.StartPmtParserIfNeed
16:32:59.113 - PlayTimePmtParser::OpenParser SID=1 PMT=4095 unknow channel=0
16:32:59.119 - Open TSTS filter pid=4095 data=2
16:32:59.123 - TSTS cur size=76704
16:32:59.183 - AudioParser::First packet 479
16:32:59.183 - AudioParser::aac detected
16:32:59.188 - VideoParser::First packet 95364 h.264
16:32:59.193 - h264 detected 0 ms
16:32:59.198 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
16:32:59.204 - PreScanner.Post_InitRender [ReceiveTraffic]
16:32:59.208 - 
16:32:59.213 - [101]       #################### Init Render. (1.860ms) #######################
16:32:59.218 - 
16:32:59.223 - ------sGetVideoParams
16:32:59.228 - video:h264 SD
16:32:59.233 - selector PlaybackTag=none videocodec=DS/ ts=1
16:32:59.238 - Channel PlaybackWay after check DS
16:32:59.248 - GraphState: GraphStarted by AsyncInitRender
16:32:59.248 - CalculBufferingSize prov=156725D4 marker=1 request=1
16:32:59.254 - CalculBuffering 2000ms br=1943kb to 485 kbytes. from marker
16:32:59.258 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
16:32:59.264 - Prereader::ReaderCursor.. OK
16:32:59.273 - ReaderCursor::SetPosition 0 (w=524037549719552)
16:32:59.279 - Prereader.StartPlayback Pull buffering=497500 recv=00000000 [EnablePullModeAndStartPlayback]
16:32:59.283 - Prereader.StartPlayback after lock
16:32:59.288 - Buffering/prereader size 485/3906 kbytes
16:32:59.293 - Not same player! old 0 new 13 prev 0
16:32:59.299 - ------sGetVideoParams
16:32:59.303 - ------sGetVideoParams
16:32:59.330 - Api2BaseModule.OnDisplaySize
16:32:59.330 - dev: UpdateNetworkRecommendations  1147x625 -1x-1
16:32:59.341 - Add timer 1000 DirectShowPlayer
16:32:59.348 - Graph::SetVideoWindowRect {175 0 625 450}
16:32:59.348 - Graph::UpdateRenderMode
16:32:59.358 - Graph::SetVideoRect {8 8 712 568}
16:32:59.358 - Graph::SetVideoWindowRect {100 0 700 450}
16:32:59.363 - demux: ProgDemux
16:32:59.377 - ------sGetVideoParams
16:32:59.377 - ChannelGraph5.CreateInterfacesAndRenderGraph
16:32:59.385 - CreateCustomGraph
16:32:59.387 - VideoType:H.264/AVC ffmpeg=0
16:32:59.392 - Video/4.H264 : MPEG2_VIDEO s={0,0,800,450}, t={0,0,800,450}, bmp=800x464, r=254/143, br=0,frametime=33ms, IF=0x0, CF=0x0)
16:32:59.397 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f
16:32:59.402 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 15BA25E4
16:32:59.413 - OK
16:32:59.413 - CChannelGraph5::CreateRender 12
16:32:59.418 - VR: MPC VR
16:32:59.424 - VR: create new render
16:32:59.535 - VR: Add video renderer Video Renderer - OK
16:32:59.537 - CreateAudioPartOfGraph
16:32:59.542 - AudioType:aac/adts 
16:32:59.547 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 48000 16bit formatTag= 0x1600)
16:32:59.552 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVAudio.ax 29C074AC
16:32:59.558 - Add audio codec e8e73b6b-4cb3-44a4-be99-4f7bcb96e491 - OK
16:32:59.569 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
16:32:59.569 - Added audio renderer
16:32:59.574 - AP: created
16:32:59.579 - Added audio processor
16:32:59.589 - Connect codec to AP - OK
16:32:59.606 - Add and connect audio renderer - OK
16:32:59.607 - Graph::AfterRender
16:32:59.613 - AV:UpdateAudioParamsAfterActive
16:32:59.617 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:32:59.622 - GR:UpdateAudioProcessor old=1 new=0
16:32:59.626 - Destroy Audio Processor update
16:32:59.631 - CPCG SetVolume 0E8D2730 50
16:32:59.637 - Graph::SetVolume 50% -1250db
16:32:59.642 - Graph::Run
16:32:59.689 - Graph::Run 1
16:32:59.689 - Graph::SetVideoRect {12 4 792 444}
16:32:59.694 - Graph::SetVideoWindowRect {0 0 800 450}
16:32:59.708 - Graph::SetPictureParams 1
16:32:59.708 - AV:UpdateAudioParamsAfterActive
16:32:59.712 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:32:59.718 - GR:UpdateAudioProcessor old=0 new=0
16:32:59.722 - CPCG SetVolume 0E8D2730 50
16:32:59.727 - Graph::SetVolume 50% -1250db
16:32:59.740 - Graph::Run
16:32:59.740 - Graph::Run 0
16:32:59.745 - subsm.StartChannel demux=ProgDemux tr=TS
16:32:59.750 - subsm.RecreateSubtitlesParsers 0E8EB230 ts=1 subindex=1 st=1
16:32:59.755 - SSTeletext: SetChannel page=100 lngrus
16:32:59.760 - subsm.Set Teletext parser 1025
16:32:59.765 - subsm.RecreateSubtitlesParsers end
16:32:59.770 - subs: OnSetChannel
16:32:59.775 - Add timer 100 Subtitles
16:32:59.786 - Force teletext
16:32:59.786 - SSTeletext: SetChannel page=100 lngrus
16:32:59.791 - ------sGetVideoParams
16:32:59.802 - ------sGetVideoParams
16:32:59.830 - Graph::SetVideoWindowRect {0 0 780 439}
16:32:59.840 - * s:57 q:100 tr=285572 (0) - ntt157 dmx0 -1 Buffering
16:32:59.841 - Api2BaseModule.OnDisplaySize
16:32:59.845 - dev: UpdateNetworkRecommendations  1127x614 -1x-1
16:32:59.925 - Graph::OnVideoWindowPositionChanged
16:33:00.653 - subs: More then 20 seconds delta of subtitles. (sub8322.304  and displat0.00)
16:33:00.653 - subs: video pts: 0.000  sub item : 8322.304 OK
16:33:00.663 - subs: More then 20 seconds delta of subtitles. (sub8322.304  and displat0.00)
16:33:00.664 - subs: video pts: 0.000  sub item : 8322.304 OK
16:33:00.673 - subs: More then 20 seconds delta of subtitles. (sub8322.304  and displat0.00)
16:33:00.674 - subs: video pts: 0.000  sub item : 8322.304 OK
16:33:00.684 - subs: More then 20 seconds delta of subtitles. (sub8322.304  and displat0.00)
16:33:00.684 - subs: video pts: 0.000  sub item : 8322.304 OK
16:33:00.695 - subs: More then 20 seconds delta of subtitles. (sub8323.626  and displat0.00)
16:33:00.695 - subs: video pts: 0.000  sub item : 8323.626 OK
16:33:00.700 - subs: Hide subtitles 
16:33:00.738 - subs: More then 20 seconds delta of subtitles. (sub8323.626  and displat0.00)
16:33:00.738 - subs: video pts: 0.000  sub item : 8323.626 OK
16:33:00.749 - 
16:33:00.749 - [0]########################### Mark of finish channel changing. (3.391ms) #############
16:33:00.754 - 
16:33:00.759 - subs: video pts: 8321.834  sub item : 8323.626 
16:33:00.777 - subs: video pts: 8321.877  sub item : 8323.626 
16:33:00.855 - * s:100 q:100 tr=266020 (0) - ntt0 dmx1763 -1 Playing
16:33:00.887 - subs: video pts: 8322.196  sub item : 8323.626 
16:33:00.994 - subs: video pts: 8322.442  sub item : 8323.626 
16:33:01.098 - subs: video pts: 8322.643  sub item : 8323.626 
16:33:01.103 - subs: video pts: 8322.643  sub item : 8323.626 
16:33:01.213 - subs: video pts: 8322.701  sub item : 8323.626 
16:33:01.322 - subs: video pts: 8322.859  sub item : 8323.626 
16:33:01.432 - subs: video pts: 8323.054  sub item : 8323.626 
16:33:01.542 - subs: video pts: 8323.121  sub item : 8323.626 
16:33:01.651 - subs: video pts: 8323.190  sub item : 8323.626 
16:33:01.761 - subs: video pts: 8323.398  sub item : 8323.626 
16:33:01.871 - * s:100 q:100 tr=275796 (0) - ntt0 dmx1786 -1 Playing
16:33:01.872 - subs: video pts: 8323.494  sub item : 8323.626 
16:33:01.980 - subs: video pts: 8323.611  sub item : 8323.626 
16:33:01.982 - subs: video pts: 8323.611  sub item : 8323.626 
16:33:02.088 - subs: video pts: 8323.755  sub item : 8323.626 OK
16:33:02.093 - subs: video pts: 8323.755  sub item : 8323.626 OK
16:33:02.103 - subs: video pts: 8323.755  sub item : 8324.948 
16:33:02.106 - subs: video pts: 8323.622  sub item : 8324.948 
16:33:02.127 - subs: video pts: 8323.702  sub item : 8324.948 
16:33:02.127 - subs: video pts: 8323.702  sub item : 8324.948 
16:33:02.198 - subs: video pts: 8323.834  sub item : 8324.948 
16:33:02.307 - subs: video pts: 8323.945  sub item : 8324.948 
16:33:02.417 - subs: video pts: 8323.944  sub item : 8324.948 
16:33:02.527 - subs: video pts: 8324.192  sub item : 8324.948 
16:33:02.637 - subs: video pts: 8324.272  sub item : 8324.948 
16:33:02.747 - subs: video pts: 8324.347  sub item : 8324.948 
16:33:02.857 - subs: video pts: 8324.536  sub item : 8324.948 
16:33:02.871 - * s:100 q:100 tr=265832 (0) - ntt0 dmx1770 -1 Playing
16:33:02.963 - subs: video pts: 8324.596  sub item : 8324.948 
16:33:03.072 - subs: video pts: 8324.669  sub item : 8324.948 
16:33:03.148 - subs: video pts: 8324.816  sub item : 8324.948 
16:33:03.182 - subs: video pts: 8324.857  sub item : 8324.948 
16:33:03.232 - subs: video pts: 8324.827  sub item : 8324.948 
16:33:03.232 - subs: video pts: 8324.827  sub item : 8324.948 
16:33:03.237 - subs: video pts: 8324.827  sub item : 8324.948 
16:33:03.292 - subs: video pts: 8324.938  sub item : 8324.948 
16:33:03.402 - subs: video pts: 8324.940  sub item : 8324.948 
16:33:03.511 - subs: video pts: 8325.201  sub item : 8324.948 OK
16:33:03.511 - subs: Hide subtitles 
16:33:03.523 - subs: video pts: 8325.201  sub item : 8324.948 OK
16:33:03.534 - subs: video pts: 8325.201  sub item : 8324.948 OK
16:33:03.544 - subs: video pts: 8325.201  sub item : 8324.948 OK
16:33:03.553 - subs: video pts: 8325.201  sub item : 8326.271 
16:33:03.622 - subs: video pts: 8325.313  sub item : 8326.271 
16:33:03.731 - subs: video pts: 8325.394  sub item : 8326.271 
16:33:03.838 - subs: video pts: 8325.541  sub item : 8326.271 
16:33:03.884 - * s:100 q:100 tr=226352 (0) - ntt0 dmx1682 -1 Playing
16:33:03.947 - subs: video pts: 8325.624  sub item : 8326.271 
16:33:04.057 - subs: video pts: 8325.717  sub item : 8326.271 
16:33:04.157 - 
16:33:04.158 - 
16:33:04.162 - ########################### Mark of start channel changing.###########################
16:33:04.167 - 
16:33:04.172 - GraphManager::MainChangeChannel Россия 1 (Абакан)  1 provs
16:33:04.177 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
16:33:04.182 - SetChannelLogic::SetChannel 0
16:33:04.187 - SetChannelLogic::SetNormalChannel
16:33:04.198 - [101]Stop channel
16:33:04.198 - PreScanner.Stop
16:33:04.203 - GraphState: Undef by PreScanner.Stop
16:33:04.208 - PlayTimePmtParser::StopParser
16:33:04.213 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
16:33:04.218 - Prereader::ReaderCursor.. OK
16:33:04.234 - ReaderCursor::SetPosition 0 (w=6124537464750080)
16:33:04.239 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
16:33:04.244 - Prereader.StartPlayback after lock
16:33:04.249 - subsm.StopChannel
16:33:04.255 - SSTeletext: SetChannel page=0 lng
16:33:04.259 - DestroyPlayer th=0
16:33:04.265 - Graph::Stop
16:33:04.296 - Before Stop ...16:33:04.303 - OnGraphStop ...16:33:04.343 - VR: Disconnect
16:33:04.345 - Graph::ReleaseAllFilters
16:33:04.349 - release: Prog Audio renderer - RR - OK.
16:33:04.359 - release: Video Renderer - RR - OK.
16:33:04.443 - release: Video decoder  - RR - OK.
16:33:04.454 - release: Audio Processor - RR - OK.
16:33:04.465 - release: Audio decoder - RR - OK.
16:33:04.476 - FilterGraph: 1
16:33:04.482 - Delete timer 1000 DirectShowPlayer
16:33:04.486 - Graph::ReleaseAllFilters
16:33:04.501 - DestroyPlayer - after
16:33:04.501 - **** StopChannel time 0.344ms
16:33:04.506 - 
16:33:04.511 - TransponderManager::SetTransponder (CH) 0 Россия 1 (Абакан)
16:33:04.516 - *Transport TS
16:33:04.521 - Api2Device::SetChannel https://vgtrkregion-reg.cdnvideo.ru/vgtrk/abakan/russia1-sd/index.m3u8
16:33:04.530 - skip old generation traffic!
16:33:04.540 - skip old generation traffic!
16:33:04.545 - skip old generation traffic!
16:33:04.549 - Delete timer 1000 HlsReader
16:33:04.555 - skip old generation traffic!
16:33:04.574 - Api2BaseModule.OnTunerStateChanged Connecting
16:33:04.579 - Api2BaseModule.OnTunerStateChanged  -3
16:33:04.624 - Api2Device::SetChannel result OK
16:33:04.624 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=43981
16:33:04.630 - TsInputTrafficProcessor.OpenTransponder 1
16:33:04.635 - FilterManager::OnSetTransponder SetChannel
16:33:04.640 - TimeShift.Reset
16:33:04.645 - TimeShift.Cursor reset
16:33:04.651 - ReaderCursor::Reset.. OK
16:33:04.662 - Prereader.Reset ...-OK
16:33:04.673 - ModuleList::ChangeChannel 0
16:33:04.678 - **** SetTransponder time 0.172ms
16:33:04.682 - [101]ChannelGraph5::StartChannel Россия 1 (Абакан)
16:33:04.688 - AV:UpdateAudioParamsAfterActive
16:33:04.693 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:33:04.698 - GR:UpdateAudioProcessor old=0 new=0
16:33:04.703 - CPCG SetVolume 00000000 50
16:33:04.708 - 
16:33:04.714 - [101]       #################### Start stream. (0.563ms) #######################
16:33:04.719 - 
16:33:04.775 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
16:33:04.775 - TimeShift.Cursor SetChannel::v 0 (0)
16:33:04.780 - ReaderCursor::SetChannel.. OK
16:33:04.791 - ReaderCursor::SetPosition 0 (w=0)
16:33:04.796 - Prereader.SetChannel..
16:33:04.802 - Prereader.SetChannel unmask 1
16:33:04.808 - Plugin::SetChannel 43981
16:33:04.812 - TransponderManager::SelectChannel
16:33:04.819 - TsInputTrafficProcessor.SelectChannel 43981
16:33:04.823 - Api2BaseModule.UpdateAllOpenedChannels 1
16:33:04.829 - TsInputTrafficProcessor.UpdateChannel 43981
16:33:04.834 - GraphState: Undef by StartChannelIsReady
16:33:04.839 - PreScanner.StartChannelIsReady net=1 parseall=1
16:33:04.845 - SimpleTsDemux::Init apid=0, vpid=0
16:33:04.850 - GraphState: RequestPATScan by StartChannelIsReady TS
16:33:04.857 - Api2BaseModule.Filters_EnabledFullTS 1
16:33:04.863 - PlayTimePATParser.OpenParser 43981
16:33:04.868 - Open TSTS filter pid=0 data=0
16:33:04.873 - TSTS cur size=0
16:33:04.879 - **** StartChannel time 0.203ms
16:33:04.884 - [101]OnChangeCurrentGraph2 -endOfSetChannel
16:33:04.889 - ChannelGraph.SetActiveState 1
16:33:04.924 - ------sGetVideoParams
16:33:05.008 - [101]**** SetChannel is finished (OK). Duration 0.844ms
16:33:05.042 - subs: video pts: -1.000  sub item : 8326.271 OK
16:33:05.042 - subs: Hide subtitles 
16:33:05.054 - subs: video pts: -1.000  sub item : 8326.271 OK
16:33:05.065 - subs: video pts: -1.000  sub item : 8326.271 OK
16:33:05.077 - subs: video pts: -1.000  sub item : 8326.271 OK
16:33:05.135 - * s:0 q:0 tr=0 (0) - ntt0 dmx0 -1 Connecting
16:33:05.921 - * s:0 q:0 tr=0 (0) - ntt0 dmx0 -1 Connecting
16:33:05.945 - Api2BaseModule.OnTunerStateChanged Preparing
16:33:05.951 - Api2BaseModule.OnTunerStateChanged  -4
16:33:05.999 - Api2BaseModule.OnTunerStateChanged Playing
16:33:06.005 - Api2BaseModule.OnTunerStateChanged  -4
16:33:06.064 - Add timer 1000 HlsReader
16:33:06.093 - Api2BaseModule.EngineApi_ChList_SendSubChannels 2/5
16:33:06.253 - * s:0 q:0 tr=0 (0) - ntt0 dmx0 -1 Connecting
16:33:06.592 - 
16:33:06.592 -        #################### First traffic. (2.438ms) #######################
16:33:06.599 - 
16:33:06.603 - PlayTimePATParser.EndTask
16:33:06.609 - TransportMarker: TS
16:33:06.609 - PreScanner.OnAfterScanPat count=2 {1;4096}
16:33:06.614 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
16:33:06.626 - Api2BaseModule.Filters_EnabledFullTS 0
16:33:06.631 - GraphState: RequestPMTScan by OnAfterScanPat
16:33:06.637 - PlayTimePmtParser::OpenParser SID=1 PMT=4096 unknow channel=1
16:33:06.642 - Open TSTS filter pid=4096 data=2
16:33:06.648 - TSTS cur size=523768
16:33:06.653 - EngineTransportsParser::UpdateLngStream update marker id=307644203 type=534769836
16:33:06.658 - TSTS quick finish
16:33:06.664 - --SwitchEngineTransport TS > TS
16:33:06.669 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
16:33:06.675 - PreScanner.OnTransportMarker TS
16:33:06.680 - PreScanner.OnTransportMarker Skiped! same marker
16:33:06.701 - --SwitchEngineTransport end
16:33:06.701 - PreScanner.OnAfterScanPmt pmt=4096
16:33:06.707 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
16:33:06.712 - PlayTimePmtParser::StopParser
16:33:06.764 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
16:33:06.764 - TimeShift.Cursor SetChannel::v 539560 (539560)
16:33:06.770 - Prereader.SetChannel unmask 1
16:33:06.775 - Plugin::SetChannel 1
16:33:06.781 - TransponderManager::SelectChannel
16:33:06.786 - TsInputTrafficProcessor.SelectChannel 1
16:33:06.792 - Api2BaseModule.UpdateAllOpenedChannels 1
16:33:06.798 - TsInputTrafficProcessor.UpdateChannel 1
16:33:06.803 - PreScanner.StartChannelIsReady net=1 parseall=0
16:33:06.808 - LngDefaultSelector.try select audio pid=257 type=1 lng=7566706-rus(enm;ang;eng,deu;gmh;goh;ger,rus) l=12
16:33:06.813 - LngDefaultSelector. selected audio pid=257
16:33:06.819 - ChannelGraph::AfterDetectChannelParams
16:33:06.824 - VideoMediaTypeDetection: h.264
16:33:06.830 - SimpleTsDemux::Init apid=257, vpid=256
16:33:06.834 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
16:33:06.840 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
16:33:06.846 - Prereader::ReaderCursor.. OK
16:33:06.857 - ReaderCursor::SetPosition 0 (w=2520063470993408)
16:33:06.863 - Prereader.StartPlayback Push buffering=0 recv=0E8E8A44 [StartChannelHelperBase(sl)]
16:33:06.868 - Prereader.StartPlayback after lock
16:33:06.873 - PreScanner.StartPmtParserIfNeed
16:33:06.873 - AudioParser::First packet 347
16:33:06.879 - PlayTimePmtParser::OpenParser SID=1 PMT=4096 unknow channel=0
16:33:06.890 - Open TSTS filter pid=4096 data=2
16:33:06.896 - TSTS cur size=877584
16:33:06.885 - AudioParser::aac detected
16:33:06.908 - VideoParser::First packet 1352 h.264
16:33:06.913 - h264 detected 0 ms
16:33:06.918 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
16:33:06.924 - PreScanner.Post_InitRender [ReceiveTraffic]
16:33:06.930 - 
16:33:06.936 - [101]       #################### Init Render. (2.781ms) #######################
16:33:06.941 - 
16:33:06.935 - * s:100 q:100 tr=1324460 (0) - ntt0 dmx0 -1 Preparing
16:33:06.947 - ------sGetVideoParams
16:33:06.959 - video:h264 SD
16:33:06.964 - selector PlaybackTag=none videocodec=DS/ ts=1
16:33:06.969 - Channel PlaybackWay after check DS
16:33:06.980 - GraphState: GraphStarted by AsyncInitRender
16:33:06.980 - CalculBufferingSize prov=156725D4 marker=1 request=1
16:33:06.986 - CalculBuffering 2000ms br=2467kb to 616 kbytes. from marker
16:33:06.992 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
16:33:06.997 - Prereader::ReaderCursor.. OK
16:33:07.008 - ReaderCursor::SetPosition 0 (w=5610189361250304)
16:33:07.013 - Prereader.StartPlayback Pull buffering=631616 recv=00000000 [EnablePullModeAndStartPlayback]
16:33:07.019 - Prereader.StartPlayback after lock
16:33:07.024 - Buffering/prereader size 616/3906 kbytes
16:33:07.030 - Not same player! old 0 new 13 prev 13
16:33:07.035 - ------sGetVideoParams
16:33:07.042 - ------sGetVideoParams
16:33:07.069 - Api2BaseModule.OnDisplaySize
16:33:07.069 - dev: UpdateNetworkRecommendations  1371x751 -1x-1
16:33:07.080 - Add timer 1000 DirectShowPlayer
16:33:07.085 - Graph::SetVideoWindowRect {224 0 800 576}
16:33:07.088 - Graph::UpdateRenderMode
16:33:07.102 - Graph::SetVideoRect {8 8 712 568}
16:33:07.102 - Graph::SetVideoWindowRect {128 0 896 576}
16:33:07.108 - demux: ProgDemux
16:33:07.126 - ------sGetVideoParams
16:33:07.126 - ChannelGraph5.CreateInterfacesAndRenderGraph
16:33:07.134 - CreateCustomGraph
16:33:07.138 - VideoType:H.264/AVC ffmpeg=0
16:33:07.143 - Video/4.H264 : MPEG2_VIDEO s={0,0,1024,576}, t={0,0,1024,576}, bmp=1024x576, r=16/9, br=0,frametime=40ms, IF=0x0, CF=0x0)
16:33:07.148 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f
16:33:07.155 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 29C0DBAC
16:33:07.166 - OK
16:33:07.166 - CChannelGraph5::CreateRender 12
16:33:07.171 - VR: MPC VR
16:33:07.176 - VR: create new render
16:33:07.285 - VR: Add video renderer Video Renderer - OK
16:33:07.285 - CreateAudioPartOfGraph
16:33:07.292 - AudioType:aac/adts 
16:33:07.297 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 48000 16bit formatTag= 0x1600)
16:33:07.303 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVAudio.ax 29A2C52C
16:33:07.308 - Add audio codec e8e73b6b-4cb3-44a4-be99-4f7bcb96e491 - OK
16:33:07.318 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
16:33:07.320 - Added audio renderer
16:33:07.324 - AP: created
16:33:07.330 - Added audio processor
16:33:07.341 - Connect codec to AP - OK
16:33:07.362 - Add and connect audio renderer - OK
16:33:07.362 - Graph::AfterRender
16:33:07.369 - AV:UpdateAudioParamsAfterActive
16:33:07.373 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:33:07.379 - GR:UpdateAudioProcessor old=1 new=0
16:33:07.384 - Destroy Audio Processor update
16:33:07.389 - CPCG SetVolume 0E8D2378 50
16:33:07.394 - Graph::SetVolume 50% -1250db
16:33:07.400 - Graph::Run
16:33:07.460 - Graph::Run 1
16:33:07.460 - Graph::SetVideoRect {12 8 1012 568}
16:33:07.464 - Graph::SetVideoWindowRect {0 0 1024 575}
16:33:07.478 - Graph::SetPictureParams 1
16:33:07.478 - AV:UpdateAudioParamsAfterActive
16:33:07.484 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:33:07.488 - GR:UpdateAudioProcessor old=0 new=0
16:33:07.494 - CPCG SetVolume 0E8D2378 50
16:33:07.499 - Graph::SetVolume 50% -1250db
16:33:07.505 - Graph::Run
16:33:07.510 - Graph::Run 0
16:33:07.515 - subsm.StartChannel demux=ProgDemux tr=TS
16:33:07.520 - subsm.RecreateSubtitlesParsers 29F949F8 ts=1 subindex=-1 st=-1
16:33:07.526 - subsm.Stop teletext parser
16:33:07.526 - 
16:33:07.537 - [0]########################### Mark of finish channel changing. (3.375ms) #############
16:33:07.543 - 
16:33:07.946 - * s:100 q:100 tr=2317852 (0) - ntt0 dmx5338 -1 Playing
16:33:08.946 - * s:100 q:100 tr=4228308 (0) - ntt0 dmx6842 -1 Playing
16:33:09.962 - * s:100 q:100 tr=0 (0) - ntt0 dmx5821 -1 Playing
16:33:11.025 - * s:100 q:100 tr=0 (0) - ntt0 dmx5734 -1 Playing
16:33:11.989 - * s:100 q:100 tr=2291156 (0) - ntt0 dmx9790 -1 Playing
16:33:12.994 - * s:100 q:100 tr=0 (0) - ntt0 dmx8764 -1 Playing
16:33:13.996 - * s:100 q:100 tr=0 (0) - ntt0 dmx7776 -1 Playing
16:33:14.999 - * s:100 q:100 tr=0 (0) - ntt0 dmx6792 -1 Playing
16:33:16.014 - * s:100 q:100 tr=0 (0) - ntt0 dmx5758 -1 Playing
16:33:17.021 - * s:0 q:0 tr=0 (0) - ntt0 dmx7255 -1 Playing
16:33:17.666 - subsm.RecreateSubtitlesParsers end
16:33:17.667 - subs: OnSetChannel
16:33:17.673 - Delete timer 100 Subtitles
16:33:17.688 - ------sGetVideoParams
16:33:17.693 - ------sGetVideoParams
16:33:17.722 - Graph::SetVideoWindowRect {0 0 1000 562}
16:33:17.765 - Api2BaseModule.OnDisplaySize
16:33:17.765 - dev: UpdateNetworkRecommendations  1347x737 -1x-1
16:33:18.008 - * s:0 q:0 tr=0 (0) - ntt0 dmx6567 -1 Playing
16:33:18.079 - Graph::OnVideoWindowPositionChanged
16:33:19.013 - * s:100 q:100 tr=2259384 (0) - ntt0 dmx6813 -1 Playing
16:33:20.027 - * s:100 q:100 tr=0 (0) - ntt0 dmx5735 -1 Playing
16:33:21.029 - * s:100 q:100 tr=0 (0) - ntt0 dmx5963 -1 Playing
16:33:22.043 - * s:100 q:100 tr=0 (0) - ntt0 dmx6330 -1 Playing
16:33:22.647 - 
16:33:22.647 - 
16:33:22.652 - ########################### Mark of start channel changing.###########################
16:33:22.658 - 
16:33:22.662 - GraphManager::MainChangeChannel Россия 1 (Анадырь)  1 provs
16:33:22.668 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
16:33:22.674 - SetChannelLogic::SetChannel 0
16:33:22.679 - SetChannelLogic::SetNormalChannel
16:33:22.690 - [101]Stop channel
16:33:22.690 - PreScanner.Stop
16:33:22.695 - GraphState: Undef by PreScanner.Stop
16:33:22.700 - PlayTimePmtParser::StopParser
16:33:22.706 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
16:33:22.711 - Prereader::ReaderCursor.. OK
16:33:22.722 - ReaderCursor::SetPosition 0 (w=52417481687433216)
16:33:22.727 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
16:33:22.732 - Prereader.StartPlayback after lock
16:33:22.738 - subsm.StopChannel
16:33:22.743 - SSTeletext: SetChannel page=0 lng
16:33:22.748 - DestroyPlayer th=0
16:33:22.754 - Graph::Stop
16:33:22.786 - Before Stop ...16:33:22.793 - OnGraphStop ...16:33:22.856 - VR: Disconnect
16:33:22.857 - Graph::ReleaseAllFilters
16:33:22.860 - release: Prog Audio renderer - RR - OK.
16:33:22.871 - release: Video Renderer - RR - OK.
16:33:22.958 - release: Video decoder  - RR - OK.
16:33:22.969 - release: Audio Processor - RR - OK.
16:33:22.980 - release: Audio decoder - RR - OK.
16:33:22.990 - FilterGraph: 1
16:33:22.996 - Delete timer 1000 DirectShowPlayer
16:33:23.001 - Graph::ReleaseAllFilters
16:33:23.015 - DestroyPlayer - after
16:33:23.015 - **** StopChannel time 0.375ms
16:33:23.021 - 
16:33:23.025 - TransponderManager::SetTransponder (CH) 0 Россия 1 (Анадырь)
16:33:23.031 - *Transport TS
16:33:23.036 - Api2Device::SetChannel https://vgtrkregion-reg.cdnvideo.ru/vgtrk/anadyr/russia1-sd/index.m3u8
16:33:23.063 - Delete timer 1000 HlsReader
16:33:23.088 - Api2BaseModule.OnTunerStateChanged Connecting
16:33:23.094 - Api2Device::SetChannel result OK
16:33:23.094 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=43981
16:33:23.094 - Api2BaseModule.OnTunerStateChanged  -3
16:33:23.099 - TsInputTrafficProcessor.OpenTransponder 1
16:33:23.110 - FilterManager::OnSetTransponder SetChannel
16:33:23.116 - TimeShift.Reset
16:33:23.120 - TimeShift.Cursor reset
16:33:23.126 - ReaderCursor::Reset.. OK
16:33:23.137 - Prereader.Reset ...-OK
16:33:23.147 - ModuleList::ChangeChannel 0
16:33:23.153 - **** SetTransponder time 0.141ms
16:33:23.158 - [101]ChannelGraph5::StartChannel Россия 1 (Анадырь)
16:33:23.163 - AV:UpdateAudioParamsAfterActive
16:33:23.169 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:33:23.173 - GR:UpdateAudioProcessor old=0 new=0
16:33:23.179 - CPCG SetVolume 00000000 50
16:33:23.184 - 
16:33:23.190 - [101]       #################### Start stream. (0.547ms) #######################
16:33:23.195 - 
16:33:23.241 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
16:33:23.241 - TimeShift.Cursor SetChannel::v 0 (0)
16:33:23.246 - ReaderCursor::SetChannel.. OK
16:33:23.250 - Api2BaseModule.OnTunerStateChanged Preparing
16:33:23.258 - ReaderCursor::SetPosition 0 (w=0)
16:33:23.268 - Prereader.SetChannel..
16:33:23.268 - Api2BaseModule.OnTunerStateChanged  -4
16:33:23.273 - Prereader.SetChannel unmask 1
16:33:23.284 - Plugin::SetChannel 43981
16:33:23.289 - TransponderManager::SelectChannel
16:33:23.295 - TsInputTrafficProcessor.SelectChannel 43981
16:33:23.299 - Api2BaseModule.UpdateAllOpenedChannels 1
16:33:23.305 - TsInputTrafficProcessor.UpdateChannel 43981
16:33:23.305 - Api2BaseModule.OnTunerStateChanged Playing
16:33:23.310 - GraphState: Undef by StartChannelIsReady
16:33:23.320 - PreScanner.StartChannelIsReady net=1 parseall=1
16:33:23.321 - Api2BaseModule.OnTunerStateChanged  -4
16:33:23.326 - SimpleTsDemux::Init apid=0, vpid=0
16:33:23.336 - GraphState: RequestPATScan by StartChannelIsReady TS
16:33:23.341 - Api2BaseModule.Filters_EnabledFullTS 1
16:33:23.347 - PlayTimePATParser.OpenParser 43981
16:33:23.352 - Open TSTS filter pid=0 data=0
16:33:23.358 - TSTS cur size=0
16:33:23.363 - **** StartChannel time 0.203ms
16:33:23.369 - [101]OnChangeCurrentGraph2 -endOfSetChannel
16:33:23.373 - ChannelGraph.SetActiveState 1
16:33:23.402 - ------sGetVideoParams
16:33:23.453 - [101]**** SetChannel is finished (OK). Duration 0.813ms
16:33:23.522 - Add timer 1000 HlsReader
16:33:23.550 - Api2BaseModule.EngineApi_ChList_SendSubChannels 2/5
16:33:23.665 - * s:0 q:0 tr=0 (0) - ntt0 dmx0 -1 Connecting
16:33:24.101 - 
16:33:24.101 -        #################### First traffic. (1.454ms) #######################
16:33:24.107 - 
16:33:24.112 - PlayTimePATParser.EndTask
16:33:24.119 - TransportMarker: TS
16:33:24.119 - PreScanner.OnAfterScanPat count=2 {1;4096}
16:33:24.123 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
16:33:24.134 - Api2BaseModule.Filters_EnabledFullTS 0
16:33:24.141 - GraphState: RequestPMTScan by OnAfterScanPat
16:33:24.146 - PlayTimePmtParser::OpenParser SID=1 PMT=4096 unknow channel=1
16:33:24.151 - Open TSTS filter pid=4096 data=2
16:33:24.157 - TSTS cur size=671160
16:33:24.163 - EngineTransportsParser::UpdateLngStream update marker id=307644203 type=534769836
16:33:24.169 - TSTS quick finish
16:33:24.173 - --SwitchEngineTransport TS > TS
16:33:24.179 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
16:33:24.185 - PreScanner.OnTransportMarker TS
16:33:24.190 - PreScanner.OnTransportMarker Skiped! same marker
16:33:24.211 - --SwitchEngineTransport end
16:33:24.211 - PreScanner.OnAfterScanPmt pmt=4096
16:33:24.215 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
16:33:24.221 - PlayTimePmtParser::StopParser
16:33:24.272 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
16:33:24.272 - TimeShift.Cursor SetChannel::v 1134580 (1134580)
16:33:24.278 - Prereader.SetChannel unmask 1
16:33:24.283 - Plugin::SetChannel 1
16:33:24.288 - TransponderManager::SelectChannel
16:33:24.292 - TsInputTrafficProcessor.SelectChannel 1
16:33:24.298 - Api2BaseModule.UpdateAllOpenedChannels 1
16:33:24.303 - TsInputTrafficProcessor.UpdateChannel 1
16:33:24.308 - PreScanner.StartChannelIsReady net=1 parseall=0
16:33:24.314 - LngDefaultSelector.try select audio pid=257 type=1 lng=7566706-rus(enm;ang;eng,deu;gmh;goh;ger,rus) l=12
16:33:24.319 - LngDefaultSelector. selected audio pid=257
16:33:24.325 - ChannelGraph::AfterDetectChannelParams
16:33:24.330 - VideoMediaTypeDetection: h.264
16:33:24.335 - SimpleTsDemux::Init apid=257, vpid=256
16:33:24.341 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
16:33:24.346 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
16:33:24.351 - Prereader::ReaderCursor.. OK
16:33:24.362 - ReaderCursor::SetPosition 0 (w=4872983994695680)
16:33:24.368 - Prereader.StartPlayback Push buffering=0 recv=0E8E8A44 [StartChannelHelperBase(sl)]
16:33:24.373 - Prereader.StartPlayback after lock
16:33:24.378 - PreScanner.StartPmtParserIfNeed
16:33:24.384 - PlayTimePmtParser::OpenParser SID=1 PMT=4096 unknow channel=0
16:33:24.389 - Open TSTS filter pid=4096 data=2
16:33:24.378 - AudioParser::First packet 358
16:33:24.398 - AudioParser::aac detected
16:33:24.394 - TSTS cur size=1134580
16:33:24.404 - VideoParser::First packet 31871 h.264
16:33:24.415 - h264 detected 0 ms
16:33:24.420 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
16:33:24.426 - PreScanner.Post_InitRender [ReceiveTraffic]
16:33:24.421 - * s:100 q:100 tr=1134768 (0) - ntt0 dmx0 -1 Preparing
16:33:24.476 - 
16:33:24.476 - [101]       #################### Init Render. (1.829ms) #######################
16:33:24.482 - 
16:33:24.487 - ------sGetVideoParams
16:33:24.493 - video:h264 SD
16:33:24.498 - selector PlaybackTag=none videocodec=DS/ ts=1
16:33:24.504 - Channel PlaybackWay after check DS
16:33:24.514 - GraphState: GraphStarted by AsyncInitRender
16:33:24.514 - CalculBufferingSize prov=156725D4 marker=1 request=1
16:33:24.519 - CalculBuffering 2000ms br=2410kb to 602 kbytes. from marker
16:33:24.525 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
16:33:24.530 - Prereader::ReaderCursor.. OK
16:33:24.540 - ReaderCursor::SetPosition 0 (w=9707210204512256)
16:33:24.545 - Prereader.StartPlayback Pull buffering=617027 recv=00000000 [EnablePullModeAndStartPlayback]
16:33:24.551 - Prereader.StartPlayback after lock
16:33:24.555 - Buffering/prereader size 602/3906 kbytes
16:33:24.561 - Not same player! old 0 new 13 prev 13
16:33:24.567 - ------sGetVideoParams
16:33:24.573 - ------sGetVideoParams
16:33:24.601 - Api2BaseModule.OnDisplaySize
16:33:24.601 - dev: UpdateNetworkRecommendations  1371x751 -1x-1
16:33:24.614 - Add timer 1000 DirectShowPlayer
16:33:24.619 - Graph::SetVideoWindowRect {224 0 800 576}
16:33:24.619 - Graph::UpdateRenderMode
16:33:24.635 - Graph::SetVideoRect {8 8 712 568}
16:33:24.635 - Graph::SetVideoWindowRect {128 0 896 576}
16:33:24.640 - demux: ProgDemux
16:33:24.661 - ------sGetVideoParams
16:33:24.661 - ChannelGraph5.CreateInterfacesAndRenderGraph
16:33:24.669 - CreateCustomGraph
16:33:24.672 - VideoType:H.264/AVC ffmpeg=0
16:33:24.678 - Video/4.H264 : MPEG2_VIDEO s={0,0,1024,576}, t={0,0,1024,576}, bmp=1024x576, r=16/9, br=0,frametime=40ms, IF=0x0, CF=0x0)
16:33:24.683 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f
16:33:24.689 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 29BFF93C
16:33:24.700 - OK
16:33:24.700 - CChannelGraph5::CreateRender 12
16:33:24.705 - VR: MPC VR
16:33:24.711 - VR: create new render
16:33:24.816 - VR: Add video renderer Video Renderer - OK
16:33:24.816 - CreateAudioPartOfGraph
16:33:24.821 - AudioType:aac/adts 
16:33:24.826 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 48000 16bit formatTag= 0x1600)
16:33:24.832 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVAudio.ax 2993419C
16:33:24.837 - Add audio codec e8e73b6b-4cb3-44a4-be99-4f7bcb96e491 - OK
16:33:24.846 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
16:33:24.847 - Added audio renderer
16:33:24.852 - AP: created
16:33:24.858 - Added audio processor
16:33:24.868 - Connect codec to AP - OK
16:33:24.888 - Add and connect audio renderer - OK
16:33:24.888 - Graph::AfterRender
16:33:24.894 - AV:UpdateAudioParamsAfterActive
16:33:24.898 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:33:24.904 - GR:UpdateAudioProcessor old=1 new=0
16:33:24.909 - Destroy Audio Processor update
16:33:24.913 - CPCG SetVolume 298FE840 50
16:33:24.919 - Graph::SetVolume 50% -1250db
16:33:24.924 - Graph::Run
16:33:24.983 - Graph::Run 1
16:33:24.983 - Graph::SetVideoRect {12 8 1012 568}
16:33:24.989 - Graph::SetVideoWindowRect {0 0 1024 575}
16:33:25.003 - Graph::SetPictureParams 1
16:33:25.003 - AV:UpdateAudioParamsAfterActive
16:33:25.008 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:33:25.013 - GR:UpdateAudioProcessor old=0 new=0
16:33:25.018 - CPCG SetVolume 298FE840 50
16:33:25.023 - Graph::SetVolume 50% -1250db
16:33:25.029 - Graph::Run
16:33:25.033 - Graph::Run 0
16:33:25.039 - subsm.StartChannel demux=ProgDemux tr=TS
16:33:25.044 - subsm.RecreateSubtitlesParsers 156DED18 ts=1 subindex=-1 st=-1
16:33:25.049 - subsm.Stop teletext parser
16:33:25.048 - * s:100 q:100 tr=2214264 (0) - ntt63 dmx6314 -1 Playing
16:33:25.055 - subsm.RecreateSubtitlesParsers end
16:33:25.066 - subs: OnSetChannel
16:33:25.058 - 
16:33:25.075 - [0]########################### Mark of finish channel changing. (2.438ms) #############
16:33:25.080 - 
16:33:25.081 - ------sGetVideoParams
16:33:25.096 - ------sGetVideoParams
16:33:25.126 - Graph::SetVideoWindowRect {0 0 1000 562}
16:33:25.138 - Api2BaseModule.OnDisplaySize
16:33:25.138 - dev: UpdateNetworkRecommendations  1347x737 -1x-1
16:33:25.228 - Graph::OnVideoWindowPositionChanged
16:33:26.058 - * s:100 q:100 tr=3557712 (0) - ntt0 dmx6512 -1 Playing
16:33:27.061 - * s:100 q:100 tr=3233036 (0) - ntt0 dmx5518 -1 Playing
16:33:28.059 - * s:100 q:100 tr=0 (0) - ntt0 dmx5688 -1 Playing
16:33:29.049 - * s:100 q:100 tr=0 (0) - ntt32 dmx6620 -1 Playing
16:33:30.061 - * s:100 q:100 tr=0 (0) - ntt0 dmx6692 -1 Playing
16:33:31.061 - * s:100 q:100 tr=0 (0) - ntt0 dmx5643 -1 Playing
16:33:32.063 - * s:0 q:0 tr=0 (0) - ntt0 dmx5982 -1 Playing
16:33:33.063 - * s:0 q:0 tr=0 (0) - ntt0 dmx5773 -1 Playing
16:33:34.062 - * s:100 q:100 tr=2318792 (0) - ntt0 dmx6064 -1 Playing
16:33:34.916 - * s:100 q:100 tr=0 (0) - ntt0 dmx6435 -1 Playing
16:33:36.012 - * s:100 q:100 tr=0 (0) - ntt0 dmx5437 -1 Playing
16:33:37.063 - * s:100 q:100 tr=0 (0) - ntt0 dmx5771 -1 Playing
16:33:38.065 - * s:100 q:100 tr=0 (0) - ntt0 dmx6120 -1 Playing
16:33:39.064 - * s:0 q:0 tr=0 (0) - ntt0 dmx6331 -1 Playing
16:33:40.071 - * s:100 q:100 tr=1137024 (0) - ntt0 dmx5331 -1 Playing
16:33:41.088 - * s:100 q:100 tr=1117848 (0) - ntt0 dmx5532 -1 Playing
16:33:42.089 - * s:100 q:100 tr=0 (0) - ntt0 dmx6256 -1 Playing
16:33:43.094 - * s:100 q:100 tr=0 (0) - ntt0 dmx6558 -1 Playing
16:33:43.670 - * s:100 q:100 tr=0 (0) - ntt0 dmx5801 -1 Playing
16:33:44.260 - * s:100 q:100 tr=0 (0) - ntt0 dmx6361 -1 Playing
16:33:44.762 - * s:0 q:0 tr=0 (0) - ntt0 dmx5863 -1 Playing
16:33:45.264 - * s:0 q:0 tr=0 (0) - ntt0 dmx6745 -1 Playing
16:33:45.854 - * s:0 q:0 tr=0 (0) - ntt0 dmx6167 -1 Playing
16:33:47.092 - * s:100 q:100 tr=2281380 (0) - ntt0 dmx5717 -1 Playing
16:33:48.051 - * s:100 q:100 tr=0 (0) - ntt0 dmx6116 -1 Playing
16:33:49.087 - ------sGetVideoParams
16:33:49.098 - * s:100 q:100 tr=0 (0) - ntt0 dmx6535 -1 Playing
16:33:50.094 - * s:100 q:100 tr=0 (0) - ntt32 dmx6872 -1 Playing
16:33:50.511 - 
16:33:50.512 - 
16:33:50.517 - ########################### Mark of start channel changing.###########################
16:33:50.522 - 
16:33:50.527 - GraphManager::MainChangeChannel Россия 1 (Архангельск)  1 provs
16:33:50.532 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
16:33:50.536 - SetChannelLogic::SetChannel 0
16:33:50.542 - SetChannelLogic::SetNormalChannel
16:33:50.553 - [101]Stop channel
16:33:50.553 - PreScanner.Stop
16:33:50.557 - GraphState: Undef by PreScanner.Stop
16:33:50.563 - PlayTimePmtParser::StopParser
16:33:50.567 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
16:33:50.572 - Prereader::ReaderCursor.. OK
16:33:50.583 - ReaderCursor::SetPosition 0 (w=71906187850809344)
16:33:50.587 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
16:33:50.593 - Prereader.StartPlayback after lock
16:33:50.597 - subsm.StopChannel
16:33:50.603 - SSTeletext: SetChannel page=0 lng
16:33:50.607 - DestroyPlayer th=0
16:33:50.612 - Graph::Stop
16:33:50.652 - Before Stop ...16:33:50.656 - OnGraphStop ...16:33:50.691 - VR: Disconnect
16:33:50.693 - Graph::ReleaseAllFilters
16:33:50.697 - release: Prog Audio renderer - RR - OK.
16:33:50.706 - release: Video Renderer - RR - OK.
16:33:50.800 - release: Video decoder  - RR - OK.
16:33:50.813 - release: Audio Processor - RR - OK.
16:33:50.823 - release: Audio decoder - RR - OK.
16:33:50.832 - FilterGraph: 1
16:33:50.838 - Delete timer 1000 DirectShowPlayer
16:33:50.842 - Graph::ReleaseAllFilters
16:33:50.854 - DestroyPlayer - after
16:33:50.854 - **** StopChannel time 0.344ms
16:33:50.860 - 
16:33:50.865 - TransponderManager::SetTransponder (CH) 0 Россия 1 (Архангельск)
16:33:50.870 - *Transport TS
16:33:50.874 - Api2Device::SetChannel https://vgtrkregion-reg.cdnvideo.ru/vgtrk/arhangelsk/russia1-hd/index.m3u8
16:33:50.901 - Delete timer 1000 HlsReader
16:33:50.924 - Api2BaseModule.OnTunerStateChanged Connecting
16:33:50.929 - Api2Device::SetChannel result OK
16:33:50.929 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=43981
16:33:50.929 - Api2BaseModule.OnTunerStateChanged  -3
16:33:50.935 - TsInputTrafficProcessor.OpenTransponder 1
16:33:50.945 - FilterManager::OnSetTransponder SetChannel
16:33:50.951 - TimeShift.Reset
16:33:50.955 - TimeShift.Cursor reset
16:33:50.961 - ReaderCursor::Reset.. OK
16:33:50.971 - Prereader.Reset ...-OK
16:33:50.981 - ModuleList::ChangeChannel 0
16:33:50.987 - **** SetTransponder time 0.125ms
16:33:50.992 - [101]ChannelGraph5::StartChannel Россия 1 (Архангельск)
16:33:50.997 - AV:UpdateAudioParamsAfterActive
16:33:51.001 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:33:51.007 - GR:UpdateAudioProcessor old=0 new=0
16:33:51.012 - CPCG SetVolume 00000000 50
16:33:51.017 - 
16:33:51.022 - [101]       #################### Start stream. (0.500ms) #######################
16:33:51.028 - 
16:33:51.073 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
16:33:51.073 - TimeShift.Cursor SetChannel::v 0 (0)
16:33:51.078 - ReaderCursor::SetChannel.. OK
16:33:51.088 - Api2BaseModule.OnTunerStateChanged Preparing
16:33:51.090 - ReaderCursor::SetPosition 0 (w=0)
16:33:51.101 - Prereader.SetChannel..
16:33:51.101 - Api2BaseModule.OnTunerStateChanged  -4
16:33:51.106 - Prereader.SetChannel unmask 1
16:33:51.116 - Plugin::SetChannel 43981
16:33:51.121 - TransponderManager::SelectChannel
16:33:51.126 - TsInputTrafficProcessor.SelectChannel 43981
16:33:51.131 - Api2BaseModule.UpdateAllOpenedChannels 1
16:33:51.137 - TsInputTrafficProcessor.UpdateChannel 43981
16:33:51.140 - Api2BaseModule.OnTunerStateChanged Playing
16:33:51.141 - GraphState: Undef by StartChannelIsReady
16:33:51.151 - PreScanner.StartChannelIsReady net=1 parseall=1
16:33:51.152 - Api2BaseModule.OnTunerStateChanged  -4
16:33:51.156 - SimpleTsDemux::Init apid=0, vpid=0
16:33:51.166 - GraphState: RequestPATScan by StartChannelIsReady TS
16:33:51.172 - Api2BaseModule.Filters_EnabledFullTS 1
16:33:51.178 - PlayTimePATParser.OpenParser 43981
16:33:51.183 - Open TSTS filter pid=0 data=0
16:33:51.187 - TSTS cur size=0
16:33:51.193 - **** StartChannel time 0.203ms
16:33:51.198 - [101]OnChangeCurrentGraph2 -endOfSetChannel
16:33:51.203 - ChannelGraph.SetActiveState 1
16:33:51.229 - ------sGetVideoParams
16:33:51.280 - [101]**** SetChannel is finished (OK). Duration 0.766ms
16:33:51.349 - Add timer 1000 HlsReader
16:33:51.375 - Api2BaseModule.EngineApi_ChList_SendSubChannels 1/7
16:33:51.502 - * s:0 q:0 tr=0 (0) - ntt0 dmx0 -1 Connecting
16:33:51.930 - 
16:33:51.930 -        #################### First traffic. (1.407ms) #######################
16:33:51.935 - 
16:33:51.941 - PlayTimePATParser.EndTask
16:33:51.945 - TransportMarker: TS
16:33:51.951 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
16:33:51.945 - PreScanner.OnAfterScanPat count=2 {1;4096}
16:33:51.961 - Api2BaseModule.Filters_EnabledFullTS 0
16:33:51.967 - GraphState: RequestPMTScan by OnAfterScanPat
16:33:51.972 - PlayTimePmtParser::OpenParser SID=1 PMT=4096 unknow channel=1
16:33:51.977 - Open TSTS filter pid=4096 data=2
16:33:51.983 - TSTS cur size=474512
16:33:51.988 - EngineTransportsParser::UpdateLngStream update marker id=307644203 type=534769836
16:33:51.993 - TSTS quick finish
16:33:51.999 - --SwitchEngineTransport TS > TS
16:33:52.003 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
16:33:52.010 - PreScanner.OnTransportMarker TS
16:33:52.014 - PreScanner.OnTransportMarker Skiped! same marker
16:33:52.035 - --SwitchEngineTransport end
16:33:52.035 - PreScanner.OnAfterScanPmt pmt=4096
16:33:52.041 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
16:33:52.046 - PlayTimePmtParser::StopParser
16:33:52.100 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
16:33:52.100 - TimeShift.Cursor SetChannel::v 2852524 (2852524)
16:33:52.106 - Prereader.SetChannel unmask 1
16:33:52.110 - Plugin::SetChannel 1
16:33:52.115 - TransponderManager::SelectChannel
16:33:52.110 - * s:100 q:100 tr=2852712 (0) - ntt0 dmx0 -1 Preparing
16:33:52.121 - TsInputTrafficProcessor.SelectChannel 1
16:33:52.131 - Api2BaseModule.UpdateAllOpenedChannels 1
16:33:52.136 - TsInputTrafficProcessor.UpdateChannel 1
16:33:52.141 - PreScanner.StartChannelIsReady net=1 parseall=0
16:33:52.145 - LngDefaultSelector.try select audio pid=257 type=1 lng=7566706-rus(enm;ang;eng,deu;gmh;goh;ger,rus) l=12
16:33:52.151 - LngDefaultSelector. selected audio pid=257
16:33:52.157 - ChannelGraph::AfterDetectChannelParams
16:33:52.161 - VideoMediaTypeDetection: h.264
16:33:52.166 - SimpleTsDemux::Init apid=257, vpid=256
16:33:52.171 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
16:33:52.177 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
16:33:52.181 - Prereader::ReaderCursor.. OK
16:33:52.192 - ReaderCursor::SetPosition 0 (w=12251497291055104)
16:33:52.198 - Prereader.StartPlayback Push buffering=0 recv=0E8E8A44 [StartChannelHelperBase(sl)]
16:33:52.202 - Prereader.StartPlayback after lock
16:33:52.208 - PreScanner.StartPmtParserIfNeed
16:33:52.208 - AudioParser::First packet 340
16:33:52.212 - PlayTimePmtParser::OpenParser SID=1 PMT=4096 unknow channel=0
16:33:52.223 - Open TSTS filter pid=4096 data=2
16:33:52.218 - AudioParser::aac detected
16:33:52.228 - TSTS cur size=2852524
16:33:52.233 - VideoParser::First packet 194940 h.264
16:33:52.243 - h264 detected 0 ms
16:33:52.249 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
16:33:52.253 - PreScanner.Post_InitRender [ReceiveTraffic]
16:33:52.251 - * s:100 q:100 tr=2852712 (0) - ntt0 dmx0 -1 Preparing
16:33:52.303 - 
16:33:52.303 - [101]       #################### Init Render. (1.782ms) #######################
16:33:52.307 - 
16:33:52.313 - ------sGetVideoParams
16:33:52.318 - video:h264 HD
16:33:52.324 - selector PlaybackTag=none videocodec=DS/ ts=1
16:33:52.329 - Channel PlaybackWay after check DS
16:33:52.339 - GraphState: GraphStarted by AsyncInitRender
16:33:52.339 - CalculBufferingSize prov=156725D4 marker=1 request=1
16:33:52.344 - CalculBuffering 2000ms br=6043kb to 1510 kbytes. from marker
16:33:52.350 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
16:33:52.354 - Prereader::ReaderCursor.. OK
16:33:52.364 - ReaderCursor::SetPosition 0 (w=13998827426021376)
16:33:52.370 - Prereader.StartPlayback Pull buffering=1547235 recv=00000000 [EnablePullModeAndStartPlayback]
16:33:52.374 - Prereader.StartPlayback after lock
16:33:52.380 - Buffering/prereader size 1510/3906 kbytes
16:33:52.385 - Not same player! old 0 new 13 prev 13
16:33:52.391 - ------sGetVideoParams
16:33:52.406 - Add timer 1000 DirectShowPlayer
16:33:52.412 - Graph::SetVideoWindowRect {219 0 781 562}
16:33:52.412 - Graph::UpdateRenderMode
16:33:52.426 - Graph::SetVideoRect {8 8 712 568}
16:33:52.428 - Graph::SetVideoWindowRect {125 0 874 562}
16:33:52.432 - demux: ProgDemux
16:33:52.448 - ------sGetVideoParams
16:33:52.448 - ChannelGraph5.CreateInterfacesAndRenderGraph
16:33:52.455 - CreateCustomGraph
16:33:52.458 - VideoType:H.264/AVC ffmpeg=0
16:33:52.463 - Video/4.H264 : MPEG2_VIDEO s={0,0,1920,1080}, t={0,0,1920,1080}, bmp=1920x1088, r=30/17, br=0,frametime=33ms, IF=0x0, CF=0x0)
16:33:52.469 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f
16:33:52.474 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 299327BC
16:33:52.483 - OK
16:33:52.484 - CChannelGraph5::CreateRender 12
16:33:52.489 - VR: MPC VR
16:33:52.494 - VR: create new render
16:33:52.645 - VR: Add video renderer Video Renderer - OK
16:33:52.645 - CreateAudioPartOfGraph
16:33:52.650 - AudioType:aac/adts 
16:33:52.656 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 48000 16bit formatTag= 0x1600)
16:33:52.661 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVAudio.ax 0E8183F4
16:33:52.667 - Add audio codec e8e73b6b-4cb3-44a4-be99-4f7bcb96e491 - OK
16:33:52.675 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
16:33:52.677 - Added audio renderer
16:33:52.681 - AP: created
16:33:52.686 - Added audio processor
16:33:52.697 - Connect codec to AP - OK
16:33:52.718 - Add and connect audio renderer - OK
16:33:52.718 - Graph::AfterRender
16:33:52.725 - AV:UpdateAudioParamsAfterActive
16:33:52.728 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:33:52.733 - GR:UpdateAudioProcessor old=1 new=0
16:33:52.739 - Destroy Audio Processor update
16:33:52.743 - CPCG SetVolume 15841640 50
16:33:52.749 - Graph::SetVolume 50% -1250db
16:33:52.755 - Graph::Run
16:33:52.812 - Graph::Run 1
16:33:52.812 - Graph::SetVideoRect {24 16 1896 1068}
16:33:52.817 - Graph::SetVideoWindowRect {4 0 995 562}
16:33:52.831 - Graph::SetPictureParams 1
16:33:52.831 - AV:UpdateAudioParamsAfterActive
16:33:52.836 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:33:52.840 - GR:UpdateAudioProcessor old=0 new=0
16:33:52.847 - CPCG SetVolume 15841640 50
16:33:52.853 - Graph::SetVolume 50% -1250db
16:33:52.859 - Graph::Run
16:33:52.863 - Graph::Run 0
16:33:52.867 - subsm.StartChannel demux=ProgDemux tr=TS
16:33:52.873 - subsm.RecreateSubtitlesParsers 29C8E578 ts=1 subindex=-1 st=-1
16:33:52.878 - subsm.Stop teletext parser
16:33:52.883 - subsm.RecreateSubtitlesParsers end
16:33:52.888 - subs: OnSetChannel
16:33:52.897 - 
16:33:52.899 - [0]########################### Mark of finish channel changing. (2.375ms) #############
16:33:52.904 - 
16:33:52.904 - ------sGetVideoParams
16:33:53.012 - Graph::OnVideoWindowPositionChanged
16:33:53.118 - * s:100 q:100 tr=5805252 (0) - ntt0 dmx280 -1 Playing
16:33:54.110 - * s:100 q:100 tr=8477108 (0) - ntt47 dmx6113 -1 Playing
16:33:55.120 - * s:100 q:100 tr=0 (0) - ntt0 dmx6148 -1 Playing
16:33:56.111 - * s:100 q:100 tr=0 (0) - ntt47 dmx5936 -1 Playing
16:33:57.133 - * s:100 q:100 tr=0 (0) - ntt0 dmx6125 -1 Playing
16:33:58.149 - * s:100 q:100 tr=0 (0) - ntt0 dmx5896 -1 Playing
16:33:59.142 - * s:0 q:0 tr=0 (0) - ntt46 dmx5944 -1 Playing
16:34:00.148 - * s:0 q:0 tr=0 (0) - ntt0 dmx5870 -1 Playing
16:34:01.147 - * s:0 q:0 tr=0 (0) - ntt0 dmx5952 -1 Playing
16:34:02.166 - * s:0 q:0 tr=0 (0) - ntt0 dmx5919 -1 Playing
16:34:02.722 - Graph::SetVideoWindowRect {5 0 995 561}
16:34:02.734 - Api2BaseModule.OnDisplaySize
16:34:02.734 - dev: UpdateNetworkRecommendations  1348x736 -1x-1
16:34:02.740 - Graph::OnVideoWindowPositionChanged
16:34:02.760 - Graph::SetVideoWindowRect {9 0 1006 565}
16:34:02.770 - Api2BaseModule.OnDisplaySize
16:34:02.770 - dev: UpdateNetworkRecommendations  1362x740 -1x-1
16:34:02.812 - Graph::OnVideoWindowPositionChanged
16:34:02.844 - Graph::SetVideoWindowRect {0 1 1091 619}
16:34:02.856 - Api2BaseModule.OnDisplaySize
16:34:02.856 - dev: UpdateNetworkRecommendations  1438x795 -1x-1
16:34:02.862 - Graph::OnVideoWindowPositionChanged
16:34:02.889 - Graph::SetVideoWindowRect {0 4 1146 653}
16:34:02.901 - Api2BaseModule.OnDisplaySize
16:34:02.901 - dev: UpdateNetworkRecommendations  1493x832 -1x-1
16:34:02.906 - Graph::OnVideoWindowPositionChanged
16:34:02.929 - Graph::SetVideoWindowRect {0 6 1185 677}
16:34:02.941 - Api2BaseModule.OnDisplaySize
16:34:02.941 - dev: UpdateNetworkRecommendations  1532x859 -1x-1
16:34:02.946 - Graph::OnVideoWindowPositionChanged
16:34:02.969 - Graph::SetVideoWindowRect {0 9 1220 700}
16:34:02.990 - Api2BaseModule.OnDisplaySize
16:34:02.990 - dev: UpdateNetworkRecommendations  1567x884 -1x-1
16:34:02.995 - Graph::OnVideoWindowPositionChanged
16:34:03.020 - Graph::SetVideoWindowRect {0 13 1264 729}
16:34:03.039 - Api2BaseModule.OnDisplaySize
16:34:03.040 - dev: UpdateNetworkRecommendations  1611x917 -1x-1
16:34:03.046 - Graph::OnVideoWindowPositionChanged
16:34:03.073 - Graph::SetVideoWindowRect {0 19 1317 765}
16:34:03.087 - Api2BaseModule.OnDisplaySize
16:34:03.087 - dev: UpdateNetworkRecommendations  1664x959 -1x-1
16:34:03.095 - Graph::OnVideoWindowPositionChanged
16:34:03.131 - Graph::SetVideoWindowRect {0 24 1360 794}
16:34:03.144 - Api2BaseModule.OnDisplaySize
16:34:03.144 - dev: UpdateNetworkRecommendations  1707x994 -1x-1
16:34:03.150 - Graph::OnVideoWindowPositionChanged
16:34:03.165 - * s:0 q:0 tr=0 (0) - ntt0 dmx5762 -1 Playing
16:34:03.182 - Graph::SetVideoWindowRect {0 28 1382 811}
16:34:03.199 - Api2BaseModule.OnDisplaySize
16:34:03.199 - dev: UpdateNetworkRecommendations  1729x1014 -1x-1
16:34:03.205 - Graph::OnVideoWindowPositionChanged
16:34:03.234 - Graph::SetVideoWindowRect {0 32 1406 828}
16:34:03.247 - Api2BaseModule.OnDisplaySize
16:34:03.247 - dev: UpdateNetworkRecommendations  1753x1035 -1x-1
16:34:03.254 - Graph::OnVideoWindowPositionChanged
16:34:03.320 - Graph::SetVideoWindowRect {0 41 1444 859}
16:34:03.334 - Api2BaseModule.OnDisplaySize
16:34:03.334 - dev: UpdateNetworkRecommendations  1791x1075 -1x-1
16:34:03.340 - Graph::OnVideoWindowPositionChanged
16:34:03.359 - Graph::SetVideoWindowRect {0 43 1454 866}
16:34:03.375 - Api2BaseModule.OnDisplaySize
16:34:03.375 - dev: UpdateNetworkRecommendations  1801x1085 -1x-1
16:34:03.380 - Graph::OnVideoWindowPositionChanged
16:34:03.431 - Graph::SetVideoWindowRect {0 43 1456 868}
16:34:03.445 - Api2BaseModule.OnDisplaySize
16:34:03.445 - dev: UpdateNetworkRecommendations  1803x1087 -1x-1
16:34:03.451 - Graph::OnVideoWindowPositionChanged
16:34:03.471 - Graph::SetVideoWindowRect {0 44 1457 869}
16:34:03.485 - Api2BaseModule.OnDisplaySize
16:34:03.485 - dev: UpdateNetworkRecommendations  1804x1089 -1x-1
16:34:03.490 - Graph::OnVideoWindowPositionChanged
16:34:03.808 - Graph::SetVideoWindowRect {0 43 1461 870}
16:34:03.824 - Api2BaseModule.OnDisplaySize
16:34:03.824 - dev: UpdateNetworkRecommendations  1808x1088 -1x-1
16:34:03.829 - Graph::OnVideoWindowPositionChanged
16:34:03.850 - Graph::SetVideoWindowRect {0 32 1479 870}
16:34:03.866 - Api2BaseModule.OnDisplaySize
16:34:03.866 - dev: UpdateNetworkRecommendations  1826x1078 -1x-1
16:34:03.871 - Graph::OnVideoWindowPositionChanged
16:34:03.896 - Graph::SetVideoWindowRect {0 23 1500 872}
16:34:03.910 - Api2BaseModule.OnDisplaySize
16:34:03.910 - dev: UpdateNetworkRecommendations  1847x1071 -1x-1
16:34:03.916 - Graph::OnVideoWindowPositionChanged
16:34:03.936 - Graph::SetVideoWindowRect {0 20 1506 873}
16:34:03.951 - Api2BaseModule.OnDisplaySize
16:34:03.951 - dev: UpdateNetworkRecommendations  1853x1068 -1x-1
16:34:03.957 - Graph::OnVideoWindowPositionChanged
16:34:03.976 - Graph::SetVideoWindowRect {0 15 1519 875}
16:34:03.993 - Api2BaseModule.OnDisplaySize
16:34:03.993 - dev: UpdateNetworkRecommendations  1866x1066 -1x-1
16:34:03.999 - Graph::OnVideoWindowPositionChanged
16:34:04.021 - Graph::SetVideoWindowRect {0 13 1526 877}
16:34:04.042 - Api2BaseModule.OnDisplaySize
16:34:04.042 - dev: UpdateNetworkRecommendations  1873x1066 -1x-1
16:34:04.050 - Graph::OnVideoWindowPositionChanged
16:34:04.071 - Graph::SetVideoWindowRect {0 10 1531 877}
16:34:04.088 - Api2BaseModule.OnDisplaySize
16:34:04.088 - dev: UpdateNetworkRecommendations  1878x1063 -1x-1
16:34:04.093 - Graph::OnVideoWindowPositionChanged
16:34:04.110 - Graph::SetVideoWindowRect {0 9 1536 879}
16:34:04.124 - Api2BaseModule.OnDisplaySize
16:34:04.124 - dev: UpdateNetworkRecommendations  1883x1063 -1x-1
16:34:04.130 - Graph::OnVideoWindowPositionChanged
16:34:04.162 - * s:0 q:0 tr=0 (0) - ntt0 dmx5830 -1 Playing
16:34:04.433 - Graph::SetVideoWindowRect {0 6 1541 879}
16:34:04.448 - Api2BaseModule.OnDisplaySize
16:34:04.448 - dev: UpdateNetworkRecommendations  1888x1061 -1x-1
16:34:04.454 - Graph::OnVideoWindowPositionChanged
16:34:04.485 - Graph::SetVideoWindowRect {0 5 1546 881}
16:34:04.501 - Api2BaseModule.OnDisplaySize
16:34:04.501 - dev: UpdateNetworkRecommendations  1893x1061 -1x-1
16:34:04.507 - Graph::OnVideoWindowPositionChanged
16:34:04.552 - Graph::SetVideoWindowRect {0 3 1554 883}
16:34:04.565 - Api2BaseModule.OnDisplaySize
16:34:04.565 - dev: UpdateNetworkRecommendations  1901x1062 -1x-1
16:34:04.571 - Graph::OnVideoWindowPositionChanged
16:34:04.605 - Graph::SetVideoWindowRect {0 3 1556 884}
16:34:04.620 - Api2BaseModule.OnDisplaySize
16:34:04.620 - dev: UpdateNetworkRecommendations  1903x1062 -1x-1
16:34:04.626 - Graph::OnVideoWindowPositionChanged
16:34:04.990 - * s:0 q:0 tr=0 (0) - ntt0 dmx5988 -1 Playing
16:34:06.167 - * s:0 q:0 tr=0 (0) - ntt0 dmx5777 -1 Playing
16:34:07.173 - * s:0 q:0 tr=0 (0) - ntt32 dmx6352 -1 Playing
16:34:08.178 - * s:0 q:0 tr=0 (0) - ntt0 dmx6082 -1 Playing
16:34:09.181 - * s:0 q:0 tr=0 (0) - ntt0 dmx6160 -1 Playing
16:34:09.911 - * s:0 q:0 tr=0 (0) - ntt0 dmx5831 -1 Playing
16:34:10.069 - OnBuffering.OnTunerStateChanged  0
16:34:11.009 - * s:0 q:0 tr=0 (0) - ntt0 dmx4732 -1 Buffering
16:34:12.102 - * s:0 q:0 tr=0 (0) - ntt0 dmx3641 -1 Buffering
16:34:13.196 - * s:0 q:0 tr=0 (0) - ntt0 dmx2561 -1 Buffering
16:34:14.205 - * s:0 q:0 tr=0 (0) - ntt16 dmx1545 -1 Buffering
16:34:15.219 - * s:0 q:0 tr=0 (0) - ntt32 dmx557 -1 Buffering
16:34:16.220 - * s:0 q:0 tr=0 (0) - ntt32 dmx557 -1 Buffering
16:34:17.221 - * s:0 q:0 tr=0 (0) - ntt1032 dmx557 -1 Buffering
16:34:17.414 - 
16:34:17.414 - 
16:34:17.420 - ########################### Mark of start channel changing.###########################
16:34:17.424 - 
16:34:17.429 - GraphManager::MainChangeChannel Das Erste FHD DE  1 provs
16:34:17.434 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
16:34:17.439 - SetChannelLogic::SetChannel 0
16:34:17.443 - SetChannelLogic::SetNormalChannel
16:34:17.453 - [101]Stop channel
16:34:17.453 - PreScanner.Stop
16:34:17.458 - GraphState: Undef by PreScanner.Stop
16:34:17.464 - PlayTimePmtParser::StopParser
16:34:17.468 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
16:34:17.473 - Prereader::ReaderCursor.. OK
16:34:17.484 - ReaderCursor::SetPosition 0 (w=73206188551962624)
16:34:17.489 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
16:34:17.493 - Prereader.StartPlayback after lock
16:34:17.498 - subsm.StopChannel
16:34:17.504 - SSTeletext: SetChannel page=0 lng
16:34:17.508 - DestroyPlayer th=0
16:34:17.513 - Graph::Stop
16:34:17.559 - Before Stop ...16:34:17.564 - OnGraphStop ...16:34:17.593 - VR: Disconnect
16:34:17.593 - Graph::ReleaseAllFilters
16:34:17.597 - release: Prog Audio renderer - RR - OK.
16:34:17.607 - release: Video Renderer - RR - OK.
16:34:17.714 - release: Video decoder  - RR - OK.
16:34:17.726 - release: Audio Processor - RR - OK.
16:34:17.736 - release: Audio decoder - RR - OK.
16:34:17.746 - FilterGraph: 1
16:34:17.751 - Delete timer 1000 DirectShowPlayer
16:34:17.756 - Graph::ReleaseAllFilters
16:34:17.769 - DestroyPlayer - after
16:34:17.769 - **** StopChannel time 0.359ms
16:34:17.775 - 
16:34:17.779 - TransponderManager::SetTransponder (CH) 0 Das Erste FHD DE
16:34:17.784 - *Transport TS
16:34:17.789 - Api2Device::SetChannel http://tv.kkzbigserver.iptv.uno:80/Uu6PpovAFKHM686/ecCM9J002/16493
16:34:17.815 - Delete timer 1000 HlsReader
16:34:17.840 - Api2BaseModule.OnTunerStateChanged Connecting
16:34:17.846 - Api2BaseModule.OnTunerStateChanged  -3
16:34:17.874 - Api2Device::SetChannel result OK
16:34:17.874 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=1
16:34:17.880 - TsInputTrafficProcessor.OpenTransponder 1
16:34:17.885 - FilterManager::OnSetTransponder SetChannel
16:34:17.889 - TimeShift.Reset
16:34:17.895 - TimeShift.Cursor reset
16:34:17.900 - ReaderCursor::Reset.. OK
16:34:17.910 - Prereader.Reset ...-OK
16:34:17.920 - Create EPGparser on SetChannel
16:34:17.926 - DvbEpgParser::SetChannel ID=13bc0002.fe66ceddb4251c10.1
16:34:17.935 - DvbEpgParser::mode normal pos=0
16:34:17.935 - ModuleList::ChangeChannel 0
16:34:17.940 - **** SetTransponder time 0.172ms
16:34:17.946 - [101]ChannelGraph5::StartChannel Das Erste FHD DE
16:34:17.951 - AV:UpdateAudioParamsAfterActive
16:34:17.957 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:34:17.963 - GR:UpdateAudioProcessor old=0 new=0
16:34:17.967 - CPCG SetVolume 00000000 50
16:34:17.972 - 
16:34:17.978 - [101]       #################### Start stream. (0.563ms) #######################
16:34:17.982 - 
16:34:17.992 - Api2BaseModule.OnTunerStateChanged Preparing
16:34:17.998 - Api2BaseModule.OnTunerStateChanged  -4
16:34:18.064 - Api2BaseModule.OnTunerStateChanged Playing
16:34:18.069 - Api2BaseModule.OnTunerStateChanged  -6
16:34:18.103 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
16:34:18.103 - TimeShift.Cursor SetChannel::v 0 (0)
16:34:18.108 - ReaderCursor::SetChannel.. OK
16:34:18.110 - Api2BaseModule.OnTunerStateChanged AnswerNotRecognized
16:34:18.118 - ReaderCursor::SetPosition 0 (w=0)
16:34:18.128 - Prereader.SetChannel..
16:34:18.133 - Prereader.SetChannel unmask 1
16:34:18.128 - Api2BaseModule.OnTunerStateChanged  --108
16:34:18.139 - Plugin::SetChannel 1
16:34:18.148 - TransponderManager::SelectChannel
16:34:18.154 - TsInputTrafficProcessor.SelectChannel 1
16:34:18.160 - Api2BaseModule.UpdateAllOpenedChannels 1
16:34:18.165 - TsInputTrafficProcessor.UpdateChannel 1
16:34:18.169 - GraphState: Undef by StartChannelIsReady
16:34:18.174 - PreScanner.StartChannelIsReady net=1 parseall=1
16:34:18.180 - VideoMediaTypeDetection: h.264
16:34:18.184 - SetMarkerAudioLngStream Gen New stream
16:34:18.190 - SimpleTsDemux::Init apid=257, vpid=256
16:34:18.194 - GraphState: RequestPATScan by StartChannelIsReady TS
16:34:18.200 - Api2BaseModule.Filters_EnabledFullTS 1
16:34:18.205 - PlayTimePATParser.OpenParser 1
16:34:18.211 - Open TSTS filter pid=0 data=0
16:34:18.215 - TSTS cur size=0
16:34:18.220 - **** StartChannel time 0.282ms
16:34:18.226 - [101]OnChangeCurrentGraph2 -endOfSetChannel
16:34:18.230 - ChannelGraph.SetActiveState 1
16:34:18.345 - [101]**** SetChannel is finished (OK). Duration 0.938ms
16:34:18.462 - Api2BaseModule.OnTunerStateChanged AnswerNotRecognized
16:34:18.467 - Api2BaseModule.OnTunerStateChanged  --108
16:34:18.483 - * s:0 q:0 tr=0 (0) - ntt0 dmx0 -1 AnswerNotRecognized
16:34:19.240 - * s:0 q:0 tr=0 (0) - ntt0 dmx0 -1 AnswerNotRecognized
16:34:20.243 - * s:0 q:0 tr=0 (0) - ntt0 dmx0 -1 AnswerNotRecognized
16:34:21.247 - * s:0 q:0 tr=0 (0) - ntt0 dmx0 -1 AnswerNotRecognized
16:34:22.257 - * s:0 q:0 tr=0 (0) - ntt0 dmx0 -1 AnswerNotRecognized
16:34:23.253 - * s:0 q:0 tr=0 (0) - ntt0 dmx0 -1 AnswerNotRecognized
16:34:23.792 - 
16:34:23.792 - 
16:34:23.798 - ########################### Mark of start channel changing.###########################
16:34:23.803 - 
16:34:23.809 - GraphManager::MainChangeChannel ZDF FHD DE  1 provs
16:34:23.815 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
16:34:23.819 - SetChannelLogic::SetChannel 0
16:34:23.825 - SetChannelLogic::SetNormalChannel
16:34:23.836 - [101]Stop channel
16:34:23.836 - PreScanner.Stop
16:34:23.840 - GraphState: Undef by PreScanner.Stop
16:34:23.846 - PlayTimePmtParser::StopParser
16:34:23.851 - Api2BaseModule.Filters_EnabledFullTS 0
16:34:23.857 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
16:34:23.862 - Prereader::ReaderCursor.. OK
16:34:23.872 - ReaderCursor::SetPosition 0 (w=0)
16:34:23.877 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
16:34:23.883 - Prereader.StartPlayback after lock
16:34:23.887 - subsm.StopChannel
16:34:23.893 - SSTeletext: SetChannel page=0 lng
16:34:23.897 - **** StopChannel time 0.093ms
16:34:23.902 - 
16:34:23.908 - TransponderManager::SetTransponder (CH) 0 ZDF FHD DE
16:34:23.912 - *Transport TS
16:34:23.917 - Api2Device::SetChannel http://tv.kkzbigserver.iptv.uno:80/Uu6PpovAFKHM686/ecCM9J002/16484
16:34:23.962 - Api2BaseModule.OnTunerStateChanged Connecting
16:34:23.967 - Api2BaseModule.OnTunerStateChanged  -3
16:34:23.968 - Api2Device::SetChannel result OK
16:34:23.973 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=43981
16:34:23.978 - TsInputTrafficProcessor.OpenTransponder 1
16:34:23.983 - FilterManager::OnSetTransponder SetChannel
16:34:23.988 - TimeShift.Reset
16:34:23.993 - TimeShift.Cursor reset
16:34:23.998 - ReaderCursor::Reset.. OK
16:34:24.008 - Prereader.Reset ...-OK
16:34:24.019 - Create EPGparser on SetChannel
16:34:24.024 - DvbEpgParser::SetChannel ID=13bc0002.9f705ea6133a73f2.abcd
16:34:24.042 - DvbEpgParser::mode normal pos=0
16:34:24.042 - ModuleList::ChangeChannel 0
16:34:24.048 - **** SetTransponder time 0.157ms
16:34:24.053 - [101]ChannelGraph5::StartChannel ZDF FHD DE
16:34:24.059 - AV:UpdateAudioParamsAfterActive
16:34:24.064 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:34:24.068 - GR:UpdateAudioProcessor old=0 new=0
16:34:24.074 - CPCG SetVolume 00000000 50
16:34:24.079 - 
16:34:24.083 - [101]       #################### Start stream. (0.281ms) #######################
16:34:24.089 - 
16:34:24.104 - Api2BaseModule.OnTunerStateChanged Preparing
16:34:24.110 - Api2BaseModule.OnTunerStateChanged  -4
16:34:24.179 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
16:34:24.179 - TimeShift.Cursor SetChannel::v 0 (0)
16:34:24.184 - ReaderCursor::SetChannel.. OK
16:34:24.194 - ReaderCursor::SetPosition 0 (w=0)
16:34:24.183 - Api2BaseModule.OnTunerStateChanged Playing
16:34:24.200 - Prereader.SetChannel..
16:34:24.210 - Prereader.SetChannel unmask 1
16:34:24.215 - Plugin::SetChannel 43981
16:34:24.220 - TransponderManager::SelectChannel
16:34:24.220 - Api2BaseModule.OnTunerStateChanged  -6
16:34:24.225 - TsInputTrafficProcessor.SelectChannel 43981
16:34:24.236 - Api2BaseModule.UpdateAllOpenedChannels 1
16:34:24.241 - TsInputTrafficProcessor.UpdateChannel 43981
16:34:24.246 - GraphState: Undef by StartChannelIsReady
16:34:24.250 - PreScanner.StartChannelIsReady net=1 parseall=1
16:34:24.256 - SimpleTsDemux::Init apid=0, vpid=0
16:34:24.261 - GraphState: RequestPATScan by StartChannelIsReady TS
16:34:24.266 - Api2BaseModule.Filters_EnabledFullTS 1
16:34:24.272 - PlayTimePATParser.OpenParser 43981
16:34:24.277 - Open TSTS filter pid=0 data=0
16:34:24.282 - TSTS cur size=0
16:34:24.287 - **** StartChannel time 0.234ms
16:34:24.291 - [101]OnChangeCurrentGraph2 -endOfSetChannel
16:34:24.297 - ChannelGraph.SetActiveState 1
16:34:24.324 - ------sGetVideoParams
16:34:24.398 - [101]**** SetChannel is finished (OK). Duration 0.593ms
16:34:24.469 - Api2BaseModule.OnTunerStateChanged Connecting
16:34:24.473 - Api2BaseModule.OnTunerStateChanged  -3
16:34:24.550 - * s:0 q:0 tr=0 (0) - ntt0 dmx0 -1 Connecting
16:34:24.573 - Api2BaseModule.OnTunerStateChanged Preparing
16:34:24.586 - Api2BaseModule.OnTunerStateChanged  -4
16:34:24.638 - Api2BaseModule.OnTunerStateChanged Playing
16:34:24.642 - Api2BaseModule.OnTunerStateChanged  -6
16:34:24.657 - 
16:34:24.657 -        #################### First traffic. (0.859ms) #######################
16:34:24.662 - 
16:34:24.667 - PlayTimePATParser.EndTask
16:34:24.672 - TransportMarker: TS
16:34:24.672 - PreScanner.OnAfterScanPat count=2 {1;4096}
16:34:24.678 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
16:34:24.689 - Api2BaseModule.Filters_EnabledFullTS 0
16:34:24.693 - GraphState: RequestPMTScan by OnAfterScanPat
16:34:24.699 - PlayTimePmtParser::OpenParser SID=1 PMT=4096 unknow channel=1
16:34:24.703 - Open TSTS filter pid=4096 data=2
16:34:24.709 - TSTS cur size=43804
16:34:24.715 - EngineTransportsParser::UpdateLngStream update marker id=307644203 type=534769836
16:34:24.719 - TSTS quick finish
16:34:24.724 - --SwitchEngineTransport TS > TS
16:34:24.730 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
16:34:24.735 - PreScanner.OnTransportMarker TS
16:34:24.739 - PreScanner.OnTransportMarker Skiped! same marker
16:34:24.759 - --SwitchEngineTransport end
16:34:24.759 - PreScanner.OnAfterScanPmt pmt=4096
16:34:24.765 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
16:34:24.770 - PlayTimePmtParser::StopParser
16:34:24.821 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
16:34:24.821 - TimeShift.Cursor SetChannel::v 227668 (227668)
16:34:24.825 - Prereader.SetChannel unmask 1
16:34:24.831 - Plugin::SetChannel 1
16:34:24.836 - TransponderManager::SelectChannel
16:34:24.842 - TsInputTrafficProcessor.SelectChannel 1
16:34:24.846 - Api2BaseModule.UpdateAllOpenedChannels 1
16:34:24.852 - TsInputTrafficProcessor.UpdateChannel 1
16:34:24.856 - PreScanner.StartChannelIsReady net=1 parseall=0
16:34:24.861 - LngDefaultSelector.try select audio pid=257 type=1 lng=0-(enm;ang;eng,deu;gmh;goh;ger,rus) l=99
16:34:24.866 - ChannelGraph::AfterDetectChannelParams
16:34:24.871 - VideoMediaTypeDetection: h.264
16:34:24.878 - SimpleTsDemux::Init apid=257, vpid=256
16:34:24.883 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
16:34:24.887 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
16:34:24.893 - Prereader::ReaderCursor.. OK
16:34:24.903 - ReaderCursor::SetPosition 0 (w=3949256788410368)
16:34:24.908 - Prereader.StartPlayback Push buffering=0 recv=0E8E8A44 [StartChannelHelperBase(sl)]
16:34:24.913 - Prereader.StartPlayback after lock
16:34:24.918 - PreScanner.StartPmtParserIfNeed
16:34:24.918 - VideoParser::First packet 245990 h.264
16:34:24.923 - PlayTimePmtParser::OpenParser SID=1 PMT=4096 unknow channel=0
16:34:24.927 - h264 detected 0 ms
16:34:24.933 - Open TSTS filter pid=4096 data=2
16:34:24.938 - AudioParser::First packet 2413
16:34:24.943 - TSTS cur size=1419400
16:34:24.949 - AudioParser::aac detected
16:34:24.958 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
16:34:24.964 - PreScanner.Post_InitRender [ReceiveTraffic]
16:34:24.969 - 
16:34:24.974 - [101]       #################### Init Render. (1.172ms) #######################
16:34:24.980 - 
16:34:24.984 - ------sGetVideoParams
16:34:24.990 - video:h264 HD
16:34:24.995 - selector PlaybackTag=none videocodec=DS/ ts=1
16:34:25.000 - Channel PlaybackWay after check DS
16:34:25.010 - GraphState: GraphStarted by AsyncInitRender
16:34:25.010 - CalculBufferingSize prov=156725D4 marker=1 request=1
16:34:25.015 - CalculBuffering 2000ms br=2000kb to 500 kbytes. By type
16:34:25.021 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
16:34:25.026 - Prereader::ReaderCursor.. OK
16:34:25.036 - ReaderCursor::SetPosition 0 (w=10280502439182336)
16:34:25.041 - Prereader.StartPlayback Pull buffering=512000 recv=00000000 [EnablePullModeAndStartPlayback]
16:34:25.046 - Prereader.StartPlayback after lock
16:34:25.051 - Buffering/prereader size 500/3906 kbytes
16:34:25.056 - Not same player! old 0 new 13 prev 13
16:34:25.061 - ------sGetVideoParams
16:34:25.077 - Add timer 1000 DirectShowPlayer
16:34:25.083 - Graph::SetVideoWindowRect {334 0 1221 887}
16:34:25.084 - Graph::UpdateRenderMode
16:34:25.098 - Graph::SetVideoRect {8 8 712 568}
16:34:25.098 - Graph::SetVideoWindowRect {187 0 1369 887}
16:34:25.104 - demux: ProgDemux
16:34:25.119 - ------sGetVideoParams
16:34:25.119 - ChannelGraph5.CreateInterfacesAndRenderGraph
16:34:25.126 - CreateCustomGraph
16:34:25.129 - VideoType:H.264/AVC ffmpeg=0
16:34:25.133 - Video/4.H264 : MPEG2_VIDEO s={0,0,1920,1080}, t={0,0,1920,1080}, bmp=1920x1088, r=30/17, br=0,frametime=33ms, IF=0x0, CF=0x0)
16:34:25.139 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f
16:34:25.145 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 299327BC
16:34:25.154 - OK
16:34:25.155 - CChannelGraph5::CreateRender 12
16:34:25.159 - VR: MPC VR
16:34:25.164 - VR: create new render
16:34:25.266 - * s:100 q:100 tr=4478912 (0) - ntt0 dmx0 -1 Preparing
16:34:25.320 - VR: Add video renderer Video Renderer - OK
16:34:25.321 - CreateAudioPartOfGraph
16:34:25.326 - AudioType:aac/adts 
16:34:25.330 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 32000 16bit formatTag= 0x1600)
16:34:25.336 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVAudio.ax 0E90F8CC
16:34:25.341 - Add audio codec e8e73b6b-4cb3-44a4-be99-4f7bcb96e491 - OK
16:34:25.350 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
16:34:25.351 - Added audio renderer
16:34:25.356 - AP: created
16:34:25.361 - Added audio processor
16:34:25.373 - Connect codec to AP - OK
16:34:25.394 - Add and connect audio renderer - OK
16:34:25.394 - Graph::AfterRender
16:34:25.400 - AV:UpdateAudioParamsAfterActive
16:34:25.404 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:34:25.409 - GR:UpdateAudioProcessor old=1 new=0
16:34:25.414 - Destroy Audio Processor update
16:34:25.420 - CPCG SetVolume 29C55AD0 50
16:34:25.425 - Graph::SetVolume 50% -1250db
16:34:25.431 - Graph::Run
16:34:25.487 - Graph::Run 1
16:34:25.487 - Graph::SetVideoRect {24 16 1896 1068}
16:34:25.491 - Graph::SetVideoWindowRect {0 3 1556 884}
16:34:25.505 - Graph::SetPictureParams 1
16:34:25.505 - AV:UpdateAudioParamsAfterActive
16:34:25.510 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:34:25.515 - GR:UpdateAudioProcessor old=0 new=0
16:34:25.520 - CPCG SetVolume 29C55AD0 50
16:34:25.525 - Graph::SetVolume 50% -1250db
16:34:25.533 - Graph::Run
16:34:25.535 - Graph::Run 0
16:34:25.539 - subsm.StartChannel demux=ProgDemux tr=TS
16:34:25.545 - subsm.RecreateSubtitlesParsers 155F89D8 ts=1 subindex=-1 st=-1
16:34:25.550 - subsm.Stop teletext parser
16:34:25.555 - subsm.RecreateSubtitlesParsers end
16:34:25.561 - subs: OnSetChannel
16:34:25.569 - 
16:34:25.572 - [0]########################### Mark of finish channel changing. (1.781ms) #############
16:34:25.577 - 
16:34:25.577 - ------sGetVideoParams
16:34:25.681 - Graph::OnVideoWindowPositionChanged
16:34:26.253 - * s:100 q:100 tr=10241864 (0) - ntt78 dmx5816 -1 Playing
16:34:27.253 - * s:100 q:100 tr=10071912 (0) - ntt63 dmx5948 -1 Playing
16:34:28.259 - * s:100 q:100 tr=4210260 (0) - ntt0 dmx5779 -1 Playing
16:34:29.252 - * s:100 q:100 tr=846564 (0) - ntt16 dmx6128 -1 Playing
16:34:29.340 - 
16:34:29.340 - 
16:34:29.345 - ########################### Mark of start channel changing.###########################
16:34:29.350 - 
16:34:29.354 - GraphManager::MainChangeChannel ZDFinfo FHD DE  1 provs
16:34:29.360 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
16:34:29.365 - SetChannelLogic::SetChannel 0
16:34:29.370 - SetChannelLogic::SetNormalChannel
16:34:29.381 - [101]Stop channel
16:34:29.381 - PreScanner.Stop
16:34:29.386 - GraphState: Undef by PreScanner.Stop
16:34:29.391 - PlayTimePmtParser::StopParser
16:34:29.396 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
16:34:29.401 - Prereader::ReaderCursor.. OK
16:34:29.411 - ReaderCursor::SetPosition 0 (w=131288766462558208)
16:34:29.415 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
16:34:29.421 - Prereader.StartPlayback after lock
16:34:29.426 - subsm.StopChannel
16:34:29.432 - SSTeletext: SetChannel page=0 lng
16:34:29.436 - DestroyPlayer th=0
16:34:29.441 - Graph::Stop
16:34:29.475 - Before Stop ...16:34:29.479 - OnGraphStop ...16:34:29.506 - VR: Disconnect
16:34:29.507 - Graph::ReleaseAllFilters
16:34:29.513 - release: Prog Audio renderer - RR - OK.
16:34:29.523 - release: Video Renderer - RR - OK.
16:34:29.615 - release: Video decoder  - RR - OK.
16:34:29.627 - release: Audio Processor - RR - OK.
16:34:29.638 - release: Audio decoder - RR - OK.
16:34:29.648 - FilterGraph: 1
16:34:29.654 - Delete timer 1000 DirectShowPlayer
16:34:29.657 - Graph::ReleaseAllFilters
16:34:29.671 - DestroyPlayer - after
16:34:29.671 - **** StopChannel time 0.328ms
16:34:29.675 - 
16:34:29.680 - TransponderManager::SetTransponder (CH) 0 ZDFinfo FHD DE
16:34:29.686 - *Transport TS
16:34:29.690 - Api2Device::SetChannel http://tv.kkzbigserver.iptv.uno:80/Uu6PpovAFKHM686/ecCM9J002/16483
16:34:29.747 - Api2BaseModule.OnTunerStateChanged Connecting
16:34:29.752 - Api2Device::SetChannel result OK
16:34:29.752 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=43981
16:34:29.753 - Api2BaseModule.OnTunerStateChanged  -3
16:34:29.757 - TsInputTrafficProcessor.OpenTransponder 1
16:34:29.768 - FilterManager::OnSetTransponder SetChannel
16:34:29.773 - TimeShift.Reset
16:34:29.778 - TimeShift.Cursor reset
16:34:29.783 - ReaderCursor::Reset.. OK
16:34:29.794 - Prereader.Reset ...-OK
16:34:29.805 - Create EPGparser on SetChannel
16:34:29.810 - DvbEpgParser::SetChannel ID=13bc0002.2335c298f9aad756.abcd
16:34:29.829 - DvbEpgParser::mode normal pos=0
16:34:29.829 - ModuleList::ChangeChannel 0
16:34:29.834 - **** SetTransponder time 0.156ms
16:34:29.839 - [101]ChannelGraph5::StartChannel ZDFinfo FHD DE
16:34:29.844 - AV:UpdateAudioParamsAfterActive
16:34:29.849 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:34:29.854 - GR:UpdateAudioProcessor old=0 new=0
16:34:29.860 - CPCG SetVolume 00000000 50
16:34:29.865 - 
16:34:29.870 - [101]       #################### Start stream. (0.531ms) #######################
16:34:29.875 - 
16:34:29.890 - Api2BaseModule.OnTunerStateChanged Preparing
16:34:29.895 - Api2BaseModule.OnTunerStateChanged  -4
16:34:29.922 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
16:34:29.922 - TimeShift.Cursor SetChannel::v 0 (0)
16:34:29.926 - ReaderCursor::SetChannel.. OK
16:34:29.937 - ReaderCursor::SetPosition 0 (w=0)
16:34:29.942 - Prereader.SetChannel..
16:34:29.947 - Prereader.SetChannel unmask 1
16:34:29.953 - Plugin::SetChannel 43981
16:34:29.958 - TransponderManager::SelectChannel
16:34:29.963 - TsInputTrafficProcessor.SelectChannel 43981
16:34:29.968 - Api2BaseModule.UpdateAllOpenedChannels 1
16:34:29.968 - Api2BaseModule.OnTunerStateChanged Playing
16:34:29.973 - TsInputTrafficProcessor.UpdateChannel 43981
16:34:29.984 - GraphState: Undef by StartChannelIsReady
16:34:29.984 - Api2BaseModule.OnTunerStateChanged  -4
16:34:29.988 - PreScanner.StartChannelIsReady net=1 parseall=1
16:34:29.999 - SimpleTsDemux::Init apid=0, vpid=0
16:34:30.004 - GraphState: RequestPATScan by StartChannelIsReady TS
16:34:30.010 - Api2BaseModule.Filters_EnabledFullTS 1
16:34:30.015 - PlayTimePATParser.OpenParser 43981
16:34:30.020 - Open TSTS filter pid=0 data=0
16:34:30.025 - TSTS cur size=0
16:34:30.030 - **** StartChannel time 0.203ms
16:34:30.036 - [101]OnChangeCurrentGraph2 -endOfSetChannel
16:34:30.041 - ChannelGraph.SetActiveState 1
16:34:30.067 - ------sGetVideoParams
16:34:30.129 - [101]**** SetChannel is finished (OK). Duration 0.781ms
16:34:30.195 - Api2BaseModule.OnTunerStateChanged Connecting
16:34:30.200 - Api2BaseModule.OnTunerStateChanged  -3
16:34:30.313 - * s:0 q:0 tr=0 (0) - ntt0 dmx0 -1 Connecting
16:34:30.318 - Api2BaseModule.OnTunerStateChanged Preparing
16:34:30.323 - Api2BaseModule.OnTunerStateChanged  -4
16:34:30.358 - * s:0 q:0 tr=0 (0) - ntt0 dmx0 -1 Connecting
16:34:30.627 - Api2BaseModule.OnTunerStateChanged Playing
16:34:30.633 - Api2BaseModule.OnTunerStateChanged  -4
16:34:30.650 - 
16:34:30.650 -        #################### First traffic. (1.296ms) #######################
16:34:30.655 - 
16:34:30.660 - PlayTimePATParser.EndTask
16:34:30.665 - TransportMarker: TS
16:34:30.670 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
16:34:30.665 - PreScanner.OnAfterScanPat count=2 {1;4096}
16:34:30.680 - Api2BaseModule.Filters_EnabledFullTS 0
16:34:30.686 - GraphState: RequestPMTScan by OnAfterScanPat
16:34:30.690 - PlayTimePmtParser::OpenParser SID=1 PMT=4096 unknow channel=1
16:34:30.696 - Open TSTS filter pid=4096 data=2
16:34:30.700 - TSTS cur size=43616
16:34:30.706 - EngineTransportsParser::UpdateLngStream update marker id=307644203 type=534769836
16:34:30.711 - TSTS quick finish
16:34:30.716 - --SwitchEngineTransport TS > TS
16:34:30.722 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
16:34:30.727 - PreScanner.OnTransportMarker TS
16:34:30.732 - PreScanner.OnTransportMarker Skiped! same marker
16:34:30.753 - --SwitchEngineTransport end
16:34:30.753 - PreScanner.OnAfterScanPmt pmt=4096
16:34:30.759 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
16:34:30.763 - PlayTimePmtParser::StopParser
16:34:30.813 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
16:34:30.813 - TimeShift.Cursor SetChannel::v 223344 (223344)
16:34:30.818 - Prereader.SetChannel unmask 1
16:34:30.823 - Plugin::SetChannel 1
16:34:30.829 - TransponderManager::SelectChannel
16:34:30.833 - TsInputTrafficProcessor.SelectChannel 1
16:34:30.838 - Api2BaseModule.UpdateAllOpenedChannels 1
16:34:30.843 - TsInputTrafficProcessor.UpdateChannel 1
16:34:30.848 - PreScanner.StartChannelIsReady net=1 parseall=0
16:34:30.853 - LngDefaultSelector.try select audio pid=257 type=1 lng=0-(enm;ang;eng,deu;gmh;goh;ger,rus) l=99
16:34:30.858 - ChannelGraph::AfterDetectChannelParams
16:34:30.863 - VideoMediaTypeDetection: h.264
16:34:30.868 - SimpleTsDemux::Init apid=257, vpid=256
16:34:30.873 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
16:34:30.878 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
16:34:30.884 - Prereader::ReaderCursor.. OK
16:34:30.896 - ReaderCursor::SetPosition 0 (w=5840313708969984)
16:34:30.902 - Prereader.StartPlayback Push buffering=0 recv=0E8E8A44 [StartChannelHelperBase(sl)]
16:34:30.907 - Prereader.StartPlayback after lock
16:34:30.912 - PreScanner.StartPmtParserIfNeed
16:34:30.912 - VideoParser::First packet 209268 h.264
16:34:30.917 - PlayTimePmtParser::OpenParser SID=1 PMT=4096 unknow channel=0
16:34:30.927 - Open TSTS filter pid=4096 data=2
16:34:30.922 - h264 detected 0 ms
16:34:30.932 - TSTS cur size=1551564
16:34:30.937 - AudioParser::First packet 2637
16:34:30.947 - AudioParser::aac detected
16:34:30.953 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
16:34:30.958 - PreScanner.Post_InitRender [ReceiveTraffic]
16:34:30.964 - 
16:34:30.969 - [101]       #################### Init Render. (1.625ms) #######################
16:34:30.974 - 
16:34:30.980 - ------sGetVideoParams
16:34:30.986 - video:h264 HD
16:34:30.990 - selector PlaybackTag=none videocodec=DS/ ts=1
16:34:30.995 - Channel PlaybackWay after check DS
16:34:31.006 - GraphState: GraphStarted by AsyncInitRender
16:34:31.006 - CalculBufferingSize prov=156725D4 marker=1 request=1
16:34:31.011 - CalculBuffering 2000ms br=2000kb to 500 kbytes. By type
16:34:31.016 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
16:34:31.021 - Prereader::ReaderCursor.. OK
16:34:31.033 - ReaderCursor::SetPosition 0 (w=12318515960741888)
16:34:31.038 - Prereader.StartPlayback Pull buffering=512000 recv=00000000 [EnablePullModeAndStartPlayback]
16:34:31.044 - Prereader.StartPlayback after lock
16:34:31.049 - Buffering/prereader size 500/3906 kbytes
16:34:31.053 - Not same player! old 0 new 13 prev 13
16:34:31.059 - ------sGetVideoParams
16:34:31.074 - Add timer 1000 DirectShowPlayer
16:34:31.080 - Graph::SetVideoWindowRect {334 0 1221 887}
16:34:31.080 - Graph::UpdateRenderMode
16:34:31.094 - Graph::SetVideoRect {8 8 712 568}
16:34:31.094 - Graph::SetVideoWindowRect {187 0 1369 887}
16:34:31.100 - demux: ProgDemux
16:34:31.115 - ------sGetVideoParams
16:34:31.115 - ChannelGraph5.CreateInterfacesAndRenderGraph
16:34:31.123 - CreateCustomGraph
16:34:31.126 - VideoType:H.264/AVC ffmpeg=0
16:34:31.131 - Video/4.H264 : MPEG2_VIDEO s={0,0,1920,1080}, t={0,0,1920,1080}, bmp=1920x1088, r=30/17, br=0,frametime=33ms, IF=0x0, CF=0x0)
16:34:31.136 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f
16:34:31.142 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 299327BC
16:34:31.150 - OK
16:34:31.151 - CChannelGraph5::CreateRender 12
16:34:31.156 - VR: MPC VR
16:34:31.162 - VR: create new render
16:34:31.299 - * s:100 q:100 tr=5520620 (0) - ntt0 dmx0 -1 Preparing
16:34:31.306 - VR: Add video renderer Video Renderer - OK
16:34:31.307 - CreateAudioPartOfGraph
16:34:31.308 - * s:100 q:100 tr=325992 (0) - ntt0 dmx0 -1 Preparing
16:34:31.310 - OnBuffering.OnTunerStateChanged  4
16:34:31.312 - AudioType:aac/adts 
16:34:31.327 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 32000 16bit formatTag= 0x1600)
16:34:31.332 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVAudio.ax 0E8183F4
16:34:31.338 - Add audio codec e8e73b6b-4cb3-44a4-be99-4f7bcb96e491 - OK
16:34:31.346 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
16:34:31.347 - Added audio renderer
16:34:31.353 - AP: created
16:34:31.357 - Added audio processor
16:34:31.368 - Connect codec to AP - OK
16:34:31.389 - Add and connect audio renderer - OK
16:34:31.389 - Graph::AfterRender
16:34:31.396 - AV:UpdateAudioParamsAfterActive
16:34:31.400 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:34:31.405 - GR:UpdateAudioProcessor old=1 new=0
16:34:31.410 - Destroy Audio Processor update
16:34:31.415 - CPCG SetVolume 05F61028 50
16:34:31.420 - Graph::SetVolume 50% -1250db
16:34:31.426 - Graph::Run
16:34:31.484 - Graph::Run 1
16:34:31.484 - Graph::SetVideoRect {24 16 1896 1068}
16:34:31.488 - Graph::SetVideoWindowRect {0 3 1556 884}
16:34:31.502 - Graph::SetPictureParams 1
16:34:31.502 - AV:UpdateAudioParamsAfterActive
16:34:31.507 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:34:31.511 - GR:UpdateAudioProcessor old=0 new=0
16:34:31.517 - CPCG SetVolume 05F61028 50
16:34:31.524 - Graph::SetVolume 50% -1250db
16:34:31.530 - Graph::Run
16:34:31.533 - Graph::Run 0
16:34:31.539 - subsm.StartChannel demux=ProgDemux tr=TS
16:34:31.544 - subsm.RecreateSubtitlesParsers 0E88AA98 ts=1 subindex=-1 st=-1
16:34:31.549 - subsm.Stop teletext parser
16:34:31.554 - subsm.RecreateSubtitlesParsers end
16:34:31.560 - subs: OnSetChannel
16:34:31.564 - 
16:34:31.571 - [0]########################### Mark of finish channel changing. (2.218ms) #############
16:34:31.575 - 
16:34:31.575 - ------sGetVideoParams
16:34:31.679 - Graph::OnVideoWindowPositionChanged
16:34:32.253 - * s:100 q:100 tr=10391700 (0) - ntt0 dmx5968 -1 Playing
16:34:33.253 - * s:100 q:100 tr=10948556 (0) - ntt78 dmx5994 -1 Playing
16:34:34.253 - * s:100 q:100 tr=11141256 (0) - ntt63 dmx5978 -1 Playing
16:34:35.266 - * s:100 q:100 tr=1532388 (0) - ntt0 dmx5950 -1 Playing
16:34:36.254 - * s:100 q:100 tr=0 (0) - ntt16 dmx5814 -1 Playing
16:34:37.252 - * s:100 q:100 tr=0 (0) - ntt16 dmx5902 -1 Playing
16:34:38.041 - 
16:34:38.041 - 
16:34:38.046 - ########################### Mark of start channel changing.###########################
16:34:38.052 - 
16:34:38.056 - GraphManager::MainChangeChannel ZDFneo FHD DE  1 provs
16:34:38.061 - DevicesManager::DestroyAllTransponderManagerUsedForSetTransponders
16:34:38.067 - SetChannelLogic::SetChannel 0
16:34:38.072 - SetChannelLogic::SetNormalChannel
16:34:38.083 - [101]Stop channel
16:34:38.083 - PreScanner.Stop
16:34:38.090 - GraphState: Undef by PreScanner.Stop
16:34:38.094 - PlayTimePmtParser::StopParser
16:34:38.100 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
16:34:38.104 - Prereader::ReaderCursor.. OK
16:34:38.114 - ReaderCursor::SetPosition 0 (w=170459967713705984)
16:34:38.120 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
16:34:38.124 - Prereader.StartPlayback after lock
16:34:38.129 - subsm.StopChannel
16:34:38.135 - SSTeletext: SetChannel page=0 lng
16:34:38.139 - DestroyPlayer th=0
16:34:38.144 - Graph::Stop
16:34:38.177 - Before Stop ...16:34:38.182 - OnGraphStop ...16:34:38.211 - VR: Disconnect
16:34:38.211 - Graph::ReleaseAllFilters
16:34:38.216 - release: Prog Audio renderer - RR - OK.
16:34:38.226 - release: Video Renderer - RR - OK.
16:34:38.330 - release: Video decoder  - RR - OK.
16:34:38.341 - release: Audio Processor - RR - OK.
16:34:38.351 - release: Audio decoder - RR - OK.
16:34:38.361 - FilterGraph: 1
16:34:38.366 - Delete timer 1000 DirectShowPlayer
16:34:38.371 - Graph::ReleaseAllFilters
16:34:38.383 - DestroyPlayer - after
16:34:38.383 - **** StopChannel time 0.328ms
16:34:38.389 - 
16:34:38.393 - TransponderManager::SetTransponder (CH) 0 ZDFneo FHD DE
16:34:38.398 - *Transport TS
16:34:38.402 - Api2Device::SetChannel http://tv.kkzbigserver.iptv.uno:80/Uu6PpovAFKHM686/ecCM9J002/16482
16:34:38.418 - skip old generation traffic!
16:34:38.424 - skip old generation traffic!
16:34:38.424 - skip old generation traffic!
16:34:38.459 - Api2BaseModule.OnTunerStateChanged Connecting
16:34:38.465 - Api2Device::SetChannel result OK
16:34:38.465 - TrafficProcessingScheme_OnSetChannelOrTransponder ch=43981
16:34:38.470 - TsInputTrafficProcessor.OpenTransponder 1
16:34:38.465 - Api2BaseModule.OnTunerStateChanged  -3
16:34:38.475 - FilterManager::OnSetTransponder SetChannel
16:34:38.484 - TimeShift.Reset
16:34:38.491 - TimeShift.Cursor reset
16:34:38.497 - ReaderCursor::Reset.. OK
16:34:38.508 - Prereader.Reset ...-OK
16:34:38.518 - Create EPGparser on SetChannel
16:34:38.523 - DvbEpgParser::SetChannel ID=13bc0002.20c29991d7975b5e.abcd
16:34:38.542 - DvbEpgParser::mode normal pos=0
16:34:38.542 - ModuleList::ChangeChannel 0
16:34:38.547 - **** SetTransponder time 0.172ms
16:34:38.552 - [101]ChannelGraph5::StartChannel ZDFneo FHD DE
16:34:38.558 - AV:UpdateAudioParamsAfterActive
16:34:38.563 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:34:38.569 - GR:UpdateAudioProcessor old=0 new=0
16:34:38.574 - CPCG SetVolume 00000000 50
16:34:38.579 - 
16:34:38.585 - [101]       #################### Start stream. (0.531ms) #######################
16:34:38.590 - 
16:34:38.630 - Api2BaseModule.OnTunerStateChanged Preparing
16:34:38.635 - TimeShift.Cursor SetChannel pidmask=00000000 first=1
16:34:38.635 - Api2BaseModule.OnTunerStateChanged  -4
16:34:38.635 - TimeShift.Cursor SetChannel::v 0 (0)
16:34:38.646 - ReaderCursor::SetChannel.. OK
16:34:38.656 - ReaderCursor::SetPosition 0 (w=0)
16:34:38.661 - Prereader.SetChannel..
16:34:38.667 - Prereader.SetChannel unmask 1
16:34:38.672 - Plugin::SetChannel 43981
16:34:38.677 - TransponderManager::SelectChannel
16:34:38.683 - TsInputTrafficProcessor.SelectChannel 43981
16:34:38.688 - Api2BaseModule.UpdateAllOpenedChannels 1
16:34:38.693 - TsInputTrafficProcessor.UpdateChannel 43981
16:34:38.698 - GraphState: Undef by StartChannelIsReady
16:34:38.703 - PreScanner.StartChannelIsReady net=1 parseall=1
16:34:38.709 - SimpleTsDemux::Init apid=0, vpid=0
16:34:38.714 - GraphState: RequestPATScan by StartChannelIsReady TS
16:34:38.716 - Api2BaseModule.OnTunerStateChanged Playing
16:34:38.720 - Api2BaseModule.Filters_EnabledFullTS 1
16:34:38.730 - Api2BaseModule.OnTunerStateChanged  -4
16:34:38.730 - PlayTimePATParser.OpenParser 43981
16:34:38.741 - Open TSTS filter pid=0 data=0
16:34:38.747 - TSTS cur size=0
16:34:38.751 - **** StartChannel time 0.203ms
16:34:38.757 - [101]OnChangeCurrentGraph2 -endOfSetChannel
16:34:38.762 - ChannelGraph.SetActiveState 1
16:34:38.790 - ------sGetVideoParams
16:34:38.846 - [101]**** SetChannel is finished (OK). Duration 0.797ms
16:34:38.918 - Api2BaseModule.OnTunerStateChanged Connecting
16:34:38.923 - Api2BaseModule.OnTunerStateChanged  -3
16:34:39.042 - Api2BaseModule.OnTunerStateChanged Preparing
16:34:39.047 - Api2BaseModule.OnTunerStateChanged  -4
16:34:39.064 - * s:0 q:0 tr=0 (0) - ntt0 dmx0 -1 Connecting
16:34:39.342 - Api2BaseModule.OnTunerStateChanged Playing
16:34:39.351 - Api2BaseModule.OnTunerStateChanged  -4
16:34:39.363 - 
16:34:39.363 -        #################### First traffic. (1.312ms) #######################
16:34:39.368 - 
16:34:39.374 - PlayTimePATParser.EndTask
16:34:39.378 - TransportMarker: TS
16:34:39.378 - PreScanner.OnAfterScanPat count=2 {1;4096}
16:34:39.384 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
16:34:39.394 - Api2BaseModule.Filters_EnabledFullTS 0
16:34:39.401 - GraphState: RequestPMTScan by OnAfterScanPat
16:34:39.406 - PlayTimePmtParser::OpenParser SID=1 PMT=4096 unknow channel=1
16:34:39.411 - Open TSTS filter pid=4096 data=2
16:34:39.417 - TSTS cur size=43616
16:34:39.421 - EngineTransportsParser::UpdateLngStream update marker id=307644203 type=534769836
16:34:39.426 - TSTS quick finish
16:34:39.431 - --SwitchEngineTransport TS > TS
16:34:39.436 - TimeShiftBuffer.SetContentLenght TimeshiftOverNetModule disabled req=0 size=209715200
16:34:39.442 - PreScanner.OnTransportMarker TS
16:34:39.447 - PreScanner.OnTransportMarker Skiped! same marker
16:34:39.467 - --SwitchEngineTransport end
16:34:39.467 - PreScanner.OnAfterScanPmt pmt=4096
16:34:39.472 - GraphState: RequestMediaTypeDetection by OnAfterScanPmt
16:34:39.477 - PlayTimePmtParser::StopParser
16:34:39.557 - TimeShift.Cursor SetChannel pidmask=00000000 first=0
16:34:39.557 - TimeShift.Cursor SetChannel::v 224848 (224848)
16:34:39.563 - Prereader.SetChannel unmask 1
16:34:39.568 - Plugin::SetChannel 1
16:34:39.574 - TransponderManager::SelectChannel
16:34:39.579 - TsInputTrafficProcessor.SelectChannel 1
16:34:39.584 - Api2BaseModule.UpdateAllOpenedChannels 1
16:34:39.590 - TsInputTrafficProcessor.UpdateChannel 1
16:34:39.594 - PreScanner.StartChannelIsReady net=1 parseall=0
16:34:39.599 - LngDefaultSelector.try select audio pid=257 type=1 lng=7693668-deu(enm;ang;eng,deu;gmh;goh;ger,rus) l=11
16:34:39.604 - LngDefaultSelector.try select audio pid=258 type=1 lng=7693668-deu(enm;ang;eng,deu;gmh;goh;ger,rus) l=11
16:34:39.609 - LngDefaultSelector.try select audio pid=259 type=1 lng=7693668-deu(enm;ang;eng,deu;gmh;goh;ger,rus) l=11
16:34:39.615 - LngDefaultSelector.try select audio pid=260 type=1 lng=7107949-mul(enm;ang;eng,deu;gmh;goh;ger,rus) l=99
16:34:39.620 - LngDefaultSelector. selected audio pid=257
16:34:39.625 - ChannelGraph::AfterDetectChannelParams
16:34:39.629 - VideoMediaTypeDetection: h.264
16:34:39.634 - SimpleTsDemux::Init apid=257, vpid=256
16:34:39.640 - GraphState: RequestMediaTypeDetection by OnAfterDetectChannelParams
16:34:39.645 - TimeShift.Cursor PushMode 1 1 (pos=0) [StartChannelHelperBase(sl)]
16:34:39.651 - Prereader::ReaderCursor.. OK
16:34:39.660 - ReaderCursor::SetPosition 0 (w=8030936008491008)
16:34:39.666 - Prereader.StartPlayback Push buffering=0 recv=0E8E8A44 [StartChannelHelperBase(sl)]
16:34:39.670 - Prereader.StartPlayback after lock
16:34:39.675 - PreScanner.StartPmtParserIfNeed
16:34:39.675 - VideoParser::First packet 53187 h.264
16:34:39.680 - PlayTimePmtParser::OpenParser SID=1 PMT=4096 unknow channel=0
16:34:39.686 - h264 detected 0 ms
16:34:39.690 - Open TSTS filter pid=4096 data=2
16:34:39.696 - AudioParser::First packet 2577
16:34:39.700 - TSTS cur size=2085108
16:34:39.706 - AudioParser::aac detected
16:34:39.717 - GraphState: GraphCreating by ReceiveTraffic !RequestAudioMediaType
16:34:39.722 - PreScanner.Post_InitRender [ReceiveTraffic]
16:34:39.727 - 
16:34:39.732 - [101]       #################### Init Render. (1.687ms) #######################
16:34:39.738 - 
16:34:39.743 - ------sGetVideoParams
16:34:39.748 - video:h264 HD
16:34:39.753 - selector PlaybackTag=none videocodec=DS/ ts=1
16:34:39.759 - Channel PlaybackWay after check DS
16:34:39.770 - GraphState: GraphStarted by AsyncInitRender
16:34:39.770 - CalculBufferingSize prov=156725D4 marker=1 request=1
16:34:39.774 - CalculBuffering 2000ms br=2000kb to 500 kbytes. By type
16:34:39.779 - TimeShift.Cursor PushMode 2 0 (pos=0) [EnablePullModeAndStartPlayback]
16:34:39.784 - Prereader::ReaderCursor.. OK
16:34:39.796 - ReaderCursor::SetPosition 0 (w=14503486083301376)
16:34:39.802 - Prereader.StartPlayback Pull buffering=512000 recv=00000000 [EnablePullModeAndStartPlayback]
16:34:39.806 - Prereader.StartPlayback after lock
16:34:39.812 - Buffering/prereader size 500/3906 kbytes
16:34:39.818 - Not same player! old 0 new 13 prev 13
16:34:39.822 - ------sGetVideoParams
16:34:39.839 - Add timer 1000 DirectShowPlayer
16:34:39.844 - Graph::SetVideoWindowRect {334 0 1221 887}
16:34:39.845 - Graph::UpdateRenderMode
16:34:39.859 - Graph::SetVideoRect {8 8 712 568}
16:34:39.859 - Graph::SetVideoWindowRect {187 0 1369 887}
16:34:39.865 - demux: ProgDemux
16:34:39.880 - ------sGetVideoParams
16:34:39.880 - ChannelGraph5.CreateInterfacesAndRenderGraph
16:34:39.888 - CreateCustomGraph
16:34:39.890 - VideoType:H.264/AVC ffmpeg=0
16:34:39.896 - Video/4.H264 : MPEG2_VIDEO s={0,0,1280,720}, t={0,0,1280,720}, bmp=1280x720, r=16/9, br=0,frametime=33ms, IF=0x0, CF=0x0)
16:34:39.900 - Add video codec ee30215d-164f-4a92-a4eb-9d4c13390f9f
16:34:39.906 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVVideo.ax 299327BC
16:34:39.915 - OK
16:34:39.916 - CChannelGraph5::CreateRender 12
16:34:39.920 - VR: MPC VR
16:34:39.926 - VR: create new render
16:34:40.080 - VR: Add video renderer Video Renderer - OK
16:34:40.080 - CreateAudioPartOfGraph
16:34:40.087 - AudioType:aac/adts 
16:34:40.092 - Audio/00001600-0000-0010-8000-00aa00389b71 : WaveFormatEx (2ch 44100 16bit formatTag= 0x1600)
16:34:40.098 - Codec from file: C:\Program Files (x86)\ProgDVB\LAVAudio.ax 0EAD79AC
16:34:40.102 - Add audio codec e8e73b6b-4cb3-44a4-be99-4f7bcb96e491 - OK
16:34:40.111 - IMyGraphBuilder::CreateAudioRenderFilter::ProgAR:Primary Sound Driver OK (normal)
16:34:40.112 - Added audio renderer
16:34:40.117 - AP: created
16:34:40.123 - Added audio processor
16:34:40.134 - Connect codec to AP - OK
16:34:40.155 - Add and connect audio renderer - OK
16:34:40.155 - Graph::AfterRender
16:34:40.161 - AV:UpdateAudioParamsAfterActive
16:34:40.164 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:34:40.170 - GR:UpdateAudioProcessor old=1 new=0
16:34:40.176 - Destroy Audio Processor update
16:34:40.180 - CPCG SetVolume 012DB598 50
16:34:40.185 - Graph::SetVolume 50% -1250db
16:34:40.191 - Graph::Run
16:34:40.244 - Graph::Run 1
16:34:40.244 - Graph::SetVideoRect {16 8 1264 712}
16:34:40.250 - Graph::SetVideoWindowRect {0 6 1556 881}
16:34:40.263 - Graph::SetPictureParams 1
16:34:40.263 - AV:UpdateAudioParamsAfterActive
16:34:40.268 - AV:UpdateAudioProcessor spec=0 agc=0 bands=0
16:34:40.274 - GR:UpdateAudioProcessor old=0 new=0
16:34:40.279 - CPCG SetVolume 012DB598 50
16:34:40.284 - Graph::SetVolume 50% -1250db
16:34:40.291 - Graph::Run
16:34:40.294 - Graph::Run 0
16:34:40.300 - subsm.StartChannel demux=ProgDemux tr=TS
16:34:40.304 - subsm.RecreateSubtitlesParsers 15CB2058 ts=1 subindex=-1 st=-1
16:34:40.310 - subsm.Stop teletext parser
16:34:40.315 - subsm.RecreateSubtitlesParsers end
16:34:40.320 - subs: OnSetChannel
16:34:40.330 - 
16:34:40.330 - [0]########################### Mark of finish channel changing. (2.281ms) #############
16:34:40.336 - 
16:34:40.336 - ------sGetVideoParams
16:34:40.364 - * s:100 q:100 tr=9349992 (0) - ntt0 dmx5770 -1 Playing
16:34:40.463 - Graph::OnVideoWindowPositionChanged
16:34:41.260 - * s:100 q:100 tr=2314468 (0) - ntt0 dmx6192 -1 Playing
16:34:42.263 - * s:100 q:100 tr=260380 (0) - ntt0 dmx6613 -1 Playing
16:34:43.262 - * s:100 q:100 tr=265832 (0) - ntt0 dmx6197 -1 Playing
16:34:44.260 - * s:100 q:100 tr=266584 (0) - ntt0 dmx6280 -1 Playing
16:34:45.258 - * s:100 q:100 tr=783960 (0) - ntt0 dmx6781 -1 Playing
16:34:46.260 - * s:100 q:100 tr=285572 (0) - ntt0 dmx5785 -1 Playing
16:34:47.258 - * s:100 q:100 tr=661196 (0) - ntt0 dmx6313 -1 Playing
16:34:48.260 - * s:100 q:100 tr=656872 (0) - ntt0 dmx5928 -1 Playing
16:34:49.266 - * s:100 q:100 tr=102272 (0) - ntt0 dmx5828 -1 Playing
16:34:50.253 - * s:100 q:100 tr=857092 (0) - ntt47 dmx6209 -1 Playing
16:34:51.260 - * s:100 q:100 tr=351372 (0) - ntt0 dmx5826 -1 Playing
16:34:52.254 - * s:100 q:100 tr=55460 (0) - ntt31 dmx6569 -1 Playing
16:34:53.254 - * s:100 q:100 tr=995084 (0) - ntt0 dmx6197 -1 Playing
16:34:54.253 - * s:100 q:100 tr=102084 (0) - ntt0 dmx6111 -1 Playing
16:34:55.261 - * s:100 q:100 tr=681876 (0) - ntt0 dmx5781 -1 Playing
16:34:56.271 - * s:100 q:100 tr=102272 (0) - ntt0 dmx6354 -1 Playing
16:34:57.461 - * s:100 q:100 tr=1023660 (0) - ntt0 dmx6047 -1 Playing
16:34:57.919 - 
16:34:57.919 - Stop engine
16:34:57.925 - DevicesManager::Stop
16:34:57.930 - [101]Stop channel
16:34:57.935 - PreScanner.Stop
16:34:57.941 - GraphState: Undef by PreScanner.Stop
16:34:57.945 - PlayTimePmtParser::StopParser
16:34:57.951 - TimeShift.Cursor PushMode 0 0 (pos=0) [Engine5ChannelBase.StopChannel]
16:34:57.955 - Prereader::ReaderCursor.. OK
16:34:57.965 - ReaderCursor::SetPosition 0 (w=81729671409958912)
16:34:57.971 - Prereader.StartPlayback Disable buffering=0 recv=00000000 [Engine5ChannelBase.StopChannel]
16:34:57.976 - Prereader.StartPlayback after lock
16:34:57.981 - subsm.StopChannel
16:34:57.987 - SSTeletext: SetChannel page=0 lng
16:34:57.991 - DestroyPlayer th=0
16:34:57.996 - Graph::Stop
16:34:58.027 - Before Stop ...16:34:58.032 - OnGraphStop ...16:34:58.060 - VR: Disconnect
16:34:58.062 - Graph::ReleaseAllFilters
16:34:58.066 - release: Prog Audio renderer - RR - OK.
16:34:58.076 - release: Video Renderer - RR - OK.
16:34:58.177 - release: Video decoder  - RR - OK.
16:34:58.189 - release: Audio Processor - RR - OK.
16:34:58.199 - release: Audio decoder - RR - OK.
16:34:58.209 - FilterGraph: 1
16:34:58.215 - Delete timer 1000 DirectShowPlayer
16:34:58.219 - Graph::ReleaseAllFilters
16:34:58.231 - DestroyPlayer - after
16:34:58.231 - subsm.StopChannel
16:34:58.236 - SSTeletext: SetChannel page=0 lng
16:34:58.242 - DestroyPlayer th=0
16:34:58.247 - DestroyPlayer - after
16:34:58.252 - TransponderManager::CloseChannel
16:34:58.257 - TsInputTrafficProcessor.RemoveChannel 1
16:34:58.263 - ~TransponderChannelSource
16:34:58.328 - TimeShift.DestroyReadingCursor
16:34:58.341 - Prereader.Exit16:34:58.341 - Api2BaseModule.UpdateAllOpenedChannels 0
16:34:58.346 - ~ChannelPlaybackGraph
16:34:58.351 - Destroy TSTS filter pid=0
16:34:58.356 - PlayTimePmtParser::StopParser
16:34:58.361 - PlayTimePmtParser::StopParser
16:34:58.366 - Destroy TSTS filter pid=4096
16:34:58.372 - DevicesManager::Free devices
16:34:58.378 - SDP:Destroy netclient.0 own=0E9A0E34
16:34:58.382 - SetOwner N -> 0
16:34:58.388 - SetOwner SetTransponder null
16:34:58.501 - ~TransponderManager
16:34:58.501 - Delete timer 1000 BaseTransponderManaer
16:34:58.507 - SetOwner N -> 0
16:34:58.513 - SetOwner SetTransponder null
16:34:58.524 - TimeShift.~TimeShift
16:34:58.524 - HugeMemoryBlocksManager::Free
16:34:58.529 - ModuleList::Free
16:34:58.535 - SDP:after tr
16:34:58.545 - SDP:after destroy device
16:34:58.546 - DevicesManager::Free RC
16:34:58.551 - Engine stopped
16:34:58.646 - !m_D3DDevices.size()
