TV Show playback causes lock up
#1
I'm running the latest XBMC available via PPA for Hardy. Everything seemed to be working fine but now that I switched my hard drive (mounted via SMB) from NTFS to XFS, XBMC locks up for seemingly no reason. I tried to play a TV show and I hear the audio but the video never comes up and XBMC locks up. SSH'ing into the box shows the CPU using 100% CPU time for xbmc.bin. Here's my log fileSadI'd REALLY like to post the whole log, but this forum won't let my post be over 10,000 characters long...hope you get the important info)
Code:
20:25:12 T:2789964688 M: 37564416  NOTICE: Opening video stream: 0 source: 256
20:25:12 T:2789964688 M: 37564416  NOTICE: Creating video codec with codec id: 13
20:25:12 T:2789964688 M: 37564416   DEBUG: FactoryCodec - Video: FFmpeg - Opening
20:25:12 T:2789964688 M: 37564416   DEBUG: SECTION:LoadDLL(Q:\system\players\dvdplayer\swscale-51-i486-linux.so)
20:25:12 T:2789964688 M: 37564416   DEBUG: Loading: /usr/share/xbmc/system/players/dvdplayer/swscale-51-i486-linux.so
20:25:12 T:2789964688 M: 37191680   DEBUG: FactoryCodec - Video: FFmpeg - Opened
20:25:12 T:2789964688 M: 37191680  NOTICE: Creating video thread
20:25:12 T:2764786576 M: 37191680   DEBUG: Running thread 2764786576
20:25:12 T:2764786576 M: 37191680   DEBUG: thread start, auto delete: 0
20:25:12 T:2764786576 M: 37191680  NOTICE: running thread: video_thread
20:25:12 T:2764786576 M: 37191680   DEBUG: thread start, auto delete: 0
20:25:12 T:2764786576 M: 37191680  NOTICE: running thread: video_thread
20:25:12 T:2789964688 M: 37191680  NOTICE: Opening audio stream: 1 source: 256
20:25:12 T:2789964688 M: 37191680  NOTICE: Finding audio codec for: 86020
20:25:12 T:2789964688 M: 37191680   DEBUG: FactoryCodec - Audio: passthrough - Opening
20:25:12 T:2789964688 M: 37191680   DEBUG: FactoryCodec - Audio: passthrough - Failed
20:25:12 T:2789964688 M: 37191680   DEBUG: FactoryCodec - Audio: liba52 - Opening
20:25:12 T:2789964688 M: 37191680   DEBUG: SECTION:LoadDLL(Q:\system\players\dvdplayer\liba52-i486-linux.so)
20:25:12 T:2789964688 M: 37191680   DEBUG: Loading: /usr/share/xbmc/system/players/dvdplayer/liba52-i486-linux.so
20:25:12 T:2789964688 M: 36925440   DEBUG: FactoryCodec - Audio: liba52 - Opened
20:25:12 T:2789964688 M: 36925440  NOTICE: Creating audio thread
20:25:12 T:2756393872 M: 36925440   DEBUG: Running thread 2756393872
20:25:12 T:2756393872 M: 36925440   DEBUG: thread start, auto delete: 0
20:25:12 T:2756393872 M: 36925440  NOTICE: running thread: CDVDPlayerAudio::Process()
20:25:12 T:2789964688 M: 36925440   DEBUG: Playback has started
20:25:12 T:2789964688 M: 36925440    INFO: Loading skin file: DialogProgress.xml
20:25:12 T:2789964688 M: 36892672   DEBUG: Load DialogProgress.xml: 18.66ms
20:25:12 T:2789964688 M: 36892672 WARNING: CDVDPlayer::CheckContinuity - stream wrapback detected (2)
20:25:12 T:2789964688 M: 36892672 WARNING: CDVDPlayer::CheckContinuity - resyncing due to stream wrapback (2)
20:25:12 T:3067516768 M: 36143104   DEBUG: ------------------- GUI_MSG_WINDOW_INIT
20:25:12 T:3067516768 M: 36143104   DEBUG:
20:25:12 T:3067516768 M: 36143104   DEBUG: -------------------
20:25:12 T:3067516768 M: 36143104   DEBUG: Load seekslider.png: 0.0ms (bundled)
20:25:12 T:3067516768 M: 36143104   DEBUG: Load slider_nibFO.png: 0.0ms (bundled)
20:25:12 T:3067516768 M: 36143104   DEBUG: Alloc resources: 0.51ms (0.00 ms skin load, 0.20 ms preload)
20:25:12 T:3067516768 M: 35610624   DEBUG: Load black-back2.png: 16.2ms (bundled)
20:25:12 T:3067516768 M: 35557376   DEBUG: Load NoCover_1.png: 0.9ms (bundled)
20:25:12 T:3067516768 M: 35557376   DEBUG: Load NoCover_1.png: 0.9ms (bundled)
20:25:12 T:3067516768 M: 35557376   DEBUG: Load black-back.png: 0.1ms (bundled)
20:25:12 T:3067516768 M: 35553280   DEBUG: CGUIInfoManager::SetCurrentMovie(smb://FOWIE-DESKTOP/TVSeries/Seinfeld/The_Big_S\
alad_s06e02.avi)
20:25:12 T:3067516768 M: 35553280   ERROR: XLCDproc::SetBackLight - Unable to write to socket
20:25:12 T:2756393872 M: 26906624   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(33375.000000, 1)
20:25:12 T:2756393872 M: 26906624  NOTICE: Creating audio device with codec id: 86020, channels: 2, sample rate: 48000, no \
pass-through
20:25:12 T:2756393872 M: 26906624   DEBUG: CALSADirectSound::CALSADirectSound - opening alsa device
20:25:12 T:2764786576 M: 26906624   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
20:25:12 T:2764786576 M: 25575424   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(66733.333333, 1)
20:25:12 T:2764786576 M: 24936448  NOTICE:  fps: 29.970030, pwidth: 720, pheight: 480, dwidth: 720, dheight: 480
20:25:12 T:2764786576 M: 25575424   DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(66733.333333, 1)
20:25:12 T:2764786576 M: 24936448  NOTICE:  fps: 29.970030, pwidth: 720, pheight: 480, dwidth: 720, dheight: 480
20:25:12 T:2764786576 M: 24936448   DEBUG: OutputPicture - change configuration. 720x480. framerate: 29.97
20:25:12 T:2764786576 M: 24883200  NOTICE: Display resolution AUTO : 1360x768 (Full Screen) (12)
20:25:12 T:2764786576 M: 24776704 WARNING: Upscale: selected algorithm 1
20:25:12 T:2798357392 M: 24403968   DEBUG: staticThread, deleting thread object
20:25:12 T:2798357392 M: 24350720   DEBUG: staticThread, deleting thread graphic context
20:25:12 T:2798357392 M: 24350720   DEBUG: Thread 2798357392 terminating
20:25:12 T:2756393872 M: 23519232   DEBUG: CALSADirectSound - using alsa device default
20:25:12 T:2756393872 M: 23519232   DEBUG: CDVDPlayerAudio:: Discontinuty - was:113723.219333, should be:33375.000000, erro\
r:-80348.219333
20:25:13 T:2756393872 M:  4857856   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_DELAY(958641.666667)
20:25:14 T:2756393872 M:  4857856   ERROR: GetDelay - snd_pcm_delay, alsa error: Broken pipe
20:25:14 T:2756393872 M:  5070848   DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(1025375.000000, 0)
20:25:14 T:2756393872 M:  5070848   DEBUG: CDVDPlayerAudio:: Discontinuty - was:1640850.716000, should be:1025375.000000, e\
rror:-615475.716000
20:25:14 T:2756393872 M: 32333824   DEBUG: CDVDPlayerAudio:: Discontinuty - was:1387767.333000, should be:1376053.367656, e\
rror:-11713.965344
20:25:22 T:2756393872 M:  7196672   DEBUG: CALSADirectSound::AddPackets - buffer underun (tried to write 1024 frames)
20:25:22 T:2756393872 M:  7196672   DEBUG: CDVDPlayerAudio:: Discontinuty - was:8994269.406656, should be:8705375.000000, e\
rror:-288894.406656
etc....
Reply
#2
Use pastebin.com for the full log and see the first link in my signature for other info we need.
Reply
#3
Ok, here goes:
http://pastebin.com/f66126472

Versions:
Mythbuntu 8.10
Linux fowie-mc 2.6.24-22-generic #1 SMP Mon Nov 24 18:32:42 UTC 2008 i686 GNU/Linux
XBMC Atlantis (From Hardy PPAs, up to date)

How to reproduce:
On my computer, load XBMC (via command line over VNC, or using the auto-started process on boot), go to Videos > TV Shows > Seinfeld, pick any episode (including ones I have watched previously in XBMC) and select OK on the MCE remote. The progress meter will display in the upper right corner, but the display will not go to the video. Audio begins playing in the background until the xbmc process is killed.

Video codec: xvid
Audio Codec: copy
Encoder command (example): mencoder /tmp//Bee_Movie-cache -oac copy -aid 128 -ovc xvid -xvidencopts bitrate=2500:chroma_opt:vhq=4:bvhq=1:quant_type=mpeg -vf pp=de -aid 128 -o "/DVDs/DVDs/B/Bee_Movie.avi"

If I run XBMC from the command line and follow the steps on how to reproduce this error, after a while the audio starts to glitch (no video ever plays) and finally xbmc crashes back to the command line and this is what spews out on the command line:
Code:
fowie@fowie-mc:~$ xbmc
********ERROR- exception caught on main loop. exitingCRITSEC[0x8bcde24]: Trying to enter destroyed section.
CRITSEC[0x8bcde24]: Trying to enter destroyed section.
CRITSEC[0x8bcde24]: Trying to enter destroyed section.
CRITSEC[0x8bcdeb0]: Trying to enter destroyed section.
X Error of failed request:  BadDrawable (invalid Pixmap or Window parameter)
  Major opcode of failed request:  146 (XFree86-DRI)
  Minor opcode of failed request:  9 ()
  Resource id in failed request:  0x2e00002
  Serial number of failed request:  1363
  Current serial number in output stream:  1363
CRITSEC[0x8bcde24]: Trying to enter destroyed section.
CRITSEC[0x8bcde24]: Trying to leave destroyed section.
CRITSEC[0x8bcf320]: Trying to enter destroyed section.
CRITSEC[0x8bcf320]: Trying to leave destroyed section.
CRITSEC[0x8bcf320]: Trying to enter destroyed section.
CRITSEC[0x8bcf320]: Trying to leave destroyed section.
CRITSEC[0x8bcf320]: Trying to enter destroyed section.
CRITSEC[0x8bcf320]: Trying to leave destroyed section.
CRITSEC[0x8bda73c]: Trying to enter destroyed section.
fowie@fowie-mc:~$ export DISPLAY=:0
fowie@fowie-mc:~$ xbmc
********ERROR- exception caught on main loop. exitingCRITSEC[0x8bcde24]: Trying to enter destroyed section.
CRITSEC[0x8bcde24]: Trying to enter destroyed section.
CRITSEC[0x8bcde24]: Trying to enter destroyed section.
CRITSEC[0x8bcdeb0]: Trying to enter destroyed section.
X Error of failed request:  BadDrawable (invalid Pixmap or Window parameter)
  Major opcode of failed request:  146 (XFree86-DRI)
  Minor opcode of failed request:  9 ()
  Resource id in failed request:  0x3400002
  Serial number of failed request:  1102
  Current serial number in output stream:  1102
CRITSEC[0x8bcde24]: Trying to enter destroyed section.
CRITSEC[0x8bcde24]: Trying to leave destroyed section.
CRITSEC[0x8bcf320]: Trying to enter destroyed section.
CRITSEC[0x8bcf320]: Trying to leave destroyed section.
CRITSEC[0x8bcf320]: Trying to enter destroyed section.
CRITSEC[0x8bcf320]: Trying to leave destroyed section.
CRITSEC[0x8bcf320]: Trying to enter destroyed section.
CRITSEC[0x8bcf320]: Trying to leave destroyed section.
CRITSEC[0x8bda73c]: Trying to enter destroyed section.
Segmentation fault (core dumped)
fowie@fowie-mc:~$

--EDIT--
I restarted XBMC again (by using VNC and executing it via a terminal window on the command line, just
Code:
$ xbmc
and it is playing. I'd like to fix whatever is causing this intermittent problem. Here is the debug output of the player working correctly:
http://pastebin.com/f28a154b2
Reply
#4
-Update-
I'm not sure if this has fixed the issue or not, I'll keep you posted, but it seems to work at least a little more reliably if I make sure that I run
Code:
$ export DISPLAY=:0
before I start up XBMC. Would that make sense why XBMC would display but video would not?
Reply
#5
If you get a core dump, run gdb on it and get a backtrace.
42.7% of all statistics are made up on the spot

Always read the XBMC online-manual, FAQ and search the forum before posting.
Do not e-mail XBMC-Team members directly asking for support. Read/follow the forum rules.
For troubleshooting and bug reporting please make sure you read this first.
Reply
#6
Hi,


I had almost the exact same problem, XBMC froze up whenever I tried to stop a running video with the stop button and it would quit to the Desktop. The problem was not only the stop button, but the stop button was the only one which was consistent.

Same kind of errors as the starter of this thread. I tried the export theory of his and it seems to work, only I had to use export DISPLAY=:1 as I run XBMC on a dedicated laptop which is located under my TV.

Thanks a lot Fowie!
Reply

Logout Mark Read Team Forum Stats Members Help
TV Show playback causes lock up0