[mythtv-users] Can't read first 2048

Hika van den Hoven hikavdh at gmail.com
Sat Jan 24 21:06:01 UTC 2015


Hoi Mike,

Saturday, January 24, 2015, 9:37:59 PM, you wrote:

> 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


Sounds  to  me  like  a  rights  issue.  Do  you  have your recordings
directory  mounted on the frontend through nfs? And if so can the user
you use on your frontend read those recordings there?
Or did you change to another user on your frontend?


Tot mails,
  Hika                            mailto:hikavdh at gmail.com

"Zonder hoop kun je niet leven
Zonder leven is er geen hoop
Het eeuwige dilemma
Zeker als je hoop moet vernietigen om te kunnen overleven!"

De lerende Mens



More information about the mythtv-users mailing list