[mythtv-users] Mythtv 0.26 hangs on playback displaying "Please Wait"

[Mark Goldberg]

I had a crash of the myth backend while recording from an hdpvr. Since
then, the backend seems to work, recording shows OK, but the frontend
hangs when trying to play any video.
It displays "Please Wait" and never does anything else. I have to kill it.

This is on Fedora 17

I have tried lots of things.
Update the Nvidia driver to several different versions.
Checked that direct rendering is enabled.
Changed myth to use Qt painter instead of Opengl and "Normal" instead
of VDPAU rendering.
Try the latest three kernels for F17
Update other packages on F17 to the latest.
Update mythtv to 0.26 to a rebuilt version as of today from git.

I get this in the log and never anything else.

Any suggestions are appreciated.

Mark



2013-08-08 17:27:27.533441 I [7736/7736] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup Interrupt handler
2013-08-08 17:27:27.533474 I [7736/7736] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup Terminated handler
2013-08-08 17:27:27.533478 I [7736/7736] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup Segmentation fault
handler
2013-08-08 17:27:27.533482 I [7736/7736] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup Aborted handler
2013-08-08 17:27:27.533486 I [7736/7736] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup Bus error handler
2013-08-08 17:27:27.533490 I [7736/7736] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup Floating point
exception handler
2013-08-08 17:27:27.533494 I [7736/7736] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup Illegal instruction
handler
2013-08-08 17:27:27.533499 I [7736/7736] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup Real-time signal 0
handler
2013-08-08 17:27:27.533505 I [7736/7736] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup User defined signal
1 handler
2013-08-08 17:27:27.533509 I [7736/7736] thread_unknown
signalhandling.cpp:194 (SetHandlerPrivate) - Setup User defined signal
2 handler
2013-08-08 17:27:27.533628 C [7736/7736] thread_unknown
mythcommandlineparser.cpp:2545 (ConfigureLogging) - mythfrontend
version:  [v0.26.0] www.mythtv.org
2013-08-08 17:27:27.533635 C [7736/7736] thread_unknown
mythcommandlineparser.cpp:2547 (ConfigureLogging) - Qt version:
compile: 4.8.4, runtime: 4.8.4
2013-08-08 17:27:27.533638 N [7736/7736] thread_unknown
mythcommandlineparser.cpp:2549 (ConfigureLogging) - Enabled verbose
msgs:  general playback
2013-08-08 17:27:27.533730 N [7736/7736] thread_unknown
logging.cpp:837 (logStart) - Setting Log Level to LOG_INFO
2013-08-08 17:27:27.533928 N [7736/7736] thread_unknown
mythdirs.cpp:55 (InitializeMythDirs) - Using runtime prefix = /usr
2013-08-08 17:27:27.533938 N [7736/7736] thread_unknown
mythdirs.cpp:68 (InitializeMythDirs) - Using configuration directory =
/home/mythtv/.mythtv
2013-08-08 17:27:27.534028 I [7736/7736] CoreContext
mythcorecontext.cpp:231 (Init) - Assumed character encoding:
en_US.UTF-8
2013-08-08 17:27:27.534490 I [7736/7737] Logger logging.cpp:306 (run)
- Added logging to the console
2013-08-08 17:27:27.534590 N [7736/7736] CoreContext
mythcontext.cpp:493 (LoadDatabaseSettings) - Empty LocalHostName.
2013-08-08 17:27:27.534601 I [7736/7736] CoreContext
mythcontext.cpp:501 (LoadDatabaseSettings) - Using localhost value of
mythpvr
2013-08-08 17:27:27.534632 I [7736/7736] CoreContext
mythcontext.cpp:682 (TestDBconnection) - Testing network connectivity
to '10.203.0.50'
2013-08-08 17:27:27.535655 I [7736/7741] SystemIOHandlerR
system-unix.cpp:90 (run) - Starting IO manager (read)
2013-08-08 17:27:27.535751 I [7736/7739] SystemSignalManager
system-unix.cpp:490 (run) - Starting process signal handler
2013-08-08 17:27:27.535756 I [7736/7738] SystemManager
system-unix.cpp:263 (run) - Starting process manager
2013-08-08 17:27:27.536055 I [7736/7743] SystemIOHandlerW
system-unix.cpp:90 (run) - Starting IO manager (write)
2013-08-08 17:27:27.666921 N [7736/7736] CoreContext
mythcorecontext.cpp:1283 (InitLocale) - Setting QT default locale to
en_US
2013-08-08 17:27:27.667090 I [7736/7736] CoreContext
mythcorecontext.cpp:1316 (SaveLocaleDefaults) - Current locale en_US
2013-08-08 17:27:27.667265 N [7736/7736] CoreContext
mythlocale.cpp:121 (LoadDefaultsFromXML) - Reading locale defaults
from /usr/share/mythtv//locales/en_us.xml
2013-08-08 17:27:27.737835 I [7736/7736] CoreContext
screensaver-x11.cpp:82 (ScreenSaverX11Private) -
ScreenSaverX11Private: DPMS is disabled.
2013-08-08 17:27:27.771724 I [7736/7737] Logger logging.cpp:447
(initialTimeout) - Added logging to mythlogserver at TCP:35327
2013-08-08 17:27:27.786111 N [7736/7736] CoreContext DisplayRes.cpp:64
(Initialize) - Desktop video mode: 1920x1080 60.000 Hz
2013-08-08 17:27:28.079081 I [7736/7736] CoreContext
DisplayRes.cpp:121 (Initialize) - max_width: 1920 max_height: 1080
2013-08-08 17:27:28.118800 I [7736/7736] CoreContext
serverpool.cpp:395 (listen) - Listening on TCP 127.0.0.1:6547
2013-08-08 17:27:28.119051 I [7736/7736] CoreContext
serverpool.cpp:395 (listen) - Listening on TCP 10.203.0.50:6547
2013-08-08 17:27:28.119265 I [7736/7736] CoreContext
serverpool.cpp:395 (listen) - Listening on TCP [::1]:6547
2013-08-08 17:27:28.119438 I [7736/7736] CoreContext
serverpool.cpp:395 (listen) - Listening on TCP
[fe80::92e6:baff:fec5:a583%eth1]:6547
2013-08-08 17:27:28.938480 I [7736/7736] CoreContext
mythtranslation.cpp:65 (load) - Loading en_us translation for module
mythfrontend
2013-08-08 17:27:29.035445 I [7736/7736] CoreContext lirc.cpp:308
(Init) - LIRC: Successfully initialized '/dev/lircd' using
'/home/mythtv/.mythtv/lircrc' config
2013-08-08 17:27:29.035605 E [7736/7736] CoreContext jsmenu.cpp:91
(Init) - JoystickMenuThread: Joystick disabled - Failed to read
/home/mythtv/.mythtv/joystickmenurc
2013-08-08 17:27:29.035620 I [7736/7736] CoreContext
mythudplistener.cpp:32 (Enable) - UDPListener: Enabling
2013-08-08 17:27:29.037116 I [7736/7736] CoreContext
serverpool.cpp:490 (bind) - Binding to UDP 127.0.0.1:6948
2013-08-08 17:27:29.037243 I [7736/7736] CoreContext
serverpool.cpp:490 (bind) - Binding to UDP 10.203.0.50:6948
2013-08-08 17:27:29.037372 I [7736/7736] CoreContext
serverpool.cpp:490 (bind) - Binding to UDP [::1]:6948
2013-08-08 17:27:29.037518 I [7736/7736] CoreContext
serverpool.cpp:490 (bind) - Binding to UDP
[fe80::92e6:baff:fec5:a583%eth1]:6948
2013-08-08 17:27:29.037636 I [7736/7736] CoreContext
serverpool.cpp:490 (bind) - Binding to UDP 10.203.1.255:6948
2013-08-08 17:27:29.080849 I [7736/7736] CoreContext
mythmainwindow.cpp:954 (Init) - Using Frameless Window
2013-08-08 17:27:29.080956 I [7736/7736] CoreContext
mythmainwindow.cpp:967 (Init) - Using Full Screen Window
2013-08-08 17:27:29.580855 I [7736/7736] CoreContext
mythmainwindow.cpp:1020 (Init) - Trying the OpenGL painter
2013-08-08 17:27:29.588370 I [7736/7736] CoreContext
mythrender_opengl.cpp:76 (Create) - OpenGL: Sync to VBlank is enabled
(good!)
2013-08-08 17:27:30.100360 I [7736/7736] CoreContext
mythrender_opengl1.cpp:77 (InitFeatures) - OpenGL1: Fragment program
support available
2013-08-08 17:27:30.100519 I [7736/7736] CoreContext
mythrender_opengl.cpp:936 (InitFeatures) - OpenGL: OpenGL vendor  :
NVIDIA Corporation
2013-08-08 17:27:30.100535 I [7736/7736] CoreContext
mythrender_opengl.cpp:938 (InitFeatures) - OpenGL: OpenGL renderer:
GeForce 9600 GT/PCIe/SSE2
2013-08-08 17:27:30.100547 I [7736/7736] CoreContext
mythrender_opengl.cpp:940 (InitFeatures) - OpenGL: OpenGL version :
3.3.0 NVIDIA 325.08
2013-08-08 17:27:30.100563 I [7736/7736] CoreContext
mythrender_opengl.cpp:942 (InitFeatures) - OpenGL: Max texture size:
8192 x 8192
2013-08-08 17:27:30.100573 I [7736/7736] CoreContext
mythrender_opengl.cpp:944 (InitFeatures) - OpenGL: Max texture units:
4
2013-08-08 17:27:30.100610 I [7736/7736] CoreContext
mythrender_opengl.cpp:946 (InitFeatures) - OpenGL: Direct rendering:
Yes
2013-08-08 17:27:30.100619 I [7736/7736] CoreContext
mythrender_opengl.cpp:953 (InitFeatures) - OpenGL: PixelBufferObject
support available
2013-08-08 17:27:30.100627 I [7736/7736] CoreContext
mythrender_opengl.cpp:128 (Init) - OpenGL: Initialised
MythRenderOpenGL
2013-08-08 17:27:31.039155 I [7736/7736] CoreContext
schemawizard.cpp:118 (Compare) - Current MythTV Schema Version
(DBSchemaVer): 1307
2013-08-08 17:27:31.039739 I [7736/7736] CoreContext
videodisplayprofile.cpp:1547 (init_statics) - VDP: decoder<->render
support: ffmpeg      null xlib xshm xv-blit opengl opengl-lite vdpau
nullvdpau nullvaapi openglvaapi
2013-08-08 17:27:31.039748 I [7736/7736] CoreContext
videodisplayprofile.cpp:1547 (init_statics) - VDP: decoder<->render
support: vdpau       vdpau nullvdpau
2013-08-08 17:27:31.039752 I [7736/7736] CoreContext
videodisplayprofile.cpp:1547 (init_statics) - VDP: decoder<->render
support: vaapi       nullvaapi openglvaapi
2013-08-08 17:27:31.039756 I [7736/7736] CoreContext
videodisplayprofile.cpp:1547 (init_statics) - VDP: decoder<->render
support: crystalhd   null xlib xshm xv-blit opengl opengl-lite vdpau
nullvdpau nullvaapi
2013-08-08 17:27:31.044541 N [7736/7736] CoreContext
videodisplayprofile.cpp:450 (LoadDB) - VDP: Ignoring profile item 28
(deinterlacer greedyhdoubleprocessdeint is not supported w/renderer
xv-blit as second deinterlacer (supported:
onefield,linearblend,kerneldeint,kerneldoubleprocessdeint,greedyhdeint,yadifdeint,yadifdoubleprocessdeint,fieldorderdoubleprocessdeint,none,bobdeint))
2013-08-08 17:27:31.046522 N [7736/7736] CoreContext
videodisplayprofile.cpp:450 (LoadDB) - VDP: Ignoring profile item 14
(deinterlacer yadifdoubleprocessdeint is not supported w/renderer
xv-blit as second deinterlacer (supported:
onefield,linearblend,kerneldeint,kerneldoubleprocessdeint,greedyhdeint,greedyhdoubleprocessdeint,yadifdeint,fieldorderdoubleprocessdeint,none,bobdeint))
2013-08-08 17:27:31.048914 N [7736/7736] CoreContext
videodisplayprofile.cpp:450 (LoadDB) - VDP: Ignoring profile item 19
(renderer quartz-blit is not supported w/decoder ffmpeg (supported:
null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau,nullvaapi,openglvaapi))
2013-08-08 17:27:31.049001 N [7736/7736] CoreContext
videodisplayprofile.cpp:467 (LoadDB) - VDP: Ignoring profile item 20
(renderer quartz-blit is not supported w/decoder ffmpeg (supported:
null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau,nullvaapi,openglvaapi))
2013-08-08 17:27:31.052442 N [7736/7736] CoreContext
videodisplayprofile.cpp:450 (LoadDB) - VDP: Ignoring profile item 23
(renderer quartz-blit is not supported w/decoder ffmpeg (supported:
null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau,nullvaapi,openglvaapi))
2013-08-08 17:27:31.052528 N [7736/7736] CoreContext
videodisplayprofile.cpp:467 (LoadDB) - VDP: Ignoring profile item 24
(renderer quartz-blit is not supported w/decoder ffmpeg (supported:
null,xlib,xshm,xv-blit,opengl,opengl-lite,vdpau,nullvdpau,nullvaapi,openglvaapi))
2013-08-08 17:27:31.053352 N [7736/7736] CoreContext
videodisplayprofile.cpp:467 (LoadDB) - VDP: Ignoring profile item 30
(deinterlacer yadifdoubleprocessdeint is not supported w/renderer
xv-blit as second deinterlacer (supported:
onefield,linearblend,kerneldeint,kerneldoubleprocessdeint,greedyhdeint,greedyhdoubleprocessdeint,yadifdeint,fieldorderdoubleprocessdeint,none,bobdeint))
2013-08-08 17:27:33.962455 N [7736/7736] CoreContext
mythmainwindow.cpp:1869 (RegisterMediaPlugin) - Registering Internal
as a media playback plugin.
2013-08-08 17:27:34.037390 I [7736/7736] CoreContext
mythtranslation.cpp:65 (load) - Loading en_us translation for module
mytharchive
2013-08-08 17:27:34.047868 N [7736/7736] CoreContext
mythmainwindow.cpp:1869 (RegisterMediaPlugin) - Registering WebBrowser
as a media playback plugin.
2013-08-08 17:27:34.047915 I [7736/7736] CoreContext
mythtranslation.cpp:65 (load) - Loading en_us translation for module
mythbrowser
2013-08-08 17:27:34.071103 I [7736/7736] CoreContext
mythtranslation.cpp:65 (load) - Loading en_us translation for module
mythgallery
2013-08-08 17:27:34.089985 I [7736/7736] CoreContext
mythtranslation.cpp:65 (load) - Loading en_us translation for module
mythgame
2013-08-08 17:27:34.133128 I [7736/7736] CoreContext
schemawizard.cpp:118 (Compare) - Current MythMusic Schema Version
(MusicDBSchemaVer): 1020
2013-08-08 17:27:34.155092 I [7736/7736] CoreContext
mythtranslation.cpp:65 (load) - Loading en_us translation for module
mythmusic
2013-08-08 17:27:34.166916 I [7736/7736] CoreContext
mythtranslation.cpp:65 (load) - Loading en_us translation for module
mythnetvision
2013-08-08 17:27:34.172191 I [7736/7736] CoreContext
mythtranslation.cpp:65 (load) - Loading en_us translation for module
mythnews
2013-08-08 17:27:34.179587 I [7736/7736] CoreContext
mythtranslation.cpp:65 (load) - Loading en_us translation for module
mythweather
2013-08-08 17:27:34.192876 I [7736/7736] CoreContext
mythtranslation.cpp:65 (load) - Loading en_us translation for module
mythzoneminder
2013-08-08 17:27:34.195379 I [7736/7736] CoreContext
serverpool.cpp:395 (listen) - Listening on TCP 127.0.0.1:6546
2013-08-08 17:27:34.195499 I [7736/7736] CoreContext
serverpool.cpp:395 (listen) - Listening on TCP 10.203.0.50:6546
2013-08-08 17:27:34.195652 I [7736/7736] CoreContext
serverpool.cpp:395 (listen) - Listening on TCP [::1]:6546
2013-08-08 17:27:34.195783 I [7736/7736] CoreContext
serverpool.cpp:395 (listen) - Listening on TCP
[fe80::92e6:baff:fec5:a583%eth1]:6546
2013-08-08 17:27:34.221906 N [7736/7736] CoreContext main.cpp:1046
(RunMenu) - Found mainmenu.xml for theme 'blue-abstract-wide'
2013-08-08 17:27:34.445326 I [7736/7736] CoreContext
bonjourregister.cpp:100 (BonjourCallback) - Bonjour: Service
registration complete: name 'Mythfrontend on mythpvr' type
'_mythfrontend._tcp.' domain: 'local.'
2013-08-08 17:27:36.639780 I [7736/7769] PlaybackBoxHelper
mythcorecontext.cpp:375 (ConnectCommandSocket) - MythCoreContext:
Connecting to backend server: 10.203.0.50:6543 (try 1 of 1)
2013-08-08 17:27:36.642246 I [7736/7769] PlaybackBoxHelper
mythcorecontext.cpp:1191 (CheckProtoVersion) - Using protocol version
75
2013-08-08 17:27:37.354675 I [7736/7736] CoreContext
mythuibuttonlist.cpp:2521 (customEvent) - Build background buttonlist
item 300
2013-08-08 17:27:39.847793 I [7736/7736] CoreContext tv_play.cpp:1017
(TV) - TV: Creating TV object
2013-08-08 17:27:39.934255 I [7736/7736] CoreContext tv_play.cpp:1036
(TV) - TV: Finished creating TV object
2013-08-08 17:27:39.934271 I [7736/7736] CoreContext tv_play.cpp:301
(StartTV) - TV: StartTV() -- begin
2013-08-08 17:27:39.934505 N [7736/7736] CoreContext
mythmainwindow.cpp:2606 (PauseIdleTimer) - Resuming idle timer
2013-08-08 17:27:39.934561 N [7736/7736] CoreContext
mythmainwindow.cpp:2601 (PauseIdleTimer) - Suspending idle timer
2013-08-08 17:27:39.934591 I [7736/7736] CoreContext tv_play.cpp:1158
(Init) - TV: Init -- begin
2013-08-08 17:27:39.938399 I [7736/7736] CoreContext tv_play.cpp:1232
(Init) - TV: Created TvPlayWindow.
2013-08-08 17:27:39.938862 I [7736/7736] CoreContext tv_play.cpp:8160
(DrawUnusedRects) - TV: DrawUnusedRects() -- begin
2013-08-08 17:27:39.938886 I [7736/7736] CoreContext tv_play.cpp:8173
(DrawUnusedRects) - TV: DrawUnusedRects() -- end
2013-08-08 17:27:39.947038 I [7736/7736] CoreContext tv_play.cpp:1278
(Init) - TV: Init -- end
2013-08-08 17:27:39.947824 I [7736/7736] CoreContext tv_play.cpp:355
(StartTV) - TV: tv->Playback() -- begin
2013-08-08 17:27:39.984588 I [7736/7736] CoreContext tv_play.cpp:2128
(HandleStateChange) - TV: HandleStateChange(0) -- begin
2013-08-08 17:27:39.984619 I [7736/7736] CoreContext tv_play.cpp:2155
(HandleStateChange) - TV: Attempting to change from None to
WatchingPreRecorded
2013-08-08 17:27:39.986206 I [7736/7736] CoreContext
fileringbuffer.cpp:191 (OpenFile) -
FileRingBuf(/video/recordings/5105_20130808050200.mpg):
OpenFile(/video/recordings/5105_20130808050200.mpg, 2000 ms)
2013-08-08 17:27:40.049378 I [7736/7736] CoreContext tv_play.cpp:5203
(StartPlayer) - TV: StartPlayer(0, WatchingPreRecorded, main) -- begin
2013-08-08 17:27:40.049445 I [7736/7736] CoreContext tv_play.cpp:5207
(StartPlayer) - TV: Elapsed time since TV constructor was called: 202
ms