Opened 6 years ago

Closed 6 years ago

#11686 closed Bug Report - General (Fixed)

Frontend OOMs at end of watching a recording

Reported by: voltaire1983red@… Owned by: Jim Stichnoth
Priority: blocker Milestone: 0.27
Component: MythTV - Video Playback Version: Master Head
Severity: medium Keywords:
Cc: Ticket locked: no

Description

I am using master updated on Saturday. I have now had two instances of the frontend gobbling all my ram when a recording comes to the end. The playback freezes on the last frame and memory usage grows until it depletes all available memory. I update about once or twice a month and have not seen this previously. I was able to reproduce using the same recording.

The recordings were both from an HDHomeRun Prime, playback with VDPAU and timestretch at 1.3. Audio is hdmi passthrough. It is a remote frontend playing directly from an NFS share, not streaming from the backend. The frontend is Ubuntu 12.04 with the 3.8 kernel and has 16GB ram with no swap file.

I have watched several other recordings from the same source without this issue.

Below is console output captured by jumping to near the end of the recording to reproduce the issue.

2013-07-15 01:05:20.004766 I  Pulse: Created PulseHandler object
2013-07-15 01:05:20.005475 I  Pulse: Callback: State changed Unconnected->Connecting
2013-07-15 01:05:20.005517 I  Pulse: Callback: State changed Connecting->Authorizing
2013-07-15 01:05:20.056196 I  Pulse: Callback: State changed Authorizing->Setting Name
2013-07-15 01:05:20.096574 I  Pulse: Callback: State changed Setting Name->Ready!
2013-07-15 01:05:20.106663 I  Pulse: Initialised handler
2013-07-15 01:05:20.137094 I  Pulse: Operation: success 1 remaining 1
2013-07-15 01:05:20.157324 I  Pulse: Operation: success 1 remaining 0
2013-07-15 01:05:20.167415 I  Pulse: PulseAudio suspend OK
2013-07-15 01:05:20.174431 I  ALSA: OpenDevice plughw:CARD=NVidia,DEV=9
2013-07-15 01:05:20.174878 I  AOS: Sample rate 32000 is supported
2013-07-15 01:05:20.174906 I  AOS: Sample rate 44100 is supported
2013-07-15 01:05:20.174930 I  AOS: Sample rate 48000 is supported
2013-07-15 01:05:20.174951 I  AOS: Format signed 16 bit is supported
2013-07-15 01:05:20.174993 I  AOS: 2 channel(s) are supported
2013-07-15 01:05:20.175226 I  ALSA: Successfully retrieved ELD data
2013-07-15 01:05:20.175265 I  ELDUTILS: Detected monitor TX-NR709 at connection type HDMI
2013-07-15 01:05:20.175286 I  ELDUTILS: available speakers: FL/FR LFE FC RL/RR RC FLC/FRC RLC/RRC FLW/FRW FLH/FRH TC FCH
2013-07-15 01:05:20.175295 I  ELDUTILS: max LPCM channels = 2
2013-07-15 01:05:20.175303 I  ELDUTILS: max channels = 2
2013-07-15 01:05:20.175310 I  ELDUTILS: supported codecs = LPCM
2013-07-15 01:05:20.175332 I  ELDUTILS: supports coding type LPCM: channels = 2, rates = 32000 44100 48000, bits = 16
2013-07-15 01:05:20.195561 I  AOS: may be AC3 or DTS capable
2013-07-15 01:05:20.195571 I  AOS: 6 channel(s) are supported
2013-07-15 01:05:20.204657 N  AudioPlayer: Enabling Audio
2013-07-15 01:05:20.220703 I  Player(0): Stretch Factor 1, allow passthru 
2013-07-15 01:05:20.220919 I  AFD: Buffer size: 32768, streamed 0
2013-07-15 01:05:20.275450 I  AFD: Stream #0, has id 0x7c0 codec id MPEG2VIDEO, type Video, bitrate 0 at 0x94dc360
2013-07-15 01:05:20.275477 I  AFD: Stream #1, has id 0x7c1 codec id AC3, type Audio, bitrate 448000 at 0x95e58c0
2013-07-15 01:05:20.275486 I  AFD: codec AC3 has 6 channels
2013-07-15 01:05:20.275492 I  AFD: Looking for decoder for AC3
2013-07-15 01:05:20.275837 I  AFD: Opened codec 0x95ed660, id(AC3) type(Audio)
2013-07-15 01:05:20.276135 I  AFD: Audio Track #1, of type (Normal) is A/V stream #1 (id=0x7c1) and has 6 channels in the English language(6647399).
2013-07-15 01:05:20.276152 I  AFD: Stream #2, has id 0x7c2 codec id AC3, type Audio, bitrate 192000 at 0x95edb20
2013-07-15 01:05:20.276160 I  AFD: codec AC3 has 2 channels
2013-07-15 01:05:20.276166 I  AFD: Looking for decoder for AC3
2013-07-15 01:05:20.276479 I  AFD: Opened codec 0x95e1140, id(AC3) type(Audio)
2013-07-15 01:05:20.276557 I  AFD: Audio Track #2, of type (Normal) is A/V stream #2 (id=0x7c2) and has 2 channels in the Spanish; Castilian language(7565409).
2013-07-15 01:05:20.276565 I  AFD: Trying to select best video track
2013-07-15 01:05:20.276593 I  AFD: Selected track #0 (id 0x7c0 codec id MPEG2VIDEO, type Video, bitrate 500000 at 0x94dc360)
2013-07-15 01:05:20.283482 I  VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
2013-07-15 01:05:20.283510 I  VDP: LoadBestPreferences(2048x2048, 0)
2013-07-15 01:05:20.283539 I  VDP: LoadBestPreferences(2048x2048, 60)
2013-07-15 01:05:20.283568 I  VDP: LoadBestPreferences(1920x1080, 60)
2013-07-15 01:05:20.283617 I  AFD: Using 1 CPUs for decoding
2013-07-15 01:05:20.283631 I  AFD: InitVideoCodec() 0x95e5460 id(MPEG2VIDEO) type (Video).
2013-07-15 01:05:20.283667 I  AFD: Selected FPS is 29.97 (avg 29.97 codec 29.97 container 90000 estimated 29.97)
2013-07-15 01:05:20.283694 I  Player(0): SetFrameInterval ps:1 scan:3
2013-07-15 01:05:20.283720 I  Player(0): detectInterlace(Detect Scan, Interlaced Scan, 29.97, 1080) ->Interlaced Scan
2013-07-15 01:05:20.283836 I  AFD: EIA-608 caption service #3 is in the Unknown language.
2013-07-15 01:05:20.283851 I  AFD: EIA-708 caption service #1 is in the Unknown language.
2013-07-15 01:05:20.283864 I  AFD: EIA-608 caption service #1 is in the Unknown language.
2013-07-15 01:05:20.283878 I  AFD: EIA-608 caption service #3 is in the Unknown language.
2013-07-15 01:05:20.283888 I  AFD: EIA-708 caption service #2 is in the Unknown language.
2013-07-15 01:05:20.283897 I  AFD: EIA-608 caption service #1 is in the Unknown language.
2013-07-15 01:05:20.283911 I  AFD: EIA-608 caption service #3 is in the Unknown language.
2013-07-15 01:05:20.283923 I  AFD: EIA-708 caption service #3 is in the Unknown language.
2013-07-15 01:05:20.283933 I  AFD: EIA-708 caption service #48 is in the Unknown language.
2013-07-15 01:05:20.283942 I  AFD: EIA-608 caption service #1 is in the Unknown language.
2013-07-15 01:05:20.283954 I  AFD: EIA-708 caption service #39 is in the Unknown language.
2013-07-15 01:05:20.283964 I  AFD: EIA-608 caption service #3 is in the Unknown language.
2013-07-15 01:05:20.283974 I  AFD: EIA-608 caption service #1 is in the Unknown language.
2013-07-15 01:05:20.283985 I  AFD: EIA-608 caption service #1 is in the Unknown language.
2013-07-15 01:05:20.283994 I  AFD: EIA-608 caption service #1 is in the Unknown language.
2013-07-15 01:05:20.284012 I  AFD: Using vdpau for video decoding
2013-07-15 01:05:20.284031 I  AFD: Opened codec 0x95e5460, id(MPEG2VIDEO) type(Video)
2013-07-15 01:05:20.284056 I  AFD: Trying to select audio track (w/lang)
2013-07-15 01:05:20.285761 I  AFD: Selected track 1: English AC3 5.1ch (A/V Stream #1)
2013-07-15 01:05:20.285779 I  AFD: Audio data is planar
2013-07-15 01:05:20.285799 I  AFD: Initializing audio parms from audio track #1
2013-07-15 01:05:20.285824 I  AFD: Audio format changed 
			from id(NONE)     -1Hz -1ch -1bps     (profile 0) to id( AC3)  48000Hz  6ch 32bps  pt (profile 0)
2013-07-15 01:05:20.285852 I  AOBase: Setting AC3 passthrough
2013-07-15 01:05:20.286672 I  SPDIFEncoder: Creating spdif encoder (for AC3)
2013-07-15 01:05:20.286685 I  AOBase: Killing AudioOutputDSP
2013-07-15 01:05:20.286701 I  AOBase: Original codec was AC3, 32 bit floating point, 48 kHz, 6 channels
2013-07-15 01:05:20.286725 I  AOBase: enc(0), passthru(1), features (AC3,DTS) configured_channels(6), 6 channels supported(1) max_channels(6)
2013-07-15 01:05:20.286746 I  AOBase: Opening audio device 'plughw:CARD=NVidia,DEV=9' ch 2(6) sr 48000 sf signed 16 bit reenc 0
2013-07-15 01:05:20.286755 I  ALSA: OpenDevice plughw:CARD=NVidia,DEV=9,AES0=6,AES1=0x82,AES2=0x00,AES3=0x01 for passthrough
2013-07-15 01:05:20.286927 I  ALSA: Auto setting passthrough failed (No such file or directory), defaulting to main device
2013-07-15 01:05:20.286934 I  ALSA: OpenDevice plughw:CARD=NVidia,DEV=9
2013-07-15 01:05:20.289947 I  ALSA: SetParameters(format=2, channels=2, rate=48000, buffer_time=500000, period_time=4)
2013-07-15 01:05:20.290285 I  ALSA: Buffer size range from 64 to 16384
2013-07-15 01:05:20.290294 I  ALSA: Period size range from 32 to 8192
2013-07-15 01:05:20.290336 E  ALSA: Requested 500000us got 341333 buffer time
2013-07-15 01:05:20.290426 I  ALSA: Hardware audio buffer cur: 64 need: 128 max allowed: 32768
2013-07-15 01:05:20.290453 E  ALSA: Try to manually increase audio buffer with: echo 128 | sudo tee /proc/asound/card1/pcm9p/sub0/prealloc
2013-07-15 01:05:20.290465 I  ALSA: Buffer time = 341333 us
2013-07-15 01:05:20.290522 I  ALSA: Period time = 4 periods
2013-07-15 01:05:20.410177 I  ALSA: Buffer size = 16384 | Period size = 4096
2013-07-15 01:05:20.506104 I  AOBase: Audio fragment size: 8192
2013-07-15 01:05:20.506137 I  AOBase: Audio Stretch Factor: 1
2013-07-15 01:05:20.506192 I  AOBase: Ending Reconfigure()
2013-07-15 01:05:20.506233 I  Dec: Selected track #1 (type 2) in the Unknown language(0)
2013-07-15 01:05:20.506247 I  Dec: Trying to select track (w/lang & forced)
2013-07-15 01:05:20.506271 I  Dec: Selected track #1 (type 4) in the Unknown language(1123328)
2013-07-15 01:05:20.506281 I  Dec: Trying to select track (w/lang & forced)
2013-07-15 01:05:20.506342 I  Dec: Selected track #1 (type 5) in the Unknown language(33255)
2013-07-15 01:05:20.506344 I  AOBase: kickoffOutputAudioLoop: pid = 27911
2013-07-15 01:05:20.506366 I  Dec: Resyncing position map. posmapStarted = 0 livetv(0) watchingRec(0)
2013-07-15 01:05:20.506372 I  AOBase: OutputAudioLoop: Play Event
2013-07-15 01:05:20.554693 I  Dec: Position map filled from DB to: 118631
2013-07-15 01:05:20.558007 I  Dec: Duration map filled from DB to: 118631
2013-07-15 01:05:20.558408 I  Dec: SyncPositionMap prerecorded, from DB: 7965 entries
2013-07-15 01:05:20.558425 I  Dec: SyncPositionMap, new totframes: 118631, new length: 3958, posMap size: 7965
2013-07-15 01:05:20.561400 I  AFD: Position map found
2013-07-15 01:05:20.561407 I  AFD: Successfully opened decoder for file: "/mnt/store2/recordings/6754_20130715055700.mpg". novideo(0)
2013-07-15 01:05:20.570235 I  VideoOutput: Allowed renderers: vdpau
2013-07-15 01:05:20.570257 I  VideoOutput: Allowed renderers (filt: vdpau): vdpau
2013-07-15 01:05:20.574128 I  VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
2013-07-15 01:05:20.574148 I  VDP: LoadBestPreferences(2048x2048, 0)
2013-07-15 01:05:20.574174 I  VDP: LoadBestPreferences(2048x2048, 60)
2013-07-15 01:05:20.574199 I  VDP: LoadBestPreferences(1920x1080, 60)
2013-07-15 01:05:20.574221 I  VideoOutput: Preferred renderer: vdpau
2013-07-15 01:05:20.574236 I  VideoOutput: Trying video renderer: 'vdpau'
2013-07-15 01:05:20.601200 I  VDP: Accepting: cmp(> 0 0) dec(vdpau) cpus(1) skiploop(enabled) rend(vdpau) osd(vdpau) osdfade(enabled) deint(vdpauadvanceddoublerate,vdpauadvanced) filt(vdpaucolorspace=auto)
2013-07-15 01:05:20.601217 I  VDP: LoadBestPreferences(2048x2048, 0)
2013-07-15 01:05:20.601240 I  VDP: LoadBestPreferences(2048x2048, 60)
2013-07-15 01:05:20.601292 I  VideoOutWindow::SetPIPState. pip_state: 0]
2013-07-15 01:05:20.601304 I  VDP: LoadBestPreferences(2048x2048, 29.97)
2013-07-15 01:05:20.601325 I  Clearing OpenGL painter cache.
2013-07-15 01:05:20.625250 I  Snapping width to avoid scaling: width: 1920, left: 0
2013-07-15 01:05:20.625273 I  Display Rect  left: 0, top: 135, width: 1920, height: 810, aspect: 1.33333
2013-07-15 01:05:20.625293 I  Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
2013-07-15 01:05:20.625315 I  VDP: LoadBestPreferences(1920x1088, 29.97)
2013-07-15 01:05:20.625364 I  Snapping width to avoid scaling: width: 1920, left: 0
2013-07-15 01:05:20.625378 I  Display Rect  left: 0, top: 135, width: 1920, height: 810, aspect: 1.33333
2013-07-15 01:05:20.625390 I  Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
2013-07-15 01:05:20.625400 I  VDP: SetVideoRenderer(vdpau)
2013-07-15 01:05:20.625410 I  VDP: SetVideoRender(vdpau) == GetVideoRenderer()
2013-07-15 01:05:20.626128 I  VideoOutput: Pixel dimensions: Screen 1920x1080, window 1920x1080
2013-07-15 01:05:20.626148 I  VideoOutput: Actual display dimensions: 650x366 mm  Aspect: 1.77596
2013-07-15 01:05:20.626160 I  VideoOutput: Estimated window dimensions: 650x366 mm  Aspect: 1.77596
2013-07-15 01:05:20.724659 I  VDPAU: Created 2 output surfaces.
2013-07-15 01:05:20.724687 I  VDPAU: Set colorkey to 0x20202
2013-07-15 01:05:20.724699 I  VDPAU: Version 1
2013-07-15 01:05:20.724707 I  VDPAU: Information NVIDIA VDPAU Driver Shared Library  304.88  Wed Mar 27 14:49:27 PDT 2013
2013-07-15 01:05:20.724720 I  VDPAU: HQ scaling level 1 of 9 available.
2013-07-15 01:05:20.724728 I  VDPAU: MPEG4 hardware acceleration supported.
2013-07-15 01:05:20.724737 I  VDPAU: Created VDPAU render device 1920x1080
2013-07-15 01:05:20.724759 I  VidOutVDPAU: Created VDPAU osd (1920x1080)
2013-07-15 01:05:20.750754 I  ColourSpace: PictureAttributes: Brightness, Contrast, Colour, Hue, Studio Levels, 
2013-07-15 01:05:20.750763 I  VidOutVDPAU: Using ITU BT.709 colorspace
2013-07-15 01:05:20.750786 I  Snapping height to avoid scaling: height: 1080, top: 0
2013-07-15 01:05:20.750791 I  Snapping width to avoid scaling: width: 1920, left: 0
2013-07-15 01:05:20.750801 I  Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
2013-07-15 01:05:20.750809 I  Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
2013-07-15 01:05:20.750813 I  VidOutVDPAU: Created VDPAU context (GPU decode)
2013-07-15 01:05:20.754441 I  Over/underscan. V: 0, H: 0
2013-07-15 01:05:20.754456 I  Snapping height to avoid scaling: height: 1080, top: 0
2013-07-15 01:05:20.754465 I  Snapping width to avoid scaling: width: 1920, left: 0
2013-07-15 01:05:20.754480 I  Display Rect  left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
2013-07-15 01:05:20.754493 I  Video Rect    left: 0, top: 0, width: 1920, height: 1080, aspect: 1.77778
2013-07-15 01:05:20.754506 N  Player(0): Forcing decode extra audio option on (Video method requires it).
2013-07-15 01:05:20.754563 I  FilterManager: GetFilterInfo(convert) returning: 0x0
2013-07-15 01:05:20.754639 I  Player(0): LoadFilters('vdpaucolorspace=auto'..) -> 0x0
2013-07-15 01:05:20.758553 I  Player(0): Decoder thread starting.
2013-07-15 01:05:20.765778 I  OSD: Loaded window osd_message
2013-07-15 01:05:20.768075 I  OSD: Loaded window osd_input
2013-07-15 01:05:20.788271 I  OSD: Loaded window program_info
2013-07-15 01:05:20.791037 I  OSD: Loaded window browse_info
2013-07-15 01:05:20.793602 I  OSD: Loaded window osd_status
2013-07-15 01:05:20.796324 I  OSD: Loaded window osd_program_editor
2013-07-15 01:05:20.801837 I  OSD: Loaded window osd_debug
2013-07-15 01:05:20.801849 I  OSD: Loaded OSD: size 1920x1080 offset 0+0
2013-07-15 01:05:20.801907 I  OSD: Created window aa_OSD_SUBTITLES
2013-07-15 01:05:20.801940 I  Player(0): ClearAfterSeek(0)
2013-07-15 01:05:20.802658 I  VDP: GetFilteredDeint() : vdpau -> 'vdpauadvanceddoublerate'
2013-07-15 01:05:20.803122 I  VidOutVDPAU: Enabled deinterlacing.
2013-07-15 01:05:20.803156 I  VSYNC: DRMVideoSync: Could not open device /dev/dri/card0, No such file or directory
2013-07-15 01:05:20.803176 E  VSYNC: RTCVideoSync: Could not open /dev/rtc: 
			eno: Permission denied (13)
2013-07-15 01:05:20.803608 I  Player(0): Video timing method: USleep with busy wait
2013-07-15 01:05:20.803621 I  Player(0): Display Refresh Rate: 59.999 Video Frame Rate: 29.970
2013-07-15 01:05:20.803627 I  Player(0): SetFrameInterval ps:1 scan:1
2013-07-15 01:05:20.804386 I  playCtx: StartPlaying(): took 0 ms to start player.
2013-07-15 01:05:20.804403 I  TV: Created player.
2013-07-15 01:05:20.804425 I  TV: StartPlayer(0, WatchingPreRecorded, main) -- end ok
2013-07-15 01:05:20.804478 I  TV: Changing from None to WatchingPreRecorded
2013-07-15 01:05:20.808411 I  AOBase: OutputAudioLoop: Play Event
2013-07-15 01:05:20.821257 I  TV: DrawUnusedRects() -- begin
2013-07-15 01:05:20.821268 I  TV: DrawUnusedRects() -- end
2013-07-15 01:05:20.821328 I  TV: Main UI disabled.
2013-07-15 01:05:20.821349 I  TV: HandleStateChange(0) -- end
2013-07-15 01:05:20.821406 I  TV: tv->Playback() -- end
2013-07-15 01:05:20.821431 I  TV: Entering main playback loop.
2013-07-15 01:05:20.829726 I  VidOutVDPAU: Created VDPAU decoder (2 ref frames)
2013-07-15 01:05:20.850447 I  Player(0): Enabled deinterlacing
2013-07-15 01:05:20.920281 I  VDPAU: Added 2 output surfaces (total 4, max 4)
2013-07-15 01:05:21.071406 I  Player(0): Video is 3.4081 frames behind audio (too slow), dropping frame to catch up.
2013-07-15 01:05:21.071418 I  AOBase: Pause 1
2013-07-15 01:05:21.071485 I  Player(0): Video is 3.73986 frames behind audio (too slow), dropping frame to catch up.
2013-07-15 01:05:21.071490 I  AOBase: Pause 1
2013-07-15 01:05:21.071533 I  Player(0): Video is 3.74145 frames behind audio (too slow), dropping frame to catch up.
2013-07-15 01:05:21.071537 I  AOBase: Pause 1
2013-07-15 01:05:21.071580 I  Player(0): Video is 3.49537 frames behind audio (too slow), dropping frame to catch up.
2013-07-15 01:05:21.071585 I  AOBase: Pause 1
2013-07-15 01:05:21.071627 I  Player(0): Video is 3.05607 frames behind audio (too slow), dropping frame to catch up.
2013-07-15 01:05:21.071632 I  AOBase: Pause 1
2013-07-15 01:05:21.071671 I  AOBase: Pause 0
2013-07-15 01:05:21.080384 I  AOBase: OutputAudioLoop: Play Event


...

2013-07-15 01:05:25.538132 I  AOBase: OutputAudioLoop: Play Event
2013-07-15 01:05:25.792478 I  Player(0): Video is 3.53643 frames ahead of audio,
			doubling video frame interval to slow down.
2013-07-15 01:05:25.892574 I  Player(0): Video is 3.73872 frames ahead of audio,
			doubling video frame interval to slow down.
2013-07-15 01:05:25.992670 I  Player(0): Video is 3.36596 frames ahead of audio,
			doubling video frame interval to slow down.
2013-07-15 01:05:27.072167 E  decoding error
			eno: Unknown error 541478725 (541478725)
2013-07-15 01:05:27.088205 I  Player(0): Video is 30 frames behind audio (too slow), dropping frame to catch up.
2013-07-15 01:05:27.088219 I  AOBase: Pause 1
2013-07-15 01:05:27.088306 I  Player(0): Video is 30 frames behind audio (too slow), dropping frame to catch up.
2013-07-15 01:05:27.088315 I  AOBase: Pause 1

...

2013-07-15 01:05:27.095046 I  Player(0): Video is 30 frames behind audio (too slow), dropping frame to catch up.
2013-07-15 01:05:27.095055 I  AOBase: Pause 1
2013-07-15 01:05:27.095123 I  AOBase: OutputAudioLoop: audio paused
2013-07-15 01:05:27.095126 I  Player(0): Video is 30 frames behind audio (too slow), dropping frame to catch up.
2013-07-15 01:05:27.095134 I  AOBase: Pause 1
2013-07-15 01:05:27.095145 I  AOBase: OutputAudioLoop: audio paused
2013-07-15 01:05:27.095187 I  Player(0): Video is 30 frames behind audio (too slow), dropping frame to catch up.
2013-07-15 01:05:27.095237 I  Player(0): Video is 30 frames behind audio (too slow), dropping frame to catch up.

And then thousands of lines of

2013-07-15 01:06:37.522728 I  Player(1): Video is 30 frames behind audio (too slow), dropping frame to catch up.
2013-07-15 01:06:37.522768 I  Player(1): Video is 30 frames behind audio (too slow), dropping frame to catch up.
2013-07-15 01:06:37.522795 I  Player(1): Video is 30 frames behind audio (too slow), dropping frame to catch up.
2013-07-15 01:06:37.522820 I  Player(1): Video is 30 frames behind audio (too slow), dropping frame to catch up.
2013-07-15 01:06:37.522843 I  Player(1): Video is 30 frames behind audio (too slow), dropping frame to catch up.
2013-07-15 01:06:37.522870 I  Player(1): Video is 30 frames behind audio (too slow), dropping frame to catch up.

I never see the entry showing that it is near the end of the recording and slowing down to 1x speed as recordings that do not have this problem typically have.

Sorry I do not have any more information. Do not have a debug build running. I run the frontend with 'mythfrontend -v playback,important,audio'. If I can reproduce, any other verbose options that might help? If you need me to run gdb, I won't have an opportunity until at least next Sunday.

Change History (4)

comment:1 Changed 6 years ago by Jim Stichnoth

Component: MythTV - GeneralMythTV - Video Playback
Status: newinfoneeded_new
Version: UnspecifiedMaster Head

Could you try reverting 0aedcaef7a16b17712dfe6502cb2e6354e3b6f0c and cef316f803117339a3e954531aedd00b462a81e9 (or equivalently, apply http://pastebin.com/NbB9EmdG) and see if that changes the behavior on the problematic recording?

comment:2 Changed 6 years ago by voltaire1983red@…

Applying the patch seems to resolve the behavior.

Was able to reproduce 2/2 attempts without the patch and was unable to 5 times with the patch.

comment:3 Changed 6 years ago by paulh

Milestone: unknown0.27
Owner: set to Jim Stichnoth
Priority: minorblocker

comment:4 Changed 6 years ago by Jim Stichnoth

Resolution: Fixed
Status: infoneeded_newclosed

This should have been fixed by 8b542e208d6a11c9d5d43a32a07ca8b82e9f2185 . If not, please re-open.

Note: See TracTickets for help on using tickets.