[mythtv-users] Can't read first 2048
Mike B
yp_38 at yahoo.com
Sat Jan 24 20:37:59 UTC 2015
I'm not sure what's changed, but one day I could no longer watch live TV
on my frontend. When I try to watch live TV, I get an error message
saying, "Cannot read first 2048 bytes". When I click on the OK button
on that message, the frontend locks up. I can watch liveTV on my
backend just fine. The backend records shows and plays those recorded
shows without trouble.
I don't know if it is at all related, but there are also a couple of
videos on my backend that I cannot watch. Most videos I can watch
without problem. I can watch them all on the backend just fine.
I'm including the terminal output from the frontend. I captured this a
few weeks ago, but only now am getting to asking about it. I checked
the backend logs and there were no entries that corresponded to these
events (none on the same day even). When I captured this output, I had
tried to watch a video (the movie LeMans) first. It gave the "cannot
read the first 2048" error (a transparent pop-up in the upper-right
corner like what you get when the backend isn't available), and wouldn't
play. I then tried to watch live TV. For both the video and live TV I
get RingBuffer errors.
$ mythfrontend
2015-01-03 13:42:11.753608 I Setup Interrupt handler
2015-01-03 13:42:11.753637 I Setup Terminated handler
2015-01-03 13:42:11.753647 I Setup Segmentation fault handler
2015-01-03 13:42:11.753657 I Setup Aborted handler
2015-01-03 13:42:11.753665 I Setup Bus error handler
2015-01-03 13:42:11.753675 I Setup Floating point exception handler
2015-01-03 13:42:11.753684 I Setup Illegal instruction handler
2015-01-03 13:42:11.753694 I Setup Real-time signal 0 handler
2015-01-03 13:42:11.753706 I Setup User defined signal 1 handler
2015-01-03 13:42:11.753715 I Setup User defined signal 2 handler
2015-01-03 13:42:11.753846 C mythfrontend version: fixes/0.27
[v0.27-193-g8ee257c] www.mythtv.org
2015-01-03 13:42:11.753855 C Qt version: compile: 4.8.6, runtime: 4.8.6
2015-01-03 13:42:11.753860 N Enabled verbose msgs: general
2015-01-03 13:42:11.753876 N Setting Log Level to LOG_INFO
2015-01-03 13:42:11.764580 I Added logging to the console
2015-01-03 13:42:11.764553 N Using runtime prefix = /usr
2015-01-03 13:42:11.764631 N Using configuration directory =
/home/tonka/.mythtv
2015-01-03 13:42:11.764717 I Assumed character encoding: en_US.UTF-8
2015-01-03 13:42:11.765198 N Empty LocalHostName.
2015-01-03 13:42:11.765209 I Using localhost value of htpc-frontend
2015-01-03 13:42:11.765248 I Testing network connectivity to '10.6.2.51'
2015-01-03 13:42:11.766543 I Starting process manager
2015-01-03 13:42:11.766757 I Starting IO manager (read)
2015-01-03 13:42:11.773558 I Starting process signal handler
2015-01-03 13:42:11.774217 I Starting IO manager (write)
2015-01-03 13:42:11.867178 I New Client: (#1)
2015-01-03 13:42:11.867227 I Added syslogging
2015-01-03 13:42:11.919596 N Setting QT default locale to en_UM
2015-01-03 13:42:11.919811 I Current locale en_UM
2015-01-03 13:42:11.919912 E No locale defaults file for en_UM, skipping
2015-01-03 13:42:11.980582 I ScreenSaverX11Private: XScreenSaver
support enabled
2015-01-03 13:42:11.981539 I ScreenSaverX11Private: DPMS is disabled.
2015-01-03 13:42:12.003056 N Desktop video mode: 1920x1080 60.000 Hz
2015-01-03 13:42:12.079013 I Listening on TCP 127.0.0.1:6547
2015-01-03 13:42:12.079202 I Listening on TCP 10.6.2.52:6547
2015-01-03 13:42:12.079361 I Listening on TCP [::1]:6547
2015-01-03 13:42:12.079528 I Listening on TCP
[fe80::6a05:caff:fe2a:b43a%eth0]:6547
2015-01-03 13:42:12.939738 I Connecting to lcd server: 127.0.0.1:6545
(try 1 of 10)
2015-01-03 13:42:12.942669 I Loading en_us translation for module
mythfrontend
2015-01-03 13:42:12.962984 I LIRC: Successfully initialized
'/dev/lircd' using '/home/tonka/.mythtv/lircrc' config
2015-01-03 13:42:12.963177 E JoystickMenuThread: Joystick disabled -
Failed to read /home/tonka/.mythtv/joystickmenurc
2015-01-03 13:42:12.963232 I UDPListener: Enabling
2015-01-03 13:42:12.964669 I Binding to UDP 127.0.0.1:6948
2015-01-03 13:42:12.964780 I Binding to UDP 10.6.2.52:6948
2015-01-03 13:42:12.964942 I Binding to UDP [::1]:6948
2015-01-03 13:42:12.965096 I Binding to UDP
[fe80::6a05:caff:fe2a:b43a%eth0]:6948
2015-01-03 13:42:12.965232 I Binding to UDP 10.6.2.255:6948
2015-01-03 13:42:13.047042 I Using Frameless Window
2015-01-03 13:42:13.047147 I Using Full Screen Window
2015-01-03 13:42:13.053886 I Using the Qt painter
2015-01-03 13:42:13.348678 I MythCoreContext: Connecting to backend
server: 10.6.2.51:6543 (try 1 of 1)
2015-01-03 13:42:13.357877 I Using protocol version 77
2015-01-03 13:42:13.495016 I MythUIWebBrowser: Loading css from -
file:///usr/share/mythtv/themes/default/htmls/mythbrowser.css
2015-01-03 13:42:13.495682 E MythUIWebBrowser: failed to find our
parent screen
2015-01-03 13:42:13.497385 I MythUIWebBrowser: enabling plugins
2015-01-03 13:42:13.536562 I Current MythTV Schema Version
(DBSchemaVer): 1317
2015-01-03 13:42:13.617565 W ThemeInfo: Unable to open themeinfo.xml
for /usr/share/mythtv/themes/BlackCurves-OSD/themeinfo.xml
2015-01-03 13:42:13.617586 E ThemeInfo: The theme
(/usr/share/mythtv/themes/BlackCurves-OSD) is missing a themeinfo.xml file.
2015-01-03 13:42:13.618377 W ThemeInfo: Unable to open themeinfo.xml
for /usr/share/mythtv/themes/Gray-OSD/themeinfo.xml
2015-01-03 13:42:13.618388 E ThemeInfo: The theme
(/usr/share/mythtv/themes/Gray-OSD) is missing a themeinfo.xml file.
2015-01-03 13:42:13.957794 N Registering Internal as a media playback
plugin.
2015-01-03 13:42:14.076378 I Loading en_us translation for module
mytharchive
2015-01-03 13:42:14.083669 N Registering WebBrowser as a media playback
plugin.
2015-01-03 13:42:14.083755 I Loading en_us translation for module
mythbrowser
2015-01-03 13:42:14.120082 I Loading en_us translation for module
mythgallery
2015-01-03 13:42:14.128899 I Loading en_us translation for module mythgame
2015-01-03 13:42:14.136057 I Current MythMusic Schema Version
(MusicDBSchemaVer): 1020
2015-01-03 13:42:14.164766 I Loading en_us translation for module mythmusic
2015-01-03 13:42:14.169016 I Loading en_us translation for module
mythnetvision
2015-01-03 13:42:14.175013 I Loading en_us translation for module mythnews
2015-01-03 13:42:14.183112 I Loading en_us translation for module
mythweather
2015-01-03 13:42:14.185409 I Listening on TCP 127.0.0.1:6546
2015-01-03 13:42:14.185489 I Listening on TCP 10.6.2.52:6546
2015-01-03 13:42:14.185586 I Listening on TCP [::1]:6546
2015-01-03 13:42:14.185673 I Listening on TCP
[fe80::6a05:caff:fe2a:b43a%eth0]:6546
2015-01-03 13:42:14.265635 N Found mainmenu.xml for theme 'Mythbuntu'
2015-01-03 13:42:14.273643 I Registering HouseKeeperTask
'HardwareProfiler'.
2015-01-03 13:42:14.278791 I Starting HouseKeeper.
2015-01-03 13:42:14.646839 I Bonjour: Service registration complete:
name 'Mythfrontend on htpc-frontend' type '_mythfrontend._tcp.' domain:
'local.'
2015-01-03 13:42:34.909405 N Suspending idle timer
2015-01-03 13:42:34.915392 I TV: Creating TV object
2015-01-03 13:42:35.005405 N Suspending idle timer
2015-01-03 13:42:35.012742 I TV: Created TvPlayWindow.
2015-01-03 13:42:35.092277 I TV: Attempting to change from None to
WatchingVideo
2015-01-03 13:42:35.454255 I Pulse: PulseAudio suspend OK
2015-01-03 13:42:35.529623 N AudioPlayer: Enabling Audio
2015-01-03 13:42:45.577838 W
RingBuf(myth://Videos@10.6.2.51:6543/Movies/Le Mans/Le Mans.mkv): Peek()
requested 2048 bytes, but only returning 0
2015-01-03 13:42:45.577927 E Player(0): OpenFile(): Could not read
first 2048 bytes of 'myth://Videos@10.6.2.51:6543/Movies/Le Mans/Le
Mans.mkv'
2015-01-03 13:42:45.578002 E Player(0): Unable to open video file.
2015-01-03 13:42:45.578023 E playCtx: StartPlaying() Failed to start player
2015-01-03 13:42:45.614398 I TV: Main UI disabled.
2015-01-03 13:42:45.614729 I TV: Entering main playback loop.
2015-01-03 13:42:45.640981 I TV: Exiting main playback loop.
2015-01-03 13:42:45.874522 I Pulse: PulseAudio resume OK
2015-01-03 13:42:45.885733 N Resuming idle timer
2015-01-03 13:42:45.885841 N Resuming idle timer
2015-01-03 13:43:21.322417 I TV: Creating TV object
2015-01-03 13:43:21.392612 N Suspending idle timer
2015-01-03 13:43:21.400665 I TV: Created TvPlayWindow.
2015-01-03 13:43:21.514143 I TV: Attempting to change from None to
WatchingLiveTV
2015-01-03 13:43:21.516886 I MythCoreContext: Connecting to backend
server: 10.6.2.51:6543 (try 1 of 1)
2015-01-03 13:43:21.546840 N TV: Spawning LiveTV Recorder -- begin
2015-01-03 13:43:21.684745 N TV: Spawning LiveTV Recorder -- end
2015-01-03 13:43:21.697249 I TV:
playbackURL(myth://10.6.2.51:6543/1063_20150103194321.mpg) cardtype(DUMMY)
2015-01-03 13:43:21.892824 I Pulse: PulseAudio suspend OK
2015-01-03 13:43:21.929837 N AudioPlayer: Enabling Audio
2015-01-03 13:43:22.664889 I VDPAU: Created 2 output surfaces.
2015-01-03 13:43:22.664921 I VDPAU: Version 1
2015-01-03 13:43:22.664929 I VDPAU: Information NVIDIA VDPAU Driver
Shared Library 331.38 Wed Jan 8 19:13:15 PST 2014
2015-01-03 13:43:22.665051 I VDPAU: Created VDPAU render device 1920x1080
2015-01-03 13:43:22.903960 I Player(1): Video timing method: USleep
with busy wait
2015-01-03 13:43:22.904466 I TV: Created player.
2015-01-03 13:43:22.904513 I TV: Changing from None to WatchingLiveTV
2015-01-03 13:43:22.904522 I TV: State is LiveTV & mctx == ctx
2015-01-03 13:43:22.907104 I TV: UpdateOSDInput done
2015-01-03 13:43:22.907123 I TV: UpdateLCD done
2015-01-03 13:43:22.907675 I TV: ITVRestart done
2015-01-03 13:43:22.908643 I TV: Main UI disabled.
2015-01-03 13:43:22.908662 I Using Idle Timer. 3 minutes
2015-01-03 13:43:22.993108 I TV: Entering main playback loop.
2015-01-03 13:43:23.363233 I VDPAU: Added 2 output surfaces (total 4,
max 4)
2015-01-03 13:44:15.271333 W
RingBuf(myth://10.6.2.51:6543/1063_20150103194412.mpg): Taking too long
to be allowed to read..
2015-01-03 13:44:16.271483 W
RingBuf(myth://10.6.2.51:6543/1063_20150103194412.mpg): Taking too long
to be allowed to read..
2015-01-03 13:44:17.271625 W
RingBuf(myth://10.6.2.51:6543/1063_20150103194412.mpg): Taking too long
to be allowed to read..
2015-01-03 13:44:18.271791 W
RingBuf(myth://10.6.2.51:6543/1063_20150103194412.mpg): Taking too long
to be allowed to read..
2015-01-03 13:44:19.271954 W
RingBuf(myth://10.6.2.51:6543/1063_20150103194412.mpg): Taking too long
to be allowed to read..
2015-01-03 13:44:20.272107 W
RingBuf(myth://10.6.2.51:6543/1063_20150103194412.mpg): Taking too long
to be allowed to read..
2015-01-03 13:44:21.272258 W
RingBuf(myth://10.6.2.51:6543/1063_20150103194412.mpg): Taking too long
to be allowed to read..
2015-01-03 13:44:22.272405 W
RingBuf(myth://10.6.2.51:6543/1063_20150103194412.mpg): Taking too long
to be allowed to read..
2015-01-03 13:44:23.272556 W
RingBuf(myth://10.6.2.51:6543/1063_20150103194412.mpg): Taking too long
to be allowed to read..
2015-01-03 13:44:23.272586 E
RingBuf(myth://10.6.2.51:6543/1063_20150103194412.mpg): Took more than
10 seconds to be allowed to read, aborting.
2015-01-03 13:44:23.318451 W
RingBuf(myth://10.6.2.51:6543/1063_20150103194412.mpg): Peek() requested
2048 bytes, but only returning 0
2015-01-03 13:44:23.318503 E Player(1): OpenFile(): Could not read
first 2048 bytes of 'myth://10.6.2.51:6543/1063_20150103194412.mpg'
2015-01-03 13:44:23.318550 E Player(1): Error opening jump program file
2015-01-03 13:44:23.318566 E Player(1): JumpToProgram failed.
2015-01-03 13:44:23.318597 E Player(1): Unknown recorder error, exiting
decoder
2015-01-03 13:44:23.363902 I TV: Attempting to change from
WatchingLiveTV to None
2015-01-03 13:44:23.369672 W MythPainter: 28 images not yet de-allocated.
2015-01-03 13:44:23.369748 I VDPAU Painter: Clearing VDPAU painter cache.
2015-01-03 13:44:23.644506 I Pulse: PulseAudio resume OK
2015-01-03 13:44:23.700337 I TV: Changing from WatchingLiveTV to None
2015-01-03 13:44:23.700904 I TV: Exiting main playback loop.
2015-01-03 13:44:23.711069 I TV: Attempting to change from None to
WatchingLiveTV
2015-01-03 13:44:23.711628 I MythCoreContext: Connecting to backend
server: 10.6.2.51:6543 (try 1 of 1)
2015-01-03 13:44:23.730091 N TV: Spawning LiveTV Recorder -- begin
2015-01-03 13:44:23.864431 N TV: Spawning LiveTV Recorder -- end
2015-01-03 13:44:23.876379 I TV:
playbackURL(myth://10.6.2.51:6543/1063_20150103194423.mpg) cardtype(DUMMY)
2015-01-03 13:44:23.880732 E TV: LiveTV not successfully started
2015-01-03 13:44:23.881346 I TV: Main UI disabled.
2015-01-03 13:44:23.881382 I Using Idle Timer. 3 minutes
2015-01-03 13:44:23.979243 I TV: Entering main playback loop.
2015-01-03 13:44:24.020365 I TV: Exiting main playback loop.
2015-01-03 13:44:24.110886 N Resuming idle timer
Killed
Does anybody have any suggestions on how to troubleshoot this?
Mike B
More information about the mythtv-users
mailing list