[mythtv-users] mythfrontend live analog tv rarely works
Brent S. Elmer, Ph.D.
webe3vt at aim.com
Sat Jan 26 03:02:55 UTC 2013
I am setting up mythtv. I can get clearQam channels to work fairly
reliably with mythbackend and mythfrontend. There are a few channels
that are encrypted that I need to tune with the analog tuner through the
comcast DTA box. mplayer always works tuning the analog tuner.
mythfrontend however rarely works. It works maybe 1 in 20 tries. Most
of the time, I get the following in the log:
2013-01-25 21:43:56.964778 W
RingBuf(/var/video/1003_20130126024355.mpg): Taking too long to be
allowed to read..
2013-01-25 21:43:57.270612 W
RingBuf(/var/video/1003_20130126024355.mpg): Taking too long to be
allowed to read..
2013-01-25 21:43:57.576202 W
RingBuf(/var/video/1003_20130126024355.mpg): Taking too long to be
allowed to read..
2013-01-25 21:43:57.881750 W
RingBuf(/var/video/1003_20130126024355.mpg): Taking too long to be
allowed to read..
2013-01-25 21:43:58.187309 W
RingBuf(/var/video/1003_20130126024355.mpg): Taking too long to be
allowed to read..
2013-01-25 21:43:58.253183 W
RingBuf(/var/video/1003_20130126024355.mpg): Taking too long to be
allowed to read..
2013-01-25 21:43:58.260630 E Player(0): Couldn't find an A/V decoder
for: '/var/video/1003_20130126024355.mpg'
2013-01-25 21:43:58.260686 E Player(0): JumpToProgram failed.
2013-01-25 21:43:58.260711 E Player(0): Unknown recorder error, exiting
decoder
The few times that it actually worked, I can make not changes to
anything at all and the next time it won't work.
here is my frontend log:
$ mythfrontend -v
2013-01-25 21:43:47.761806 I Setup Interrupt handler
2013-01-25 21:43:47.761832 I Setup Terminated handler
2013-01-25 21:43:47.761840 I Setup Segmentation fault handler
2013-01-25 21:43:47.761848 I Setup Aborted handler
2013-01-25 21:43:47.761856 I Setup Bus error handler
2013-01-25 21:43:47.761864 I Setup Floating point exception handler
2013-01-25 21:43:47.761873 I Setup Illegal instruction handler
2013-01-25 21:43:47.761883 I Setup Real-time signal 0 handler
2013-01-25 21:43:47.761893 I Setup User defined signal 1 handler
2013-01-25 21:43:47.761901 I Setup User defined signal 2 handler
2013-01-25 21:43:47.762021 C mythfrontend version: [v0.26.0]
www.mythtv.org
2013-01-25 21:43:47.762029 C Qt version: compile: 4.8.2, runtime: 4.8.2
2013-01-25 21:43:47.762035 N Enabled verbose msgs: general
2013-01-25 21:43:47.762049 N Setting Log Level to LOG_INFO
2013-01-25 21:43:47.762326 N Using runtime prefix = /usr
2013-01-25 21:43:47.762353 N Using configuration directory
= /home/brent/.mythtv
2013-01-25 21:43:47.762599 I Added logging to the console
2013-01-25 21:43:47.762558 I Assumed character encoding: en_US.utf8
2013-01-25 21:43:47.762656 W This application expects to be running a
locale that specifies a UTF-8 codeset, and many features may behave
improperly with your current language settings. Please set the LC_ALL or
LC_CTYPE, and LANG variable(s) in the environment in which this program
is executed to include a UTF-8 codeset (such as 'en_US.UTF-8').
2013-01-25 21:43:47.763262 N Empty LocalHostName.
2013-01-25 21:43:47.763274 I Using localhost value of webe3
2013-01-25 21:43:47.782061 N Setting QT default locale to en_US
2013-01-25 21:43:47.782142 I Current locale en_US
2013-01-25 21:43:47.782216 N Reading locale defaults
from /usr/share/mythtv//locales/en_us.xml
2013-01-25 21:43:47.790607 I Starting process manager
2013-01-25 21:43:47.790689 I Starting IO manager (write)
2013-01-25 21:43:47.793205 I Starting IO manager (read)
2013-01-25 21:43:47.793328 I Starting process signal handler
2013-01-25 21:43:47.894559 I ScreenSaverX11Private: DPMS is disabled.
2013-01-25 21:43:47.909090 N Desktop video mode: 1280x1024 60.020 Hz
2013-01-25 21:43:47.989207 I Added logging to mythlogserver at
TCP:35327
2013-01-25 21:43:48.075034 I Listening on TCP 127.0.0.1:6547
2013-01-25 21:43:48.075141 I Listening on TCP 192.168.1.67:6547
2013-01-25 21:43:48.075272 I Listening on TCP [::1]:6547
2013-01-25 21:43:48.075377 I Listening on TCP
[fe80::219:21ff:fe56:9680%eth0]:6547
2013-01-25 21:43:48.588169 I Loading en_us translation for module
mythfrontend
libcec.so.1: cannot open shared object file: No such file or directory
2013-01-25 21:43:48.602828 E LIRC: Failed to read config file
'/home/brent/.lircrc'
2013-01-25 21:43:48.606489 E JoystickMenuThread: Joystick disabled -
Failed to read /home/brent/.mythtv/joystickmenurc
2013-01-25 21:43:48.623683 E CECAdapter: Failed to load libcec.
2013-01-25 21:43:48.623756 I UDPListener: Enabling
2013-01-25 21:43:48.626476 I Binding to UDP 127.0.0.1:6948
2013-01-25 21:43:48.626630 I Binding to UDP 192.168.1.67:6948
2013-01-25 21:43:48.626820 I Binding to UDP [::1]:6948
2013-01-25 21:43:48.626984 I Binding to UDP [fe80::219:21ff:fe56:9680%
eth0]:6948
2013-01-25 21:43:48.627135 I Binding to UDP 192.168.1.255:6948
2013-01-25 21:43:48.678979 I Using Frameless Window
2013-01-25 21:43:48.679118 I Using Full Screen Window
2013-01-25 21:43:48.708250 I Using the Qt painter
2013-01-25 21:43:49.063939 I Current MythTV Schema Version
(DBSchemaVer): 1307
2013-01-25 21:43:49.179716 E RAOP Conn: Failed to read key
from: /home/brent/.mythtv/RAOPKey.rsa
2013-01-25 21:43:49.255650 N Registering Internal as a media playback
plugin.
2013-01-25 21:43:49.314057 I Loading en_us translation for module
mythweather
2013-01-25 21:43:49.433308 N Found mainmenu.xml for theme 'Terra'
2013-01-25 21:43:49.781814 I Bonjour: Service registration complete:
name 'Mythfrontend on webe3' type '_mythfrontend._tcp.' domain: 'local.'
2013-01-25 21:43:52.803301 I MythCoreContext: Connecting to backend
server: 192.168.1.67:6543 (try 1 of 1)
2013-01-25 21:43:52.805281 I Using protocol version 75
2013-01-25 21:43:52.808798 I TV: Creating TV object
2013-01-25 21:43:52.842307 N Suspending idle timer
2013-01-25 21:43:52.853852 I TV: Created TvPlayWindow.
2013-01-25 21:43:53.013238 I TV: Attempting to change from None to
WatchingLiveTV
2013-01-25 21:43:53.013310 I MythCoreContext: Connecting to backend
server: 192.168.1.67:6543 (try 1 of 1)
2013-01-25 21:43:53.016403 I Using protocol version 75
2013-01-25 21:43:53.028128 N TV: Spawning LiveTV Recorder -- begin
2013-01-25 21:43:53.733905 N TV: Spawning LiveTV Recorder -- end
2013-01-25 21:43:53.744869 I TV:
playbackURL(/var/video/1003_20130126024353.mpg) cardtype(DUMMY)
2013-01-25 21:43:53.887507 E ALSA: snd_pcm_info_get_card: Operation not
permitted
2013-01-25 21:43:53.899987 N AudioPlayer: Enabling Audio
2013-01-25 21:43:53.918435 I Setup Interrupt handler
2013-01-25 21:43:53.918446 I Setup Terminated handler
2013-01-25 21:43:53.918584 I VideoOutputXv: XVideo Adaptor Name: 'NV17
Video Texture'
2013-01-25 21:43:53.970046 I OSD: Base theme size: 1280x720
2013-01-25 21:43:53.970156 I OSD: Scaling factors: 0.5625x0.8
greedyhdeint: size changed from 0 x 0 -> 720 x 576
2013-01-25 21:43:54.027978 I OSD: Base theme size: 1280x720
2013-01-25 21:43:54.028001 I OSD: Scaling factors: 0.5625x0.8
2013-01-25 21:43:54.036602 I Player(0): Video timing method: USleep
with busy wait
2013-01-25 21:43:54.036988 I TV: Created player.
2013-01-25 21:43:54.037020 I TV: Changing from None to WatchingLiveTV
2013-01-25 21:43:54.037029 I TV: State is LiveTV & mctx == ctx
2013-01-25 21:43:54.037988 I TV: UpdateOSDInput done
2013-01-25 21:43:54.038011 I TV: UpdateLCD done
2013-01-25 21:43:54.038684 I TV: ITVRestart done
2013-01-25 21:43:54.047880 I TV: Main UI disabled.
2013-01-25 21:43:54.050035 I TV: Entering main playback loop.
2013-01-25 21:43:54.131980 I VideoOutput: Created YV12 OSD.
2013-01-25 21:43:56.964778 W
RingBuf(/var/video/1003_20130126024355.mpg): Taking too long to be
allowed to read..
2013-01-25 21:43:57.270612 W
RingBuf(/var/video/1003_20130126024355.mpg): Taking too long to be
allowed to read..
2013-01-25 21:43:57.576202 W
RingBuf(/var/video/1003_20130126024355.mpg): Taking too long to be
allowed to read..
2013-01-25 21:43:57.881750 W
RingBuf(/var/video/1003_20130126024355.mpg): Taking too long to be
allowed to read..
2013-01-25 21:43:58.187309 W
RingBuf(/var/video/1003_20130126024355.mpg): Taking too long to be
allowed to read..
2013-01-25 21:43:58.253183 W
RingBuf(/var/video/1003_20130126024355.mpg): Taking too long to be
allowed to read..
2013-01-25 21:43:58.260630 E Player(0): Couldn't find an A/V decoder
for: '/var/video/1003_20130126024355.mpg'
2013-01-25 21:43:58.260686 E Player(0): JumpToProgram failed.
2013-01-25 21:43:58.260711 E Player(0): Unknown recorder error, exiting
decoder
2013-01-25 21:43:58.312767 I TV: Attempting to change from
WatchingLiveTV to None
2013-01-25 21:43:58.318466 I Setup Interrupt handler
2013-01-25 21:43:58.318508 I Setup Terminated handler
2013-01-25 21:43:58.990478 I TV: Changing from WatchingLiveTV to None
2013-01-25 21:43:58.990987 I TV: Exiting main playback loop.
2013-01-25 21:43:58.997700 I TV: Attempting to change from None to
WatchingLiveTV
2013-01-25 21:43:58.997866 I MythCoreContext: Connecting to backend
server: 192.168.1.67:6543 (try 1 of 1)
2013-01-25 21:43:58.999234 I Using protocol version 75
2013-01-25 21:43:59.007985 N TV: Spawning LiveTV Recorder -- begin
2013-01-25 21:43:59.698548 N TV: Spawning LiveTV Recorder -- end
2013-01-25 21:43:59.708704 I TV:
playbackURL(/var/video/1003_20130126024359.mpg) cardtype(DUMMY)
2013-01-25 21:43:59.710958 E TV: LiveTV not successfully started
2013-01-25 21:43:59.711616 I TV: Main UI disabled.
2013-01-25 21:43:59.711638 I TV: Entering main playback loop.
2013-01-25 21:43:59.713923 I TV: Exiting main playback loop.
2013-01-25 21:43:59.786132 N Resuming idle timer
2013-01-25 21:44:04.507476 I Using protocol version 75
2013-01-25 21:44:04.510172 I Using protocol version 75
2013-01-25 21:44:05.517582 I Bonjour: De-registering service
'_mythfrontend._tcp.' on 'Mythfrontend on webe3'
2013-01-25 21:44:05.518135 I RAOP Device: Cleaning up.
2013-01-25 21:44:05.518167 I AirPlay: Cleaning up.
2013-01-25 21:44:05.518208 I Deleting UPnP client...
2013-01-25 21:44:06.201037 I Waiting for threads to exit.
brent at webe3:~$
here is the backend log section during that time period:
Jan 25 21:43:53 webe3 mythbackend[8979]: I ProcessRequest
mainserver.cpp:1395 (HandleAnnounce) MainServer::ANN Monitor
Jan 25 21:43:53 webe3 mythbackend[8979]: I ProcessRequest
mainserver.cpp:1397 (HandleAnnounce) adding: webe3 as a client (events:
0)
Jan 25 21:43:53 webe3 mythbackend[8979]: I ProcessRequest
mainserver.cpp:1395 (HandleAnnounce) MainServer::ANN Monitor
Jan 25 21:43:53 webe3 mythbackend[8979]: I ProcessRequest
mainserver.cpp:1397 (HandleAnnounce) adding: webe3 as a client (events:
1)
Jan 25 21:43:53 webe3 mythbackend[8979]: I ProcessRequest
mainserver.cpp:1395 (HandleAnnounce) MainServer::ANN Playback
Jan 25 21:43:53 webe3 mythbackend[8979]: I ProcessRequest
mainserver.cpp:1397 (HandleAnnounce) adding: webe3 as a client (events:
0)
Jan 25 21:43:53 webe3 mythbackend[8979]: I TVRecEvent tv_rec.cpp:1043
(HandleStateChange) TVRec(1): Changing from None to WatchingLiveTV
Jan 25 21:43:53 webe3 mythbackend[8979]: I TVRecEvent tv_rec.cpp:3562
(TuningCheckForHWChange) TVRec(1): HW Tuner: 1->1
Jan 25 21:43:53 webe3 mythbackend[8979]: I TVRecEvent
v4lchannel.cpp:661 (SetInputAndFormat) V4LChannel(/dev/video0):
SetInputAndFormat(1, NTSC) (v4l v2) input_switch: 0 mode_switch: 1
Jan 25 21:43:53 webe3 mythbackend[8979]: N CoreContext
autoexpire.cpp:264 (CalcParams) AutoExpire: CalcParams(): Max required
Free Space: 2.0 GB w/freq: 15 min
Jan 25 21:43:55 webe3 mythbackend[8979]: N CoreContext
autoexpire.cpp:264 (CalcParams) AutoExpire: CalcParams(): Max required
Free Space: 2.0 GB w/freq: 15 min
Jan 25 21:43:58 webe3 mythbackend[8979]: W DeviceReadBuffer
DeviceReadBuffer.cpp:530 (Poll) DevRdB(/dev/video0): Poll took an
unusually long time 2502 ms
Jan 25 21:43:58 webe3 mythbackend[8979]: I TVRecEvent tv_rec.cpp:1043
(HandleStateChange) TVRec(1): Changing from WatchingLiveTV to None
Jan 25 21:43:59 webe3 mythbackend[8979]: I ProcessRequest
mainserver.cpp:1395 (HandleAnnounce) MainServer::ANN Playback
Jan 25 21:43:59 webe3 mythbackend[8979]: I ProcessRequest
mainserver.cpp:1397 (HandleAnnounce) adding: webe3 as a client (events:
0)
Jan 25 21:43:59 webe3 mythbackend[8979]: I TVRecEvent tv_rec.cpp:1043
(HandleStateChange) TVRec(1): Changing from None to WatchingLiveTV
Jan 25 21:43:59 webe3 mythbackend[8979]: I TVRecEvent tv_rec.cpp:3562
(TuningCheckForHWChange) TVRec(1): HW Tuner: 1->1
Jan 25 21:43:59 webe3 mythbackend[8979]: I TVRecEvent
v4lchannel.cpp:661 (SetInputAndFormat) V4LChannel(/dev/video0):
SetInputAndFormat(1, NTSC) (v4l v2) input_switch: 0 mode_switch: 1
Jan 25 21:43:59 webe3 mythbackend[8979]: N CoreContext
autoexpire.cpp:264 (CalcParams) AutoExpire: CalcParams(): Max required
Free Space: 2.0 GB w/freq: 15 min
Jan 25 21:43:59 webe3 mythbackend[8979]: I TVRecEvent tv_rec.cpp:1043
(HandleStateChange) TVRec(1): Changing from WatchingLiveTV to None
Jan 25 21:44:04 webe3 mythbackend[8979]: I ProcessRequest
mainserver.cpp:1395 (HandleAnnounce) MainServer::ANN Playback
Jan 25 21:44:04 webe3 mythbackend[8979]: I ProcessRequest
mainserver.cpp:1397 (HandleAnnounce) adding: webe3 as a client (events:
0)
Jan 25 21:44:04 webe3 mythbackend[8979]: I ProcessRequest
mainserver.cpp:1510 (HandleAnnounce) MainServer::HandleAnnounce
FileTransfer
Jan 25 21:44:04 webe3 mythbackend[8979]: I ProcessRequest
mainserver.cpp:1512 (HandleAnnounce) adding: webe3 as a remote file
transfer
Jan 25 21:44:21 webe3 mythbackend[8979]: N Expire autoexpire.cpp:641
(SendDeleteMessages) Expiring 0 MB for 1003 at 2013-01-26T02:41:48Z =>
"CSI: NY":Reignited
Jan 25 21:44:21 webe3 mythbackend[8979]: N Expire autoexpire.cpp:641
(SendDeleteMessages) Expiring 1 MB for 1003 at 2013-01-26T02:41:49Z =>
"CSI: NY":Reignited
Jan 25 21:44:21 webe3 mythbackend[8979]: N Expire autoexpire.cpp:641
(SendDeleteMessages) Expiring 0 MB for 1003 at 2013-01-26T02:41:54Z =>
"CSI: NY":Reignited
Jan 25 21:44:33 webe3 mythbackend[8979]: I HouseKeeping
housekeeper.cpp:221 (RunHouseKeeping) Running housekeeping thread
Jan 25 21:46:21 webe3 mythbackend[8979]: N Expire autoexpire.cpp:641
(SendDeleteMessages) Expiring 0 MB for 1003 at 2013-01-26T02:43:53Z =>
"CSI: NY":Reignited
Jan 25 21:46:21 webe3 mythbackend[8979]: N Expire autoexpire.cpp:641
(SendDeleteMessages) Expiring 1 MB for 1003 at 2013-01-26T02:43:55Z =>
"CSI: NY":Reignited
Jan 25 21:46:21 webe3 mythbackend[8979]: N Expire autoexpire.cpp:641
(SendDeleteMessages) Expiring 0 MB for 1003 at 2013-01-26T02:43:59Z =>
"CSI: NY":Reignited
Jan 25 21:47:21 webe3 mythbackend[8979]: N Expire autoexpire.cpp:264
(CalcParams) AutoExpire: CalcParams(): Max required Free Space: 1.0 GB
w/freq: 15 min
Jan 25 21:49:33 webe3 mythbackend[8979]: I HouseKeeping
housekeeper.cpp:221 (RunHouseKeeping) Running housekeeping thread
Jan 25 21:54:34 webe3 mythbackend[8979]: I HouseKeeping
housekeeper.cpp:221 (RunHouseKeeping) Running housekeeping thread
Does anyone have any ideas? This is driving me crazy. I am trying to
start as simple as possible. I have only channel 3 set up because that
is the channel the DTA box is set to. I have mythbackend fixed to tune
channel 3. Like I said. I have seen it work a few times without
changing anything.
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://www.mythtv.org/pipermail/mythtv-users/attachments/20130125/277055cd/attachment.html>
More information about the mythtv-users
mailing list