<div dir="ltr">I noticed this as well yesterday after updating to latest trunk build. If necessary I can rebuild with debug sooner than Sunday.<div><br></div><div>Tom</div></div><div class="gmail_extra"><br><br><div class="gmail_quote">
On Mon, Jul 15, 2013 at 4:49 AM,  <span dir="ltr">&lt;<a href="mailto:noreply@mythtv.org" target="_blank">noreply@mythtv.org</a>&gt;</span> wrote:<br><blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex">
#11686: Frontend OOMs at end of watching a recording<br>
-------------------------------+--------------------------------------<br>
 Reporter:  voltaire1983red@…  |           Type:  Bug Report - General<br>
   Status:  new                |       Priority:  minor<br>
Milestone:  unknown            |      Component:  MythTV - General<br>
  Version:  Unspecified        |       Severity:  medium<br>
 Keywords:                     |  Ticket locked:  0<br>
-------------------------------+--------------------------------------<br>
 I am using master updated on Saturday.  I have now had two instances of<br>
 the frontend gobbling all my ram when a recording comes to the end.  The<br>
 playback freezes on the last frame and memory usage grows until it<br>
 depletes all available memory.  I update about once or twice a month and<br>
 have not seen this previously.  I was able to reproduce using the same<br>
 recording.<br>
<br>
 The recordings were both from an HDHomeRun Prime, playback with VDPAU and<br>
 timestretch at 1.3.  Audio is hdmi passthrough.  It is a remote frontend<br>
 playing directly from an NFS share, not streaming from the backend.  The<br>
 frontend is Ubuntu 12.04 with the 3.8 kernel and has 16GB ram with no swap<br>
 file.<br>
<br>
 I have watched several other recordings from the same source without this<br>
 issue.<br>
<br>
 Below is console output captured by jumping to near the end of the<br>
 recording to reproduce the issue.<br>
<br>
 {{{<br>
 2013-07-15 01:05:20.004766 I  Pulse: Created PulseHandler object<br>
 2013-07-15 01:05:20.005475 I  Pulse: Callback: State changed<br>
 Unconnected-&gt;Connecting<br>
 2013-07-15 01:05:20.005517 I  Pulse: Callback: State changed<br>
 Connecting-&gt;Authorizing<br>
 2013-07-15 01:05:20.056196 I  Pulse: Callback: State changed<br>
 Authorizing-&gt;Setting Name<br>
 2013-07-15 01:05:20.096574 I  Pulse: Callback: State changed Setting<br>
 Name-&gt;Ready!<br>
 2013-07-15 01:05:20.106663 I  Pulse: Initialised handler<br>
 2013-07-15 01:05:20.137094 I  Pulse: Operation: success 1 remaining 1<br>
 2013-07-15 01:05:20.157324 I  Pulse: Operation: success 1 remaining 0<br>
 2013-07-15 01:05:20.167415 I  Pulse: PulseAudio suspend OK<br>
 2013-07-15 01:05:20.174431 I  ALSA: OpenDevice plughw:CARD=NVidia,DEV=9<br>
 2013-07-15 01:05:20.174878 I  AOS: Sample rate 32000 is supported<br>
 2013-07-15 01:05:20.174906 I  AOS: Sample rate 44100 is supported<br>
 2013-07-15 01:05:20.174930 I  AOS: Sample rate 48000 is supported<br>
 2013-07-15 01:05:20.174951 I  AOS: Format signed 16 bit is supported<br>
 2013-07-15 01:05:20.174993 I  AOS: 2 channel(s) are supported<br>
 2013-07-15 01:05:20.175226 I  ALSA: Successfully retrieved ELD data<br>
 2013-07-15 01:05:20.175265 I  ELDUTILS: Detected monitor TX-NR709 at<br>
 connection type HDMI<br>
 2013-07-15 01:05:20.175286 I  ELDUTILS: available speakers: FL/FR LFE FC<br>
 RL/RR RC FLC/FRC RLC/RRC FLW/FRW FLH/FRH TC FCH<br>
 2013-07-15 01:05:20.175295 I  ELDUTILS: max LPCM channels = 2<br>
 2013-07-15 01:05:20.175303 I  ELDUTILS: max channels = 2<br>
 2013-07-15 01:05:20.175310 I  ELDUTILS: supported codecs = LPCM<br>
 2013-07-15 01:05:20.175332 I  ELDUTILS: supports coding type LPCM:<br>
 channels = 2, rates = 32000 44100 48000, bits = 16<br>
 2013-07-15 01:05:20.195561 I  AOS: may be AC3 or DTS capable<br>
 2013-07-15 01:05:20.195571 I  AOS: 6 channel(s) are supported<br>
 2013-07-15 01:05:20.204657 N  AudioPlayer: Enabling Audio<br>
 2013-07-15 01:05:20.220703 I  Player(0): Stretch Factor 1, allow passthru<br>
 2013-07-15 01:05:20.220919 I  AFD: Buffer size: 32768, streamed 0<br>
 2013-07-15 01:05:20.275450 I  AFD: Stream #0, has id 0x7c0 codec id<br>
 MPEG2VIDEO, type Video, bitrate 0 at 0x94dc360<br>
 2013-07-15 01:05:20.275477 I  AFD: Stream #1, has id 0x7c1 codec id AC3,<br>
 type Audio, bitrate 448000 at 0x95e58c0<br>
 2013-07-15 01:05:20.275486 I  AFD: codec AC3 has 6 channels<br>
 2013-07-15 01:05:20.275492 I  AFD: Looking for decoder for AC3<br>
 2013-07-15 01:05:20.275837 I  AFD: Opened codec 0x95ed660, id(AC3)<br>
 type(Audio)<br>
 2013-07-15 01:05:20.276135 I  AFD: Audio Track #1, of type (Normal) is A/V<br>
 stream #1 (id=0x7c1) and has 6 channels in the English language(6647399).<br>
 2013-07-15 01:05:20.276152 I  AFD: Stream #2, has id 0x7c2 codec id AC3,<br>
 type Audio, bitrate 192000 at 0x95edb20<br>
 2013-07-15 01:05:20.276160 I  AFD: codec AC3 has 2 channels<br>
 2013-07-15 01:05:20.276166 I  AFD: Looking for decoder for AC3<br>
 2013-07-15 01:05:20.276479 I  AFD: Opened codec 0x95e1140, id(AC3)<br>
 type(Audio)<br>
 2013-07-15 01:05:20.276557 I  AFD: Audio Track #2, of type (Normal) is A/V<br>
 stream #2 (id=0x7c2) and has 2 channels in the Spanish; Castilian<br>
 language(7565409).<br>
 2013-07-15 01:05:20.276565 I  AFD: Trying to select best video track<br>
 2013-07-15 01:05:20.276593 I  AFD: Selected track #0 (id 0x7c0 codec id<br>
 MPEG2VIDEO, type Video, bitrate 500000 at 0x94dc360)<br>
 2013-07-15 01:05:20.283482 I  VDP: Accepting: cmp(&gt; 0 0) dec(vdpau)<br>
 cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled)<br>
 deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)<br>
 2013-07-15 01:05:20.283510 I  VDP: LoadBestPreferences(2048x2048, 0)<br>
 2013-07-15 01:05:20.283539 I  VDP: LoadBestPreferences(2048x2048, 60)<br>
 2013-07-15 01:05:20.283568 I  VDP: LoadBestPreferences(1920x1080, 60)<br>
 2013-07-15 01:05:20.283617 I  AFD: Using 1 CPUs for decoding<br>
 2013-07-15 01:05:20.283631 I  AFD: InitVideoCodec() 0x95e5460<br>
 id(MPEG2VIDEO) type (Video).<br>
 2013-07-15 01:05:20.283667 I  AFD: Selected FPS is 29.97 (avg 29.97 codec<br>
 29.97 container 90000 estimated 29.97)<br>
 2013-07-15 01:05:20.283694 I  Player(0): SetFrameInterval ps:1 scan:3<br>
 2013-07-15 01:05:20.283720 I  Player(0): detectInterlace(Detect Scan,<br>
 Interlaced Scan, 29.97, 1080) -&gt;Interlaced Scan<br>
 2013-07-15 01:05:20.283836 I  AFD: EIA-608 caption service #3 is in the<br>
 Unknown language.<br>
 2013-07-15 01:05:20.283851 I  AFD: EIA-708 caption service #1 is in the<br>
 Unknown language.<br>
 2013-07-15 01:05:20.283864 I  AFD: EIA-608 caption service #1 is in the<br>
 Unknown language.<br>
 2013-07-15 01:05:20.283878 I  AFD: EIA-608 caption service #3 is in the<br>
 Unknown language.<br>
 2013-07-15 01:05:20.283888 I  AFD: EIA-708 caption service #2 is in the<br>
 Unknown language.<br>
 2013-07-15 01:05:20.283897 I  AFD: EIA-608 caption service #1 is in the<br>
 Unknown language.<br>
 2013-07-15 01:05:20.283911 I  AFD: EIA-608 caption service #3 is in the<br>
 Unknown language.<br>
 2013-07-15 01:05:20.283923 I  AFD: EIA-708 caption service #3 is in the<br>
 Unknown language.<br>
 2013-07-15 01:05:20.283933 I  AFD: EIA-708 caption service #48 is in the<br>
 Unknown language.<br>
 2013-07-15 01:05:20.283942 I  AFD: EIA-608 caption service #1 is in the<br>
 Unknown language.<br>
 2013-07-15 01:05:20.283954 I  AFD: EIA-708 caption service #39 is in the<br>
 Unknown language.<br>
 2013-07-15 01:05:20.283964 I  AFD: EIA-608 caption service #3 is in the<br>
 Unknown language.<br>
 2013-07-15 01:05:20.283974 I  AFD: EIA-608 caption service #1 is in the<br>
 Unknown language.<br>
 2013-07-15 01:05:20.283985 I  AFD: EIA-608 caption service #1 is in the<br>
 Unknown language.<br>
 2013-07-15 01:05:20.283994 I  AFD: EIA-608 caption service #1 is in the<br>
 Unknown language.<br>
 2013-07-15 01:05:20.284012 I  AFD: Using vdpau for video decoding<br>
 2013-07-15 01:05:20.284031 I  AFD: Opened codec 0x95e5460, id(MPEG2VIDEO)<br>
 type(Video)<br>
 2013-07-15 01:05:20.284056 I  AFD: Trying to select audio track (w/lang)<br>
 2013-07-15 01:05:20.285761 I  AFD: Selected track 1: English AC3 5.1ch<br>
 (A/V Stream #1)<br>
 2013-07-15 01:05:20.285779 I  AFD: Audio data is planar<br>
 2013-07-15 01:05:20.285799 I  AFD: Initializing audio parms from audio<br>
 track #1<br>
 2013-07-15 01:05:20.285824 I  AFD: Audio format changed<br>
                         from id(NONE)     -1Hz -1ch -1bps     (profile 0)<br>
 to id( AC3)  48000Hz  6ch 32bps  pt (profile 0)<br>
 2013-07-15 01:05:20.285852 I  AOBase: Setting AC3 passthrough<br>
 2013-07-15 01:05:20.286672 I  SPDIFEncoder: Creating spdif encoder (for<br>
 AC3)<br>
 2013-07-15 01:05:20.286685 I  AOBase: Killing AudioOutputDSP<br>
 2013-07-15 01:05:20.286701 I  AOBase: Original codec was AC3, 32 bit<br>
 floating point, 48 kHz, 6 channels<br>
 2013-07-15 01:05:20.286725 I  AOBase: enc(0), passthru(1), features<br>
 (AC3,DTS) configured_channels(6), 6 channels supported(1) max_channels(6)<br>
 2013-07-15 01:05:20.286746 I  AOBase: Opening audio device<br>
 &#39;plughw:CARD=NVidia,DEV=9&#39; ch 2(6) sr 48000 sf signed 16 bit reenc 0<br>
 2013-07-15 01:05:20.286755 I  ALSA: OpenDevice<br>
 plughw:CARD=NVidia,DEV=9,AES0=6,AES1=0x82,AES2=0x00,AES3=0x01 for<br>
 passthrough<br>
 2013-07-15 01:05:20.286927 I  ALSA: Auto setting passthrough failed (No<br>
 such file or directory), defaulting to main device<br>
 2013-07-15 01:05:20.286934 I  ALSA: OpenDevice plughw:CARD=NVidia,DEV=9<br>
 2013-07-15 01:05:20.289947 I  ALSA: SetParameters(format=2, channels=2,<br>
 rate=48000, buffer_time=500000, period_time=4)<br>
 2013-07-15 01:05:20.290285 I  ALSA: Buffer size range from 64 to 16384<br>
 2013-07-15 01:05:20.290294 I  ALSA: Period size range from 32 to 8192<br>
 2013-07-15 01:05:20.290336 E  ALSA: Requested 500000us got 341333 buffer<br>
 time<br>
 2013-07-15 01:05:20.290426 I  ALSA: Hardware audio buffer cur: 64 need:<br>
 128 max allowed: 32768<br>
 2013-07-15 01:05:20.290453 E  ALSA: Try to manually increase audio buffer<br>
 with: echo 128 | sudo tee /proc/asound/card1/pcm9p/sub0/prealloc<br>
 2013-07-15 01:05:20.290465 I  ALSA: Buffer time = 341333 us<br>
 2013-07-15 01:05:20.290522 I  ALSA: Period time = 4 periods<br>
 2013-07-15 01:05:20.410177 I  ALSA: Buffer size = 16384 | Period size =<br>
 4096<br>
 2013-07-15 01:05:20.506104 I  AOBase: Audio fragment size: 8192<br>
 2013-07-15 01:05:20.506137 I  AOBase: Audio Stretch Factor: 1<br>
 2013-07-15 01:05:20.506192 I  AOBase: Ending Reconfigure()<br>
 2013-07-15 01:05:20.506233 I  Dec: Selected track #1 (type 2) in the<br>
 Unknown language(0)<br>
 2013-07-15 01:05:20.506247 I  Dec: Trying to select track (w/lang &amp;<br>
 forced)<br>
 2013-07-15 01:05:20.506271 I  Dec: Selected track #1 (type 4) in the<br>
 Unknown language(1123328)<br>
 2013-07-15 01:05:20.506281 I  Dec: Trying to select track (w/lang &amp;<br>
 forced)<br>
 2013-07-15 01:05:20.506342 I  Dec: Selected track #1 (type 5) in the<br>
 Unknown language(33255)<br>
 2013-07-15 01:05:20.506344 I  AOBase: kickoffOutputAudioLoop: pid = 27911<br>
 2013-07-15 01:05:20.506366 I  Dec: Resyncing position map. posmapStarted =<br>
 0 livetv(0) watchingRec(0)<br>
 2013-07-15 01:05:20.506372 I  AOBase: OutputAudioLoop: Play Event<br>
 2013-07-15 01:05:20.554693 I  Dec: Position map filled from DB to: 118631<br>
 2013-07-15 01:05:20.558007 I  Dec: Duration map filled from DB to: 118631<br>
 2013-07-15 01:05:20.558408 I  Dec: SyncPositionMap prerecorded, from DB:<br>
 7965 entries<br>
 2013-07-15 01:05:20.558425 I  Dec: SyncPositionMap, new totframes: 118631,<br>
 new length: 3958, posMap size: 7965<br>
 2013-07-15 01:05:20.561400 I  AFD: Position map found<br>
 2013-07-15 01:05:20.561407 I  AFD: Successfully opened decoder for file:<br>
 &quot;/mnt/store2/recordings/6754_20130715055700.mpg&quot;. novideo(0)<br>
 2013-07-15 01:05:20.570235 I  VideoOutput: Allowed renderers: vdpau<br>
 2013-07-15 01:05:20.570257 I  VideoOutput: Allowed renderers (filt:<br>
 vdpau): vdpau<br>
 2013-07-15 01:05:20.574128 I  VDP: Accepting: cmp(&gt; 0 0) dec(vdpau)<br>
 cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled)<br>
 deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)<br>
 2013-07-15 01:05:20.574148 I  VDP: LoadBestPreferences(2048x2048, 0)<br>
 2013-07-15 01:05:20.574174 I  VDP: LoadBestPreferences(2048x2048, 60)<br>
 2013-07-15 01:05:20.574199 I  VDP: LoadBestPreferences(1920x1080, 60)<br>
 2013-07-15 01:05:20.574221 I  VideoOutput: Preferred renderer: vdpau<br>
 2013-07-15 01:05:20.574236 I  VideoOutput: Trying video renderer: &#39;vdpau&#39;<br>
 2013-07-15 01:05:20.601200 I  VDP: Accepting: cmp(&gt; 0 0) dec(vdpau)<br>
 cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled)<br>
 deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)<br>
 2013-07-15 01:05:20.601217 I  VDP: LoadBestPreferences(2048x2048, 0)<br>
 2013-07-15 01:05:20.601240 I  VDP: LoadBestPreferences(2048x2048, 60)<br>
 2013-07-15 01:05:20.601292 I  VideoOutWindow::SetPIPState. pip_state: 0]<br>
 2013-07-15 01:05:20.601304 I  VDP: LoadBestPreferences(2048x2048, 29.97)<br>
 2013-07-15 01:05:20.601325 I  Clearing OpenGL painter cache.<br>
 2013-07-15 01:05:20.625250 I  Snapping width to avoid scaling: width:<br>
 1920, left: 0<br>
 2013-07-15 01:05:20.625273 I  Display Rect  left: 0, top: 135, width:<br>
 1920, height: 810, aspect: 1.33333<br>
 2013-07-15 01:05:20.625293 I  Video Rect    left: 0, top: 0, width: 1920,<br>
 height: 1080, aspect: 1.77778<br>
 2013-07-15 01:05:20.625315 I  VDP: LoadBestPreferences(1920x1088, 29.97)<br>
 2013-07-15 01:05:20.625364 I  Snapping width to avoid scaling: width:<br>
 1920, left: 0<br>
 2013-07-15 01:05:20.625378 I  Display Rect  left: 0, top: 135, width:<br>
 1920, height: 810, aspect: 1.33333<br>
 2013-07-15 01:05:20.625390 I  Video Rect    left: 0, top: 0, width: 1920,<br>
 height: 1080, aspect: 1.77778<br>
 2013-07-15 01:05:20.625400 I  VDP: SetVideoRenderer(vdpau)<br>
 2013-07-15 01:05:20.625410 I  VDP: SetVideoRender(vdpau) ==<br>
 GetVideoRenderer()<br>
 2013-07-15 01:05:20.626128 I  VideoOutput: Pixel dimensions: Screen<br>
 1920x1080, window 1920x1080<br>
 2013-07-15 01:05:20.626148 I  VideoOutput: Actual display dimensions:<br>
 650x366 mm  Aspect: 1.77596<br>
 2013-07-15 01:05:20.626160 I  VideoOutput: Estimated window dimensions:<br>
 650x366 mm  Aspect: 1.77596<br>
 2013-07-15 01:05:20.724659 I  VDPAU: Created 2 output surfaces.<br>
 2013-07-15 01:05:20.724687 I  VDPAU: Set colorkey to 0x20202<br>
 2013-07-15 01:05:20.724699 I  VDPAU: Version 1<br>
 2013-07-15 01:05:20.724707 I  VDPAU: Information NVIDIA VDPAU Driver<br>
 Shared Library  304.88  Wed Mar 27 14:49:27 PDT 2013<br>
 2013-07-15 01:05:20.724720 I  VDPAU: HQ scaling level 1 of 9 available.<br>
 2013-07-15 01:05:20.724728 I  VDPAU: MPEG4 hardware acceleration<br>
 supported.<br>
 2013-07-15 01:05:20.724737 I  VDPAU: Created VDPAU render device 1920x1080<br>
 2013-07-15 01:05:20.724759 I  VidOutVDPAU: Created VDPAU osd (1920x1080)<br>
 2013-07-15 01:05:20.750754 I  ColourSpace: PictureAttributes: Brightness,<br>
 Contrast, Colour, Hue, Studio Levels,<br>
 2013-07-15 01:05:20.750763 I  VidOutVDPAU: Using ITU BT.709 colorspace<br>
 2013-07-15 01:05:20.750786 I  Snapping height to avoid scaling: height:<br>
 1080, top: 0<br>
 2013-07-15 01:05:20.750791 I  Snapping width to avoid scaling: width:<br>
 1920, left: 0<br>
 2013-07-15 01:05:20.750801 I  Display Rect  left: 0, top: 0, width: 1920,<br>
 height: 1080, aspect: 1.77778<br>
 2013-07-15 01:05:20.750809 I  Video Rect    left: 0, top: 0, width: 1920,<br>
 height: 1080, aspect: 1.77778<br>
 2013-07-15 01:05:20.750813 I  VidOutVDPAU: Created VDPAU context (GPU<br>
 decode)<br>
 2013-07-15 01:05:20.754441 I  Over/underscan. V: 0, H: 0<br>
 2013-07-15 01:05:20.754456 I  Snapping height to avoid scaling: height:<br>
 1080, top: 0<br>
 2013-07-15 01:05:20.754465 I  Snapping width to avoid scaling: width:<br>
 1920, left: 0<br>
 2013-07-15 01:05:20.754480 I  Display Rect  left: 0, top: 0, width: 1920,<br>
 height: 1080, aspect: 1.77778<br>
 2013-07-15 01:05:20.754493 I  Video Rect    left: 0, top: 0, width: 1920,<br>
 height: 1080, aspect: 1.77778<br>
 2013-07-15 01:05:20.754506 N  Player(0): Forcing decode extra audio option<br>
 on (Video method requires it).<br>
 2013-07-15 01:05:20.754563 I  FilterManager: GetFilterInfo(convert)<br>
 returning: 0x0<br>
 2013-07-15 01:05:20.754639 I  Player(0):<br>
 LoadFilters(&#39;vdpaucolorspace=auto&#39;..) -&gt; 0x0<br>
 2013-07-15 01:05:20.758553 I  Player(0): Decoder thread starting.<br>
 2013-07-15 01:05:20.765778 I  OSD: Loaded window osd_message<br>
 2013-07-15 01:05:20.768075 I  OSD: Loaded window osd_input<br>
 2013-07-15 01:05:20.788271 I  OSD: Loaded window program_info<br>
 2013-07-15 01:05:20.791037 I  OSD: Loaded window browse_info<br>
 2013-07-15 01:05:20.793602 I  OSD: Loaded window osd_status<br>
 2013-07-15 01:05:20.796324 I  OSD: Loaded window osd_program_editor<br>
 2013-07-15 01:05:20.801837 I  OSD: Loaded window osd_debug<br>
 2013-07-15 01:05:20.801849 I  OSD: Loaded OSD: size 1920x1080 offset 0+0<br>
 2013-07-15 01:05:20.801907 I  OSD: Created window aa_OSD_SUBTITLES<br>
 2013-07-15 01:05:20.801940 I  Player(0): ClearAfterSeek(0)<br>
 2013-07-15 01:05:20.802658 I  VDP: GetFilteredDeint() : vdpau -&gt;<br>
 &#39;vdpauadvanceddoublerate&#39;<br>
 2013-07-15 01:05:20.803122 I  VidOutVDPAU: Enabled deinterlacing.<br>
 2013-07-15 01:05:20.803156 I  VSYNC: DRMVideoSync: Could not open device<br>
 /dev/dri/card0, No such file or directory<br>
 2013-07-15 01:05:20.803176 E  VSYNC: RTCVideoSync: Could not open<br>
 /dev/rtc:<br>
                         eno: Permission denied (13)<br>
 2013-07-15 01:05:20.803608 I  Player(0): Video timing method: USleep with<br>
 busy wait<br>
 2013-07-15 01:05:20.803621 I  Player(0): Display Refresh Rate: 59.999<br>
 Video Frame Rate: 29.970<br>
 2013-07-15 01:05:20.803627 I  Player(0): SetFrameInterval ps:1 scan:1<br>
 2013-07-15 01:05:20.804386 I  playCtx: StartPlaying(): took 0 ms to start<br>
 player.<br>
 2013-07-15 01:05:20.804403 I  TV: Created player.<br>
 2013-07-15 01:05:20.804425 I  TV: StartPlayer(0, WatchingPreRecorded,<br>
 main) -- end ok<br>
 2013-07-15 01:05:20.804478 I  TV: Changing from None to<br>
 WatchingPreRecorded<br>
 2013-07-15 01:05:20.808411 I  AOBase: OutputAudioLoop: Play Event<br>
 2013-07-15 01:05:20.821257 I  TV: DrawUnusedRects() -- begin<br>
 2013-07-15 01:05:20.821268 I  TV: DrawUnusedRects() -- end<br>
 2013-07-15 01:05:20.821328 I  TV: Main UI disabled.<br>
 2013-07-15 01:05:20.821349 I  TV: HandleStateChange(0) -- end<br>
 2013-07-15 01:05:20.821406 I  TV: tv-&gt;Playback() -- end<br>
 2013-07-15 01:05:20.821431 I  TV: Entering main playback loop.<br>
 2013-07-15 01:05:20.829726 I  VidOutVDPAU: Created VDPAU decoder (2 ref<br>
 frames)<br>
 2013-07-15 01:05:20.850447 I  Player(0): Enabled deinterlacing<br>
 2013-07-15 01:05:20.920281 I  VDPAU: Added 2 output surfaces (total 4, max<br>
 4)<br>
 2013-07-15 01:05:21.071406 I  Player(0): Video is 3.4081 frames behind<br>
 audio (too slow), dropping frame to catch up.<br>
 2013-07-15 01:05:21.071418 I  AOBase: Pause 1<br>
 2013-07-15 01:05:21.071485 I  Player(0): Video is 3.73986 frames behind<br>
 audio (too slow), dropping frame to catch up.<br>
 2013-07-15 01:05:21.071490 I  AOBase: Pause 1<br>
 2013-07-15 01:05:21.071533 I  Player(0): Video is 3.74145 frames behind<br>
 audio (too slow), dropping frame to catch up.<br>
 2013-07-15 01:05:21.071537 I  AOBase: Pause 1<br>
 2013-07-15 01:05:21.071580 I  Player(0): Video is 3.49537 frames behind<br>
 audio (too slow), dropping frame to catch up.<br>
 2013-07-15 01:05:21.071585 I  AOBase: Pause 1<br>
 2013-07-15 01:05:21.071627 I  Player(0): Video is 3.05607 frames behind<br>
 audio (too slow), dropping frame to catch up.<br>
 2013-07-15 01:05:21.071632 I  AOBase: Pause 1<br>
 2013-07-15 01:05:21.071671 I  AOBase: Pause 0<br>
 2013-07-15 01:05:21.080384 I  AOBase: OutputAudioLoop: Play Event<br>
<br>
<br>
 ...<br>
<br>
 2013-07-15 01:05:25.538132 I  AOBase: OutputAudioLoop: Play Event<br>
 2013-07-15 01:05:25.792478 I  Player(0): Video is 3.53643 frames ahead of<br>
 audio,<br>
                         doubling video frame interval to slow down.<br>
 2013-07-15 01:05:25.892574 I  Player(0): Video is 3.73872 frames ahead of<br>
 audio,<br>
                         doubling video frame interval to slow down.<br>
 2013-07-15 01:05:25.992670 I  Player(0): Video is 3.36596 frames ahead of<br>
 audio,<br>
                         doubling video frame interval to slow down.<br>
 2013-07-15 01:05:27.072167 E  decoding error<br>
                         eno: Unknown error 541478725 (541478725)<br>
 2013-07-15 01:05:27.088205 I  Player(0): Video is 30 frames behind audio<br>
 (too slow), dropping frame to catch up.<br>
 2013-07-15 01:05:27.088219 I  AOBase: Pause 1<br>
 2013-07-15 01:05:27.088306 I  Player(0): Video is 30 frames behind audio<br>
 (too slow), dropping frame to catch up.<br>
 2013-07-15 01:05:27.088315 I  AOBase: Pause 1<br>
<br>
 ...<br>
<br>
 2013-07-15 01:05:27.095046 I  Player(0): Video is 30 frames behind audio<br>
 (too slow), dropping frame to catch up.<br>
 2013-07-15 01:05:27.095055 I  AOBase: Pause 1<br>
 2013-07-15 01:05:27.095123 I  AOBase: OutputAudioLoop: audio paused<br>
 2013-07-15 01:05:27.095126 I  Player(0): Video is 30 frames behind audio<br>
 (too slow), dropping frame to catch up.<br>
 2013-07-15 01:05:27.095134 I  AOBase: Pause 1<br>
 2013-07-15 01:05:27.095145 I  AOBase: OutputAudioLoop: audio paused<br>
 2013-07-15 01:05:27.095187 I  Player(0): Video is 30 frames behind audio<br>
 (too slow), dropping frame to catch up.<br>
 2013-07-15 01:05:27.095237 I  Player(0): Video is 30 frames behind audio<br>
 (too slow), dropping frame to catch up.<br>
 }}}<br>
<br>
 And then thousands of lines of<br>
<br>
 {{{<br>
 2013-07-15 01:06:37.522728 I  Player(1): Video is 30 frames behind audio<br>
 (too slow), dropping frame to catch up.<br>
 2013-07-15 01:06:37.522768 I  Player(1): Video is 30 frames behind audio<br>
 (too slow), dropping frame to catch up.<br>
 2013-07-15 01:06:37.522795 I  Player(1): Video is 30 frames behind audio<br>
 (too slow), dropping frame to catch up.<br>
 2013-07-15 01:06:37.522820 I  Player(1): Video is 30 frames behind audio<br>
 (too slow), dropping frame to catch up.<br>
 2013-07-15 01:06:37.522843 I  Player(1): Video is 30 frames behind audio<br>
 (too slow), dropping frame to catch up.<br>
 2013-07-15 01:06:37.522870 I  Player(1): Video is 30 frames behind audio<br>
 (too slow), dropping frame to catch up.<br>
 }}}<br>
<br>
<br>
 I never see the entry showing that it is near the end of the recording and<br>
 slowing down to 1x speed as recordings that do not have this problem<br>
 typically have.<br>
<br>
 Sorry I do not have any more information.  Do not have a debug build<br>
 running.  I run the frontend with &#39;mythfrontend -v<br>
 playback,important,audio&#39;.  If I can reproduce, any other verbose options<br>
 that might help?  If you need me to run gdb, I won&#39;t have an opportunity<br>
 until at least next Sunday.<br>
<br>
--<br>
Ticket URL: &lt;<a href="http://code.mythtv.org/trac/ticket/11686" target="_blank">http://code.mythtv.org/trac/ticket/11686</a>&gt;<br>
MythTV &lt;<a href="http://www.mythtv.org" target="_blank">http://www.mythtv.org</a>&gt;<br>
MythTV Media Center<br>
_______________________________________________<br>
mythtv-commits mailing list<br>
<a href="mailto:mythtv-commits@mythtv.org">mythtv-commits@mythtv.org</a><br>
<a href="http://www.mythtv.org/mailman/listinfo/mythtv-commits" target="_blank">http://www.mythtv.org/mailman/listinfo/mythtv-commits</a><br>
</blockquote></div><br></div>