Ticket #13223: fe-log2.txt

File fe-log2.txt, 24.3 KB (added by warpme@…, 7 years ago)

log for FE with patch

Line 
1Go to Main Manu
2List of content mythfrontend LOG for FE-Nvidia
3
4       
5
62018-02-21 12:57:31.299159 I Setup Interrupt handler
72018-02-21 12:57:31.299295 I Setup Terminated handler
82018-02-21 12:57:31.299324 I Setup Segmentation fault handler
92018-02-21 12:57:31.299353 I Setup Aborted handler
102018-02-21 12:57:31.299381 I Setup Bus error handler
112018-02-21 12:57:31.299410 I Setup Floating point exception handler
122018-02-21 12:57:31.299437 I Setup Illegal instruction handler
132018-02-21 12:57:31.299470 I Setup Real-time signal 0 handler
142018-02-21 12:57:31.299505 I Setup User defined signal 1 handler
152018-02-21 12:57:31.299532 I Setup User defined signal 2 handler
162018-02-21 12:57:31.299558 I Setup Hangup handler
172018-02-21 12:57:31.299948 C mythfrontend version: master [v30-Pre-513-g3810d2f] www.mythtv.org
182018-02-21 12:57:31.300007 C Qt version: compile: 5.4.1, runtime: 5.4.1
192018-02-21 12:57:31.300022 N Enabled verbose msgs: general
202018-02-21 12:57:31.300097 N Setting Log Level to LOG_INFO
212018-02-21 12:57:31.311653 I Added logging to the console
222018-02-21 12:57:31.311786 N Using runtime prefix = /usr
232018-02-21 12:57:31.311802 N Using configuration directory = /home/minimyth/.mythtv
242018-02-21 12:57:31.312053 I Assumed character encoding: en_US.UTF-8
252018-02-21 12:57:31.317718 E DBHostName is not set in config.xml
262018-02-21 12:57:31.317948 N Empty LocalHostName.
272018-02-21 12:57:31.317980 I Using localhost value of FE-Nvidia
282018-02-21 12:57:31.318202 I Start up testing connections. DB 192.168.1.254, BE , attempt 0, status dbAwake
292018-02-21 12:57:32.982656 N Setting QT default locale to pl_US
302018-02-21 12:57:32.982726 I Current locale pl_US
312018-02-21 12:57:32.986434 E No locale defaults file for pl_US, skipping
322018-02-21 12:57:33.002437 I Starting process manager
332018-02-21 12:57:33.002577 I Starting process signal handler
342018-02-21 12:57:33.005532 I Starting IO manager (read)
352018-02-21 12:57:33.005532 I Starting IO manager (write)
362018-02-21 12:57:33.053333 I ScreenSaverX11Private: XScreenSaver support enabled
372018-02-21 12:57:33.054621 I ScreenSaverX11Private: DPMS is disabled.
382018-02-21 12:57:33.145933 N Desktop video mode: 1920x1080 60.000 Hz
392018-02-21 12:57:33.238817 E SG() Error: Could not create builtinStorage Group directory \'/home/minimyth/.mythtv/tmp/hls\' for \'Streaming\'
402018-02-21 12:57:33.468164 I Listening on TCP 0.0.0.0:6547
412018-02-21 12:57:33.473792 I Listening on TCP [::]:6547
422018-02-21 12:57:36.726058 I Loading pl translation for module mythfrontend
432018-02-21 12:57:36.732908 N Desktop video mode: 1920x1080 60.000 Hz
442018-02-21 12:57:36.790388 I Changing to 1920x1080 54.000 Hz
452018-02-21 12:57:36.945557 I SwitchToGUI: Switched to 1920x1080 54.000 Hz
462018-02-21 12:57:37.260648 I LIRC: Successfully initialized \'/dev/lircd\' using \'/home/minimyth/.mythtv/lircrc\' config
472018-02-21 12:57:37.260801 I UDPListener: Enabling
482018-02-21 12:57:37.264048 I Binding to UDP 0.0.0.0:6948
492018-02-21 12:57:37.264197 I Binding to UDP [::]:6948
502018-02-21 12:57:37.519936 I Using Frameless Window
512018-02-21 12:57:37.519951 I Using Full Screen Window
522018-02-21 12:57:37.561467 I UI Screen Resolution: 1920 x 1080
532018-02-21 12:57:37.577420 I OpenGL: Sync to VBlank is enabled (good!)
542018-02-21 12:57:37.977291 I Trying the OpenGL 2.0 render
552018-02-21 12:57:37.999934 I OpenGL painter using existing OpenGL context.
562018-02-21 12:57:38.385639 I OpenGL2: GLSL supported
572018-02-21 12:57:38.385862 I OpenGL: OpenGL vendor : NVIDIA Corporation
582018-02-21 12:57:38.385879 I OpenGL: OpenGL renderer: GeForce 610M/PCIe/SSE2
592018-02-21 12:57:38.385892 I OpenGL: OpenGL version : 4.6.0 NVIDIA 390.25
602018-02-21 12:57:38.385913 I OpenGL: Max texture size: 16384 x 16384
612018-02-21 12:57:38.385926 I OpenGL: Max texture units: 4
622018-02-21 12:57:38.385941 I OpenGL: Direct rendering: Yes
632018-02-21 12:57:38.385962 I OpenGL: Extensions Supported: 1e3b
642018-02-21 12:57:38.385982 I OpenGL: PixelBufferObject support available
652018-02-21 12:57:38.895796 I OpenGL: Initialised MythRenderOpenGL
662018-02-21 12:57:38.930467 I MythUIHelper: Pruning cache directory: /home/minimyth/.mythtv/cache/remotecache is disabled
672018-02-21 12:57:38.930508 I MythUIHelper: Pruning cache directory: /home/minimyth/.mythtv/cache/thumbnails is disabled
682018-02-21 12:57:45.895753 I MythCoreContext::ConnectCommandSocket(): Connecting to backend server: 192.168.1.254:6543 (try 1 of 1)
692018-02-21 12:57:45.898070 I MythCoreContext::CheckProtoVersion(): Using protocol version 91 BuzzOff
702018-02-21 12:57:47.809402 W MythCookieJar::load() failed to open file for reading: /home/minimyth/.mythtv/MythBrowser/cookiejar.txt
712018-02-21 12:57:48.128864 I MythUIWebBrowser: Loading css from - file:///usr/share/mythtv/themes/default/htmls/mythbrowser.css
722018-02-21 12:57:48.162757 I MythUIWebBrowser: enabling plugins
732018-02-21 12:57:48.372532 I RAOP Device: Created RAOP device objects.
742018-02-21 12:57:48.372890 I Listening on TCP 0.0.0.0:5000
752018-02-21 12:57:48.373020 I Listening on TCP [::]:5000
762018-02-21 12:57:48.373062 I RAOP Device: Listening for connections on port 5000
772018-02-21 12:57:48.375166 I AirPlay: Created airplay objects.
782018-02-21 12:57:48.375495 I Listening on TCP 0.0.0.0:5100
792018-02-21 12:57:48.375624 I Listening on TCP [::]:5100
802018-02-21 12:57:48.379430 I Registering service 3d684f2a4a3d@MythTV on FE-Nvidia._raop._tcp port 5000 TXT tp=UDPsm=falsesv=falseek=1et=0,1cn=0,1ch=2ss=16sr=44100pw=falsevn=3       txtvers=1md=0,1,2vs=115.2da=trueam=MythTV,1
812018-02-21 12:57:48.392556 I Current MythTV Schema Version (DBSchemaVer): 1348
822018-02-21 12:57:49.214759 I Bonjour: Service registration complete: name \'MythTV on FE-Nvidia\' type \'_airplay._tcp.\' domain: \'local.\'
832018-02-21 12:57:49.235812 I Bonjour: Service registration complete: name \'3d684f2a4a3d@MythTV on FE-Nvidia\' type \'_raop._tcp.\' domain: \'local.\'
842018-02-21 12:57:50.959990 N Registering Internal as a media playback plugin.
852018-02-21 12:57:50.972557 E MythSystemLegacy(udevinfo) command not executable,
86eno: No such file or directory (2)
872018-02-21 12:57:51.030600 N Registering WebBrowser as a media playback plugin.
882018-02-21 12:57:51.033103 I Loading pl translation for module mythbrowser
892018-02-21 12:57:51.099430 I Loading pl translation for module mythgame
902018-02-21 12:57:51.257990 I Current MythMusic Schema Version (MusicDBSchemaVer): 1024
912018-02-21 12:57:51.389631 I Loading pl translation for module mythmusic
922018-02-21 12:57:51.437891 I Loading pl translation for module mythnetvision
932018-02-21 12:57:51.479341 I Loading pl translation for module mythnews
942018-02-21 12:57:51.539929 I Loading pl translation for module mythweather
952018-02-21 12:57:51.587281 I ZMClient: no valid IP or port found for mythzmserver
962018-02-21 12:57:51.598731 I Loading pl translation for module mythzoneminder
972018-02-21 12:57:51.611081 I Listening on TCP 0.0.0.0:6546
982018-02-21 12:57:51.616068 I Listening on TCP [::]:6546
992018-02-21 12:57:51.888155 N Found mainmenu.xml for theme \'Default\'
1002018-02-21 12:57:51.910201 I Registering HouseKeeperTask \'HardwareProfiler\'.
1012018-02-21 12:57:51.918846 I Starting HouseKeeper.
1022018-02-21 12:57:52.219868 I Bonjour: Service registration complete: name \'Mythfrontend on FE-Nvidia\' type \'_mythfrontend._tcp.\' domain: \'local.\'
1032018-02-21 12:58:07.386541 I NetworkControl: New connection established.
1042018-02-21 12:58:07.388308 N Verbose mask changed, new level is: general playback audio
1052018-02-21 12:58:07.399266 I NetworkControl: Client Socket disconnected
1062018-02-21 12:58:11.463340 I NetworkControl: New connection established.
1072018-02-21 12:58:11.465243 I NetworkControl: Client Socket disconnected
1082018-02-21 12:58:49.076999 N Suspending idle timer
1092018-02-21 12:58:49.197799 I TV::TV(): Creating TV object
1102018-02-21 12:58:49.269189 I TV::TV(): Finished creating TV object
1112018-02-21 12:58:49.269278 N Suspending idle timer
1122018-02-21 12:58:49.273682 I TV::Init(): Created TvPlayWindow.
1132018-02-21 12:58:49.376098 I TV::HandleStateChange(): Attempting to change from None to WatchingVideo
1142018-02-21 12:58:49.398484 I FileRingBuf(myth://Videos@mythtv/Telewizja/sample3.mkv): OpenFile(myth://Videos@mythtv/Telewizja/sample3.mkv, 2000 ms)
1152018-02-21 12:58:49.437510 I TV::StartPlayer(): Elapsed time since TV constructor was called: 240 ms
1162018-02-21 12:58:49.622005 I ALSA: OpenDevice hdmi:CARD=NVidia,DEV=0
1172018-02-21 12:58:49.666705 I AOS: Sample rate 32000 is supported
1182018-02-21 12:58:49.666751 I AOS: Sample rate 44100 is supported
1192018-02-21 12:58:49.666783 I AOS: Sample rate 48000 is supported
1202018-02-21 12:58:49.666882 I AOS: Format signed 16 bit is supported
1212018-02-21 12:58:49.667021 I AOS: Format signed 24 bit MSB is supported
1222018-02-21 12:58:49.667071 I AOS: Format signed 32 bit is supported
1232018-02-21 12:58:49.667157 I AOS: 2 channel(s) are supported
1242018-02-21 12:58:49.667214 I AOS: 4 channel(s) are supported
1252018-02-21 12:58:49.667262 I AOS: 6 channel(s) are supported
1262018-02-21 12:58:49.667298 I AOS: 8 channel(s) are supported
1272018-02-21 12:58:49.668193 I ALSA: Successfully retrieved ELD data
1282018-02-21 12:58:49.668318 I ELDUTILS: Detected monitor S2-TEK TV at connection type HDMI
1292018-02-21 12:58:49.668354 I ELDUTILS: available speakers: FL/FR LFE FC RL/RR RLC/RRC
1302018-02-21 12:58:49.668377 I ELDUTILS: max LPCM channels = 2
1312018-02-21 12:58:49.668400 I ELDUTILS: max channels = 8
1322018-02-21 12:58:49.668424 I ELDUTILS: supported codecs = LPCM, AC3, E-AC3
1332018-02-21 12:58:49.668486 I ELDUTILS: supports coding type LPCM: channels = 2, rates = 32000 44100 48000, bits = 16 20 24
1342018-02-21 12:58:49.668520 I ELDUTILS: supports coding type AC3: channels = 6, rates = 32000 44100 48000, max bitrate = 640000
1352018-02-21 12:58:49.668552 I ELDUTILS: supports coding type E-AC3: channels = 8, rates = 32000 44100 48000
1362018-02-21 12:58:49.731126 N AudioPlayer: Enabling Audio
1372018-02-21 12:58:50.320299 I AFD: PlayerFlags: 0xc0, AudioReadAhead: 100 msec
1382018-02-21 12:58:50.320385 I Player(0): Stretch Factor 1, allow passthru
1392018-02-21 12:58:50.321889 I AFD: Buffer size: 32768 streamed 0 seekable 1
1402018-02-21 12:58:50.873238 I AFD: Stream #0, has id 0x0 codec id H264, type Video, bitrate 0 at 0xa1c1dc0
1412018-02-21 12:58:50.873284 I AFD: Stream #1, has id 0x0 codec id DTS, type Audio, bitrate 1536000 at 0xa1c0d20
1422018-02-21 12:58:50.873313 I AFD: codec DTS has 6 channels
1432018-02-21 12:58:50.873327 I AFD: Looking for decoder for DTS
1442018-02-21 12:58:50.873729 I AFD: Opened codec 0xa398b80, id(DTS) type(Audio)
1452018-02-21 12:58:50.874017 I AFD: Audio Track #1, of type (Normalny) is A/V stream #1 (id=0x0) and has 6 channels in the English language(6647399).
1462018-02-21 12:58:50.874035 I AFD: Trying to select best video track
1472018-02-21 12:58:50.874190 I AFD: Selected track #0 (id 0x0 codec id H264, type Video, bitrate 500000 at 0xa1c1dc0)
1482018-02-21 12:58:50.885535 I VDP: Accepting: cmp() w(>=0) h(>=720) framerate() codecs() dec(vdpau) cpus(4) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpaubasic) filt(vdpaucolorspace=auto)
1492018-02-21 12:58:50.885649 I VDP: Accepting: cmp() w() h() framerate() codecs() dec(vdpau) cpus(4) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
1502018-02-21 12:58:50.885722 I VDP: LoadBestPreferences(1280x548, 0.000, h264)
1512018-02-21 12:58:50.885875 I VDP: LoadBestPreferences Result prio:2, w:, h:, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpauadvanceddoublerate
1522018-02-21 12:58:50.886003 I VDPAU: Checking VDPAU support.
1532018-02-21 12:58:51.558839 I VDPAU: Version 1
1542018-02-21 12:58:51.558869 I VDPAU: Information NVIDIA VDPAU Driver Shared Library 390.25 Wed Jan 24 19:28:27 PST 2018
1552018-02-21 12:58:51.558912 I VDPAU: HQ scaling level 1 of 9 available.
1562018-02-21 12:58:51.558929 I VDPAU: MPEG4 hardware acceleration supported.
1572018-02-21 12:58:51.558943 I VDPAU: HEVC hardware acceleration not supported.
1582018-02-21 12:58:51.571635 I AFD: Using 1 CPUs for decoding
1592018-02-21 12:58:51.571669 I AFD: InitVideoCodec() 0xa39b6a0 id(H264) type (Video).
1602018-02-21 12:58:51.571723 I AFD: Selected FPS is 24 (avg 24 codec 0 container 1000 estimated 24)
1612018-02-21 12:58:51.571800 I Player(0): SetFrameInterval ps:1 scan:3
1622018-02-21 12:58:51.571849 I Player(0): detectInterlace(Detect Scan, Interlaced Scan, 24, 548) ->Interlaced Scan
1632018-02-21 12:58:51.571900 I AFD: Using vdpau for video decoding
1642018-02-21 12:58:51.572722 I AFD: Opened codec 0xa39b6a0, id(H264) type(Video)
1652018-02-21 12:58:51.585013 I AFD: Selected track 1: English DCA 5.1ch (A/V Stream #1)
1662018-02-21 12:58:51.585114 I AFD: Audio data is planar
1672018-02-21 12:58:51.585208 I AFD: Initializing audio parms from audio track #1
1682018-02-21 12:58:51.585265 I AFD: Audio format changed
169from id(NONE) -1Hz -1ch -1bps (profile 0) to id( DTS) 48000Hz 6ch 32bps (profile 20)
1702018-02-21 12:58:51.585315 I AOBase: Needs downmix from 6 -> 2 channels
1712018-02-21 12:58:51.585337 I AOBase: Killing AudioOutputDSP
1722018-02-21 12:58:51.585387 I AOBase: Original codec was DTS, 32 bit floating point, 48 kHz, 6 channels
1732018-02-21 12:58:51.585428 I AOBase: enc(0), passthru(0), features () configured_channels(2), 2 channels supported(1) max_channels(2)
1742018-02-21 12:58:51.585448 I AOBase: Audio processing enabled
1752018-02-21 12:58:51.585491 I AOBase: Opening audio device \'hdmi:CARD=NVidia,DEV=0\' ch 2(6) sr 48000 sf signed 32 bit reenc 0
1762018-02-21 12:58:51.585507 I ALSA: OpenDevice hdmi:CARD=NVidia,DEV=0
1772018-02-21 12:58:51.593334 I ALSA: SetParameters(format=10, channels=2, rate=48000, buffer_time=500000, period_time=4)
1782018-02-21 12:58:51.593715 I ALSA: Buffer size range from 32 to 8192
1792018-02-21 12:58:51.593733 I ALSA: Period size range from 16 to 4096
1802018-02-21 12:58:51.593799 W ALSA: Requested 500000us got 170666 buffer time
1812018-02-21 12:58:51.594066 I ALSA: Hardware audio buffer cur: 64 need: 192 max allowed: 32768
1822018-02-21 12:58:51.594121 W ALSA: Try to manually increase audio buffer with: echo 192 | sudo tee /proc/asound/card1/pcm3p/sub0/prealloc
1832018-02-21 12:58:51.594147 I ALSA: Buffer time = 170666 us
1842018-02-21 12:58:51.594228 I ALSA: Period time = 4 periods
1852018-02-21 12:58:51.662518 I ALSA: Buffer size = 8192 | Period size = 2048
1862018-02-21 12:58:51.795731 E ALSA: no playback control PCM found on mixer device default
1872018-02-21 12:58:51.795752 E ALSA: Unable to open audio mixer. Volume control disabled
1882018-02-21 12:58:51.795769 I AOBase: Audio fragment size: 8192
1892018-02-21 12:58:51.795830 I AOBase: Audio Stretch Factor: 1
1902018-02-21 12:58:51.795950 I AOBase: Ending Reconfigure()
1912018-02-21 12:58:51.796011 I Dec: Selected track #1 (type 2) in the Unknown language(0)
1922018-02-21 12:58:51.796042 I Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
1932018-02-21 12:58:51.796212 I AOBase: kickoffOutputAudioLoop: pid = 10434
1942018-02-21 12:58:51.796275 I AOBase: OutputAudioLoop: Play Event
1952018-02-21 12:58:51.803864 I Dec: SyncPositionMap prerecorded, from DB: 0 entries
1962018-02-21 12:58:51.807144 I AFD: Recording has no position -- using libavformat seeking.
1972018-02-21 12:58:51.807874 I AFD: Successfully opened decoder for file: "myth://Videos@mythtv/Telewizja/sample3.mkv". novideo(0)
1982018-02-21 12:58:51.812574 I VideoOutput: Allowed renderers: vdpau
1992018-02-21 12:58:51.812616 I VideoOutput: Allowed renderers (filt: vdpau): vdpau
2002018-02-21 12:58:51.820678 I VDP: Accepting: cmp() w(>=0) h(>=720) framerate() codecs() dec(vdpau) cpus(4) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpaubasic) filt(vdpaucolorspace=auto)
2012018-02-21 12:58:51.820787 I VDP: Accepting: cmp() w() h() framerate() codecs() dec(vdpau) cpus(4) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
2022018-02-21 12:58:51.820829 I VDP: LoadBestPreferences(1280x548, 24.000, h264)
2032018-02-21 12:58:51.820962 I VDP: LoadBestPreferences Result prio:2, w:, h:, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpauadvanceddoublerate
2042018-02-21 12:58:51.820997 I VideoOutput: Preferred renderer: vdpau
2052018-02-21 12:58:51.821010 I VideoOutput: Trying video renderer: \'vdpau\'
2062018-02-21 12:58:51.929186 I VideoOutWindow::SetPIPState. pip_state: 0]
2072018-02-21 12:58:51.929241 I Clearing OpenGL painter cache.
2082018-02-21 12:58:52.086694 I Display Rect left: 0, top: 232, width: 1920, height: 616, aspect: 1.33333
2092018-02-21 12:58:52.086736 I Video Rect left: 0, top: 0, width: 1280, height: 548, aspect: 2.33577
2102018-02-21 12:58:52.086771 I VDP: LoadBestPreferences(1280x560, 24.000, h264)
2112018-02-21 12:58:52.086972 I VDP: LoadBestPreferences Result prio:2, w:, h:, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpauadvanceddoublerate
2122018-02-21 12:58:52.087016 I Display Rect left: 0, top: 232, width: 1920, height: 616, aspect: 1.33333
2132018-02-21 12:58:52.087045 I Video Rect left: 0, top: 0, width: 1280, height: 548, aspect: 2.33577
2142018-02-21 12:58:52.087071 I VDP: SetVideoRenderer(vdpau)
2152018-02-21 12:58:52.087092 I VDP: SetVideoRender(vdpau) == GetVideoRenderer()
2162018-02-21 12:58:52.117384 I Doubling refresh rate for interlaced display.
2172018-02-21 12:58:52.117797 I Trying to match best refresh rate 24.000Hz
2182018-02-21 12:58:52.117866 I Using 1920x1080 54.000 Hz
2192018-02-21 12:58:52.117927 I SwitchToVideo: Video size 1280 x 548:
220Already displaying resolution 1920 x 1080, 650mm x 366mm
2212018-02-21 12:58:52.117962 I VideoOutput: Pixel dimensions: Screen 1920x1080, window 1920x1080
2222018-02-21 12:58:52.117991 I VideoOutput: Actual display dimensions: 650x365 mm Aspect: 1.78082
2232018-02-21 12:58:52.118017 I VideoOutput: Estimated window dimensions: 650x365 mm Aspect: 1.77596
2242018-02-21 12:58:52.276050 I VDPAU: Created 2 output surfaces.
2252018-02-21 12:58:52.276101 I VDPAU: Set colorkey to 0x20202
2262018-02-21 12:58:52.276125 I VDPAU: Created VDPAU render device 1920x1080
2272018-02-21 12:58:52.288171 I VidOutVDPAU: Created VDPAU osd (1920x1080)
2282018-02-21 12:58:52.390634 I ColourSpace: PictureAttributes: Brightness, Contrast, Colour, Hue, Studio Levels,
2292018-02-21 12:58:52.390659 I VidOutVDPAU: Using ITU BT.709 colorspace
2302018-02-21 12:58:52.390736 I Display Rect left: 0, top: 129, width: 1920, height: 822, aspect: 1.77778
2312018-02-21 12:58:52.390766 I Video Rect left: 0, top: 0, width: 1280, height: 548, aspect: 2.33577
2322018-02-21 12:58:52.390782 I VidOutVDPAU: Created VDPAU context (GPU decode)
2332018-02-21 12:58:52.396402 I Over/underscan. V: 0, H: 0
2342018-02-21 12:58:52.396458 I Display Rect left: 0, top: 129, width: 1920, height: 822, aspect: 1.77778
2352018-02-21 12:58:52.396500 I Video Rect left: 0, top: 0, width: 1280, height: 548, aspect: 2.33577
2362018-02-21 12:58:52.396614 I FilterManager: GetFilterInfo(convert) returning: 0x0
2372018-02-21 12:58:52.396666 I Player(0): LoadFilters(\'vdpaucolorspace=auto\'..) -> 0x0
2382018-02-21 12:58:52.401950 I Player(0): Decoder thread starting.
2392018-02-21 12:58:52.429878 I OSD: Loaded window osd_message
2402018-02-21 12:58:52.444058 I OSD: Loaded window osd_input
2412018-02-21 12:58:52.524025 I OSD: Loaded window program_info
2422018-02-21 12:58:52.548068 I OSD: Loaded window browse_info
2432018-02-21 12:58:52.584905 I OSD: Loaded window osd_status
2442018-02-21 12:58:52.657477 I OSD: Loaded window osd_program_editor
2452018-02-21 12:58:52.702516 I OSD: Loaded window osd_debug
2462018-02-21 12:58:52.702589 I OSD: Loaded OSD: size 1920x1080 offset 0+0
2472018-02-21 12:58:52.703000 I OSD: Created window aa_OSD_SUBTITLES
2482018-02-21 12:58:52.703159 I Player(0): ClearAfterSeek(0)
2492018-02-21 12:58:52.704134 I AOBase: OutputAudioLoop: Play Event
2502018-02-21 12:58:52.706670 I Doubling refresh rate for interlaced display.
2512018-02-21 12:58:52.707164 I VDP: GetFilteredDeint() : vdpau -> \'vdpauadvanceddoublerate\'
2522018-02-21 12:58:52.710670 I VidOutVDPAU: Enabled deinterlacing.
2532018-02-21 12:58:52.710842 I VSYNC: DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory
2542018-02-21 12:58:52.710914 E VSYNC: RTCVideoSync: Could not open /dev/rtc:
255eno: No such file or directory (2)
2562018-02-21 12:58:52.712245 I Doubling refresh rate for interlaced display.
2572018-02-21 12:58:52.717938 I Player(0): Video timing method: USleep with busy wait
2582018-02-21 12:58:52.717980 I Player(0): Display Refresh Rate: 50.045 Video Frame Rate: 24.000
2592018-02-21 12:58:52.718007 I Player(0): SetFrameInterval ps:1 scan:1
2602018-02-21 12:58:52.719103 I playCtx: StartPlaying(): took 0 ms to start player.
2612018-02-21 12:58:52.719146 I TV::StartPlayer(): Created player.
2622018-02-21 12:58:52.719207 I TV::HandleStateChange(): Changing from None to WatchingVideo
2632018-02-21 12:58:52.720347 E AFD: video decode error: Invalid data found when processing input (0)
2642018-02-21 12:58:52.720633 E AFD: video decode error: Invalid data found when processing input (0)
2652018-02-21 12:58:52.720729 E AFD: video decode error: Invalid data found when processing input (0)
2662018-02-21 12:58:52.720821 E AFD: video decode error: Invalid data found when processing input (0)
2672018-02-21 12:58:52.720988 E AFD: video decode error: Invalid data found when processing input (0)
2682018-02-21 12:58:52.722189 E AFD: video decode error: Invalid data found when processing input (0)
2692018-02-21 12:58:52.722381 E AFD: video decode error: Invalid data found when processing input (0)
2702018-02-21 12:58:52.722563 E AFD: video decode error: Invalid data found when processing input (0)
2712018-02-21 12:58:52.722719 E AFD: video decode error: Invalid data found when processing input (0)
2722018-02-21 12:58:52.723724 E AFD: video decode error: Invalid data found when processing input (0)
2732018-02-21 12:58:52.723877 E AFD: video decode error: Invalid data found when processing input (0)
2742018-02-21 12:58:52.723953 I AFD: SeekReset(0, 0, do flush, do discard)
2752018-02-21 12:58:52.724051 I AFD: SeekReset() flushing
2762018-02-21 12:58:52.724156 I VidOutVDPAU: DiscardFrames(1)
2772018-02-21 12:58:52.724338 I VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAA
2782018-02-21 12:58:52.724441 I VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAA -- done
2792018-02-21 12:58:52.724507 I VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAA -- done()
2802018-02-21 12:58:52.724560 I AFD: Stream #0, has id 0x0 codec id H264, type Video, bitrate 0 at 0xa1c1dc0
2812018-02-21 12:58:52.724622 I AFD: Stream #1, has id 0x0 codec id DTS, type Audio, bitrate 1536000 at 0xa1c0d20
2822018-02-21 12:58:52.724653 W AFD: Warning, audio codec 0xa398b80 id(DTS) type (Audio) already open, leaving it alone.
2832018-02-21 12:58:52.724686 I AFD: codec DTS has 6 channels
2842018-02-21 12:58:52.724703 I AFD: Looking for decoder for DTS
2852018-02-21 12:58:52.724739 I AFD: Opened codec 0xa398b80, id(DTS) type(Audio)
2862018-02-21 12:58:52.724851 I AFD: Audio Track #1, of type (Normalny) is A/V stream #1 (id=0x0) and has 6 channels in the English language(6647399).
2872018-02-21 12:58:52.724873 I AFD: Trying to select best video track
2882018-02-21 12:58:52.725251 I AFD: Selected track #0 (id 0x0 codec id H264, type Video, bitrate 500000 at 0xa1c1dc0)
2892018-02-21 12:58:52.734542 I TV::HandleStateChange(): Main UI disabled.
2902018-02-21 12:58:52.747367 I VDP: Accepting: cmp() w(>=0) h(>=720) framerate() codecs() dec(vdpau) cpus(4) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpaubasic) filt(vdpaucolorspace=auto)
2912018-02-21 12:58:52.747480 I VDP: Accepting: cmp() w() h() framerate() codecs() dec(vdpau) cpus(4) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
2922018-02-21 12:58:52.747521 I VDP: LoadBestPreferences(1280x548, 0.000, h264)
2932018-02-21 12:58:52.747664 I VDP: LoadBestPreferences Result prio:2, w:, h:, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpauadvanceddoublerate
2942018-02-21 12:58:52.747720 W AFD: Unsupported Video Profile, forcing software decode
2952018-02-21 12:58:52.747761 I AFD: Using 4 CPUs for decoding
2962018-02-21 12:58:52.747782 I AFD: InitVideoCodec() 0x7fa4680ae1e0 id(H264) type (Video).
2972018-02-21 12:58:52.747834 I Player(0): SetFrameInterval ps:1 scan:3
2982018-02-21 12:58:52.747876 I VidOutVDPAU: InputChanged(1280,548,2.33577) \'H.264 VDPAU\'->\'H.264\'
2992018-02-21 12:58:52.749197 I VidOutVDPAU: DiscardFrames(1)
3002018-02-21 12:58:52.749262 I VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAA
3012018-02-21 12:58:52.749338 I VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAA -- done
3022018-02-21 12:58:52.749385 I VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAA -- done()
3032018-02-21 12:58:52.754463 W MythPainter: 40 images not yet de-allocated.
3042018-02-21 12:58:52.754544 I VDPAU Painter: Clearing VDPAU painter cache.
3052018-02-21 12:58:52.755165 I TV::StartTV(): Entering main playback loop.
3062018-02-21 12:58:52.830933 I Clearing OpenGL painter cache.
307