[mythtv-users] Playback short pauses - remote frontends
Richard Arthur
richard.arthur1 at gmail.com
Mon Apr 18 13:47:48 UTC 2011
This problem started about 3 to 4 weeks ago whilst running 0.23 + fixes.
I've run this system without problem for a number of months. I've not
made any changes apart from running updates (I don't remember the
problem starting with a specific update). I have a combined
frontend/backend with 3 separate frontends. The combined
frontend/backend works without problem, the short pauses on live TV or
recordings occur on all 3 separate frontends, behaving in a similar
manner. They are noticeably slower to connect to the backend since the
problem started. The pauses start within seconds after playing live TV
or watching a recording and continue until you exit. I have updated to
0.24 + fixes on Ubuntu 10.10 with no change to the pause problem. All
frontends/backend are connected over gigabit ethernet; I don't believe
there is a problem here. Although similar to other posts, I thought I
should post separately, I hope that was the correct thing to do. I am
including the terminal output from running a remote frontend, I hope
this isn't too much text to include on the list.
Thanks for looking.
richard at A8N5X:~$ mythfrontend
2011-04-18 11:24:00.398 mythfrontend version: fixes/0.24
[v0.24-244-g0bbd75b] www.mythtv.org
2011-04-18 11:24:00.398 Using runtime prefix = /usr
2011-04-18 11:24:00.398 Using configuration directory =
/home/richard/.mythtv
2011-04-18 11:24:00.399 ThreadPool:HTTP: Initial 1, Max 25, Timeout 60000
2011-04-18 11:24:01.045 Empty LocalHostName.
2011-04-18 11:24:01.045 Using localhost value of A8N5X
2011-04-18 11:24:01.045 Testing network connectivity to '192.168.1.123'
2011-04-18 11:24:01.152 New DB connection, total: 1
2011-04-18 11:24:01.355 Connected to database 'mythconverg' at host:
192.168.1.123
2011-04-18 11:24:01.606 Closing DB connection named 'DBManager0'
2011-04-18 11:24:01.607 Connected to database 'mythconverg' at host:
192.168.1.123
2011-04-18 11:24:02.219 Current locale EN_GB
2011-04-18 11:24:02.219 Reading locale defaults from
/usr/share/mythtv//locales/en_gb.xml
2011-04-18 11:24:06.050 ScreenSaverX11Private: Gnome screen saver
support enabled
2011-04-18 11:24:06.051 DPMS is active.
2011-04-18 11:24:07.289 Desktop video mode: 1280x1024 60.020 Hz
2011-04-18 11:24:09.747 Enabled verbose msgs: important general
2011-04-18 11:24:10.381 Loading en_gb translation for module mythfrontend
2011-04-18 11:24:11.444 LIRC, Error: Failed to connect to Unix socket
'/var/run/lirc/lircd'
eno: No such file or directory (2)
2011-04-18 11:24:11.445 JoystickMenuThread: Joystick disabled - Failed
to read /home/richard/.mythtv/joystickmenurc
2011-04-18 11:24:22.692 Using Frameless Window
2011-04-18 11:24:22.693 Using Full Screen Window
2011-04-18 11:24:23.587 Using the Qt painter
2011-04-18 11:24:26.298 New DB connection, total: 2
2011-04-18 11:24:26.302 New DB connection, total: 3
2011-04-18 11:24:26.499 Connected to database 'mythconverg' at host:
192.168.1.123
2011-04-18 11:24:26.696 Current MythTV Schema Version (DBSchemaVer): 1264
2011-04-18 11:24:26.707 Connected to database 'mythconverg' at host:
192.168.1.123
2011-04-18 11:24:45.083 ThemeInfo, Warning: Unable to open themeinfo.xml
for /usr/share/mythtv/themes/BlackCurves-OSD/themeinfo.xml
2011-04-18 11:24:45.083 ThemeInfo, Error: The theme
(/usr/share/mythtv/themes/BlackCurves-OSD) is missing a themeinfo.xml file.
2011-04-18 11:24:45.122 ThemeInfo, Warning: Unable to open themeinfo.xml
for /usr/share/mythtv/themes/Gray-OSD/themeinfo.xml
2011-04-18 11:24:45.122 ThemeInfo, Error: The theme
(/usr/share/mythtv/themes/Gray-OSD) is missing a themeinfo.xml file.
2011-04-18 11:24:56.141 Pulse: PulseAudio suspend OK
2011-04-18 11:24:56.939 Pulse: PulseAudio resume OK
2011-04-18 11:25:34.272 Registering Internal as a media playback plugin.
2011-04-18 11:25:34.688 No plugins directory /usr/lib/mythtv/plugins
2011-04-18 11:25:34.897 MediaMonitorUnix::AddDevice() - empty device path.
2011-04-18 11:25:34.897 MediaMonitorUnix::AddDevice() - empty device path.
2011-04-18 11:25:34.898 MediaMonitorUnix::AddDevice() - empty device path.
2011-04-18 11:25:35.131 Found mainmenu.xml for theme 'Childish'
2011-04-18 11:25:36.905 MythCoreContext: Connecting to backend server:
192.168.1.123:6543 (try 1 of 1)
2011-04-18 11:25:37.108 Using protocol version 63
2011-04-18 11:26:05.114 TV: Attempting to change from None to WatchingLiveTV
2011-04-18 11:26:05.114 MythCoreContext: Connecting to backend server:
192.168.1.123:6543 (try 1 of 1)
2011-04-18 11:26:08.118 Using protocol version 63
2011-04-18 11:26:08.841 Spawning LiveTV Recorder -- begin
2011-04-18 11:26:09.288 Spawning LiveTV Recorder -- end
2011-04-18 11:26:11.559 We have a
playbackURL(myth://192.168.1.123:6543/1001_20110418112608.mpg) &
cardtype(DUMMY)
2011-04-18 11:26:11.559 We have a RingBuffer
2011-04-18 11:26:13.686 Pulse: PulseAudio suspend OK
2011-04-18 11:26:19.436 VideoOutputXv: XVideo Adaptor Name: 'NV17 Video
Texture'
2011-04-18 11:26:20.908 OSD: Base theme size: 800x600
2011-04-18 11:26:20.908 OSD: Scaling factors: 0.9x0.96
2011-04-18 11:26:20.984 OSD: Base theme size: 800x600
2011-04-18 11:26:20.984 OSD: Scaling factors: 0.9x0.96
2011-04-18 11:26:21.603 Player(0): Video timing method: USleep with busy
wait
2011-04-18 11:26:21.603 TV: Changing from None to WatchingLiveTV
2011-04-18 11:26:21.603 TV: State is LiveTV & mctx == ctx
2011-04-18 11:26:21.814 TV: UpdateOSDInput done
2011-04-18 11:26:21.814 TV: UpdateLCD done
2011-04-18 11:26:21.814 TV: ITVRestart done
2011-04-18 11:26:22.296 ScreenSaverX11Private: DPMS Deactivated 1
2011-04-18 11:26:30.218
RingBuf(myth://192.168.1.123:6543/1001_20110418112611.mpg): Waited 0.5
seconds for data
to become available... 0 < 32768
2011-04-18 11:26:34.637
RingBuf(myth://192.168.1.123:6543/1001_20110418112611.mpg): Waited 0.5
seconds for data
to become available... 0 < 32768
2011-04-18 11:26:35.137
RingBuf(myth://192.168.1.123:6543/1001_20110418112611.mpg): Waited 1.0
seconds for data
to become available... 0 < 32768
2011-04-18 11:26:38.538
RingBuf(myth://192.168.1.123:6543/1001_20110418112611.mpg): Waited 0.2
seconds for data
to become available... 0 < 32768
2011-04-18 11:26:38.788
RingBuf(myth://192.168.1.123:6543/1001_20110418112611.mpg): Waited 0.5
seconds for data
to become available... 0 < 32768
2011-04-18 11:26:39.288
RingBuf(myth://192.168.1.123:6543/1001_20110418112611.mpg): Waited 1.0
seconds for data
to become available... 0 < 32768
2011-04-18 11:26:40.808
RingBuf(myth://192.168.1.123:6543/1001_20110418112611.mpg): Waited 0.2
seconds for data
to become available... 0 < 32768
2011-04-18 11:26:41.058
RingBuf(myth://192.168.1.123:6543/1001_20110418112611.mpg): Waited 0.5
seconds for data
to become available... 0 < 32768
2011-04-18 11:27:01.800
RingBuf(myth://192.168.1.123:6543/1001_20110418112611.mpg): Waited 0.2
seconds for data
to become available... 0 < 32768
2011-04-18 11:27:02.050
RingBuf(myth://192.168.1.123:6543/1001_20110418112611.mpg): Waited 0.5
seconds for data
to become available... 0 < 32768
2011-04-18 11:27:02.550
RingBuf(myth://192.168.1.123:6543/1001_20110418112611.mpg): Waited 1.0
seconds for data
to become available... 0 < 32768
2011-04-18 11:27:06.032
RingBuf(myth://192.168.1.123:6543/1001_20110418112611.mpg): Waited 0.2
seconds for data
to become available... 0 < 32768
2011-04-18 11:27:06.282
RingBuf(myth://192.168.1.123:6543/1001_20110418112611.mpg): Waited 0.5
seconds for data
to become available... 0 < 32768
2011-04-18 11:27:11.063 VideoOutputXv: XVideo Adaptor Name: 'NV17 Video
Texture'
2011-04-18 11:27:11.107 AFD: Opened codec 0xafd526e0, id(MPEG2VIDEO)
type(Video)
2011-04-18 11:27:11.107 AFD: codec MP2 has 2 channels
2011-04-18 11:27:11.107 AFD: Opened codec 0xafd57e70, id(MP2) type(Audio)
2011-04-18 11:27:11.107 AFD: codec MP3 has 0 channels
2011-04-18 11:27:11.107 AFD: Opened codec 0xafd5bf40, id(MP3) type(Audio)
2011-04-18 11:27:11.107 AFD: Opened codec 0xafd7b3c0, id(DVB_SUBTITLE)
type(Subtitle)
2011-04-18 11:27:11.621 Pulse: PulseAudio resume OK
2011-04-18 11:27:11.721 Pulse: PulseAudio suspend OK
2011-04-18 11:27:11.739 AO: Opening audio device 'dmix:CARD=CK804,DEV=0'
ch 2(2) sr 48000 sf signed 16 bit reenc 0
2011-04-18 11:27:11.740 ALSA, Error: Setting hardware audio buffer size
to 128
2011-04-18 11:27:11.740 ALSA, Error: Error opening
/proc/asound/card0/pcm0p/sub0/prealloc: Permission denied.
2011-04-18 11:27:11.740 ALSA, Error: Try to manually increase audio
buffer with: echo 128 | sudo tee /proc/asound/card0/pcm0p/sub0/prealloc
2011-04-18 11:27:11.740 ALSA, Error: Unable to sufficiently increase
ALSA hardware buffer size - underruns are likely
ALSA lib control.c:882:(snd_ctl_open_noupdate) Invalid CTL /dev/mixer
2011-04-18 11:27:11.744 ALSA, Error: failed to register mixer device
/dev/mixer: No such file or directory
2011-04-18 11:27:11.744 ALSA, Error: Unable to open audio mixer. Volume
control disabled
2011-04-18 11:27:11.744 AudioPlayer: Enabling Audio
2011-04-18 11:27:12.415 AFD: Resetting byte context eof (livetv 1 was eof 0)
2011-04-18 11:27:13.057 VideoOutput: Created YV12 OSD.
2011-04-18 11:27:18.997
RingBuf(myth://192.168.1.123:6543/1001_20110418112611.mpg): Waited 0.2
seconds for data
to become available... 0 < 32768
2011-04-18 11:27:19.247
RingBuf(myth://192.168.1.123:6543/1001_20110418112611.mpg): Waited 0.5
seconds for data
to become available... 0 < 32768
2011-04-18 11:27:19.271 Player(0): Waited 100ms for video buffers
AAAAAAAAAAAAAAAAAAAUUUUUUUUuUuL
2011-04-18 11:27:19.276 Player(0): Waited 100ms for video buffers
AAAAAAAAAAAAAAAAAAAUUUUUUUUuUuL
2011-04-18 11:27:19.287 Player(0): Waited 100ms for video buffers
AAAAAAAAAAAAAAAAAAAUUUUUUUUuUuL
2011-04-18 11:27:19.292 Player(0): Waited 100ms for video buffers
AAAAAAAAAAAAAAAAAAAUUUUUUUUuUuL
2011-04-18 11:27:19.399 Player(0): Waited 100ms for video buffers
AAAAAAAAAAAAAAAAAAAUUUUUUUUuUuL
2011-04-18 11:27:19.404 Player(0): Waited 100ms for video buffers
AAAAAAAAAAAAAAAAAAAUUUUUUUUuUuL
2011-04-18 11:27:19.415 Player(0): Waited 100ms for video buffers
AAAAAAAAAAAAAAAAAAAUUUUUUUUuUuL
2011-04-18 11:27:19.420 Player(0): Waited 100ms for video buffers
AAAAAAAAAAAAAAAAAAAUUUUUUUUuUuL
2011-04-18 11:27:19.533 Player(0): Waited 100ms for video buffers
AAAAAAAAAAAAAAAAAAAUUUUUUUUuUuL
2011-04-18 11:27:19.543 Player(0): Waited 100ms for video buffers
AAAAAAAAAAAAAAAAAAAUUUUUUUUuUuL
2011-04-18 11:27:19.548 Player(0): Waited 100ms for video buffers
AAAAAAAAAAAAAAAAAAAUUUUUUUUuUuL
2011-04-18 11:27:19.661 Player(0): Waited 100ms for video buffers
AAAAAAAAAAAAAAAAAAAUUUUUUUUuUuL
2011-04-18 11:27:19.671 Player(0): Waited 100ms for video buffers
AAAAAAAAAAAAAAAAAAAUUUUUUUUuUuL
2011-04-18 11:27:19.676 Player(0): Waited 100ms for video buffers
AAAAAAAAAAAAAAAAAAAUUUUUUUUuUuL
2011-04-18 11:27:19.747
RingBuf(myth://192.168.1.123:6543/1001_20110418112611.mpg): Waited 1.0
seconds for data
to become available... 0 < 32768
and continues as above until exit:
2011-04-18 11:27:29.196 TV: Attempting to change from WatchingLiveTV to None
2011-04-18 11:27:29.534 Pulse: PulseAudio resume OK
2011-04-18 11:27:30.350 TV: Changing from WatchingLiveTV to None
2011-04-18 11:27:30.351 ScreenSaverX11Private: DPMS Reactivated 1
More information about the mythtv-users
mailing list