I have a Mac mini, 512MB ram, 1.33 Ghz G4, with upgraded 5400rpm 100GB
internal drive, and all music stored on an external Maxtor 300GB drive.
I have three SqeezeBox v3s, one wired, and the other two wireless.

I have ~35K tracks. I just wiped my hard drive, and installed a fresh
copy of 10.4.8, and the latest daily build (12-25) of 6.5.1. I use
iTunes to organize my tracks and playlists.

>From the very beginning, I have had performance issues with changing
playlists from the SB3s. I used to run several plugins, but did the
clean install to determine if any of those were causing the issue.
Right now, the installation is as clean as possible, with the "Disable
library statistics" option. I also set the server to a -16 priority.
The only application running in the background is iTunes, but it is not
playing or doing anything.

As a reference, I created 4 playlists, 80 songs, 300 songs, 2250 songs,
and 22000 songs. Following the instructions I have read in this post, I
set up performance monitoring to show all operations that take longer
than 1.0 sec. I then performed the following tests, to show just how
long the server takes to switch. Right now, two slims are set to sync,
and the third is not. Once playback begins, there is no stuttering or
pauses during playback.

Delays ranged from 7 seconds in the best case to nearly 4 minutes in
the worst case. This seems to be significantly worse performance than I
see posted about in other places on the site. I have been plagued with
this issue since I began several months ago with this setup... It has
never been quick. I have 1GB of ram on its way, but I also tried
running this on a PowerBook G4 with 1.25GB ram, and the performance was
not much better. The library was freshly imported, and the slimserver I
just rescanned the library using "Clear library and rescan everything"
the night before (which takes over three hours).

Can anyone offer a suggestion on why the slimserver performance is so
horrible? Or anything I can do to fix it? Could corrupt music files be
the culprit?

Timing for the playlist switches is listed below. I started the clock
when I hit "Play" on the remote and stopped it when music played from
the speakers:

switch from 22000 playlist -> 80 playlist: 57 sec
80 -> 300: 16 sec
300 -> 80: 7 sec
80 -> 300: 15 sec
300 - > 2250: 80 sec
2250 -> 300: 16 sec
300 -> 2250: 88 sec
2250 -> 22000: 240 sec (4 min !)

I have attached the log file for this sequence of events... a small
excerpt of the last 4 playlist switches are shown below:

2006-12-26 16:49:13.6167 Request Task     >   1.0 : 60.40402    Notify:
Slim::Player::Playlist::modifyPlaylistCallback
2006-12-26 16:49:56.4850 Request Task     >   1.0 :  1.30956   
Execute: Slim::Control::Commands::playlistXtracksCommand
2006-12-26 16:49:56.4875 Request Task     >   1.0 :  1.34285   
Execute: Slim::Control::Commands::buttonCommand
2006-12-26 16:49:56.4880 Timer Task       >   1.0 :  1.34682   
Slim::Hardware::IR::checkRelease
2006-12-26 16:49:56.4919 Response Time    >   1.0 :  1.35257
2006-12-26 16:49:57.2914 Timer Late       >   1.0 :  1.54495
2006-12-26 16:49:57.3133 Timer Late       >   1.0 :  1.55636
2006-12-26 16:49:57.3264 Timer Late       >   1.0 :  1.55630
2006-12-26 16:49:57.3383 Timer Late       >   1.0 :  1.55020
2006-12-26 16:49:57.3907 Timer Late       >   1.0 :  1.39060
2006-12-26 16:49:57.4084 Timer Late       >   1.0 :  1.23776
2006-12-26 16:50:05.8359 Request Task     >   1.0 :  9.25155    Notify:
Slim::Player::Playlist::modifyPlaylistCallback
2006-12-26 16:50:27.5006 Request Task     >   1.0 :  2.09362   
Execute: Slim::Control::Commands::buttonCommand
2006-12-26 16:50:27.5030 Request Task     >   1.0 :  2.10049   
Execute: Slim::Control::Commands::irCommand
2006-12-26 16:50:27.5046 Response Time    >   1.0 :  2.10682
2006-12-26 16:50:27.5188 Timer Late       >   1.0 :  1.85805
2006-12-26 16:50:27.5213 IR Delay         >   1.0 :  2.12298
2006-12-26 16:50:27.6044 Timer Late       >   1.0 :  1.89278
2006-12-26 16:50:27.6052 IR Delay         >   1.0 :  2.09913
2006-12-26 16:50:27.6097 Timer Late       >   1.0 :  1.60964
2006-12-26 16:50:27.6167 IR Delay         >   1.0 :  2.11035
2006-12-26 16:50:27.6213 Timer Late       >   1.0 :  1.48516
2006-12-26 16:50:27.6282 Timer Late       >   1.0 :  1.48050
2006-12-26 16:50:38.8838 Request Task     >   1.0 :  5.42240   
Execute: Slim::Control::Commands::playlistXtracksCommand
2006-12-26 16:50:38.8858 Request Task     >   1.0 :  5.44032   
Execute: Slim::Control::Commands::buttonCommand
2006-12-26 16:50:39.0105 Timer Task       >   1.0 :  5.56844   
Slim::Hardware::IR::checkRelease
2006-12-26 16:50:39.0131 Response Time    >   1.0 :  5.57213
2006-12-26 16:50:39.0785 Timer Late       >   1.0 :  5.45754
2006-12-26 16:50:39.2074 Timer Late       >   1.0 :  5.56088
2006-12-26 16:50:39.2188 Timer Late       >   1.0 :  5.56322
2006-12-26 16:50:39.2301 Timer Late       >   1.0 :  5.23001
2006-12-26 16:50:39.2442 Timer Late       >   1.0 :  5.24411
2006-12-26 16:50:39.2592 Timer Late       >   1.0 :  4.80038
2006-12-26 16:50:39.2770 Timer Late       >   1.0 :  2.54650
2006-12-26 16:50:39.2887 Timer Late       >   1.0 :  2.54461
2006-12-26 16:50:39.2998 Timer Late       >   1.0 :  2.48104
2006-12-26 16:51:34.3389 Request Task     >   1.0 : 55.25821    Notify:
Slim::Player::Playlist::modifyPlaylistCallback
2006-12-26 17:31:54.5815 Select Task      >   1.0 :  1.19545   
Slim::Web::HTTP::processHTTP
2006-12-26 17:38:45.8011 Web Page Build   >   1.0 :  1.02237    Page:
status_header.html
2006-12-26 17:38:45.8068 Select Task      >   1.0 :  1.07228   
Slim::Web::HTTP::processHTTP
2006-12-26 17:44:27.9259 Web Page Build   >   1.0 :  2.10443    Page:
setup.html
2006-12-26 17:44:27.9522 Select Task      >   1.0 :  2.17352   
Slim::Web::HTTP::processHTTP
2006-12-26 17:44:37.2127 Web Page Build   >   1.0 :  1.41516    Page:
setup.html
2006-12-26 17:44:37.2198 Select Task      >   1.0 :  1.47551   
Slim::Web::HTTP::processHTTP
2006-12-26 17:47:51.6084 Request Task     >   1.0 : 23.56859   
Execute: Slim::Control::Commands::playlistXtracksCommand
2006-12-26 17:47:51.6092 Request Task     >   1.0 : 23.57848   
Execute: Slim::Control::Commands::buttonCommand
2006-12-26 17:47:51.6096 Timer Task       >   1.0 : 23.57982   
Slim::Hardware::IR::checkRelease
2006-12-26 17:47:51.6110 Response Time    >   1.0 : 23.58125
2006-12-26 17:47:51.9097 Timer Late       >   1.0 : 23.58194
2006-12-26 17:47:51.9153 Timer Late       >   1.0 : 23.50839
2006-12-26 17:47:51.9354 Timer Late       >   1.0 : 23.24805
2006-12-26 17:47:51.9406 Timer Late       >   1.0 : 22.94052
2006-12-26 17:47:51.9462 Timer Late       >   1.0 : 22.94606
2006-12-26 17:47:51.9539 Timer Late       >   1.0 : 22.93472
2006-12-26 17:47:51.9594 Timer Late       >   1.0 : 22.92087
2006-12-26 17:47:51.9687 Timer Late       >   1.0 : 12.37249
2006-12-26 17:47:51.9742 Timer Late       >   1.0 : 12.36450
2006-12-26 17:51:12.5731 Request Task     >   1.0 : 200.93569   
Notify: Slim::Player::Playlist::modifyPlaylistCallback


+-------------------------------------------------------------------+
|Filename: log.txt                                                  |
|Download: http://forums.slimdevices.com/attachment.php?attachmentid=2184|
+-------------------------------------------------------------------+

-- 
wcburnette
------------------------------------------------------------------------
wcburnette's Profile: http://forums.slimdevices.com/member.php?userid=4638
View this thread: http://forums.slimdevices.com/showthread.php?t=30145

_______________________________________________
discuss mailing list
[email protected]
http://lists.slimdevices.com/lists/listinfo/discuss

Reply via email to