[mythtv-users] Ticket #9177: "Error opening jump program file buffer" when changing channels in live TV

[lstyles at yahoo.com]

I have a similar sounding problem. I'm hoping someone can tell me whether it 
matches ticket #9177 (or any other existing tickets.)

I have a combination frontend/backend system with a single PCTV 800i HD Card 
that records to a single local ext4 drive. I receive NTSC and ClearQAM channels 
from my cable provider through a coax cable connected directly to the PCTV card.

Prior to upgrading to 0.24 fixes everything worked fine. But since upgrading, if 
I change from one NTSC channel to another NTSC channel when watching live TV I 
get an "Error opening jump program file" message and mythfrontend stops 
responding. The strange thing (to me at least) is that the problem only occurs 
when switching between NTSC channels. Switching between two ClearQAM channels or 
between a ClearQAM and an NTSC channel works just fine.

In case it helps, below are the excerpts from my frontend and backend logs as 
well as my backend version info.

***mythbackend.log***

2011-06-13 16:11:37.383 TVRec(6): Changing from None to WatchingLiveTV
2011-06-13 16:11:37.432 TVRec(6): HW Tuner: 6->6
2011-06-13 16:11:37.511 AutoExpire: CalcParams(): Max required Free Space: 2.0 
GB w/freq: 15 min
2011-06-13 16:11:37.538 LoadFromScheduler(): Error, called from backend.
2011-06-13 16:11:38.600 Finished recording iCarly "iParty With Victorious": 
channel 1042
2011-06-13 16:11:38.649 LoadFromScheduler(): Error, called from backend.
2011-06-13 16:11:38.652 AutoExpire: CalcParams(): Max required Free Space: 2.0 
GB w/freq: 15 min
2011-06-13 16:11:38.760 Finished recording iCarly "iParty With Victorious": 
channel 1042
2011-06-13 16:11:41.979 RecBase(6:/dev/video0): 
GetKeyframePositions(3,9223372036854775807,#0) out of 3
2011-06-13 16:11:42.054 RecBase(6:/dev/video0): 
GetKeyframePositions(3,9223372036854775807,#1) out of 4
2011-06-13 16:12:27.326 TVRec(6): HW Tuner: 6->6
2011-06-13 16:12:27.343 LoadFromScheduler(): Error, called from backend.
2011-06-13 16:12:27.347 AutoExpire: CalcParams(): Max required Free Space: 2.0 
GB w/freq: 15 min
2011-06-13 16:12:27.771 Finished recording iCarly "iParty With Victorious": 
channel 1042
2011-06-13 16:12:28.044 MainServer::ANN Monitor
2011-06-13 16:12:28.060 adding: mythbox as a client (events: 0)
2011-06-13 16:12:28.072 MainServer::ANN Monitor
2011-06-13 16:12:28.082 adding: mythbox as a client (events: 1)
2011-06-13 16:12:28.249 Finished recording Sherlock Holmes in Terror by Night: 
channel 1064
2011-06-13 16:12:28.263 LoadFromScheduler(): Error, called from backend.
2011-06-13 16:12:28.267 AutoExpire: CalcParams(): Max required Free Space: 2.0 
GB w/freq: 15 min
2011-06-13 16:12:28.289 Finished recording Sherlock Holmes in Terror by Night: 
channel 1064
2011-06-13 16:12:28.652 TVRec(6): Changing from WatchingLiveTV to None
2011-06-13 16:12:29.091 MainServer::ANN Playback
2011-06-13 16:12:29.100 adding: mythbox as a client (events: 0)
2011-06-13 16:12:29.120 TVRec(6): Changing from None to WatchingLiveTV
2011-06-13 16:12:29.136 TVRec(6): HW Tuner: 6->6
2011-06-13 16:12:29.152 LoadFromScheduler(): Error, called from backend.
2011-06-13 16:12:29.156 AutoExpire: CalcParams(): Max required Free Space: 2.0 
GB w/freq: 15 min
2011-06-13 16:12:29.306 TVRec(6): Changing from WatchingLiveTV to None
2011-06-13 16:12:29.442 Channel(/dev/video0) Error: 
InitPictureAttribute(brightness): failed to query controls.
            eno: Bad file descriptor (9)
Error in my_thread_global_end(): 1 threads didn't exit


***mythfrontend.log***

2011-06-13 16:11:36.938 New DB connection, total: 1
2011-06-13 16:11:36.948 Connected to database 'mythconverg' at host: 192.168.1.4
2011-06-13 16:11:37.238 TV: Attempting to change from None to WatchingLiveTV
2011-06-13 16:11:37.238 MythCoreContext: Connecting to backend server: 
192.168.1.4:6543 (try 1 of 1)
2011-06-13 16:11:37.238 Using protocol version 63
2011-06-13 16:11:37.326 Spawning LiveTV Recorder -- begin
2011-06-13 16:11:38.345 Spawning LiveTV Recorder -- end
2011-06-13 16:11:38.351 We have a 
playbackURL(/var/lib/mythtv/livetv/1042_20110613161137.nuv) & cardtype(DUMMY)
2011-06-13 16:11:38.351 We have a RingBuffer
2011-06-13 16:11:39.455 VideoOutputXv: XVideo Adaptor Name: 'Intel(R) Textured 
Video'
2011-06-13 16:11:39.511 OSD: Base theme size: 1280x720
2011-06-13 16:11:39.512 OSD: Scaling factors: 0.5625x0.8
2011-06-13 16:11:39.767 OSD: Base theme size: 1280x720
2011-06-13 16:11:39.767 OSD: Scaling factors: 0.5625x0.8
YadifDeint: In-Pixformat = 1 Out-Pixformat=1
YadifDeint: size changed from 0 x 0 -> 720 x 576
yadifdeint: Created 2 threads (2 requested)
2011-06-13 16:11:39.824 Player(2): Video timing method: DRM
2011-06-13 16:11:39.840 TV: Changing from None to WatchingLiveTV
2011-06-13 16:11:39.840 TV: State is LiveTV & mctx == ctx
2011-06-13 16:11:39.841 TV: UpdateOSDInput done
2011-06-13 16:11:39.841 TV: UpdateLCD done
2011-06-13 16:11:39.841 TV: ITVRestart done
2011-06-13 16:11:39.886 Using Idle Timer. 180 minutes
2011-06-13 16:11:39.887 pause_active: 0
2011-06-13 16:11:40.656 New DB connection, total: 2
2011-06-13 16:11:40.656 Connected to database 'mythconverg' at host: 192.168.1.4
YadifDeint: In-Pixformat = 1 Out-Pixformat=1
YadifDeint: In-Pixformat = 1 Out-Pixformat=1
YadifDeint: size changed from 0 x 0 -> 720 x 576
yadifdeint: Created 2 threads (2 requested)
YadifDeint: size changed from 0 x 0 -> 480 x 480
yadifdeint: Created 2 threads (2 requested)
2011-06-13 16:11:41.550 VideoOutputXv: XVideo Adaptor Name: 'Intel(R) Textured 
Video'
2011-06-13 16:11:41.587 OSD: Base theme size: 1280x720
2011-06-13 16:11:41.587 OSD: Scaling factors: 1.13516x0.470833
2011-06-13 16:11:41.866 AO: Opening audio device 'default' ch 2(2) sr 48000 sf 
signed 32 bit reenc 0
2011-06-13 16:11:41.925 ALSA, Error: Setting hardware audio buffer size to 6016
2011-06-13 16:11:41.925 ALSA, Error: Error opening 
/proc/asound/card0/pcm0p/sub0/prealloc: Permission denied. 

2011-06-13 16:11:41.925 ALSA, Error: Try to manually increase audio buffer with: 
echo 6016 | sudo tee /proc/asound/card0/pcm0p/sub0/prealloc
2011-06-13 16:11:41.925 ALSA, Error: Unable to sufficiently increase ALSA 
hardware buffer size - underruns are likely
2011-06-13 16:11:41.976 AudioPlayer: Enabling Audio
2011-06-13 16:11:42.568 Player(2): Waited 100ms for video buffers 
AAAAAAAAAAAAAAAAAAAAUUUUUUUUUUU
2011-06-13 16:11:42.585 Player(2): Waited 100ms for video buffers 
AAAAAAAAAAAAAAAAAAAAUUUUUUUUUUU
2011-06-13 16:11:42.953 Player(2): Waited 100ms for video buffers 
AAAAAAAAAAAAAAAAAAAAUUUUUUUUUUU
2011-06-13 16:11:42.969 Player(2): Waited 100ms for video buffers 
AAAAAAAAAAAAAAAAAAAAUUUUUUUUUUU
2011-06-13 16:12:27.234 OSD: Base theme size: 1280x720
2011-06-13 16:12:27.234 OSD: Scaling factors: 0.375x0.666667
2011-06-13 16:12:27.297 Clearing OpenGL painter cache.
YadifDeint: In-Pixformat = 1 Out-Pixformat=1
YadifDeint: size changed from 0 x 0 -> 480 x 480
yadifdeint: Created 2 threads (2 requested)
2011-06-13 16:12:28.157 VideoOutput: Created YV12 OSD.
2011-06-13 16:12:28.335 RingBuf(/var/lib/mythtv/livetv/1064_20110613161228.nuv) 
Warning: Not starting read ahead thread, already running
2011-06-13 16:12:28.523 Player(2), Error: Couldn't find an A/V decoder for: 
'/var/lib/mythtv/livetv/1064_20110613161228.nuv'
2011-06-13 16:12:28.523 Player(2), Error: JumpToProgram failed.
2011-06-13 16:12:28.523 Player(2), Error: Unknown recorder error, exiting 
decoder
2011-06-13 16:12:28.577 TV: Attempting to change from WatchingLiveTV to None
2011-06-13 16:12:29.078 TV: Changing from WatchingLiveTV to None
2011-06-13 16:12:29.080 TV: Attempting to change from None to None
2011-06-13 16:12:29.090 TV: Attempting to change from None to WatchingLiveTV
2011-06-13 16:12:29.090 MythCoreContext: Connecting to backend server: 
192.168.1.4:6543 (try 1 of 1)
2011-06-13 16:12:29.090 Using protocol version 63
2011-06-13 16:12:29.119 Spawning LiveTV Recorder -- begin
2011-06-13 16:12:29.293 Spawning LiveTV Recorder -- end
2011-06-13 16:12:29.299 We have a 
playbackURL(/var/lib/mythtv/livetv/1042_20110613161229.nuv) & cardtype(DUMMY)
2011-06-13 16:12:29.301 We have a RingBuffer
2011-06-13 16:12:29.301 playCtx, Error: Attempting to setup a player, but it 
already exists.
2011-06-13 16:12:29.301 TV Error: LiveTV not successfully started
2011-06-13 16:12:29.302 Using Idle Timer. 180 minutes
2011-06-13 16:12:29.302 pause_active: 1
QMutex::lock: mutex lock failure: 


***mythbackend --version***

Please attach all output as a file in bug reports.
MythTV Version   : v0.24.1-9-g3657f31
MythTV Branch    : fixes/0.24
Network Protocol : 63
Library API      : 0.24.20110505-1
QT Version       : 4.6.2
Options compiled in:
 linux debug using_alsa using_oss using_pulse using_pulseoutput using_backend 
using_bindings_perl using_bindings_python using_directfb using_dvb 
using_firewire using_frontend using_hdhomerun using_hdpvr using_iptv using_ivtv 
using_joystick_menu using_lirc using_mheg using_opengl_video using_opengl_vsync 
using_qtdbus using_qtwebkit using_v4l using_x11 using_xrandr using_xv 
using_bindings_perl using_bindings_python using_mythtranscode using_opengl 
using_vdpau using_ffmpeg_threads using_live using_mheg