<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"><<a href="mailto:noreply@mythtv.org" target="_blank">noreply@mythtv.org</a>></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->Connecting<br>
2013-07-15 01:05:20.005517 I Pulse: Callback: State changed<br>
Connecting->Authorizing<br>
2013-07-15 01:05:20.056196 I Pulse: Callback: State changed<br>
Authorizing->Setting Name<br>
2013-07-15 01:05:20.096574 I Pulse: Callback: State changed Setting<br>
Name->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(> 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) ->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>
'plughw:CARD=NVidia,DEV=9' 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 &<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 &<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>
"/mnt/store2/recordings/6754_20130715055700.mpg". 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(> 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: 'vdpau'<br>
2013-07-15 01:05:20.601200 I VDP: Accepting: cmp(> 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('vdpaucolorspace=auto'..) -> 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 -><br>
'vdpauadvanceddoublerate'<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->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 'mythfrontend -v<br>
playback,important,audio'. If I can reproduce, any other verbose options<br>
that might help? If you need me to run gdb, I won't have an opportunity<br>
until at least next Sunday.<br>
<br>
--<br>
Ticket URL: <<a href="http://code.mythtv.org/trac/ticket/11686" target="_blank">http://code.mythtv.org/trac/ticket/11686</a>><br>
MythTV <<a href="http://www.mythtv.org" target="_blank">http://www.mythtv.org</a>><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>