So I'm running across this issue with svn28256 taking a very long time to bring up library directories on the new media center PC I just built, while running with no trouble whatsoever on my old PC. The new PC is an Intel Atom 330 / Nvidia ION based machine with 2GB of RAM, while the old one is a rather dinky Celeron-D with an Nvidia card in it (don't remember which off the top of my head, but towards the newer side) and 512MB of RAM. Both machines access a central MySQL database for library data.
The new machine is diskless, so I have tried running XBMC-Live two different ways: first, I installed it to an 8GB USB key and ran it off of there, and changing directories was very slow. Figuring it might have something to do with using a USB key, I then tried setting up a netboot image and installing XBMC-Live to that; however, the results are exactly the same.
During these delays, both the debug info and running top show the CPU usage never exceeding 40 percent or so. It doesn't appear to be a throughput issue either, as it's on a gigabit link and doesn't come anywhere near maxing out. It just seems to be sitting there for a good five to fifteen seconds.
I've pasted the relevant part of a debug log below. This is the log from pressing Enter on the "TV Shows" menu item, up to the point when I have control again.
Those lines at 16:31:02 seem to be a big part of it, but they don't give me a lot of detail other than it took 5.2 seconds to load the skin and allocate resources. Could I perhaps create a ramdisk at system boot and cache the skin contents there? Or is there something else going on?
Any help would be really appreciated! I've been dying to get a diskless system set up, and I'd hate to be stopped by this!
The new machine is diskless, so I have tried running XBMC-Live two different ways: first, I installed it to an 8GB USB key and ran it off of there, and changing directories was very slow. Figuring it might have something to do with using a USB key, I then tried setting up a netboot image and installing XBMC-Live to that; however, the results are exactly the same.
During these delays, both the debug info and running top show the CPU usage never exceeding 40 percent or so. It doesn't appear to be a throughput issue either, as it's on a gigabit link and doesn't come anywhere near maxing out. It just seems to be sitting there for a good five to fifteen seconds.
I've pasted the relevant part of a debug log below. This is the log from pressing Enter on the "TV Shows" menu item, up to the point when I have control again.
Quote:16:30:47 T:3078371200 M:1674665984 DEBUG: SDLKeyboard: scancode: 36, sym: 13, unicode: 13, modifier: 0
16:30:47 T:3078371200 M:1674665984 DEBUG: OnKey: 61453 pressed, action is Select
16:30:47 T:3078371200 M:1674665984 DEBUG: ExecuteXBMCAction : Translating ActivateWindow(VideoLibrary,TVShowTitles,return)
16:30:47 T:3078371200 M:1674665984 DEBUG: ExecuteXBMCAction : To ActivateWindow(VideoLibrary,TVShowTitles,return)
16:30:47 T:3078371200 M:1674665984 DEBUG: Activating window ID: 10025
16:30:47 T:3078371200 M:1674665984 DEBUG: Checking if window ID 10024 is locked.
16:30:47 T:3078371200 M:1674665984 DEBUG: ------ Window Deinit (Home.xml) ------
16:30:47 T:3078371200 M:1674670080 INFO: Attempting to return to: TVShowTitles
16:30:47 T:3078371200 M:1674670080 DEBUG: CDatabase: Connecting to database ViewModes at /home/xbmc/.xbmc/userdata/Database:
16:30:47 T:3037117296 M:1674797056 DEBUG: CDatabase: Connecting to database xbmc_video at 10.10.10.10:3306
16:30:47 T:3078371200 M:1674797056 DEBUG: ------ Window Init (DialogBusy.xml) ------
16:30:47 T:3078371200 M:1674797056 DEBUG: Alloc resources: 0.01ms (0.01 ms skin load)
16:30:52 T:3078371200 M:1675939840 WARNING: CRITSEC[0xbfbbf48c]: Trying to initialze initialized section.
16:30:52 T:3078371200 M:1675939840 DEBUG: CDatabase: Connecting to database xbmc_video at 10.10.10.10:3306
16:30:57 T:3078371200 M:1675939840 DEBUG: ------ Window Init (MyVideoNav.xml) ------
16:30:57 T:3078371200 M:1675939840 INFO: Loading skin file: MyVideoNav.xml
16:30:57 T:3078371200 M:1675939840 DEBUG: CDatabase: Connecting to database ViewModes at /home/xbmc/.xbmc/userdata/Database:
16:30:57 T:2920262512 M:1675939840 DEBUG: CDatabase: Connecting to database xbmc_video at 10.10.10.10:3306
16:30:57 T:3078371200 M:1675939840 DEBUG: ------ Window Init (DialogBusy.xml) ------
16:30:57 T:3078371200 M:1675939840 DEBUG: Alloc resources: 0.01ms (0.01 ms skin load)
16:31:02 T:3078371200 M:1675939840 WARNING: CRITSEC[0xbfbbeeac]: Trying to initialze initialized section.
16:31:02 T:3078371200 M:1675939840 DEBUG: Load MyVideoNav.xml: 5260.27ms
16:31:02 T:3078371200 M:1675939840 DEBUG: Alloc resources: 5285.33ms (5267.39 ms skin load)
16:31:02 T:3078371200 M:1675939840 DEBUG: CGUIMediaWindow::GetDirectory (videodb://2/2/3/)
16:31:02 T:3078371200 M:1675939840 DEBUG: ParentPath = [videodb://2/2/3/]
16:31:02 T:3037117296 M:1675939840 DEBUG: CDatabase: Connecting to database xbmc_video at 10.10.10.10:3306
16:31:03 T:3078371200 M:1675939840 DEBUG: ------ Window Init (DialogBusy.xml) ------
16:31:03 T:3078371200 M:1675939840 DEBUG: Alloc resources: 0.01ms (0.01 ms skin load)
16:31:03 T:2920262512 M:1665658880 DEBUG: DoWork - took 522 ms to load special://masterprofile/Thumbnails/Video/Fanart/4debd7b2.tbn
16:31:08 T:3037117296 M:1665654784 DEBUG: GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=3) order by idShow
16:31:08 T:3037117296 M:1665654784 DEBUG: GetSeasonsNav query: select episode.c12,path.strPath,tvshow.c00,tvshow.c08,count(1),count(files.playCount) from episode join tvshowlinkepisode on tvshowlinkepisode.idEpisode=episode.idEpisode join tvshow on tvshow.idShow=tvshowlinkepisode.idShow join files on files.idFile=episode.idFile join tvshowlinkpath on tvshowlinkpath.idShow = tvshow.idShow join path on path.idPath = tvshowlinkpath.idPath where tvshow.idShow = 3 group by episode.c12
16:31:08 T:3037117296 M:1665654784 DEBUG: GetMoviesByWhere query: select * from movieview join movielinktvshow on movielinktvshow.idMovie=movieview.idMovie where movielinktvshow.idShow = 3
16:31:08 T:3037117296 M:1665654784 WARNING: GetIcon - Unknown nodetype requested videodb://2/2/3/1/
16:31:08 T:3037117296 M:1665654784 WARNING: GetIcon - Unknown nodetype requested videodb://2/2/3/2/
16:31:08 T:3037117296 M:1665654784 WARNING: GetIcon - Unknown nodetype requested videodb://2/2/3/-1/
16:31:08 T:3078371200 M:1665654784 WARNING: CRITSEC[0xbfbbf2bc]: Trying to initialze initialized section.
16:31:08 T:3078371200 M:1665654784 DEBUG: WindowVideoNav::GetDirectory
16:31:08 T:3078371200 M:1665654784 WARNING: CRITSEC[0xb203604]: Trying to initialze initialized section.
16:31:08 T:3078371200 M:1665654784 DEBUG: CDatabase: Connecting to database ViewModes at /home/xbmc/.xbmc/userdata/Database:
16:31:08 T:3078371200 M:1665654784 DEBUG: CDatabase: Connecting to database ViewModes at /home/xbmc/.xbmc/userdata/Database:
16:31:08 T:3078371200 M:1665654784 DEBUG: CDatabase: Connecting to database ViewModes at /home/xbmc/.xbmc/userdata/Database:
16:31:08 T:3078371200 M:1665654784 DEBUG: Saving fileitems [videodb://2/2/3/]
16:31:08 T:3078371200 M:1665654784 DEBUG: -- items: 4, sort method: 21, ascending: true
16:31:08 T:3078371200 M:1665654784 DEBUG: CDatabase: Connecting to database xbmc_video at 10.10.10.10:3306
16:31:13 T:3078371200 M:1665662976 WARNING: GetLabel - Unknown nodetype requested 11
16:31:13 T:2907003760 M:1665662976 DEBUG: thread start, auto delete: 0
16:31:13 T:2907003760 M:1665662976 DEBUG: Thread 2907003760 terminating
16:31:13 T:3078371200 M:1665662976 INFO: CheckIdle - Closing session to http://xoap.weather.com (easy=0xae9a730, multi=0xb2bf228)
16:31:13 T:3078371200 M:1665662976 INFO: CheckIdle - Closing session to http://feeds.feedburner.com (easy=0xb55dc58, multi=0xb5104b8)
16:31:13 T:3078371200 M:1669345280 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
Those lines at 16:31:02 seem to be a big part of it, but they don't give me a lot of detail other than it took 5.2 seconds to load the skin and allocate resources. Could I perhaps create a ramdisk at system boot and cache the skin contents there? Or is there something else going on?
Any help would be really appreciated! I've been dying to get a diskless system set up, and I'd hate to be stopped by this!
