Ticket #13580: playback-log

File playback-log, 76.8 KB (added by Jarno Suni, 4 years ago)

there are 4 blocks in this log: first file and second file playback when web browser is running; then the second file and first file playback when the web browser is not running.

Line 
12020-02-10 04:30:46.369959 I  AFD: Looking for decoder for AC3
22020-02-10 04:30:46.371860 I  AFD: Opened codec 0x56430021a680, id(AC3) type(Audio)
32020-02-10 04:30:46.371963 I  AFD: Trying to select best video track
42020-02-10 04:30:46.372047 I  AFD: Selected track #1 (id 0x138 codec id H264, type Video, bitrate 500000 at 0x5642fe47ab80)
52020-02-10 04:30:46.434513 I  VDP: Accepting: cmp() w(>=0) h(>=720) framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpaubasicdoublerate,vdpaubasic) filt(vdpaucolorspace=auto)
62020-02-10 04:30:46.434562 I  VDP: Accepting: cmp() w() h() framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
72020-02-10 04:30:46.434589 I  VDP: LoadBestPreferences(16x16, 0.000, h264)
82020-02-10 04:30:46.434648 I  VDP: LoadBestPreferences Result prio:2, w:, h:, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpauadvanceddoublerate
92020-02-10 04:30:46.435720 I  VDPAU: Checking VDPAU support.
102020-02-10 04:30:46.550085 I  VDPAU: Version 1
112020-02-10 04:30:46.550108 I  VDPAU: Information NVIDIA VDPAU Driver Shared Library  340.107  Thu May 24 21:44:57 PDT 2018
122020-02-10 04:30:46.550146 I  VDPAU: HQ Scaling not supported.
132020-02-10 04:30:46.550182 I  VDPAU: MPEG4 hardware acceleration not supported.
142020-02-10 04:30:46.550194 I  VDPAU: HEVC hardware acceleration not supported.
152020-02-10 04:30:46.583713 I  AFD: Using 1 CPUs for decoding
162020-02-10 04:30:46.583736 I  AFD: InitVideoCodec() 0x56430069a9c0 id(H264) type (Video).
172020-02-10 04:30:46.584741 I  AFD: Selected FPS is 29.97 (avg 0 codec 0 container 90000 estimated 0)
182020-02-10 04:30:46.584755 I  AFD: InitVideoCodec invalid dimensions, resetting decoder.
192020-02-10 04:30:46.584793 I  Player(0): SetFrameInterval ps:1 scan:3
202020-02-10 04:30:46.584820 I  Player(0): detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
212020-02-10 04:30:46.585426 I  AFD: Using vdpau for video decoding
222020-02-10 04:30:46.585528 I  AFD: Opened codec 0x56430069a9c0, id(H264) type(Video)
232020-02-10 04:30:46.585541 W  Enabling buffering optimisations for low bitrate stream.
242020-02-10 04:30:46.605514 W  Enabling buffering optimisations for low bitrate stream.
252020-02-10 04:30:46.630070 N  AudioPlayer: Enabling Audio
262020-02-10 04:30:46.630105 I  Dec: Selected track #1 (type 2) in the Unknown language(0)
272020-02-10 04:30:46.630123 I  Dec: Selected track #1 (type 7) in the Finnish language(6711662)
282020-02-10 04:30:46.630138 I  Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
292020-02-10 04:30:47.358826 I  Dec: Position map filled from DB to: 262525
302020-02-10 04:30:47.380416 I  Dec: Duration map filled from DB to: 262525
312020-02-10 04:30:47.382958 I  Dec: SyncPositionMap prerecorded, from DB: 13184 entries
322020-02-10 04:30:47.382997 I  Dec: SyncPositionMap, new totframes: 262525, new length: 8759, posMap size: 13184
332020-02-10 04:30:47.391314 I  AFD: Position map found
342020-02-10 04:30:47.391332 I  AFD: Successfully opened decoder for file: "myth://mythbook/10022_20200104175000.ts". novideo(0)
352020-02-10 04:30:47.488065 I  VideoOutput: Allowed renderers: vdpau
362020-02-10 04:30:47.488110 I  VideoOutput: Allowed renderers (filt: vdpau): vdpau
372020-02-10 04:30:47.515868 I  VDP: Accepting: cmp() w(>=0) h(>=720) framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpaubasicdoublerate,vdpaubasic) filt(vdpaucolorspace=auto)
382020-02-10 04:30:47.515925 I  VDP: Accepting: cmp() w() h() framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
392020-02-10 04:30:47.515950 I  VDP: LoadBestPreferences(640x480, 29.970, h264)
402020-02-10 04:30:47.516021 I  VDP: LoadBestPreferences Result prio:2, w:, h:, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpauadvanceddoublerate
412020-02-10 04:30:47.516045 I  VideoOutput: Preferred renderer: vdpau
422020-02-10 04:30:47.516055 I  VideoOutput: Trying video renderer: 'vdpau'
432020-02-10 04:30:47.803350 I  VideoOutWindow::SetPIPState. pip_state: 0]
442020-02-10 04:30:47.848886 I  Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.33333
452020-02-10 04:30:47.848909 I  Video Rect    left: 0, top: 0, width: 640, height: 480, aspect: 1.33333
462020-02-10 04:30:47.848927 I  Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.33333
472020-02-10 04:30:47.848941 I  Video Rect    left: 0, top: 0, width: 640, height: 480, aspect: 1.33333
482020-02-10 04:30:47.848955 I  VDP: SetVideoRenderer(vdpau)
492020-02-10 04:30:47.848970 I  VDP: SetVideoRender(vdpau) == GetVideoRenderer()
502020-02-10 04:30:47.905130 I  VideoOutput: Pixel dimensions: Screen 1920x1080, window 1920x1080
512020-02-10 04:30:47.905157 I  VideoOutput: Actual display dimensions: 508x286 mm  Aspect: 1.77622
522020-02-10 04:30:47.905169 I  VideoOutput: Estimated window dimensions: 508x286 mm  Aspect: 1.77622
532020-02-10 04:30:48.211121 I  VDPAU: Created 2 output surfaces.
542020-02-10 04:30:48.211143 I  VDPAU: Set colorkey to 0x20202
552020-02-10 04:30:48.211155 I  VDPAU: Created VDPAU render device 1920x1080
562020-02-10 04:30:48.243733 I  VidOutVDPAU: Created VDPAU osd (1920x1080)
572020-02-10 04:30:48.320942 I  ColourSpace: PictureAttributes: Brightness, Contrast, Colour, Hue, Studio Levels,
582020-02-10 04:30:48.320959 I  VidOutVDPAU: Using ITU BT.601 colorspace
592020-02-10 04:30:48.320999 I  Display Rect  left: 240, top: 0, width: 1440, height: 1080, aspect: 1.77778
602020-02-10 04:30:48.321012 I  Video Rect    left: 0, top: 0, width: 640, height: 480, aspect: 1.33333
612020-02-10 04:30:48.321020 I  VidOutVDPAU: Created VDPAU context (GPU decode)
622020-02-10 04:30:48.336415 I  Over/underscan. V: 0, H: 0
632020-02-10 04:30:48.336444 I  Display Rect  left: 240, top: 0, width: 1440, height: 1080, aspect: 1.77778
642020-02-10 04:30:48.336456 I  Video Rect    left: 0, top: 0, width: 640, height: 480, aspect: 1.33333
652020-02-10 04:30:48.336493 I  FilterManager: GetFilterInfo(convert) returning: 0x0
662020-02-10 04:30:48.336523 I  Player(0): LoadFilters('vdpaucolorspace=auto'..) -> 0x0
672020-02-10 04:30:48.354757 I  Player(0): Decoder thread starting.
682020-02-10 04:30:48.369087 I  OSD: Loaded window osd_message
692020-02-10 04:30:48.374848 I  OSD: Loaded window osd_input
702020-02-10 04:30:48.408716 I  OSD: Loaded window program_info
712020-02-10 04:30:48.419168 I  OSD: Loaded window browse_info
722020-02-10 04:30:48.424291 I  OSD: Loaded window osd_status
732020-02-10 04:30:48.429321 I  OSD: Loaded window osd_program_editor
742020-02-10 04:30:48.453039 I  OSD: Loaded window osd_debug
752020-02-10 04:30:48.453067 I  OSD: Loaded OSD: size 1920x1080 offset 0+0
762020-02-10 04:30:48.453231 I  OSD: Created window aa_OSD_SUBTITLES
772020-02-10 04:30:48.453273 I  Player(0): ClearAfterSeek(0)
782020-02-10 04:30:48.516275 I  VDP: GetFilteredDeint() : vdpau -> 'vdpauadvanceddoublerate'
792020-02-10 04:30:48.516299 I  VDP: GetFilteredDeint() : vdpau -> 'vdpauadvanceddoublerate'
802020-02-10 04:30:48.518904 I  VidOutVDPAU: Enabled deinterlacing.
812020-02-10 04:30:48.518973 E  VSYNC: DRMVideoSync: VBlank ioctl did not work, unimplemented in this driver?
822020-02-10 04:30:48.519028 E  VSYNC: RTCVideoSync: Could not open /dev/rtc:
83                        eno: Permission denied (13)
842020-02-10 04:30:48.519047 E  Player(0): Video sync method can't support double framerate (refresh rate too low for 2x deint)
852020-02-10 04:30:48.527055 I  VDP: GetFilteredDeint(vdpauadvanced) : vdpau -> 'vdpauadvanced'
862020-02-10 04:30:48.530585 I  VidOutVDPAU: Enabled deinterlacing.
872020-02-10 04:30:48.553341 I  Player(0): Video timing method: USleep with busy wait
882020-02-10 04:30:48.553371 I  Player(0): Display Refresh Rate: 50.000 Video Frame Rate: 29.970
892020-02-10 04:30:48.553400 I  Player(0): SetFrameInterval ps:1 scan:1
902020-02-10 04:30:48.554321 I  playCtx: StartPlaying(): took 0 ms to start player.
912020-02-10 04:30:48.554352 I  TV::StartPlayer(): Created player.
922020-02-10 04:30:48.554453 I  TV::HandleStateChange(): Changing from None to WatchingPreRecorded
932020-02-10 04:30:48.554714 I  AFD: streams_changed 0x5642fe40bee0 -- stream count 4
942020-02-10 04:30:48.555259 I  AFD: SeekReset(0, 0, do flush, do discard)
952020-02-10 04:30:48.555289 I  AFD: SeekReset() flushing
962020-02-10 04:30:48.555310 I  VidOutVDPAU: DiscardFrames(1)
972020-02-10 04:30:48.555378 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAA
982020-02-10 04:30:48.555434 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAA -- done
992020-02-10 04:30:48.555471 I  VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAA -- done()
1002020-02-10 04:30:48.555504 I  AFD: Stream #0, has id 0x32 codec id DVB_TELETEXT, type Subtitle, bitrate 0 at 0x7fd7240c8540
1012020-02-10 04:30:48.555620 I  AFD: Teletext stream #0 (Menu) is in the Finnish language on page 1 0.
1022020-02-10 04:30:48.555646 I  AFD: subtitle codec (Subtitle)
1032020-02-10 04:30:48.555676 I  AFD: Stream #1, has id 0x138 codec id H264, type Video, bitrate 0 at 0x7fd7240c7e80
1042020-02-10 04:30:48.555700 I  AFD: Stream #2, has id 0x35c codec id AC3, type Audio, bitrate 0 at 0x7fd7240c8d40
1052020-02-10 04:30:48.555723 I  AFD: codec AC3 has 0 channels
1062020-02-10 04:30:48.555736 I  AFD: Looking for decoder for AC3
1072020-02-10 04:30:48.556299 I  AFD: Opened codec 0x7fd7240a5e80, id(AC3) type(Audio)
1082020-02-10 04:30:48.556372 I  AFD: Stream #3, has id 0x361 codec id AC3, type Audio, bitrate 0 at 0x7fd7240c9400
1092020-02-10 04:30:48.556390 I  AFD: codec AC3 has 0 channels
1102020-02-10 04:30:48.556402 I  AFD: Looking for decoder for AC3
1112020-02-10 04:30:48.557148 I  AFD: Opened codec 0x7fd7240a9c00, id(AC3) type(Audio)
1122020-02-10 04:30:48.557218 I  AFD: Trying to select best video track
1132020-02-10 04:30:48.557350 I  AFD: Selected track #1 (id 0x138 codec id H264, type Video, bitrate 500000 at 0x7fd7240c7e80)
1142020-02-10 04:30:48.597029 I  TV::HandleStateChange(): Main UI disabled.
1152020-02-10 04:30:48.597467 I  TV::StartTV(): Entering main playback loop.
1162020-02-10 04:30:48.607300 I  Player(0): Waiting for video buffers...
1172020-02-10 04:30:48.679773 I  VDP: Accepting: cmp() w(>=0) h(>=720) framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpaubasicdoublerate,vdpaubasic) filt(vdpaucolorspace=auto)
1182020-02-10 04:30:48.679835 I  VDP: Accepting: cmp() w() h() framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
1192020-02-10 04:30:48.679865 I  VDP: LoadBestPreferences(16x16, 0.000, h264)
1202020-02-10 04:30:48.679940 I  VDP: LoadBestPreferences Result prio:2, w:, h:, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpauadvanceddoublerate
1212020-02-10 04:30:48.680002 I  AFD: Using 1 CPUs for decoding
1222020-02-10 04:30:48.680019 I  AFD: InitVideoCodec() 0x7fd724062300 id(H264) type (Video).
1232020-02-10 04:30:48.680041 I  VDP: GetFilteredDeint() : vdpau -> 'vdpauadvanceddoublerate'
1242020-02-10 04:30:48.680077 I  AFD: Selected FPS is 29.97 (avg 0 codec 0 container 90000 estimated 0)
1252020-02-10 04:30:48.680088 I  AFD: InitVideoCodec invalid dimensions, resetting decoder.
1262020-02-10 04:30:48.680109 I  Player(0): SetFrameInterval ps:1 scan:3
1272020-02-10 04:30:48.680134 I  VidOutVDPAU: InputChanged(640,480,1.33333) 'H.264 VDPAU'->'H.264 VDPAU'
1282020-02-10 04:30:48.710194 N  Player(0): Waited 103ms for video buffers AAAAAAAAAAAAAA
1292020-02-10 04:30:48.741205 I  Player(0): detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
1302020-02-10 04:30:48.741314 I  AFD: Using vdpau for video decoding
1312020-02-10 04:30:48.741512 I  AFD: Opened codec 0x7fd724062300, id(H264) type(Video)
1322020-02-10 04:30:48.741524 W  Enabling buffering optimisations for low bitrate stream.
1332020-02-10 04:30:48.742115 I  Player(0): Enabled Video Output based deinterlacing
1342020-02-10 04:30:48.752798 I  AOBase: Opening audio device 'pulse' ch 2(2) sr 48000 sf 32 bit floating point reenc 0
1352020-02-10 04:30:48.814003 N  Player(0): Waited 206ms for video buffers AAAAAAAAAAAAAA
1362020-02-10 04:30:48.820564 I  Player(0): SetFrameInterval ps:1 scan:3
1372020-02-10 04:30:48.820591 I  VDP: LoadBestPreferences(640x480, 25.000, h264)
1382020-02-10 04:30:48.820998 I  VDP: LoadBestPreferences Result prio:2, w:, h:, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpauadvanceddoublerate
1392020-02-10 04:30:48.821024 I  VidOutVDPAU: InputChanged(1920,1080,1.77778) 'H.264 VDPAU'->'H.264 VDPAU'
1402020-02-10 04:30:48.829946 I  VidOutVDPAU: DiscardFrames(1)
1412020-02-10 04:30:48.829984 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAA
1422020-02-10 04:30:48.830018 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAA -- done
1432020-02-10 04:30:48.830039 I  VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAA -- done()
1442020-02-10 04:30:48.849710 W  MythPainter: 25 images not yet de-allocated.
1452020-02-10 04:30:48.849742 I  VDPAU Painter: Clearing VDPAU painter cache.
1462020-02-10 04:30:48.918685 N  Player(0): Waited 311ms for video buffers               
1472020-02-10 04:30:49.003504 I  Snapping height to avoid scaling: height: 1080, top: 0
1482020-02-10 04:30:49.003520 I  Snapping width to avoid scaling: width: 1920, left: 0
1492020-02-10 04:30:49.003541 I  Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
1502020-02-10 04:30:49.003557 I  Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
1512020-02-10 04:30:49.003578 I  VDP: LoadBestPreferences(1920x1088, 25.000, h264)
1522020-02-10 04:30:49.003675 I  VDP: LoadBestPreferences Result prio:1, w:>=0, h:>=720, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpaubasicdoublerate
1532020-02-10 04:30:49.003689 I  Snapping height to avoid scaling: height: 1080, top: 0
1542020-02-10 04:30:49.003697 I  Snapping width to avoid scaling: width: 1920, left: 0
1552020-02-10 04:30:49.003709 I  Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
1562020-02-10 04:30:49.003721 I  Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
1572020-02-10 04:30:49.003730 I  VDP: SetVideoRenderer(vdpau)
1582020-02-10 04:30:49.003741 I  VDP: SetVideoRender(vdpau) == GetVideoRenderer()
1592020-02-10 04:30:49.023939 N  Player(0): Waited 416ms for video buffers               
1602020-02-10 04:30:49.026318 I  VideoOutput: Pixel dimensions: Screen 1920x1080, window 1920x1080
1612020-02-10 04:30:49.026342 I  VideoOutput: Actual display dimensions: 508x286 mm  Aspect: 1.77622
1622020-02-10 04:30:49.026354 I  VideoOutput: Estimated window dimensions: 508x286 mm  Aspect: 1.77622
1632020-02-10 04:30:49.110635 N  Player(0): Timed out waiting for frames, and
164                        there are not enough free frames. Discarding buffered frames.
1652020-02-10 04:30:49.206386 E  VDPAU: Error at mythrender_vdpau.cpp:632 (#23, The system does not have enough resources to complete the requested operation at this time.)
1662020-02-10 04:30:49.206406 E  VDPAU: Failed to create output surface.
1672020-02-10 04:30:49.206418 E  VDPAU: No presentation surfaces
1682020-02-10 04:30:49.206425 E  VDPAU: Failed to create VDPAU render device.
1692020-02-10 04:30:49.206440 E  VidOutVDPAU: Failed to initialise VDPAU
1702020-02-10 04:30:49.206452 I  VidOutVDPAU: DiscardFrames(1)
1712020-02-10 04:30:49.206478 I  VideoBuffers::DiscardFrames(1):               
1722020-02-10 04:30:49.206560 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAA -- done
1732020-02-10 04:30:49.206582 I  VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAA -- done()
1742020-02-10 04:30:49.323337 E  VidOutVDPAU: Failed to re-initialise video output.
1752020-02-10 04:30:49.323372 I  VidOutVDPAU: DiscardFrames(1)
1762020-02-10 04:30:49.323399 I  VideoBuffers::DiscardFrames(1):               
1772020-02-10 04:30:49.323465 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAA -- done
1782020-02-10 04:30:49.323486 I  VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAA -- done()
1792020-02-10 04:30:49.323622 E  Player(0): Failed to Reinitialize Video. Exiting..
1802020-02-10 04:30:49.323677 I  AFD: Selected FPS is 29.97 (avg 0 codec 0 container 90000 estimated 0)
1812020-02-10 04:30:49.323688 I  AFD: avFPS(29.97) != seqFPS(25)
1822020-02-10 04:30:49.323707 I  Player(0): Decoder thread exiting.
1832020-02-10 04:30:49.328786 N  Player(0): Waited 721ms for video buffers AAAAAAAAAAAAAA
1842020-02-10 04:30:49.329962 I  TV::HandleStateChange(): Attempting to change from WatchingPreRecorded to None
1852020-02-10 04:30:49.330046 I  Player(0): StopPlaying - begin
1862020-02-10 04:30:49.430210 W  Player(0): Waited 100ms for decoder to pause
1872020-02-10 04:30:49.530395 W  Player(0): Waited 100ms for decoder to pause
1882020-02-10 04:30:49.630589 W  Player(0): Waited 100ms for decoder to pause
1892020-02-10 04:30:49.730703 W  Player(0): Waited 100ms for decoder to pause
1902020-02-10 04:30:49.830896 W  Player(0): Waited 100ms for decoder to pause
1912020-02-10 04:30:49.931033 W  Player(0): Waited 100ms for decoder to pause
1922020-02-10 04:30:50.031184 W  Player(0): Waited 100ms for decoder to pause
1932020-02-10 04:30:50.131301 W  Player(0): Waited 100ms for decoder to pause
1942020-02-10 04:30:50.231456 W  Player(0): Waited 100ms for decoder to pause
1952020-02-10 04:30:50.331606 W  Player(0): Waited 100ms for decoder to pause
1962020-02-10 04:30:50.431740 W  Player(0): Waited 100ms for decoder to pause
1972020-02-10 04:30:50.531869 W  Player(0): Waited 100ms for decoder to pause
1982020-02-10 04:30:50.632006 W  Player(0): Waited 100ms for decoder to pause
1992020-02-10 04:30:50.732136 W  Player(0): Waited 100ms for decoder to pause
2002020-02-10 04:30:50.832271 W  Player(0): Waited 100ms for decoder to pause
2012020-02-10 04:30:50.932399 W  Player(0): Waited 100ms for decoder to pause
2022020-02-10 04:30:51.032545 W  Player(0): Waited 100ms for decoder to pause
2032020-02-10 04:30:51.132688 W  Player(0): Waited 100ms for decoder to pause
2042020-02-10 04:30:51.232864 W  Player(0): Waited 100ms for decoder to pause
2052020-02-10 04:30:51.332991 W  Player(0): Waited 100ms for decoder to pause
2062020-02-10 04:30:51.433148 W  Player(0): Waited 100ms for decoder to pause
2072020-02-10 04:30:51.533313 W  Player(0): Waited 100ms for decoder to pause
2082020-02-10 04:30:51.633461 W  Player(0): Waited 100ms for decoder to pause
2092020-02-10 04:30:51.733601 W  Player(0): Waited 100ms for decoder to pause
2102020-02-10 04:30:51.833748 W  Player(0): Waited 100ms for decoder to pause
2112020-02-10 04:30:51.933914 W  Player(0): Waited 100ms for decoder to pause
2122020-02-10 04:30:52.034041 W  Player(0): Waited 100ms for decoder to pause
2132020-02-10 04:30:52.134177 W  Player(0): Waited 100ms for decoder to pause
2142020-02-10 04:30:52.234313 W  Player(0): Waited 100ms for decoder to pause
2152020-02-10 04:30:52.334467 W  Player(0): Waited 100ms for decoder to pause
2162020-02-10 04:30:52.434596 W  Player(0): Waited 100ms for decoder to pause
2172020-02-10 04:30:52.534724 W  Player(0): Waited 100ms for decoder to pause
2182020-02-10 04:30:52.634869 W  Player(0): Waited 100ms for decoder to pause
2192020-02-10 04:30:52.735011 W  Player(0): Waited 100ms for decoder to pause
2202020-02-10 04:30:52.835173 W  Player(0): Waited 100ms for decoder to pause
2212020-02-10 04:30:52.935320 W  Player(0): Waited 100ms for decoder to pause
2222020-02-10 04:30:53.035470 W  Player(0): Waited 100ms for decoder to pause
2232020-02-10 04:30:53.135605 W  Player(0): Waited 100ms for decoder to pause
2242020-02-10 04:30:53.235769 W  Player(0): Waited 100ms for decoder to pause
2252020-02-10 04:30:53.336021 W  Player(0): Waited 100ms for decoder to pause
2262020-02-10 04:30:53.436172 W  Player(0): Waited 100ms for decoder to pause
2272020-02-10 04:30:53.536302 W  Player(0): Waited 100ms for decoder to pause
2282020-02-10 04:30:53.636449 W  Player(0): Waited 100ms for decoder to pause
2292020-02-10 04:30:53.736582 W  Player(0): Waited 100ms for decoder to pause
2302020-02-10 04:30:53.836734 W  Player(0): Waited 100ms for decoder to pause
2312020-02-10 04:30:53.936889 W  Player(0): Waited 100ms for decoder to pause
2322020-02-10 04:30:54.037013 W  Player(0): Waited 100ms for decoder to pause
2332020-02-10 04:30:54.137164 W  Player(0): Waited 100ms for decoder to pause
2342020-02-10 04:30:54.237327 W  Player(0): Waited 100ms for decoder to pause
2352020-02-10 04:30:54.337489 W  Player(0): Waited 100ms for decoder to pause
2362020-02-10 04:30:54.437639 W  Player(0): Waited 100ms for decoder to pause
2372020-02-10 04:30:54.537796 W  Player(0): Waited 100ms for decoder to pause
2382020-02-10 04:30:54.637949 W  Player(0): Waited 100ms for decoder to pause
2392020-02-10 04:30:54.738104 W  Player(0): Waited 100ms for decoder to pause
2402020-02-10 04:30:54.838252 W  Player(0): Waited 100ms for decoder to pause
2412020-02-10 04:30:54.938391 W  Player(0): Waited 100ms for decoder to pause
2422020-02-10 04:30:55.038519 W  Player(0): Waited 100ms for decoder to pause
2432020-02-10 04:30:55.138673 W  Player(0): Waited 100ms for decoder to pause
2442020-02-10 04:30:55.238856 W  Player(0): Waited 100ms for decoder to pause
2452020-02-10 04:30:55.338975 W  Player(0): Waited 100ms for decoder to pause
2462020-02-10 04:30:55.439142 W  Player(0): Waited 100ms for decoder to pause
2472020-02-10 04:30:55.539216 W  Player(0): Waited 100ms for decoder to pause
2482020-02-10 04:30:55.639357 W  Player(0): Waited 100ms for decoder to pause
2492020-02-10 04:30:55.739495 W  Player(0): Waited 100ms for decoder to pause
2502020-02-10 04:30:55.839656 W  Player(0): Waited 100ms for decoder to pause
2512020-02-10 04:30:55.939780 W  Player(0): Waited 100ms for decoder to pause
2522020-02-10 04:30:56.039903 W  Player(0): Waited 100ms for decoder to pause
2532020-02-10 04:30:56.140026 W  Player(0): Waited 100ms for decoder to pause
2542020-02-10 04:30:56.240183 W  Player(0): Waited 100ms for decoder to pause
2552020-02-10 04:30:56.340345 W  Player(0): Waited 100ms for decoder to pause
2562020-02-10 04:30:56.440503 W  Player(0): Waited 100ms for decoder to pause
2572020-02-10 04:30:56.540647 W  Player(0): Waited 100ms for decoder to pause
2582020-02-10 04:30:56.640818 W  Player(0): Waited 100ms for decoder to pause
2592020-02-10 04:30:56.740988 W  Player(0): Waited 100ms for decoder to pause
2602020-02-10 04:30:56.841150 W  Player(0): Waited 100ms for decoder to pause
2612020-02-10 04:30:56.941294 W  Player(0): Waited 100ms for decoder to pause
2622020-02-10 04:30:57.041451 W  Player(0): Waited 100ms for decoder to pause
2632020-02-10 04:30:57.141579 W  Player(0): Waited 100ms for decoder to pause
2642020-02-10 04:30:57.241728 W  Player(0): Waited 100ms for decoder to pause
2652020-02-10 04:30:57.341904 W  Player(0): Waited 100ms for decoder to pause
2662020-02-10 04:30:57.442072 W  Player(0): Waited 100ms for decoder to pause
2672020-02-10 04:30:57.542218 W  Player(0): Waited 100ms for decoder to pause
2682020-02-10 04:30:57.642361 W  Player(0): Waited 100ms for decoder to pause
2692020-02-10 04:30:57.742517 W  Player(0): Waited 100ms for decoder to pause
2702020-02-10 04:30:57.842681 W  Player(0): Waited 100ms for decoder to pause
2712020-02-10 04:30:57.942844 W  Player(0): Waited 100ms for decoder to pause
2722020-02-10 04:30:58.042994 W  Player(0): Waited 100ms for decoder to pause
2732020-02-10 04:30:58.143160 W  Player(0): Waited 100ms for decoder to pause
2742020-02-10 04:30:58.243304 W  Player(0): Waited 100ms for decoder to pause
2752020-02-10 04:30:58.343456 W  Player(0): Waited 100ms for decoder to pause
2762020-02-10 04:30:58.443616 W  Player(0): Waited 100ms for decoder to pause
2772020-02-10 04:30:58.543769 W  Player(0): Waited 100ms for decoder to pause
2782020-02-10 04:30:58.643935 W  Player(0): Waited 100ms for decoder to pause
2792020-02-10 04:30:58.744117 W  Player(0): Waited 100ms for decoder to pause
2802020-02-10 04:30:58.844299 W  Player(0): Waited 100ms for decoder to pause
2812020-02-10 04:30:58.944451 W  Player(0): Waited 100ms for decoder to pause
2822020-02-10 04:30:59.044617 W  Player(0): Waited 100ms for decoder to pause
2832020-02-10 04:30:59.144799 W  Player(0): Waited 100ms for decoder to pause
2842020-02-10 04:30:59.244973 W  Player(0): Waited 100ms for decoder to pause
2852020-02-10 04:30:59.345114 W  Player(0): Waited 100ms for decoder to pause
2862020-02-10 04:30:59.345140 I  Player(0): Exited decoder loop.
2872020-02-10 04:30:59.356240 I  VidOutVDPAU: DiscardFrames(1)
2882020-02-10 04:30:59.356278 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAA
2892020-02-10 04:30:59.356311 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAA -- done
2902020-02-10 04:30:59.356332 I  VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAA -- done()
2912020-02-10 04:30:59.356365 I  VDPAU Painter: Clearing VDPAU painter cache.
2922020-02-10 04:30:59.365571 I  Player(0): StopPlaying - end
2932020-02-10 04:30:59.365591 I  TV::StopStuff(): Stopping ring buffer
2942020-02-10 04:30:59.365679 I  TV::StopStuff(): Stopping player
2952020-02-10 04:30:59.365703 I  TV::HandleStateChange(): Changing from WatchingPreRecorded to None
2962020-02-10 04:30:59.365756 I  TV::StartTV(): Exiting main playback loop.
2972020-02-10 04:30:59.365771 I  TV::StartTV(): -- process events 2 begin
2982020-02-10 04:30:59.382940 I  TV::StartTV(): -- process events 2 end
2992020-02-10 04:30:59.394012 I  TV::~TV(): -- lock
3002020-02-10 04:30:59.394261 I  Player(0): StopPlaying - begin
3012020-02-10 04:30:59.394294 I  Player(0): Exited decoder loop.
3022020-02-10 04:30:59.394313 I  Player(0): StopPlaying - end
3032020-02-10 04:30:59.411936 N  Resuming idle timer
3042020-02-10 04:31:02.478959 I  Running HouseKeeperTask 'HardwareProfiler'.
3052020-02-10 04:31:02.507572 I  HouseKeeperTask 'HardwareProfiler' Failed.
306
307
308
309
310
311
312
313
314
315
316
317
318
319
320
321
322
323
324
325
326
327
328
329
330
3312020-02-10 04:38:07.114820 I  TV::TV(): Creating TV object
3322020-02-10 04:38:07.162034 I  TV::TV(): Finished creating TV object
3332020-02-10 04:38:07.162067 N  Suspending idle timer
3342020-02-10 04:38:07.176233 I  TV::Init(): Created TvPlayWindow.
3352020-02-10 04:38:07.332822 I  TV::HandleStateChange(): Attempting to change from None to WatchingPreRecorded
3362020-02-10 04:38:07.367499 I  FileRingBuf(myth://mythbook/10025_20200122203441.ts): OpenFile(myth://mythbook/10025_20200122203441.ts, 2000 ms)
3372020-02-10 04:38:07.428630 I  TV::StartPlayer(): Elapsed time since TV constructor was called: 314 ms
3382020-02-10 04:38:07.448755 E  ALSA: snd_pcm_info_get_card: Operation not permitted
3392020-02-10 04:38:07.467918 N  AudioPlayer: Enabling Audio
3402020-02-10 04:38:07.532025 I  AFD: PlayerFlags: 0xc0, AudioReadAhead: 100 msec
3412020-02-10 04:38:07.532103 I  Player(1): Stretch Factor 1, allow passthru
3422020-02-10 04:38:07.532426 I  AFD: Buffer size: 32768 streamed 0 seekable 1
3432020-02-10 04:38:08.352958 I  AFD: Stream #0, has id 0x39 codec id DVB_TELETEXT, type Subtitle, bitrate 0 at 0x5642f9e17240
3442020-02-10 04:38:08.353065 I  AFD: Teletext stream #0 (Menu) is in the Finnish language on page 1 0.
3452020-02-10 04:38:08.353095 I  AFD: subtitle codec (Subtitle)
3462020-02-10 04:38:08.353120 I  AFD: Stream #1, has id 0x13a codec id H264, type Video, bitrate 0 at 0x5642fad90c00
3472020-02-10 04:38:08.353140 I  AFD: Stream #2, has id 0x366 codec id AC3, type Audio, bitrate 448000 at 0x5642f9dc5e40
3482020-02-10 04:38:08.353159 I  AFD: codec AC3 has 6 channels
3492020-02-10 04:38:08.353170 I  AFD: Looking for decoder for AC3
3502020-02-10 04:38:08.353747 I  AFD: Opened codec 0x5642fdd7b000, id(AC3) type(Audio)
3512020-02-10 04:38:08.353821 I  AFD: Stream #3, has id 0x369 codec id AC3, type Audio, bitrate 192000 at 0x564300fdd040
3522020-02-10 04:38:08.353840 I  AFD: codec AC3 has 2 channels
3532020-02-10 04:38:08.353851 I  AFD: Looking for decoder for AC3
3542020-02-10 04:38:08.354485 I  AFD: Opened codec 0x5642f992ea00, id(AC3) type(Audio)
3552020-02-10 04:38:08.354548 I  AFD: Stream #4, has id 0xc37 codec id DVB_SUBTITLE, type Subtitle, bitrate 0 at 0x5642f9a69cc0
3562020-02-10 04:38:08.354562 I  AFD: subtitle codec (Subtitle)
3572020-02-10 04:38:08.354575 I  AFD: Looking for decoder for DVB_SUBTITLE
3582020-02-10 04:38:08.354648 I  AFD: Opened codec 0x5642f993b400, id(DVB_SUBTITLE) type(Subtitle)
3592020-02-10 04:38:08.354679 I  AFD: Subtitle track #1 is A/V stream #4 and is in the Finnish language(6711662).
3602020-02-10 04:38:08.354701 I  AFD: Stream #5, has id 0xc38 codec id DVB_SUBTITLE, type Subtitle, bitrate 0 at 0x5642f99935c0
3612020-02-10 04:38:08.354716 I  AFD: subtitle codec (Subtitle)
3622020-02-10 04:38:08.354729 I  AFD: Looking for decoder for DVB_SUBTITLE
3632020-02-10 04:38:08.354786 I  AFD: Opened codec 0x5642f993dc00, id(DVB_SUBTITLE) type(Subtitle)
3642020-02-10 04:38:08.354834 I  AFD: Subtitle track #2 is A/V stream #5 and is in the Swedish language(7567205).
3652020-02-10 04:38:08.354846 I  AFD: Trying to select best video track
3662020-02-10 04:38:08.354915 I  AFD: Selected track #1 (id 0x13a codec id H264, type Video, bitrate 500000 at 0x5642fad90c00)
3672020-02-10 04:38:08.386753 I  VDP: Accepting: cmp() w(>=0) h(>=720) framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpaubasicdoublerate,vdpaubasic) filt(vdpaucolorspace=auto)
3682020-02-10 04:38:08.386813 I  VDP: Accepting: cmp() w() h() framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
3692020-02-10 04:38:08.386838 I  VDP: LoadBestPreferences(1920x1080, 0.000, h264)
3702020-02-10 04:38:08.386907 I  VDP: LoadBestPreferences Result prio:1, w:>=0, h:>=720, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpaubasicdoublerate
3712020-02-10 04:38:08.386967 I  AFD: Using 1 CPUs for decoding
3722020-02-10 04:38:08.386983 I  AFD: InitVideoCodec() 0x5642f9948000 id(H264) type (Video).
3732020-02-10 04:38:08.387020 I  AFD: Selected FPS is 25 (avg 25 codec 0 container 90000 estimated 25)
3742020-02-10 04:38:08.387045 I  Player(1): SetFrameInterval ps:1 scan:3
3752020-02-10 04:38:08.387068 I  Player(1): detectInterlace(Detect Scan, Interlaced Scan, 25, 1080) ->Interlaced Scan
3762020-02-10 04:38:08.387174 I  AFD: Using vdpau for video decoding
3772020-02-10 04:38:08.387398 I  AFD: Opened codec 0x5642f9948000, id(H264) type(Video)
3782020-02-10 04:38:08.409399 I  AOBase: Opening audio device 'pulse' ch 2(6) sr 48000 sf 32 bit floating point reenc 0
3792020-02-10 04:38:08.432601 I  Dec: Selected track #1 (type 2) in the Unknown language(0)
3802020-02-10 04:38:08.432650 I  Dec: Trying to select track (w/lang & forced)
3812020-02-10 04:38:08.432738 I  Dec: Selected track #1 (type 3) in the Finnish language(6711662)
3822020-02-10 04:38:08.432795 I  Dec: Selected track #1 (type 7) in the Finnish language(6711662)
3832020-02-10 04:38:08.432883 I  Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
3842020-02-10 04:38:09.375621 I  Dec: Position map filled from DB to: 54332
3852020-02-10 04:38:09.380176 I  Dec: Duration map filled from DB to: 54332
3862020-02-10 04:38:09.380743 I  Dec: SyncPositionMap prerecorded, from DB: 2726 entries
3872020-02-10 04:38:09.380763 I  Dec: SyncPositionMap, new totframes: 54332, new length: 2173, posMap size: 2726
3882020-02-10 04:38:09.404666 I  AFD: Position map found
3892020-02-10 04:38:09.404689 I  AFD: Successfully opened decoder for file: "myth://mythbook/10025_20200122203441.ts". novideo(0)
3902020-02-10 04:38:09.556929 I  VideoOutput: Allowed renderers: vdpau
3912020-02-10 04:38:09.557007 I  VideoOutput: Allowed renderers (filt: vdpau): vdpau
3922020-02-10 04:38:09.622391 I  VDP: Accepting: cmp() w(>=0) h(>=720) framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpaubasicdoublerate,vdpaubasic) filt(vdpaucolorspace=auto)
3932020-02-10 04:38:09.622455 I  VDP: Accepting: cmp() w() h() framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
3942020-02-10 04:38:09.622497 I  VDP: LoadBestPreferences(1920x1080, 25.000, h264)
3952020-02-10 04:38:09.622555 I  VDP: LoadBestPreferences Result prio:1, w:>=0, h:>=720, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpaubasicdoublerate
3962020-02-10 04:38:09.622573 I  VideoOutput: Preferred renderer: vdpau
3972020-02-10 04:38:09.622580 I  VideoOutput: Trying video renderer: 'vdpau'
3982020-02-10 04:38:09.680713 I  VideoOutWindow::SetPIPState. pip_state: 0]
3992020-02-10 04:38:09.782843 I  Snapping width to avoid scaling: width: 1920, left: 0
4002020-02-10 04:38:09.782870 I  Display Rect  left: 0, top: 135, width: 1920, height: 810, aspect: 1.33333
4012020-02-10 04:38:09.782882 I  Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
4022020-02-10 04:38:09.782902 I  VDP: LoadBestPreferences(1920x1088, 25.000, h264)
4032020-02-10 04:38:09.783016 I  VDP: LoadBestPreferences Result prio:1, w:>=0, h:>=720, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpaubasicdoublerate
4042020-02-10 04:38:09.783030 I  Snapping width to avoid scaling: width: 1920, left: 0
4052020-02-10 04:38:09.783043 I  Display Rect  left: 0, top: 135, width: 1920, height: 810, aspect: 1.33333
4062020-02-10 04:38:09.783055 I  Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
4072020-02-10 04:38:09.783064 I  VDP: SetVideoRenderer(vdpau)
4082020-02-10 04:38:09.783074 I  VDP: SetVideoRender(vdpau) == GetVideoRenderer()
4092020-02-10 04:38:09.808031 I  VideoOutput: Pixel dimensions: Screen 1920x1080, window 1920x1080
4102020-02-10 04:38:09.808059 I  VideoOutput: Actual display dimensions: 508x286 mm  Aspect: 1.77622
4112020-02-10 04:38:09.808071 I  VideoOutput: Estimated window dimensions: 508x286 mm  Aspect: 1.77622
4122020-02-10 04:38:10.134342 E  VDPAU: Error at mythrender_vdpau.cpp:632 (#23, The system does not have enough resources to complete the requested operation at this time.)
4132020-02-10 04:38:10.134358 E  VDPAU: Failed to create output surface.
4142020-02-10 04:38:10.134366 E  VDPAU: No presentation surfaces
4152020-02-10 04:38:10.134373 E  VDPAU: Failed to create VDPAU render device.
4162020-02-10 04:38:10.134387 E  VidOutVDPAU: Failed to initialise VDPAU
4172020-02-10 04:38:10.134398 I  VidOutVDPAU: DiscardFrames(1)
4182020-02-10 04:38:10.134413 I  VideoBuffers::DiscardFrames(1):
4192020-02-10 04:38:10.134434 I  VideoBuffers::DiscardFrames(1):  -- done
4202020-02-10 04:38:10.134444 I  VidOutVDPAU: DiscardFrames() 3:  -- done()
4212020-02-10 04:38:10.168112 I  VidOutVDPAU: DiscardFrames(1)
4222020-02-10 04:38:10.168141 I  VideoBuffers::DiscardFrames(1):
4232020-02-10 04:38:10.168165 I  VideoBuffers::DiscardFrames(1):  -- done
4242020-02-10 04:38:10.168178 I  VidOutVDPAU: DiscardFrames() 3:  -- done()
4252020-02-10 04:38:10.168218 E  VideoOutput: Not compiled with any useable video output method.
4262020-02-10 04:38:10.168264 E  Player(1): Couldn't create VideoOutput instance. Exiting..
4272020-02-10 04:38:10.168280 E  Player(1): Unable to initialize video.
4282020-02-10 04:38:10.191824 E  playCtx: StartPlaying() Failed to start player
4292020-02-10 04:38:10.191892 C  TV::StartPlayer(): Failed to create player.
4302020-02-10 04:38:10.202147 I  TV::HandleStateChange(): Main UI disabled.
4312020-02-10 04:38:10.202215 I  TV::StartTV(): Entering main playback loop.
4322020-02-10 04:38:10.259760 I  TV::StartTV(): Exiting main playback loop.
4332020-02-10 04:38:10.259776 I  TV::StartTV(): -- process events 2 begin
4342020-02-10 04:38:10.260606 I  TV::StartTV(): -- process events 2 end
4352020-02-10 04:38:10.273121 I  TV::~TV(): -- lock
4362020-02-10 04:38:10.273339 I  Player(1): StopPlaying - begin
4372020-02-10 04:38:10.273363 I  Player(1): Exited decoder loop.
4382020-02-10 04:38:10.274183 I  Player(1): StopPlaying - end
4392020-02-10 04:38:10.312742 N  Resuming idle timer
440
441
442
443
444
445
446
447
448
449
450
451
4522020-02-10 04:39:59.550239 I  TV::TV(): Creating TV object
4532020-02-10 04:39:59.598956 I  TV::TV(): Finished creating TV object
4542020-02-10 04:39:59.599016 N  Suspending idle timer
4552020-02-10 04:39:59.615054 I  TV::Init(): Created TvPlayWindow.
4562020-02-10 04:39:59.715894 I  TV::HandleStateChange(): Attempting to change from None to WatchingPreRecorded
4572020-02-10 04:39:59.746766 I  FileRingBuf(myth://mythbook/10025_20200122203441.ts): OpenFile(myth://mythbook/10025_20200122203441.ts, 2000 ms)
4582020-02-10 04:39:59.799507 I  TV::StartPlayer(): Elapsed time since TV constructor was called: 249 ms
4592020-02-10 04:39:59.822986 E  ALSA: snd_pcm_info_get_card: Operation not permitted
4602020-02-10 04:39:59.839456 N  AudioPlayer: Enabling Audio
4612020-02-10 04:39:59.900569 I  AFD: PlayerFlags: 0xc0, AudioReadAhead: 100 msec
4622020-02-10 04:39:59.900603 I  Player(2): Stretch Factor 1, allow passthru
4632020-02-10 04:39:59.900883 I  AFD: Buffer size: 32768 streamed 0 seekable 1
4642020-02-10 04:40:00.644997 I  AFD: Stream #0, has id 0x39 codec id DVB_TELETEXT, type Subtitle, bitrate 0 at 0x5642f9807080
4652020-02-10 04:40:00.645107 I  AFD: Teletext stream #0 (Menu) is in the Finnish language on page 1 0.
4662020-02-10 04:40:00.645157 I  AFD: subtitle codec (Subtitle)
4672020-02-10 04:40:00.645182 I  AFD: Stream #1, has id 0x13a codec id H264, type Video, bitrate 0 at 0x5642f9dc5e40
4682020-02-10 04:40:00.645204 I  AFD: Stream #2, has id 0x366 codec id AC3, type Audio, bitrate 448000 at 0x564300fdd040
4692020-02-10 04:40:00.645221 I  AFD: codec AC3 has 6 channels
4702020-02-10 04:40:00.645233 I  AFD: Looking for decoder for AC3
4712020-02-10 04:40:00.645819 I  AFD: Opened codec 0x5642f991af80, id(AC3) type(Audio)
4722020-02-10 04:40:00.645893 I  AFD: Stream #3, has id 0x369 codec id AC3, type Audio, bitrate 192000 at 0x564300218e80
4732020-02-10 04:40:00.645909 I  AFD: codec AC3 has 2 channels
4742020-02-10 04:40:00.645923 I  AFD: Looking for decoder for AC3
4752020-02-10 04:40:00.646450 I  AFD: Opened codec 0x5642f993a600, id(AC3) type(Audio)
4762020-02-10 04:40:00.646512 I  AFD: Stream #4, has id 0xc37 codec id DVB_SUBTITLE, type Subtitle, bitrate 0 at 0x564301003e40
4772020-02-10 04:40:00.646527 I  AFD: subtitle codec (Subtitle)
4782020-02-10 04:40:00.646539 I  AFD: Looking for decoder for DVB_SUBTITLE
4792020-02-10 04:40:00.646612 I  AFD: Opened codec 0x5642f993dc00, id(DVB_SUBTITLE) type(Subtitle)
4802020-02-10 04:40:00.646642 I  AFD: Subtitle track #1 is A/V stream #4 and is in the Finnish language(6711662).
4812020-02-10 04:40:00.646664 I  AFD: Stream #5, has id 0xc38 codec id DVB_SUBTITLE, type Subtitle, bitrate 0 at 0x564301002540
4822020-02-10 04:40:00.646678 I  AFD: subtitle codec (Subtitle)
4832020-02-10 04:40:00.646801 I  AFD: Looking for decoder for DVB_SUBTITLE
4842020-02-10 04:40:00.646863 I  AFD: Opened codec 0x5642f983ce00, id(DVB_SUBTITLE) type(Subtitle)
4852020-02-10 04:40:00.646894 I  AFD: Subtitle track #2 is A/V stream #5 and is in the Swedish language(7567205).
4862020-02-10 04:40:00.646906 I  AFD: Trying to select best video track
4872020-02-10 04:40:00.646978 I  AFD: Selected track #1 (id 0x13a codec id H264, type Video, bitrate 500000 at 0x5642f9dc5e40)
4882020-02-10 04:40:00.684879 I  VDP: Accepting: cmp() w(>=0) h(>=720) framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpaubasicdoublerate,vdpaubasic) filt(vdpaucolorspace=auto)
4892020-02-10 04:40:00.684997 I  VDP: Accepting: cmp() w() h() framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
4902020-02-10 04:40:00.685024 I  VDP: LoadBestPreferences(1920x1080, 0.000, h264)
4912020-02-10 04:40:00.685102 I  VDP: LoadBestPreferences Result prio:1, w:>=0, h:>=720, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpaubasicdoublerate
4922020-02-10 04:40:00.685165 I  AFD: Using 1 CPUs for decoding
4932020-02-10 04:40:00.685181 I  AFD: InitVideoCodec() 0x5642f993ce00 id(H264) type (Video).
4942020-02-10 04:40:00.685219 I  AFD: Selected FPS is 25 (avg 25 codec 0 container 90000 estimated 25)
4952020-02-10 04:40:00.685245 I  Player(2): SetFrameInterval ps:1 scan:3
4962020-02-10 04:40:00.685268 I  Player(2): detectInterlace(Detect Scan, Interlaced Scan, 25, 1080) ->Interlaced Scan
4972020-02-10 04:40:00.685581 I  AFD: Using vdpau for video decoding
4982020-02-10 04:40:00.685925 I  AFD: Opened codec 0x5642f993ce00, id(H264) type(Video)
4992020-02-10 04:40:00.706285 I  AOBase: Opening audio device 'pulse' ch 2(6) sr 48000 sf 32 bit floating point reenc 0
5002020-02-10 04:40:00.737997 I  Dec: Selected track #1 (type 2) in the Unknown language(0)
5012020-02-10 04:40:00.738015 I  Dec: Trying to select track (w/lang & forced)
5022020-02-10 04:40:00.738033 I  Dec: Selected track #1 (type 3) in the Finnish language(6711662)
5032020-02-10 04:40:00.738048 I  Dec: Selected track #1 (type 7) in the Finnish language(6711662)
5042020-02-10 04:40:00.738063 I  Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
5052020-02-10 04:40:00.886028 I  Dec: Position map filled from DB to: 54332
5062020-02-10 04:40:00.891651 I  Dec: Duration map filled from DB to: 54332
5072020-02-10 04:40:00.892237 I  Dec: SyncPositionMap prerecorded, from DB: 2726 entries
5082020-02-10 04:40:00.892256 I  Dec: SyncPositionMap, new totframes: 54332, new length: 2173, posMap size: 2726
5092020-02-10 04:40:00.909538 I  AFD: Position map found
5102020-02-10 04:40:00.909559 I  AFD: Successfully opened decoder for file: "myth://mythbook/10025_20200122203441.ts". novideo(0)
5112020-02-10 04:40:00.985534 I  VideoOutput: Allowed renderers: vdpau
5122020-02-10 04:40:00.985563 I  VideoOutput: Allowed renderers (filt: vdpau): vdpau
5132020-02-10 04:40:01.042059 I  VDP: Accepting: cmp() w(>=0) h(>=720) framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpaubasicdoublerate,vdpaubasic) filt(vdpaucolorspace=auto)
5142020-02-10 04:40:01.042118 I  VDP: Accepting: cmp() w() h() framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
5152020-02-10 04:40:01.042146 I  VDP: LoadBestPreferences(1920x1080, 25.000, h264)
5162020-02-10 04:40:01.042213 I  VDP: LoadBestPreferences Result prio:1, w:>=0, h:>=720, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpaubasicdoublerate
5172020-02-10 04:40:01.042231 I  VideoOutput: Preferred renderer: vdpau
5182020-02-10 04:40:01.042240 I  VideoOutput: Trying video renderer: 'vdpau'
5192020-02-10 04:40:01.133511 I  VideoOutWindow::SetPIPState. pip_state: 0]
5202020-02-10 04:40:01.172801 I  Snapping width to avoid scaling: width: 1920, left: 0
5212020-02-10 04:40:01.172830 I  Display Rect  left: 0, top: 135, width: 1920, height: 810, aspect: 1.33333
5222020-02-10 04:40:01.172842 I  Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
5232020-02-10 04:40:01.172861 I  VDP: LoadBestPreferences(1920x1088, 25.000, h264)
5242020-02-10 04:40:01.172955 I  VDP: LoadBestPreferences Result prio:1, w:>=0, h:>=720, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpaubasicdoublerate
5252020-02-10 04:40:01.172969 I  Snapping width to avoid scaling: width: 1920, left: 0
5262020-02-10 04:40:01.172982 I  Display Rect  left: 0, top: 135, width: 1920, height: 810, aspect: 1.33333
5272020-02-10 04:40:01.172995 I  Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
5282020-02-10 04:40:01.173005 I  VDP: SetVideoRenderer(vdpau)
5292020-02-10 04:40:01.173017 I  VDP: SetVideoRender(vdpau) == GetVideoRenderer()
5302020-02-10 04:40:01.178675 I  VideoOutput: Pixel dimensions: Screen 1920x1080, window 1920x1080
5312020-02-10 04:40:01.178704 I  VideoOutput: Actual display dimensions: 508x286 mm  Aspect: 1.77622
5322020-02-10 04:40:01.178716 I  VideoOutput: Estimated window dimensions: 508x286 mm  Aspect: 1.77622
5332020-02-10 04:40:01.261037 I  VDPAU: Created 2 output surfaces.
5342020-02-10 04:40:01.261058 I  VDPAU: Set colorkey to 0x20202
5352020-02-10 04:40:01.261069 I  VDPAU: Created VDPAU render device 1920x1080
5362020-02-10 04:40:01.261106 I  VidOutVDPAU: Created VDPAU osd (1920x1080)
5372020-02-10 04:40:01.353694 I  ColourSpace: PictureAttributes: Brightness, Contrast, Colour, Hue, Studio Levels,
5382020-02-10 04:40:01.353712 I  VidOutVDPAU: Using ITU BT.709 colorspace
5392020-02-10 04:40:01.353739 I  Snapping height to avoid scaling: height: 1080, top: 0
5402020-02-10 04:40:01.353747 I  Snapping width to avoid scaling: width: 1920, left: 0
5412020-02-10 04:40:01.353766 I  Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
5422020-02-10 04:40:01.353779 I  Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
5432020-02-10 04:40:01.353787 I  VidOutVDPAU: Created VDPAU context (GPU decode)
5442020-02-10 04:40:01.353809 I  Over/underscan. V: 0, H: 0
5452020-02-10 04:40:01.353818 I  Snapping height to avoid scaling: height: 1080, top: 0
5462020-02-10 04:40:01.353825 I  Snapping width to avoid scaling: width: 1920, left: 0
5472020-02-10 04:40:01.353838 I  Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
5482020-02-10 04:40:01.353850 I  Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
5492020-02-10 04:40:01.353878 I  FilterManager: GetFilterInfo(convert) returning: 0x0
5502020-02-10 04:40:01.353905 I  Player(2): LoadFilters('vdpaucolorspace=auto'..) -> 0x0
5512020-02-10 04:40:01.387073 I  Player(2): Decoder thread starting.
5522020-02-10 04:40:01.392093 I  OSD: Loaded window osd_message
5532020-02-10 04:40:01.397325 I  OSD: Loaded window osd_input
5542020-02-10 04:40:01.414972 I  OSD: Loaded window program_info
5552020-02-10 04:40:01.424851 I  OSD: Loaded window browse_info
5562020-02-10 04:40:01.431547 I  OSD: Loaded window osd_status
5572020-02-10 04:40:01.438679 I  OSD: Loaded window osd_program_editor
5582020-02-10 04:40:01.448278 I  OSD: Loaded window osd_debug
5592020-02-10 04:40:01.448303 I  OSD: Loaded OSD: size 1920x1080 offset 0+0
5602020-02-10 04:40:01.448396 I  OSD: Created window aa_OSD_SUBTITLES
5612020-02-10 04:40:01.465615 I  EnableCaptions(4) msg: Subtitle 1: Finnish On
5622020-02-10 04:40:01.465652 I  Player(2): ClearAfterSeek(0)
5632020-02-10 04:40:01.466760 I  VDP: GetFilteredDeint() : vdpau -> 'vdpaubasicdoublerate'
5642020-02-10 04:40:01.466783 I  VDP: GetFilteredDeint() : vdpau -> 'vdpaubasicdoublerate'
5652020-02-10 04:40:01.468907 I  VidOutVDPAU: Enabled deinterlacing.
5662020-02-10 04:40:01.468962 E  VSYNC: DRMVideoSync: VBlank ioctl did not work, unimplemented in this driver?
5672020-02-10 04:40:01.469009 E  VSYNC: RTCVideoSync: Could not open /dev/rtc:
568                        eno: Permission denied (13)
5692020-02-10 04:40:01.470162 I  Player(2): Video timing method: USleep with busy wait
5702020-02-10 04:40:01.470189 I  Player(2): Display Refresh Rate: 50.000 Video Frame Rate: 25.000
5712020-02-10 04:40:01.470214 I  Player(2): SetFrameInterval ps:1 scan:1
5722020-02-10 04:40:01.471501 I  playCtx: StartPlaying(): took 0 ms to start player.
5732020-02-10 04:40:01.471532 I  TV::StartPlayer(): Created player.
5742020-02-10 04:40:01.471620 I  TV::HandleStateChange(): Changing from None to WatchingPreRecorded
5752020-02-10 04:40:01.549096 I  TV::HandleStateChange(): Main UI disabled.
5762020-02-10 04:40:01.549179 I  TV::StartTV(): Entering main playback loop.
5772020-02-10 04:40:01.594146 I  Player(2): Waiting for video buffers...
5782020-02-10 04:40:01.697728 N  Player(2): Waited 103ms for video buffers AAAAAAAAAALLLLL
5792020-02-10 04:40:01.698711 E  VDPAU: Error at mythrender_vdpau.cpp:674 (#23, The system does not have enough resources to complete the requested operation at this time.)
5802020-02-10 04:40:01.698724 E  VDPAU: Failed to create video surface.
5812020-02-10 04:40:01.698742 I  VidOutVDPAU: Added 1 new buffers. New buffer size 15 (3 decode and 12 process)
5822020-02-10 04:40:01.752184 E  VDPAU: Error at mythrender_vdpau.cpp:762 (#23, The system does not have enough resources to complete the requested operation at this time.)
5832020-02-10 04:40:01.752204 E  VDPAU: Failed to create decoder.
5842020-02-10 04:40:01.752219 E  VidOutVDPAU: Failed to create decoder.
5852020-02-10 04:40:01.752628 E  VidOutVDPAU: IsErrored() in DrawSlice
5862020-02-10 04:40:01.753045 E  VidOutVDPAU: IsErrored() in DrawSlice
5872020-02-10 04:40:01.754252 E  VidOutVDPAU: IsErrored() in DrawSlice
5882020-02-10 04:40:01.754676 E  VidOutVDPAU: IsErrored() in DrawSlice
5892020-02-10 04:40:01.755068 I  MythCodecContext: Disabled hardware decoder based deinterlacer.
5902020-02-10 04:40:01.757038 I  Player(2): Enabled Video Output based deinterlacing
5912020-02-10 04:40:01.760767 E  VidOutVDPAU: IsErrored() in DrawSlice
5922020-02-10 04:40:01.762012 E  VidOutVDPAU: IsErrored() in DrawSlice
5932020-02-10 04:40:01.763218 E  VidOutVDPAU: IsErrored() in DrawSlice
5942020-02-10 04:40:01.763746 E  VidOutVDPAU: IsErrored() in DrawSlice
5952020-02-10 04:40:01.765607 E  VidOutVDPAU: IsErrored() in DrawSlice
5962020-02-10 04:40:01.776440 E  Player(2): AVSync: Unknown error in videoOutput, aborting playback.
5972020-02-10 04:40:01.781703 I  Player(2): Decoder thread exiting.
5982020-02-10 04:40:01.848550 I  TV::HandleStateChange(): Attempting to change from WatchingPreRecorded to None
5992020-02-10 04:40:01.848634 I  Player(2): StopPlaying - begin
6002020-02-10 04:40:01.948785 W  Player(2): Waited 100ms for decoder to pause
6012020-02-10 04:40:02.049050 W  Player(2): Waited 100ms for decoder to pause
6022020-02-10 04:40:02.149194 W  Player(2): Waited 100ms for decoder to pause
6032020-02-10 04:40:02.249342 W  Player(2): Waited 100ms for decoder to pause
6042020-02-10 04:40:02.349485 W  Player(2): Waited 100ms for decoder to pause
6052020-02-10 04:40:02.449627 W  Player(2): Waited 100ms for decoder to pause
6062020-02-10 04:40:02.549750 W  Player(2): Waited 100ms for decoder to pause
6072020-02-10 04:40:02.650210 W  Player(2): Waited 100ms for decoder to pause
6082020-02-10 04:40:02.750435 W  Player(2): Waited 100ms for decoder to pause
6092020-02-10 04:40:02.850579 W  Player(2): Waited 100ms for decoder to pause
6102020-02-10 04:40:02.950740 W  Player(2): Waited 100ms for decoder to pause
6112020-02-10 04:40:03.050873 W  Player(2): Waited 100ms for decoder to pause
6122020-02-10 04:40:03.151018 W  Player(2): Waited 100ms for decoder to pause
6132020-02-10 04:40:03.251170 W  Player(2): Waited 100ms for decoder to pause
6142020-02-10 04:40:03.351296 W  Player(2): Waited 100ms for decoder to pause
6152020-02-10 04:40:03.451438 W  Player(2): Waited 100ms for decoder to pause
6162020-02-10 04:40:03.551577 W  Player(2): Waited 100ms for decoder to pause
6172020-02-10 04:40:03.651712 W  Player(2): Waited 100ms for decoder to pause
6182020-02-10 04:40:03.751856 W  Player(2): Waited 100ms for decoder to pause
6192020-02-10 04:40:03.852021 W  Player(2): Waited 100ms for decoder to pause
6202020-02-10 04:40:03.952192 W  Player(2): Waited 100ms for decoder to pause
6212020-02-10 04:40:04.052358 W  Player(2): Waited 100ms for decoder to pause
6222020-02-10 04:40:04.152523 W  Player(2): Waited 100ms for decoder to pause
6232020-02-10 04:40:04.252662 W  Player(2): Waited 100ms for decoder to pause
6242020-02-10 04:40:04.352803 W  Player(2): Waited 100ms for decoder to pause
6252020-02-10 04:40:04.452946 W  Player(2): Waited 100ms for decoder to pause
6262020-02-10 04:40:04.553090 W  Player(2): Waited 100ms for decoder to pause
6272020-02-10 04:40:04.653228 W  Player(2): Waited 100ms for decoder to pause
6282020-02-10 04:40:04.753373 W  Player(2): Waited 100ms for decoder to pause
6292020-02-10 04:40:04.853517 W  Player(2): Waited 100ms for decoder to pause
6302020-02-10 04:40:04.953670 W  Player(2): Waited 100ms for decoder to pause
6312020-02-10 04:40:05.053851 W  Player(2): Waited 100ms for decoder to pause
6322020-02-10 04:40:05.154021 W  Player(2): Waited 100ms for decoder to pause
6332020-02-10 04:40:05.254188 W  Player(2): Waited 100ms for decoder to pause
6342020-02-10 04:40:05.354355 W  Player(2): Waited 100ms for decoder to pause
6352020-02-10 04:40:05.454521 W  Player(2): Waited 100ms for decoder to pause
6362020-02-10 04:40:05.554684 W  Player(2): Waited 100ms for decoder to pause
6372020-02-10 04:40:05.654853 W  Player(2): Waited 100ms for decoder to pause
6382020-02-10 04:40:05.755021 W  Player(2): Waited 100ms for decoder to pause
6392020-02-10 04:40:05.855195 W  Player(2): Waited 100ms for decoder to pause
6402020-02-10 04:40:05.955332 W  Player(2): Waited 100ms for decoder to pause
6412020-02-10 04:40:06.055475 W  Player(2): Waited 100ms for decoder to pause
6422020-02-10 04:40:06.155618 W  Player(2): Waited 100ms for decoder to pause
6432020-02-10 04:40:06.255776 W  Player(2): Waited 100ms for decoder to pause
6442020-02-10 04:40:06.355949 W  Player(2): Waited 100ms for decoder to pause
6452020-02-10 04:40:06.456116 W  Player(2): Waited 100ms for decoder to pause
6462020-02-10 04:40:06.556282 W  Player(2): Waited 100ms for decoder to pause
6472020-02-10 04:40:06.656450 W  Player(2): Waited 100ms for decoder to pause
6482020-02-10 04:40:06.756607 W  Player(2): Waited 100ms for decoder to pause
6492020-02-10 04:40:06.856762 W  Player(2): Waited 100ms for decoder to pause
6502020-02-10 04:40:06.956921 W  Player(2): Waited 100ms for decoder to pause
6512020-02-10 04:40:07.057075 W  Player(2): Waited 100ms for decoder to pause
6522020-02-10 04:40:07.157223 W  Player(2): Waited 100ms for decoder to pause
6532020-02-10 04:40:07.257370 W  Player(2): Waited 100ms for decoder to pause
6542020-02-10 04:40:07.357515 W  Player(2): Waited 100ms for decoder to pause
6552020-02-10 04:40:07.457661 W  Player(2): Waited 100ms for decoder to pause
6562020-02-10 04:40:07.557827 W  Player(2): Waited 100ms for decoder to pause
6572020-02-10 04:40:07.657986 W  Player(2): Waited 100ms for decoder to pause
6582020-02-10 04:40:07.758151 W  Player(2): Waited 100ms for decoder to pause
6592020-02-10 04:40:07.858311 W  Player(2): Waited 100ms for decoder to pause
6602020-02-10 04:40:07.958481 W  Player(2): Waited 100ms for decoder to pause
6612020-02-10 04:40:08.058637 W  Player(2): Waited 100ms for decoder to pause
6622020-02-10 04:40:08.158794 W  Player(2): Waited 100ms for decoder to pause
6632020-02-10 04:40:08.258945 W  Player(2): Waited 100ms for decoder to pause
6642020-02-10 04:40:08.359136 W  Player(2): Waited 100ms for decoder to pause
6652020-02-10 04:40:08.459306 W  Player(2): Waited 100ms for decoder to pause
6662020-02-10 04:40:08.559451 W  Player(2): Waited 100ms for decoder to pause
6672020-02-10 04:40:08.659627 W  Player(2): Waited 100ms for decoder to pause
6682020-02-10 04:40:08.759799 W  Player(2): Waited 100ms for decoder to pause
6692020-02-10 04:40:08.859987 W  Player(2): Waited 100ms for decoder to pause
6702020-02-10 04:40:08.960175 W  Player(2): Waited 100ms for decoder to pause
6712020-02-10 04:40:09.060359 W  Player(2): Waited 100ms for decoder to pause
6722020-02-10 04:40:09.160544 W  Player(2): Waited 100ms for decoder to pause
6732020-02-10 04:40:09.260717 W  Player(2): Waited 100ms for decoder to pause
6742020-02-10 04:40:09.360902 W  Player(2): Waited 100ms for decoder to pause
6752020-02-10 04:40:09.461088 W  Player(2): Waited 100ms for decoder to pause
6762020-02-10 04:40:09.561264 W  Player(2): Waited 100ms for decoder to pause
6772020-02-10 04:40:09.661434 W  Player(2): Waited 100ms for decoder to pause
6782020-02-10 04:40:09.761597 W  Player(2): Waited 100ms for decoder to pause
6792020-02-10 04:40:09.861755 W  Player(2): Waited 100ms for decoder to pause
6802020-02-10 04:40:09.961895 W  Player(2): Waited 100ms for decoder to pause
6812020-02-10 04:40:10.062073 W  Player(2): Waited 100ms for decoder to pause
6822020-02-10 04:40:10.162258 W  Player(2): Waited 100ms for decoder to pause
6832020-02-10 04:40:10.262421 W  Player(2): Waited 100ms for decoder to pause
6842020-02-10 04:40:10.362588 W  Player(2): Waited 100ms for decoder to pause
6852020-02-10 04:40:10.462767 W  Player(2): Waited 100ms for decoder to pause
6862020-02-10 04:40:10.562928 W  Player(2): Waited 100ms for decoder to pause
6872020-02-10 04:40:10.663114 W  Player(2): Waited 100ms for decoder to pause
6882020-02-10 04:40:10.763261 W  Player(2): Waited 100ms for decoder to pause
6892020-02-10 04:40:10.863416 W  Player(2): Waited 100ms for decoder to pause
6902020-02-10 04:40:10.963566 W  Player(2): Waited 100ms for decoder to pause
6912020-02-10 04:40:11.063710 W  Player(2): Waited 100ms for decoder to pause
6922020-02-10 04:40:11.163851 W  Player(2): Waited 100ms for decoder to pause
6932020-02-10 04:40:11.263992 W  Player(2): Waited 100ms for decoder to pause
6942020-02-10 04:40:11.364132 W  Player(2): Waited 100ms for decoder to pause
6952020-02-10 04:40:11.464271 W  Player(2): Waited 100ms for decoder to pause
6962020-02-10 04:40:11.564408 W  Player(2): Waited 100ms for decoder to pause
6972020-02-10 04:40:11.664542 W  Player(2): Waited 100ms for decoder to pause
6982020-02-10 04:40:11.764712 W  Player(2): Waited 100ms for decoder to pause
6992020-02-10 04:40:11.864869 W  Player(2): Waited 100ms for decoder to pause
7002020-02-10 04:40:11.864896 I  Player(2): Exited decoder loop.
7012020-02-10 04:40:11.891198 I  VidOutVDPAU: DiscardFrames(1)
7022020-02-10 04:40:11.891241 I  VideoBuffers::DiscardFrames(1): AAUUUAUUAAAAAAA
7032020-02-10 04:40:11.891295 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAAA -- done
7042020-02-10 04:40:11.891318 I  VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAAA -- done()
7052020-02-10 04:40:11.897707 I  VDPAU Painter: Clearing VDPAU painter cache.
7062020-02-10 04:40:11.940020 I  VDPAU Painter: Clearing VDPAU painter cache.
7072020-02-10 04:40:11.946516 I  Player(2): StopPlaying - end
7082020-02-10 04:40:11.946534 I  TV::StopStuff(): Stopping ring buffer
7092020-02-10 04:40:11.946923 I  TV::StopStuff(): Stopping player
7102020-02-10 04:40:11.946947 I  TV::HandleStateChange(): Changing from WatchingPreRecorded to None
7112020-02-10 04:40:11.946981 I  TV::StartTV(): Exiting main playback loop.
7122020-02-10 04:40:11.946993 I  TV::StartTV(): -- process events 2 begin
7132020-02-10 04:40:11.948377 I  TV::StartTV(): -- process events 2 end
7142020-02-10 04:40:11.959369 I  TV::~TV(): -- lock
7152020-02-10 04:40:11.959612 I  Player(2): StopPlaying - begin
7162020-02-10 04:40:11.959638 I  Player(2): Exited decoder loop.
7172020-02-10 04:40:11.959653 I  Player(2): StopPlaying - end
7182020-02-10 04:40:11.974443 N  Resuming idle timer
719
720
721
722
723
724
725
726
727
728
729
730
731
732
733
734
735
7362020-02-10 04:41:27.382993 I  TV::TV(): Creating TV object
7372020-02-10 04:41:27.656643 I  TV::TV(): Finished creating TV object
7382020-02-10 04:41:27.656685 N  Suspending idle timer
7392020-02-10 04:41:27.676937 I  TV::Init(): Created TvPlayWindow.
7402020-02-10 04:41:27.794789 I  TV::HandleStateChange(): Attempting to change from None to WatchingPreRecorded
7412020-02-10 04:41:27.828145 I  FileRingBuf(myth://mythbook/10022_20200104175000.ts): OpenFile(myth://mythbook/10022_20200104175000.ts, 2000 ms)
7422020-02-10 04:41:27.918193 I  TV::StartPlayer(): Elapsed time since TV constructor was called: 535 ms
7432020-02-10 04:41:27.933937 E  ALSA: snd_pcm_info_get_card: Operation not permitted
7442020-02-10 04:41:27.950341 N  AudioPlayer: Enabling Audio
7452020-02-10 04:41:28.007232 I  AFD: PlayerFlags: 0xc0, AudioReadAhead: 100 msec
7462020-02-10 04:41:28.007266 I  Player(2): Stretch Factor 1, allow passthru
7472020-02-10 04:41:28.007523 I  AFD: Buffer size: 32768 streamed 0 seekable 1
7482020-02-10 04:41:32.366969 I  AFD: Stream #0, has id 0x32 codec id DVB_TELETEXT, type Subtitle, bitrate 0 at 0x56430114a180
7492020-02-10 04:41:32.367070 I  AFD: Teletext stream #0 (Menu) is in the Finnish language on page 1 0.
7502020-02-10 04:41:32.367120 I  AFD: subtitle codec (Subtitle)
7512020-02-10 04:41:32.367145 I  AFD: Stream #1, has id 0x138 codec id H264, type Video, bitrate 0 at 0x5642f983b400
7522020-02-10 04:41:32.367166 I  AFD: Stream #2, has id 0x35c codec id AC3, type Audio, bitrate 0 at 0x5642fd83d640
7532020-02-10 04:41:32.367188 I  AFD: codec AC3 has 0 channels
7542020-02-10 04:41:32.367200 I  AFD: Looking for decoder for AC3
7552020-02-10 04:41:32.367762 I  AFD: Opened codec 0x564301163200, id(AC3) type(Audio)
7562020-02-10 04:41:32.367840 I  AFD: Stream #3, has id 0x35d codec id AC3, type Audio, bitrate 0 at 0x56430111e2c0
7572020-02-10 04:41:32.367856 I  AFD: codec AC3 has 0 channels
7582020-02-10 04:41:32.367868 I  AFD: Looking for decoder for AC3
7592020-02-10 04:41:32.368380 I  AFD: Opened codec 0x5642fdffd800, id(AC3) type(Audio)
7602020-02-10 04:41:32.368444 I  AFD: Stream #4, has id 0x361 codec id AC3, type Audio, bitrate 0 at 0x5642f9801480
7612020-02-10 04:41:32.368460 I  AFD: codec AC3 has 0 channels
7622020-02-10 04:41:32.368472 I  AFD: Looking for decoder for AC3
7632020-02-10 04:41:32.369087 I  AFD: Opened codec 0x5642f983aa80, id(AC3) type(Audio)
7642020-02-10 04:41:32.369141 I  AFD: Trying to select best video track
7652020-02-10 04:41:32.369212 I  AFD: Selected track #1 (id 0x138 codec id H264, type Video, bitrate 500000 at 0x5642f983b400)
7662020-02-10 04:41:32.507437 I  VDP: Accepting: cmp() w(>=0) h(>=720) framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpaubasicdoublerate,vdpaubasic) filt(vdpaucolorspace=auto)
7672020-02-10 04:41:32.507514 I  VDP: Accepting: cmp() w() h() framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
7682020-02-10 04:41:32.507545 I  VDP: LoadBestPreferences(16x16, 0.000, h264)
7692020-02-10 04:41:32.507656 I  VDP: LoadBestPreferences Result prio:2, w:, h:, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpauadvanceddoublerate
7702020-02-10 04:41:32.507734 I  AFD: Using 1 CPUs for decoding
7712020-02-10 04:41:32.507754 I  AFD: InitVideoCodec() 0x5642f97fc280 id(H264) type (Video).
7722020-02-10 04:41:32.507859 I  AFD: Selected FPS is 29.97 (avg 0 codec 0 container 90000 estimated 0)
7732020-02-10 04:41:32.507874 I  AFD: InitVideoCodec invalid dimensions, resetting decoder.
7742020-02-10 04:41:32.507901 I  Player(2): SetFrameInterval ps:1 scan:3
7752020-02-10 04:41:32.507933 I  Player(2): detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
7762020-02-10 04:41:32.508035 I  AFD: Using vdpau for video decoding
7772020-02-10 04:41:32.508179 I  AFD: Opened codec 0x5642f97fc280, id(H264) type(Video)
7782020-02-10 04:41:32.640089 W  Enabling buffering optimisations for low bitrate stream.
7792020-02-10 04:41:32.653114 W  Enabling buffering optimisations for low bitrate stream.
7802020-02-10 04:41:32.653462 N  AudioPlayer: Enabling Audio
7812020-02-10 04:41:32.653528 I  Dec: Selected track #1 (type 2) in the Unknown language(0)
7822020-02-10 04:41:32.653544 I  Dec: Selected track #1 (type 7) in the Finnish language(6711662)
7832020-02-10 04:41:32.653561 I  Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
7842020-02-10 04:41:33.744078 I  Dec: Position map filled from DB to: 262525
7852020-02-10 04:41:33.763622 I  Dec: Duration map filled from DB to: 262525
7862020-02-10 04:41:33.765946 I  Dec: SyncPositionMap prerecorded, from DB: 13184 entries
7872020-02-10 04:41:33.765990 I  Dec: SyncPositionMap, new totframes: 262525, new length: 8759, posMap size: 13184
7882020-02-10 04:41:33.785921 I  AFD: Position map found
7892020-02-10 04:41:33.785939 I  AFD: Successfully opened decoder for file: "myth://mythbook/10022_20200104175000.ts". novideo(0)
7902020-02-10 04:41:33.930920 I  VideoOutput: Allowed renderers: vdpau
7912020-02-10 04:41:33.930949 I  VideoOutput: Allowed renderers (filt: vdpau): vdpau
7922020-02-10 04:41:34.005292 I  VDP: Accepting: cmp() w(>=0) h(>=720) framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpaubasicdoublerate,vdpaubasic) filt(vdpaucolorspace=auto)
7932020-02-10 04:41:34.005351 I  VDP: Accepting: cmp() w() h() framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
7942020-02-10 04:41:34.005379 I  VDP: LoadBestPreferences(640x480, 29.970, h264)
7952020-02-10 04:41:34.005449 I  VDP: LoadBestPreferences Result prio:2, w:, h:, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpauadvanceddoublerate
7962020-02-10 04:41:34.005473 I  VideoOutput: Preferred renderer: vdpau
7972020-02-10 04:41:34.005482 I  VideoOutput: Trying video renderer: 'vdpau'
7982020-02-10 04:41:34.077079 I  VideoOutWindow::SetPIPState. pip_state: 0]
7992020-02-10 04:41:34.110700 I  Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.33333
8002020-02-10 04:41:34.110722 I  Video Rect    left: 0, top: 0, width: 640, height: 480, aspect: 1.33333
8012020-02-10 04:41:34.110740 I  Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.33333
8022020-02-10 04:41:34.110754 I  Video Rect    left: 0, top: 0, width: 640, height: 480, aspect: 1.33333
8032020-02-10 04:41:34.110766 I  VDP: SetVideoRenderer(vdpau)
8042020-02-10 04:41:34.110779 I  VDP: SetVideoRender(vdpau) == GetVideoRenderer()
8052020-02-10 04:41:34.124087 I  VideoOutput: Pixel dimensions: Screen 1920x1080, window 1920x1080
8062020-02-10 04:41:34.124116 I  VideoOutput: Actual display dimensions: 508x286 mm  Aspect: 1.77622
8072020-02-10 04:41:34.124128 I  VideoOutput: Estimated window dimensions: 508x286 mm  Aspect: 1.77622
8082020-02-10 04:41:34.216550 I  VDPAU: Created 2 output surfaces.
8092020-02-10 04:41:34.216571 I  VDPAU: Set colorkey to 0x20202
8102020-02-10 04:41:34.216582 I  VDPAU: Created VDPAU render device 1920x1080
8112020-02-10 04:41:34.216621 I  VidOutVDPAU: Created VDPAU osd (1920x1080)
8122020-02-10 04:41:34.242006 I  ColourSpace: PictureAttributes: Brightness, Contrast, Colour, Hue, Studio Levels,
8132020-02-10 04:41:34.242024 I  VidOutVDPAU: Using ITU BT.601 colorspace
8142020-02-10 04:41:34.242057 I  Display Rect  left: 240, top: 0, width: 1440, height: 1080, aspect: 1.77778
8152020-02-10 04:41:34.242069 I  Video Rect    left: 0, top: 0, width: 640, height: 480, aspect: 1.33333
8162020-02-10 04:41:34.242078 I  VidOutVDPAU: Created VDPAU context (GPU decode)
8172020-02-10 04:41:34.242101 I  Over/underscan. V: 0, H: 0
8182020-02-10 04:41:34.242115 I  Display Rect  left: 240, top: 0, width: 1440, height: 1080, aspect: 1.77778
8192020-02-10 04:41:34.242126 I  Video Rect    left: 0, top: 0, width: 640, height: 480, aspect: 1.33333
8202020-02-10 04:41:34.242212 I  FilterManager: GetFilterInfo(convert) returning: 0x0
8212020-02-10 04:41:34.242244 I  Player(2): LoadFilters('vdpaucolorspace=auto'..) -> 0x0
8222020-02-10 04:41:34.291219 I  Player(2): Decoder thread starting.
8232020-02-10 04:41:34.300214 I  OSD: Loaded window osd_message
8242020-02-10 04:41:34.304433 I  OSD: Loaded window osd_input
8252020-02-10 04:41:34.319621 I  OSD: Loaded window program_info
8262020-02-10 04:41:34.326082 I  OSD: Loaded window browse_info
8272020-02-10 04:41:34.331155 I  OSD: Loaded window osd_status
8282020-02-10 04:41:34.336389 I  OSD: Loaded window osd_program_editor
8292020-02-10 04:41:34.343234 I  OSD: Loaded window osd_debug
8302020-02-10 04:41:34.343256 I  OSD: Loaded OSD: size 1920x1080 offset 0+0
8312020-02-10 04:41:34.343327 I  OSD: Created window aa_OSD_SUBTITLES
8322020-02-10 04:41:34.343356 I  Player(2): ClearAfterSeek(0)
8332020-02-10 04:41:34.344314 I  VDP: GetFilteredDeint() : vdpau -> 'vdpauadvanceddoublerate'
8342020-02-10 04:41:34.344331 I  VDP: GetFilteredDeint() : vdpau -> 'vdpauadvanceddoublerate'
8352020-02-10 04:41:34.345852 I  VidOutVDPAU: Enabled deinterlacing.
8362020-02-10 04:41:34.345900 E  VSYNC: DRMVideoSync: VBlank ioctl did not work, unimplemented in this driver?
8372020-02-10 04:41:34.345940 E  VSYNC: RTCVideoSync: Could not open /dev/rtc:
838                        eno: Permission denied (13)
8392020-02-10 04:41:34.345955 E  Player(2): Video sync method can't support double framerate (refresh rate too low for 2x deint)
8402020-02-10 04:41:34.347199 I  VDP: GetFilteredDeint(vdpauadvanced) : vdpau -> 'vdpauadvanced'
8412020-02-10 04:41:34.348269 I  VidOutVDPAU: Enabled deinterlacing.
8422020-02-10 04:41:34.349205 I  Player(2): Video timing method: USleep with busy wait
8432020-02-10 04:41:34.349228 I  Player(2): Display Refresh Rate: 50.000 Video Frame Rate: 29.970
8442020-02-10 04:41:34.349250 I  Player(2): SetFrameInterval ps:1 scan:1
8452020-02-10 04:41:34.349427 I  playCtx: StartPlaying(): took 0 ms to start player.
8462020-02-10 04:41:34.349448 I  TV::StartPlayer(): Created player.
8472020-02-10 04:41:34.349503 I  TV::HandleStateChange(): Changing from None to WatchingPreRecorded
8482020-02-10 04:41:34.349722 I  AFD: streams_changed 0x5642fdce1170 -- stream count 4
8492020-02-10 04:41:34.350062 I  AFD: SeekReset(0, 0, do flush, do discard)
8502020-02-10 04:41:34.350074 I  AFD: SeekReset() flushing
8512020-02-10 04:41:34.350085 I  VidOutVDPAU: DiscardFrames(1)
8522020-02-10 04:41:34.350124 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAA
8532020-02-10 04:41:34.350163 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAA -- done
8542020-02-10 04:41:34.350184 I  VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAA -- done()
8552020-02-10 04:41:34.350204 I  AFD: Stream #0, has id 0x32 codec id DVB_TELETEXT, type Subtitle, bitrate 0 at 0x7fd7e8004bc0
8562020-02-10 04:41:34.350244 I  AFD: Teletext stream #0 (Menu) is in the Finnish language on page 1 0.
8572020-02-10 04:41:34.350258 I  AFD: subtitle codec (Subtitle)
8582020-02-10 04:41:34.350272 I  AFD: Stream #1, has id 0x138 codec id H264, type Video, bitrate 0 at 0x7fd7e8001000
8592020-02-10 04:41:34.350284 I  AFD: Stream #2, has id 0x35c codec id AC3, type Audio, bitrate 0 at 0x7fd7e8005c80
8602020-02-10 04:41:34.350293 I  AFD: codec AC3 has 0 channels
8612020-02-10 04:41:34.350300 I  AFD: Looking for decoder for AC3
8622020-02-10 04:41:34.350908 I  AFD: Opened codec 0x7fd7e8015880, id(AC3) type(Audio)
8632020-02-10 04:41:34.350973 I  AFD: Stream #3, has id 0x361 codec id AC3, type Audio, bitrate 0 at 0x7fd7e8006c40
8642020-02-10 04:41:34.350983 I  AFD: codec AC3 has 0 channels
8652020-02-10 04:41:34.350990 I  AFD: Looking for decoder for AC3
8662020-02-10 04:41:34.351467 I  AFD: Opened codec 0x7fd7e801b500, id(AC3) type(Audio)
8672020-02-10 04:41:34.351593 I  AFD: Trying to select best video track
8682020-02-10 04:41:34.351679 I  AFD: Selected track #1 (id 0x138 codec id H264, type Video, bitrate 500000 at 0x7fd7e8001000)
8692020-02-10 04:41:34.418375 I  TV::HandleStateChange(): Main UI disabled.
8702020-02-10 04:41:34.418427 I  TV::StartTV(): Entering main playback loop.
8712020-02-10 04:41:34.419080 I  Player(2): Waiting for video buffers...
8722020-02-10 04:41:34.520282 N  Player(2): Waited 101ms for video buffers AAAAAAAAAAAAAA
8732020-02-10 04:41:34.621650 N  Player(2): Waited 202ms for video buffers AAAAAAAAAAAAAA
8742020-02-10 04:41:34.645191 I  VDP: Accepting: cmp() w(>=0) h(>=720) framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpaubasicdoublerate,vdpaubasic) filt(vdpaucolorspace=auto)
8752020-02-10 04:41:34.645248 I  VDP: Accepting: cmp() w() h() framerate() codecs() dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
8762020-02-10 04:41:34.645273 I  VDP: LoadBestPreferences(16x16, 0.000, h264)
8772020-02-10 04:41:34.645342 I  VDP: LoadBestPreferences Result prio:2, w:, h:, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpauadvanceddoublerate
8782020-02-10 04:41:34.645397 I  AFD: Using 1 CPUs for decoding
8792020-02-10 04:41:34.645412 I  AFD: InitVideoCodec() 0x7fd7e801ff40 id(H264) type (Video).
8802020-02-10 04:41:34.645433 I  VDP: GetFilteredDeint() : vdpau -> 'vdpauadvanceddoublerate'
8812020-02-10 04:41:34.645466 I  AFD: Selected FPS is 29.97 (avg 0 codec 0 container 90000 estimated 0)
8822020-02-10 04:41:34.645476 I  AFD: InitVideoCodec invalid dimensions, resetting decoder.
8832020-02-10 04:41:34.645512 I  Player(2): SetFrameInterval ps:1 scan:3
8842020-02-10 04:41:34.645533 I  VidOutVDPAU: InputChanged(640,480,1.33333) 'H.264 VDPAU'->'H.264 VDPAU'
8852020-02-10 04:41:34.646980 I  Player(2): detectInterlace(Detect Scan, Interlaced Scan, 29.97, 480) ->Interlaced Scan
8862020-02-10 04:41:34.647122 I  AFD: Using vdpau for video decoding
8872020-02-10 04:41:34.647355 I  AFD: Opened codec 0x7fd7e801ff40, id(H264) type(Video)
8882020-02-10 04:41:34.648019 I  Player(2): Enabled Video Output based deinterlacing
8892020-02-10 04:41:34.667423 W  Enabling buffering optimisations for low bitrate stream.
8902020-02-10 04:41:34.699114 I  AOBase: Opening audio device 'pulse' ch 2(2) sr 48000 sf 32 bit floating point reenc 0
8912020-02-10 04:41:34.726365 N  Player(2): Waited 307ms for video buffers AAAAAAAAAAAAAA
8922020-02-10 04:41:34.736046 I  Player(2): SetFrameInterval ps:1 scan:3
8932020-02-10 04:41:34.736072 I  VDP: LoadBestPreferences(640x480, 25.000, h264)
8942020-02-10 04:41:34.736171 I  VDP: LoadBestPreferences Result prio:2, w:, h:, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpauadvanceddoublerate
8952020-02-10 04:41:34.736189 I  VidOutVDPAU: InputChanged(1920,1080,1.77778) 'H.264 VDPAU'->'H.264 VDPAU'
8962020-02-10 04:41:34.738182 I  VidOutVDPAU: DiscardFrames(1)
8972020-02-10 04:41:34.738219 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAA
8982020-02-10 04:41:34.738258 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAA -- done
8992020-02-10 04:41:34.738280 I  VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAA -- done()
9002020-02-10 04:41:34.740955 I  VDPAU Painter: Clearing VDPAU painter cache.
9012020-02-10 04:41:34.809545 I  Snapping height to avoid scaling: height: 1080, top: 0
9022020-02-10 04:41:34.809561 I  Snapping width to avoid scaling: width: 1920, left: 0
9032020-02-10 04:41:34.809582 I  Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
9042020-02-10 04:41:34.809597 I  Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
9052020-02-10 04:41:34.809616 I  VDP: LoadBestPreferences(1920x1088, 25.000, h264)
9062020-02-10 04:41:34.809711 I  VDP: LoadBestPreferences Result prio:1, w:>=0, h:>=720, fps:, codecs:, decoder:vdpau, renderer:vdpau, deint:vdpaubasicdoublerate
9072020-02-10 04:41:34.809726 I  Snapping height to avoid scaling: height: 1080, top: 0
9082020-02-10 04:41:34.809735 I  Snapping width to avoid scaling: width: 1920, left: 0
9092020-02-10 04:41:34.809746 I  Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
9102020-02-10 04:41:34.809758 I  Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
9112020-02-10 04:41:34.809767 I  VDP: SetVideoRenderer(vdpau)
9122020-02-10 04:41:34.809777 I  VDP: SetVideoRender(vdpau) == GetVideoRenderer()
9132020-02-10 04:41:34.813878 I  VideoOutput: Pixel dimensions: Screen 1920x1080, window 1920x1080
9142020-02-10 04:41:34.813904 I  VideoOutput: Actual display dimensions: 508x286 mm  Aspect: 1.77622
9152020-02-10 04:41:34.813919 I  VideoOutput: Estimated window dimensions: 508x286 mm  Aspect: 1.77622
9162020-02-10 04:41:34.835316 N  Player(2): Waited 416ms for video buffers               
9172020-02-10 04:41:34.909173 I  VDPAU: Created 2 output surfaces.
9182020-02-10 04:41:34.909194 I  VDPAU: Set colorkey to 0x20202
9192020-02-10 04:41:34.909205 I  VDPAU: Created VDPAU render device 1920x1080
9202020-02-10 04:41:34.909241 I  VidOutVDPAU: Created VDPAU osd (1920x1080)
9212020-02-10 04:41:34.943622 N  Player(2): Waited 524ms for video buffers AAAAAAAAAAAAAA
9222020-02-10 04:41:35.003605 I  ColourSpace: PictureAttributes: Brightness, Contrast, Colour, Hue, Studio Levels,
9232020-02-10 04:41:35.003622 I  VidOutVDPAU: Using ITU BT.709 colorspace
9242020-02-10 04:41:35.003648 I  Snapping height to avoid scaling: height: 1080, top: 0
9252020-02-10 04:41:35.003657 I  Snapping width to avoid scaling: width: 1920, left: 0
9262020-02-10 04:41:35.003675 I  Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
9272020-02-10 04:41:35.003687 I  Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
9282020-02-10 04:41:35.003695 I  VidOutVDPAU: Created VDPAU context (GPU decode)
9292020-02-10 04:41:35.003715 I  VDP: GetFilteredDeint() : vdpau -> 'vdpaubasicdoublerate'
9302020-02-10 04:41:35.005033 I  VidOutVDPAU: Enabled deinterlacing.
9312020-02-10 04:41:35.005044 I  Snapping height to avoid scaling: height: 1080, top: 0
9322020-02-10 04:41:35.005067 I  Snapping width to avoid scaling: width: 1920, left: 0
9332020-02-10 04:41:35.005081 I  Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
9342020-02-10 04:41:35.005097 I  Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
9352020-02-10 04:41:35.006090 I  Player(2): ClearAfterSeek(1)
9362020-02-10 04:41:35.006101 I  VidOutVDPAU: ClearAfterSeek()
9372020-02-10 04:41:35.006109 I  VidOutVDPAU: DiscardFrames(0)
9382020-02-10 04:41:35.006143 I  VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAA
9392020-02-10 04:41:35.006171 I  VideoBuffers::DiscardFrames(0): AAAAAAAAAAAAAA -- done
9402020-02-10 04:41:35.006308 I  VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAA -- done()
9412020-02-10 04:41:35.006347 I  FilterManager: GetFilterInfo(convert) returning: 0x0
9422020-02-10 04:41:35.006377 I  Player(2): LoadFilters('vdpaucolorspace=auto'..) -> 0x0
9432020-02-10 04:41:35.006399 I  Player(2): detectInterlace(Detect Scan, Interlaced Scan, 25, 1080) ->Interlaced Scan
9442020-02-10 04:41:35.006427 I  AFD: Selected FPS is 29.97 (avg 0 codec 0 container 90000 estimated 0)
9452020-02-10 04:41:35.006438 I  AFD: avFPS(29.97) != seqFPS(25)
9462020-02-10 04:41:35.008678 I  Player(2): Enabled Video Output based deinterlacing
9472020-02-10 04:41:35.045304 N  Player(2): Waited 626ms for video buffers LLLLLAAAAAAAAA
9482020-02-10 04:41:35.083790 I  VidOutVDPAU: Added 2 new buffers. New buffer size 16 (4 decode and 12 process)
9492020-02-10 04:41:35.150437 N  Player(2): Waited 731ms for video buffers (AL)(AL)LLLAAAAAAAAA 
9502020-02-10 04:41:35.150589 E  VDPAU: Error at mythrender_vdpau.cpp:762 (#23, The system does not have enough resources to complete the requested operation at this time.)
9512020-02-10 04:41:35.150599 E  VDPAU: Failed to create decoder.
9522020-02-10 04:41:35.150609 E  VidOutVDPAU: Failed to create decoder.
9532020-02-10 04:41:35.150947 I  MythCodecContext: Disabled hardware decoder based deinterlacer.
9542020-02-10 04:41:35.155811 E  Player(2): AVSync: Unknown error in videoOutput, aborting playback.
9552020-02-10 04:41:35.293553 I  TV::HandleStateChange(): Attempting to change from WatchingPreRecorded to None
9562020-02-10 04:41:35.293629 I  Player(2): StopPlaying - begin
9572020-02-10 04:41:35.393768 W  Player(2): Waited 100ms for decoder to pause
9582020-02-10 04:41:35.493905 W  Player(2): Waited 100ms for decoder to pause
9592020-02-10 04:41:35.536477 I  Player(2): Decoder thread exiting.
9602020-02-10 04:41:35.536875 I  Player(2): Exited decoder loop.
9612020-02-10 04:41:35.564995 I  VidOutVDPAU: DiscardFrames(1)
9622020-02-10 04:41:35.565052 I  VideoBuffers::DiscardFrames(1): AAAAFAAAAAAAAA 
9632020-02-10 04:41:35.565098 I  VideoBuffers::DiscardFrames(1): AAAAAAAAAAAAAA   -- done
9642020-02-10 04:41:35.565126 I  VidOutVDPAU: DiscardFrames() 3: AAAAAAAAAAAAAA   -- done()
9652020-02-10 04:41:35.572927 I  VDPAU Painter: Clearing VDPAU painter cache.
9662020-02-10 04:41:35.572947 I  VDPAU Painter: Clearing VDPAU painter cache.
9672020-02-10 04:41:35.632324 I  VDPAU Painter: Clearing VDPAU painter cache.
9682020-02-10 04:41:35.706713 I  Player(2): StopPlaying - end
9692020-02-10 04:41:35.706730 I  TV::StopStuff(): Stopping ring buffer
9702020-02-10 04:41:35.718323 I  TV::StopStuff(): Stopping player
9712020-02-10 04:41:35.718349 I  TV::HandleStateChange(): Changing from WatchingPreRecorded to None
9722020-02-10 04:41:35.718396 I  TV::StartTV(): Exiting main playback loop.
9732020-02-10 04:41:35.718407 I  TV::StartTV(): -- process events 2 begin
9742020-02-10 04:41:35.719326 I  TV::StartTV(): -- process events 2 end
9752020-02-10 04:41:35.730073 I  TV::~TV(): -- lock
9762020-02-10 04:41:35.730343 I  Player(2): StopPlaying - begin
9772020-02-10 04:41:35.730376 I  Player(2): Exited decoder loop.
9782020-02-10 04:41:35.730394 I  Player(2): StopPlaying - end
9792020-02-10 04:41:35.749483 N  Resuming idle timer