[mythtv-users] Analog tuner - can't change channels

Mark Yovorsky mythtv at m4.itbitme.org
Sun Jan 15 22:41:46 UTC 2012


I've just reinstalled my mythtv box, and I'm having trouble getting channel changing to work.
This is a combined frontend/backend, running on Ubuntu 10.04, with the mythbuntu packages, on version 0.24-fixes.20120112

In LiveTV, myth will tune to the starting channel, but changing channels either gives me an "Unknown recorder error" or locks up the frontend until I manually kill it.  Scheduled recordings also fail, with an message about being unable to change channel

I've tried two different tuners -  a generic PCI card (claiming to be a Sabrent SBT-TVFM) and a Hauppauge 61381, connected to analog cable. 
They work properly with both tvtime and xawtv, and under previous myth versions. I can also start LiveTV and change channels manually with v4l2-ctl
So, the problem seems to be somewhere within myth, but I'm not sure what to check at this point.

I've also compared my channels table to a backup of my previous one, and they appear to be similar
I also found that scanning for channels using the hauppage card crashed mythtv-setup every time, while it successfully worked with the generic one.


Here are some logs (with -v channel), watching LiveTV with a starting channel of 3, trying to change it to 4, using the generic PCI tuner card.

2012-01-15 16:39:35.865 mythbackend version: fixes/0.24 [v0.24.1-120-g294968b] www.mythtv.org
2012-01-15 16:39:35.865 Using runtime prefix = /usr
2012-01-15 16:39:35.865 Using configuration directory = /home/local/.mythtv
2012-01-15 16:39:35.866 Empty LocalHostName.
2012-01-15 16:39:35.866 Using localhost value of gonzo
2012-01-15 16:39:35.870 New DB connection, total: 1
2012-01-15 16:39:35.873 Connected to database 'mythconverg' at host: localhost
2012-01-15 16:39:35.875 Closing DB connection named 'DBManager0'
2012-01-15 16:39:35.875 Connected to database 'mythconverg' at host: localhost
2012-01-15 16:39:35.876 Current locale EN_US
2012-01-15 16:39:35.877 Reading locale defaults from /usr/share/mythtv//locales/en_us.xml
2012-01-15 16:39:35.884 Current MythTV Schema Version (DBSchemaVer): 1264
2012-01-15 16:39:35.887 ThreadPool:HTTP: Initial 1, Max 25, Timeout 60000
2012-01-15 16:39:35.894 Enabling Upnpmedia rebuild thread.
2012-01-15 16:39:37.097 MythBackend: Starting up as the master server.
2012-01-15 16:39:37.099 mythbackend: MythBackend started as master server
2012-01-15 16:39:37.100 New DB connection, total: 2
2012-01-15 16:39:37.101 Connected to database 'mythconverg' at host: localhost
2012-01-15 16:39:37.102 TVRec(2): Start channel: 3.
2012-01-15 16:39:37.115 Channel(/dev/video0): Device name 'Sabrent SBT-TVFM (saa7130)' driver 'saa7134'.
2012-01-15 16:39:37.115 New DB connection, total: 3
2012-01-15 16:39:37.115 Connected to database 'mythconverg' at host: localhost
2012-01-15 16:39:37.126 ChannelBase(2): Input #3: 'Television' schan(3) sourceid(1) ccid(2)
2012-01-15 16:39:37.126 ChannelBase(2): Current Input #3: 'Television'
2012-01-15 16:39:37.126 Global TVFormat Setting 'NTSC'
2012-01-15 16:39:37.126 Channel(/dev/video0): Input #3: 'Television' schan(3) tun() v4l1(NTSC) v4l2(NTSC)
2012-01-15 16:39:37.126 Channel(/dev/video0): SetFormat(Default) fmt(NTSC) input(3)
2012-01-15 16:39:37.126 Channel(/dev/video0): SetInputAndFormat(3, NTSC) (v4l v2)
2012-01-15 16:39:37.164 Channel(/dev/video0): SetFormat(NTSC) fmt(NTSC) input(3)
2012-01-15 16:39:37.165 Channel(/dev/video0)::SwitchToInput(in 3, '')
2012-01-15 16:39:37.165 Channel(/dev/video0): SetInputAndFormat(3, NTSC) (v4l v2)
2012-01-15 16:39:37.204 ChannelBase(2): SelectChannel 3
2012-01-15 16:39:37.205 Channel(/dev/video0): SetChannelByString(3)
2012-01-15 16:39:37.206 Channel(/dev/video0): SetFormat(Default) fmt(NTSC) input(3)
2012-01-15 16:39:37.206 Channel(/dev/video0)::TuneTo(3): curList[1].freq(61250)
2012-01-15 16:39:37.206 Channel(/dev/video0): Tune(61250000, , analog, analog)
2012-01-15 16:39:37.224 Channel(/dev/video0)::Tune(): Frequency is now 61250000
2012-01-15 16:39:37.225 Channel(/dev/video0): InitPictureAttribute(brightness):  128
			[    0,  255] dflt(  128, 0.50, 128)
2012-01-15 16:39:37.226 Channel(/dev/video0): InitPictureAttribute(  contrast):  67
			[    0,  127] dflt(   68, 0.54, 2321)
2012-01-15 16:39:37.226 Channel(/dev/video0): InitPictureAttribute(    colour):  63
			[    0,  127] dflt(   64, 0.50, 257)
2012-01-15 16:39:37.227 Channel(/dev/video0): InitPictureAttribute(       hue):  0
			[ -128,  127] dflt(    0, 0.50, 128)
2012-01-15 16:39:37.236 New DB scheduler connection
2012-01-15 16:39:37.237 Connected to database 'mythconverg' at host: localhost
2012-01-15 16:39:37.239 Main::Registering HttpStatus Extension
2012-01-15 16:39:37.239 Enabled verbose msgs:  important general channel
2012-01-15 16:39:37.243 AutoExpire: CalcParams(): Max required Free Space: 1.0 GB w/freq: 15 min
2012-01-15 16:39:40.243 Reschedule requested for id -1.
2012-01-15 16:39:40.326 Scheduled 14 items in 0.1 = 0.00 match + 0.08 place
2012-01-15 16:39:40.328 scheduler: Scheduled items: Scheduled 14 items in 0.1 = 0.00 match + 0.08 place
2012-01-15 16:39:40.330 Seem to be woken up by USER
2012-01-15 16:39:38.698 UPnpMedia: BuildMediaMap VIDEO scan starting in :/var/lib/mythtv/videos:
2012-01-15 16:39:38.699 UPnpMedia: BuildMediaMap Done. Found 0 objects
2012-01-15 16:39:40.044 mythbackend: Running housekeeping thread
2012-01-15 16:39:50.178 MainServer::ANN Monitor
2012-01-15 16:39:50.178 adding: gonzo as a client (events: 0)
2012-01-15 16:39:50.179 MainServer::ANN Monitor
2012-01-15 16:39:50.179 adding: gonzo as a client (events: 1)
2012-01-15 16:39:54.979 MainServer::ANN Playback
2012-01-15 16:39:54.979 adding: gonzo as a client (events: 0)
2012-01-15 16:39:54.982 TVRec(2): Changing from None to WatchingLiveTV
2012-01-15 16:39:54.983 ChannelBase(2): Looking for startchannel '3' on input 'Television'
2012-01-15 16:39:54.984 ChannelBase(2): Found startchannel '3' on input 'Television'
2012-01-15 16:39:54.984 TVRec(2): HW Tuner: 2->2
2012-01-15 16:39:54.999 Channel(/dev/video0): Device name 'Sabrent SBT-TVFM (saa7130)' driver 'saa7134'.
2012-01-15 16:39:55.009 ChannelBase(2): Input #3: 'Television' schan(3) sourceid(1) ccid(2)
2012-01-15 16:39:55.009 ChannelBase(2): Current Input #3: 'Television'
2012-01-15 16:39:55.009 Global TVFormat Setting 'NTSC'
2012-01-15 16:39:55.009 Channel(/dev/video0): Input #3: 'Television' schan(3) tun() v4l1(NTSC) v4l2(NTSC)
2012-01-15 16:39:55.009 Channel(/dev/video0): SetFormat(Default) fmt(NTSC) input(3)
2012-01-15 16:39:55.011 LoadFromScheduler(): Error, called from backend.
2012-01-15 16:39:55.012 AutoExpire: CalcParams(): Max required Free Space: 2.0 GB w/freq: 15 min
2012-01-15 16:39:55.027 Channel(/dev/video0)::SwitchToInput(in 3, '')
2012-01-15 16:39:55.028 Channel(/dev/video0): SetInputAndFormat(3, NTSC) (v4l v2)
2012-01-15 16:39:55.067 ChannelBase(2): SelectChannel 3
2012-01-15 16:39:55.067 SM(/dev/video0)::Start: begin
2012-01-15 16:39:55.067 ChannelThread::run
2012-01-15 16:39:55.068 Channel(/dev/video0): SetChannelByString(3)
2012-01-15 16:39:55.068 SM(/dev/video0)::Start: end
2012-01-15 16:39:55.071 Channel(/dev/video0): SetFormat(Default) fmt(NTSC) input(3)
2012-01-15 16:39:55.071 Channel(/dev/video0)::TuneTo(3): curList[1].freq(61250)
2012-01-15 16:39:55.071 Channel(/dev/video0): Tune(61250000, , analog, analog)
2012-01-15 16:39:55.089 Channel(/dev/video0)::Tune(): Frequency is now 61250000
2012-01-15 16:39:55.090 Channel(/dev/video0): InitPictureAttribute(brightness):  128
			[    0,  255] dflt(  128, 0.50, 128)
2012-01-15 16:39:55.091 Channel(/dev/video0): InitPictureAttribute(  contrast):  67
			[    0,  127] dflt(   68, 0.54, 2321)
2012-01-15 16:39:55.091 Channel(/dev/video0): InitPictureAttribute(    colour):  63
			[    0,  127] dflt(   64, 0.50, 257)
2012-01-15 16:39:55.092 Channel(/dev/video0): InitPictureAttribute(       hue):  0
			[ -128,  127] dflt(    0, 0.50, 128)
2012-01-15 16:39:55.118 SM(/dev/video0)::Stop: begin
2012-01-15 16:39:55.168 SM(/dev/video0)::Stop: end
2012-01-15 16:39:55.170 Finished recording Iron Man: channel 1003
2012-01-15 16:39:55.172 scheduler: Finished recording: Iron Man: channel 1003
2012-01-15 16:39:55.183 SampleRate: Attempted to add a rate 32000 Hz, which is not in the list of allowed rates.
2012-01-15 16:39:55.185 LoadFromScheduler(): Error, called from backend.
2012-01-15 16:39:55.187 recording already exists...
2012-01-15 16:39:55.187 AutoExpire: CalcParams(): Max required Free Space: 2.0 GB w/freq: 15 min
2012-01-15 16:39:55.196 Finished recording Iron Man: channel 1003
2012-01-15 16:39:55.228 Channel(/dev/video0): InitPictureAttribute(brightness):  128
			[    0,  255] dflt(  128, 0.50, 128)
2012-01-15 16:39:55.229 Channel(/dev/video0): InitPictureAttribute(  contrast):  67
			[    0,  127] dflt(   68, 0.54, 2321)
2012-01-15 16:39:55.229 Channel(/dev/video0): InitPictureAttribute(    colour):  63
			[    0,  127] dflt(   64, 0.50, 257)
2012-01-15 16:39:55.230 Channel(/dev/video0): InitPictureAttribute(       hue):  0
			[ -128,  127] dflt(    0, 0.50, 128)
2012-01-15 16:39:55.881 RecBase(2:/dev/video0): GetKeyframePositions(1,9223372036854775807,#0) out of 1
2012-01-15 16:39:55.894 RecBase(2:/dev/video0): GetKeyframePositions(1,9223372036854775807,#0) out of 1
2012-01-15 16:40:02.626 MainServer::ANN Monitor
2012-01-15 16:40:02.626 adding: gonzo as a client (events: 0)
2012-01-15 16:40:11.656 TVRec(2): SetChannel(4) -- begin
2012-01-15 16:40:11.656 ChannelBase(2): Looking for startchannel '4' on input 'Television'
2012-01-15 16:40:11.658 ChannelBase(2): Found startchannel '4' on input 'Television'
2012-01-15 16:40:11.658 TVRec(2): HW Tuner: 2->2
2012-01-15 16:40:50.048 AutoExpire: CalcParams(): Max required Free Space: 2.0 GB w/freq: 15 min
2012-01-15 16:40:50.052 Expiring 0 MB for 1003 at 2012-01-14T19:40:00 => "16:9 The Bigger Picture"
2012-01-15 16:40:50.053 autoexpire: Expiring Program: Expiring 0 MB for 1003 at 2012-01-14T19:40:00 => "16:9 The Bigger Picture"
2012-01-15 16:42:50.079 Expiring 0 MB for 1003 at 2012-01-15T16:39:55 => "Iron Man"
2012-01-15 16:42:50.080 autoexpire: Expiring Program: Expiring 0 MB for 1003 at 2012-01-15T16:39:55 => "Iron Man"


and the frontend

2012-01-15 16:39:46.956 mythfrontend version: fixes/0.24 [v0.24.1-120-g294968b] www.mythtv.org
2012-01-15 16:39:46.956 Using runtime prefix = /usr
2012-01-15 16:39:46.956 Using configuration directory = /home/local/.mythtv
2012-01-15 16:39:46.957 ThreadPool:HTTP: Initial 1, Max 25, Timeout 60000
2012-01-15 16:39:48.458 Empty LocalHostName.
2012-01-15 16:39:48.458 Using localhost value of gonzo
2012-01-15 16:39:48.464 New DB connection, total: 1
2012-01-15 16:39:48.467 Connected to database 'mythconverg' at host: localhost
2012-01-15 16:39:48.471 Closing DB connection named 'DBManager0'
2012-01-15 16:39:48.472 Connected to database 'mythconverg' at host: localhost
2012-01-15 16:39:48.473 Current locale EN_US
2012-01-15 16:39:48.473 Reading locale defaults from /usr/share/mythtv//locales/en_us.xml
2012-01-15 16:39:48.679 ScreenSaverX11Private: XScreenSaver support enabled
2012-01-15 16:39:48.680 DPMS is disabled.
2012-01-15 16:39:48.692 Desktop video mode: 1280x1024 60.020 Hz
2012-01-15 16:39:48.707 Enabled verbose msgs:  important general channel
2012-01-15 16:39:48.709 Loading en_us translation for module mythfrontend
2012-01-15 16:39:48.716 LIRC, Error: Failed to connect to Unix socket '/dev/lircd'
			eno: No such file or directory (2)
2012-01-15 16:39:48.717 JoystickMenuThread: Joystick disabled - Failed to read /home/local/.mythtv/joystickmenurc
2012-01-15 16:39:48.745 Using Frameless Window
2012-01-15 16:39:48.745 Using Full Screen Window
2012-01-15 16:39:48.892 Using the OpenGL painter
2012-01-15 16:39:48.991 OpenGL: OpenGL vendor  : NVIDIA Corporation
2012-01-15 16:39:48.991 OpenGL: OpenGL renderer: GeForce 210/PCI/SSE2
2012-01-15 16:39:48.991 OpenGL: OpenGL version : 3.2.0 NVIDIA 195.36.24
2012-01-15 16:39:48.991 OpenGL: Max texture size: 8192 x 8192
2012-01-15 16:39:48.991 OpenGL: Max texture units: 4
2012-01-15 16:39:48.991 OpenGL: Direct rendering: Yes
2012-01-15 16:39:48.991 OpenGL: Initialised MythRenderOpenGL
2012-01-15 16:39:49.247 XMLParseBase, Error: Unable to load window 'backgroundwindow' from base
2012-01-15 16:39:49.249 New DB connection, total: 2
2012-01-15 16:39:49.249 Connected to database 'mythconverg' at host: localhost
2012-01-15 16:39:49.249 New DB connection, total: 3
2012-01-15 16:39:49.250 Connected to database 'mythconverg' at host: localhost
2012-01-15 16:39:49.250 Current MythTV Schema Version (DBSchemaVer): 1264
2012-01-15 16:39:49.326 ThemeInfo, Warning: Unable to open themeinfo.xml for /usr/share/mythtv/themes/BlackCurves-OSD/themeinfo.xml
2012-01-15 16:39:49.326 ThemeInfo, Error: The theme (/usr/share/mythtv/themes/BlackCurves-OSD) is missing a themeinfo.xml file.
2012-01-15 16:39:49.329 ThemeInfo, Warning: Unable to open themeinfo.xml for /usr/share/mythtv/themes/Gray-OSD/themeinfo.xml
2012-01-15 16:39:49.329 ThemeInfo, Error: The theme (/usr/share/mythtv/themes/Gray-OSD) is missing a themeinfo.xml file.
2012-01-15 16:39:49.644 Pulse: PulseAudio suspend OK
2012-01-15 16:39:49.840 Pulse: PulseAudio resume OK
2012-01-15 16:39:49.928 Registering Internal as a media playback plugin.
2012-01-15 16:39:49.947 Loading en_us translation for module mytharchive
2012-01-15 16:39:49.974 MediaMonitorUnix::AddDevice() - empty device path.
2012-01-15 16:39:49.974 MediaMonitorUnix::AddDevice() - empty device path.
2012-01-15 16:39:49.974 MediaMonitorUnix::AddDevice() - empty device path.
2012-01-15 16:39:49.975 MonitorRegisterExtensions(0x100, gif,jpg,png)
2012-01-15 16:39:49.975 Loading en_us translation for module mythgallery
2012-01-15 16:39:49.988 Current MythMusic Schema Version (MusicDBSchemaVer): 1017
2012-01-15 16:39:50.015 MonitorRegisterExtensions(0x40, mp3,mp2,ogg,oga,flac,wma,wav,ac3,oma,omg,atp,ra,dts,aac,m4a,aa3,tta,mka,aiff,swa,wv)
2012-01-15 16:39:50.019 Loading en_us translation for module mythmusic
2012-01-15 16:39:50.027 Current MythVideo Schema Version (mythvideo.DBSchemaVer): 1038
2012-01-15 16:39:50.042 Loading en_us translation for module mythvideo
2012-01-15 16:39:50.048 Loading en_us translation for module mythweather
2012-01-15 16:39:50.049 NetworkControl: Listening for remote connections on port 6546
2012-01-15 16:39:50.065 Found mainmenu.xml for theme 'Graphite'
2012-01-15 16:39:50.177 MythCoreContext: Connecting to backend server: 172.20.5.11:6543 (try 1 of 1)
2012-01-15 16:39:50.178 Using protocol version 63
2012-01-15 16:39:54.978 TV: Attempting to change from None to WatchingLiveTV
2012-01-15 16:39:54.978 MythCoreContext: Connecting to backend server: 172.20.5.11:6543 (try 1 of 1)
2012-01-15 16:39:54.979 Using protocol version 63
2012-01-15 16:39:54.982 Spawning LiveTV Recorder -- begin
2012-01-15 16:39:55.068 Spawning LiveTV Recorder -- end
2012-01-15 16:39:55.073 We have a playbackURL(/var/lib/media/livetv/1003_20120115163955.nuv) & cardtype(DUMMY)
2012-01-15 16:39:55.073 We have a RingBuffer
2012-01-15 16:39:55.093 playCtx: Output filters for this channel are: ''
2012-01-15 16:39:55.245 Pulse: PulseAudio suspend OK
2012-01-15 16:39:55.284 VideoOutputXv: XVideo Adaptor Name: 'NV17 Video Texture'
2012-01-15 16:39:55.309 OSD: Base theme size: 1280x720
2012-01-15 16:39:55.309 OSD: Scaling factors: 0.5625x0.8
2012-01-15 16:39:55.347 OSD: Base theme size: 1280x720
2012-01-15 16:39:55.347 OSD: Scaling factors: 0.5625x0.8
2012-01-15 16:39:55.351 Player(0): Video timing method: USleep with busy wait
2012-01-15 16:39:55.351 TV: Changing from None to WatchingLiveTV
2012-01-15 16:39:55.351 TV: State is LiveTV & mctx == ctx
2012-01-15 16:39:55.352 TV: UpdateOSDInput done
2012-01-15 16:39:55.352 TV: UpdateLCD done
2012-01-15 16:39:55.352 TV: ITVRestart done
2012-01-15 16:39:55.396 playCtx: Output filters for this channel are: ''
2012-01-15 16:39:55.411 VideoOutputXv: XVideo Adaptor Name: 'NV17 Video Texture'
2012-01-15 16:39:55.429 OSD: Base theme size: 1280x720
2012-01-15 16:39:55.429 OSD: Scaling factors: 0.375x0.666667
2012-01-15 16:39:55.674 Pulse: PulseAudio resume OK
2012-01-15 16:39:55.844 Pulse: PulseAudio suspend OK
2012-01-15 16:39:55.865 AO: Opening audio device 'default' ch 2(2) sr 32000 sf signed 16 bit reenc 0
2012-01-15 16:39:55.868 AudioOutput Warning: mmap not available, attempting to fall back to slow writes
2012-01-15 16:39:55.880 ALSA, Error: no playback control PCM found on mixer device default
2012-01-15 16:39:55.880 ALSA, Error: Unable to open audio mixer. Volume control disabled
2012-01-15 16:39:55.880 AudioPlayer: Enabling Audio
2012-01-15 16:39:55.954 VideoOutput: Created YV12 OSD.
2012-01-15 16:40:18.660 MythSocket(9c6a40:55): readStringList: Error, timed out after 7000 ms.
2012-01-15 16:40:18.660 RemoteEncoder::SendReceiveStringList(): No response.
2012-01-15 16:40:18.664 LiveTVChain(live-gonzo-2012-01-15T16:39:54): SwitchTo() not switching to current
2012-01-15 16:40:18.930 Player(0), Error: Unknown recorder error, exiting decoder
2012-01-15 16:40:18.964 TV: Attempting to change from WatchingLiveTV to None

(the frontend does nothing after this)

Can anyone help?
Thanks!


More information about the mythtv-users mailing list