Login | Register For Free | Help
Search for: (Advanced)

Mailing List Archive: MythTV: Dev

Recorded show plays back with time stretch

 

 

MythTV dev RSS feed   Index | Next | Previous | View Threaded


dan at hentschels

Aug 31, 2012, 11:56 AM

Post #1 of 3 (433 views)
Permalink
Recorded show plays back with time stretch

I have been using MythTV for more than 5 years, and don't remember seeing
anything like this before. Any ideas? I just started recording The Wiggles
for my children. I have recorded four episodes across two weekends.
Recording is done via HDHomerun from ATSC antenna source. All four episodes
play back (from the Watch Recordings menu option) at a very slow rate. I
have tried playing on two different frontends with the same results on
both. If I manually adjust the time stretch to 1.0x, then they play at
normal speed. I was hopeful that transcoding the episodes (after I cut
commercials) would fix the problem, but no change.

I have over 1000 recordings on my backend, many of them recorded on the
same channel (NBC) from the same tuner. I don't know what's different about
these four shows. The frontend log has a suspicious entry in it:
"(SetStretchFactorLocked) AO: Using time stretch 0.45".

Here is the relevant section of a frontend log file:


Aug 31 07:30:14 ZBox-down mythfrontend[2649]: I CoreContext tv_play.cpp:987
(TV) TV: Creating TV object
Aug 31 07:30:14 ZBox-down mythfrontend[2649]: N CoreContext
mythmainwindow.cpp:2591 (PauseIdleTimer) Resuming idle timer
Aug 31 07:30:14 ZBox-down mythfrontend[2649]: N CoreContext
mythmainwindow.cpp:2586 (PauseIdleTimer) Suspending idle timer
Aug 31 07:30:14 ZBox-down mythfrontend[2649]: I CoreContext
tv_play.cpp:1206 (Init) TV: Created TvPlayWindow.
Aug 31 07:30:14 ZBox-down mythfrontend[2649]: I CoreContext
tv_play.cpp:2121 (HandleStateChange) TV: Attempting to change from None to
WatchingPreRecorded
Aug 31 07:30:15 ZBox-down mythfrontend[2649]: N CoreContext
audioplayer.cpp:167 (ReinitAudio) AudioPlayer: Enabling Audio
Aug 31 07:30:15 ZBox-down mythfrontend[2649]: I CoreContext
avformatdecoder.cpp:2102 (ScanStreams) AFD: Opened codec 0xae17b50,
id(MPEG2VIDEO) type(Video)
Aug 31 07:30:15 ZBox-down mythfrontend[2649]: I CoreContext
avformatdecoder.cpp:1960 (ScanStreams) AFD: codec AC3 has 6 channels
Aug 31 07:30:15 ZBox-down mythfrontend[2649]: I CoreContext
avformatdecoder.cpp:2102 (ScanStreams) AFD: Opened codec 0x9ad6340, id(AC3)
type(Audio)
Aug 31 07:30:15 ZBox-down mythfrontend[2649]: I CoreContext
audio/audiooutputbase.cpp:791 (Reconfigure) AO: Opening audio device
'iec958:CARD=Intel,DEV=0' ch 2(6) sr 48000 sf signed 16 bit reenc 1
Aug 31 07:30:15 ZBox-down mythfrontend[2649]: E CoreContext
audio/audiooutputalsa.cpp:195 (SetPreallocBufferSize) ALSA: Setting
hardware audio buffer size to 128
Aug 31 07:30:15 ZBox-down mythfrontend[2649]: E CoreContext
audio/audiooutputalsa.cpp:211 (SetPreallocBufferSize) ALSA: Error opening
/proc/asound/card0/pcm1p/sub0/prealloc: Permission denied.
Aug 31 07:30:15 ZBox-down mythfrontend[2649]: E CoreContext
audio/audiooutputalsa.cpp:213 (SetPreallocBufferSize) ALSA: Try to manually
increase audio buffer with: echo 128 | sudo tee
/proc/asound/card0/pcm1p/sub0/prealloc
Aug 31 07:30:15 ZBox-down mythfrontend[2649]: E CoreContext
audio/audiooutputalsa.cpp:545 (OpenDevice) ALSA: Unable to sufficiently
increase ALSA hardware buffer size - underruns are likely
Aug 31 07:30:15 ZBox-down mythfrontend[2649]: I CoreContext
audio/audiooutputbase.cpp:353 (SetStretchFactorLocked) AO: Using time
stretch 0.45
Aug 31 07:30:16 ZBox-down mythfrontend[2649]: I CoreContext
mythpainter_ogl.cpp:62 (ClearCache) Clearing OpenGL painter cache.
Aug 31 07:30:17 ZBox-down mythfrontend[2649]: I CoreContext
mythrender_vdpau.cpp:1675 (CreatePresentationSurfaces) VDPAU: Created 2
output surfaces.
Aug 31 07:30:17 ZBox-down mythfrontend[2649]: I CoreContext
mythrender_vdpau.cpp:401 (Create) VDPAU: Created VDPAU render device
1920x1080
Aug 31 07:30:17 ZBox-down mythfrontend[2649]: N CoreContext
mythplayer.cpp:506 (CheckExtraAudioDecode) Player(3): Forcing decode extra
audio option on (Video method requires it).
Aug 31 07:30:17 ZBox-down mythfrontend[2649]: E CoreContext
mythplayer.cpp:2308 (VideoStart) Player(3): Video sync method can't support
double framerate (refresh rate too low for 2x deint)
Aug 31 07:30:17 ZBox-down mythfrontend[2649]: I CoreContext
mythplayer.cpp:1737 (InitAVSync) Player(3): Video timing method: USleep
with busy wait
Aug 31 07:30:17 ZBox-down mythfrontend[2649]: I CoreContext
tv_play.cpp:5169 (StartPlayer) TV: Created player.
Aug 31 07:30:17 ZBox-down mythfrontend[2649]: I CoreContext
tv_play.cpp:2360 (HandleStateChange) TV: Changing from None to
WatchingPreRecorded
Aug 31 07:30:17 ZBox-down mythfrontend[2649]: I CoreContext
tv_play.cpp:2451 (HandleStateChange) TV: Main UI disabled.
Aug 31 07:30:17 ZBox-down mythfrontend[2649]: I CoreContext tv_play.cpp:378
(StartTV) TV: Entering main playback loop.
Aug 31 07:30:17 ZBox-down mythfrontend[2649]: I CoreContext
mythrender_vdpau.cpp:587 (CheckOutputSurfaces) VDPAU: Added 2 output
surfaces (total 4, max 4)
Aug 31 07:30:17 ZBox-down mythfrontend[2649]: I CoreContext
subtitlescreen.cpp:766 (InitializeFonts) InitializeFonts()


--
dan B hentschel
dan [at] hentschels


joe at thefrys

Aug 31, 2012, 7:48 PM

Post #2 of 3 (394 views)
Permalink
Re: Recorded show plays back with time stretch [In reply to]

>
> I have been using MythTV for more than 5 years, and don't remember seeing
> anything like this before. Any ideas? I just started recording The Wiggles
> for my children. I have recorded four episodes across two weekends.
> Recording is done via HDHomerun from ATSC antenna source. All four episodes
> play back (from the Watch Recordings menu option) at a very slow rate. I
> have tried playing on two different frontends with the same results on
> both. If I manually adjust the time stretch to 1.0x, then they play at
> normal speed. I was hopeful that transcoding the episodes (after I cut
> commercials) would fix the problem, but no change.
>
> I have over 1000 recordings on my backend, many of them recorded on the
> same channel (NBC) from the same tuner. I don't know what's different about
> these four shows. The frontend log has a suspicious entry in it:
> "(SetStretchFactorLocked) AO: Using time stretch 0.45".
>
> Here is the relevant section of a frontend log file:
>
>
> Aug 31 07:30:14 ZBox-down mythfrontend[2649]: I CoreContext
> tv_play.cpp:987 (TV) TV: Creating TV object
> Aug 31 07:30:14 ZBox-down mythfrontend[2649]: N CoreContext
> mythmainwindow.cpp:2591 (PauseIdleTimer) Resuming idle timer
> Aug 31 07:30:14 ZBox-down mythfrontend[2649]: N CoreContext
> mythmainwindow.cpp:2586 (PauseIdleTimer) Suspending idle timer
> Aug 31 07:30:14 ZBox-down mythfrontend[2649]: I CoreContext
> tv_play.cpp:1206 (Init) TV: Created TvPlayWindow.
> Aug 31 07:30:14 ZBox-down mythfrontend[2649]: I CoreContext
> tv_play.cpp:2121 (HandleStateChange) TV: Attempting to change from None to
> WatchingPreRecorded
> Aug 31 07:30:15 ZBox-down mythfrontend[2649]: N CoreContext
> audioplayer.cpp:167 (ReinitAudio) AudioPlayer: Enabling Audio
> Aug 31 07:30:15 ZBox-down mythfrontend[2649]: I CoreContext
> avformatdecoder.cpp:2102 (ScanStreams) AFD: Opened codec 0xae17b50,
> id(MPEG2VIDEO) type(Video)
> Aug 31 07:30:15 ZBox-down mythfrontend[2649]: I CoreContext
> avformatdecoder.cpp:1960 (ScanStreams) AFD: codec AC3 has 6 channels
> Aug 31 07:30:15 ZBox-down mythfrontend[2649]: I CoreContext
> avformatdecoder.cpp:2102 (ScanStreams) AFD: Opened codec 0x9ad6340, id(AC3)
> type(Audio)
> Aug 31 07:30:15 ZBox-down mythfrontend[2649]: I CoreContext
> audio/audiooutputbase.cpp:791 (Reconfigure) AO: Opening audio device
> 'iec958:CARD=Intel,DEV=0' ch 2(6) sr 48000 sf signed 16 bit reenc 1
> Aug 31 07:30:15 ZBox-down mythfrontend[2649]: E CoreContext
> audio/audiooutputalsa.cpp:195 (SetPreallocBufferSize) ALSA: Setting
> hardware audio buffer size to 128
> Aug 31 07:30:15 ZBox-down mythfrontend[2649]: E CoreContext
> audio/audiooutputalsa.cpp:211 (SetPreallocBufferSize) ALSA: Error opening
> /proc/asound/card0/pcm1p/sub0/prealloc: Permission denied.
> Aug 31 07:30:15 ZBox-down mythfrontend[2649]: E CoreContext
> audio/audiooutputalsa.cpp:213 (SetPreallocBufferSize) ALSA: Try to manually
> increase audio buffer with: echo 128 | sudo tee
> /proc/asound/card0/pcm1p/sub0/prealloc
> Aug 31 07:30:15 ZBox-down mythfrontend[2649]: E CoreContext
> audio/audiooutputalsa.cpp:545 (OpenDevice) ALSA: Unable to sufficiently
> increase ALSA hardware buffer size - underruns are likely
> Aug 31 07:30:15 ZBox-down mythfrontend[2649]: I CoreContext
> audio/audiooutputbase.cpp:353 (SetStretchFactorLocked) AO: Using time
> stretch 0.45
> Aug 31 07:30:16 ZBox-down mythfrontend[2649]: I CoreContext
> mythpainter_ogl.cpp:62 (ClearCache) Clearing OpenGL painter cache.
> Aug 31 07:30:17 ZBox-down mythfrontend[2649]: I CoreContext
> mythrender_vdpau.cpp:1675 (CreatePresentationSurfaces) VDPAU: Created 2
> output surfaces.
> Aug 31 07:30:17 ZBox-down mythfrontend[2649]: I CoreContext
> mythrender_vdpau.cpp:401 (Create) VDPAU: Created VDPAU render device
> 1920x1080
> Aug 31 07:30:17 ZBox-down mythfrontend[2649]: N CoreContext
> mythplayer.cpp:506 (CheckExtraAudioDecode) Player(3): Forcing decode extra
> audio option on (Video method requires it).
> Aug 31 07:30:17 ZBox-down mythfrontend[2649]: E CoreContext
> mythplayer.cpp:2308 (VideoStart) Player(3): Video sync method can't support
> double framerate (refresh rate too low for 2x deint)
> Aug 31 07:30:17 ZBox-down mythfrontend[2649]: I CoreContext
> mythplayer.cpp:1737 (InitAVSync) Player(3): Video timing method: USleep
> with busy wait
> Aug 31 07:30:17 ZBox-down mythfrontend[2649]: I CoreContext
> tv_play.cpp:5169 (StartPlayer) TV: Created player.
> Aug 31 07:30:17 ZBox-down mythfrontend[2649]: I CoreContext
> tv_play.cpp:2360 (HandleStateChange) TV: Changing from None to
> WatchingPreRecorded
> Aug 31 07:30:17 ZBox-down mythfrontend[2649]: I CoreContext
> tv_play.cpp:2451 (HandleStateChange) TV: Main UI disabled.
> Aug 31 07:30:17 ZBox-down mythfrontend[2649]: I CoreContext
> tv_play.cpp:378 (StartTV) TV: Entering main playback loop.
> Aug 31 07:30:17 ZBox-down mythfrontend[2649]: I CoreContext
> mythrender_vdpau.cpp:587 (CheckOutputSurfaces) VDPAU: Added 2 output
> surfaces (total 4, max 4)
> Aug 31 07:30:17 ZBox-down mythfrontend[2649]: I CoreContext
> subtitlescreen.cpp:766 (InitializeFonts) InitializeFonts()
>
>
I feel your pain... 30 minutes of the wiggles is bad... stretching it out
to over 60 minutes sounds like a nightmare come true.

Sounds like you have a playback group assigned to the Wiggles? Never used
playback groups, but I believe you can set the speed on them.


dan at hentschels

Sep 4, 2012, 6:48 AM

Post #3 of 3 (370 views)
Permalink
Re: Recorded show plays back with time stretch [In reply to]

On Fri, Aug 31, 2012 at 10:48 PM, Joseph Fry <joe [at] thefrys> wrote:
>
> I feel your pain... 30 minutes of the wiggles is bad... stretching it out
> to over 60 minutes sounds like a nightmare come true.
>
> Sounds like you have a playback group assigned to the Wiggles? Never used
> playback groups, but I believe you can set the speed on them.
>
>
Thanks! I hadn't considered the playback group. That is exactly what was
causing the problem, although the playback group I was using had the speed
set to "default". I can't imagine in what world "default" would map to
0.45x, but when I set it to 100, everything started working fine. Thanks
again.


--
dan B hentschel
dan [at] hentschels

MythTV dev RSS feed   Index | Next | Previous | View Threaded
 
 


Interested in having your list archived? Contact Gossamer Threads
 
  Web Applications & Managed Hosting Powered by Gossamer Threads Inc.