PDA

View Full Version : LMS Has Become Unstable



gershbec
2015-01-26, 19:08
Iím a longtime Squeezebox user (Transporter and Boom) and Iíve usually been able to work through whatever problems Iíve encountered with keep my music up. Unfortunately my LMS has become very unstable lately and Iíve been tearing out my hair trying to fix it. I've upgraded and downgraded the version with clean installs and now I'm back on 7.8.1. Reset both my players too.

Iíve got a MacMini (Mavericks) with an external drive with about 225,000 songs in Apple lossless. The Logitech Media Server lists nothing under Media Library Statistics and Information comes up empty, despite the scan having finished.

My iPeng will list the players but when I play some music, I may or may not get a little music before the LMS restarts itself. Sometimes Iíll get a list of the artists but when I go to look at the albums, there is no content.

I suspect that this may have something to do with album art, as my Squeezebox is playing right now but no artwork is showing. I could turn off the artwork if anyone knows how to do this. My other suspicion is that perhaps this is because of the size of my library.

I will post the log in the first reply. If anyone has any idea of troubleshooting ideas Iíd love to hear from you!

gershbec
2015-01-26, 19:09
[15-01-25 21:45:39.1141] main::init (368) Starting Logitech Media Server (v7.8.1, 1421915369, Thu Jan 22 19:08:05 PST 2015) perl 5.016002
[15-01-25 21:45:39.1139] main::init (368) Starting Logitech Media Server (v7.8.1, 1421915369, Thu Jan 22 19:08:05 PST 2015) perl 5.016002
[15-01-25 21:47:36.0487] Slim::Formats::XML::gotErrorViaHTTP (356) Error: getting http://opml.radiotime.com/Index.aspx?partnerId=16
Timed out waiting for data
[15-01-25 21:47:36.0489] Slim::Plugin::InternetRadio::Plugin::_gotRadioErro r (78) Unable to retrieve radio directory from SN: Timed out waiting for data
[15-01-25 21:47:36.1011] Slim::Networking::SqueezeNetwork::_error (604) Unable to login to SN: Timed out waiting for data
[15-01-25 21:47:36.1015] Slim::Networking::SqueezeNetwork::_init_error (213) Unable to login to mysqueezebox.com, sync is disabled: Timed out waiting for data (http://www.mysqueezebox.com)
[15-01-25 21:47:36.1019] Slim::Networking::SqueezeNetwork::_init_error (227) mysqueezebox.com sync init failed: Timed out waiting for data, will retry in 300 (http://www.mysqueezebox.com)
[15-01-25 21:58:29.6688] Slim::Networking::SqueezeNetwork::Players::_player s_error (337) Unable to get players from SN: Timed out waiting for data, retrying in 60 seconds
[15-01-25 22:01:18.2578] Slim::Networking::SqueezeNetwork::_error (604) Unable to login to SN: Timed out waiting for data
[15-01-25 22:01:18.2582] Slim::Networking::SqueezeNetwork::Players::_player s_error (337) Unable to get players from SN: Timed out waiting for data, retrying in 120 seconds
[15-01-25 22:15:17.9528] Slim::Web::Cometd::handler (201) Invalid request without clientId - discarding remaining requests in packet
[15-01-25 21:47:36.0486] Slim::Formats::XML::gotErrorViaHTTP (356) Error: getting http://opml.radiotime.com/Index.aspx?partnerId=16
Timed out waiting for data
[15-01-25 21:47:36.0488] Slim::Plugin::InternetRadio::Plugin::_gotRadioErro r (78) Unable to retrieve radio directory from SN: Timed out waiting for data
[15-01-25 21:47:36.1009] Slim::Networking::SqueezeNetwork::_error (604) Unable to login to SN: Timed out waiting for data
[15-01-25 21:47:36.1013] Slim::Networking::SqueezeNetwork::_init_error (213) Unable to login to mysqueezebox.com, sync is disabled: Timed out waiting for data (http://www.mysqueezebox.com)
[15-01-25 21:47:36.1018] Slim::Networking::SqueezeNetwork::_init_error (227) mysqueezebox.com sync init failed: Timed out waiting for data, will retry in 300 (http://www.mysqueezebox.com)
[15-01-25 21:58:29.6687] Slim::Networking::SqueezeNetwork::Players::_player s_error (337) Unable to get players from SN: Timed out waiting for data, retrying in 60 seconds
[15-01-25 22:01:18.2577] Slim::Networking::SqueezeNetwork::_error (604) Unable to login to SN: Timed out waiting for data
[15-01-25 22:01:18.2581] Slim::Networking::SqueezeNetwork::Players::_player s_error (337) Unable to get players from SN: Timed out waiting for data, retrying in 120 seconds
[15-01-25 22:15:17.9526] Slim::Web::Cometd::handler (201) Invalid request without clientId - discarding remaining requests in packet
/Library/PreferencePanes/Squeezebox.prefPane/Contents/server/Bin/darwin/sox FAIL sox: `-' error writing output file: Broken pipe
/Library/PreferencePanes/Squeezebox.prefPane/Contents/server/Bin/darwin/sox FAIL sox: `-' error writing output file: Broken pipe
[15-01-25 22:39:19.0499] Slim::Networking::IO::Select::__ANON__ (147) Error: Select task failed calling Slim::Web::HTTP::processHTTP: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Library/PreferencePanes/Squeezebox.prefPane/Contents/server/Slim/Networking/IO/Select.pm line 150.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x7ff3366b11c8 )
[15-01-25 22:39:19.1133] Slim::Web::Cometd::handler (201) Invalid request without clientId - discarding remaining requests in packet
[15-01-25 22:39:52.8919] Slim::Web::Cometd::handler (201) Invalid request without clientId - discarding remaining requests in packet
/Library/PreferencePanes/Squeezebox.prefPane/Contents/server/Bin/darwin/sox FAIL sox: `-' error writing output file: Broken pipe
[15-01-25 22:39:19.0497] Slim::Networking::IO::Select::__ANON__ (147) Error: Select task failed calling Slim::Web::HTTP::processHTTP: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Library/PreferencePanes/Squeezebox.prefPane/Contents/server/Slim/Networking/IO/Select.pm line 150.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x7ff3366b11c8 )
[15-01-25 22:39:19.1132] Slim::Web::Cometd::handler (201) Invalid request without clientId - discarding remaining requests in packet
[15-01-25 22:39:52.8918] Slim::Web::Cometd::handler (201) Invalid request without clientId - discarding remaining requests in packet
sh: fork: Resource temporarily unavailable
sh: fork: Resource temporarily unavailable
sh: fork: Resource temporarily unavailable
sh: fork: Resource temporarily unavailable
sh: fork: Resource temporarily unavailable

pippin
2015-01-26, 19:22
Did the scan complete? Was it a full one?

gershbec
2015-01-26, 19:37
The last scan was for new music but I've done complete scans multiple times in the last couple of days trying to sort this out. Here's the last log:

[15-01-24 23:24:52.7066] main::main (202) Starting Logitech Media Server scanner (v7.8.1, 1421915369, Thu Jan 22 19:08:05 PST 2015) perl 5.016002
[15-01-24 23:24:53.6081] Slim::Schema::forceCommit (2125) Warning: Trying to commit transactions before DB is initialized!
[15-01-24 23:24:54.0983] Slim::Music::Import::runImporter (488) Starting Slim::Media::MediaFolderScan scan
[15-01-24 23:24:54.0989] Slim::Utils::Scanner::Local::rescan (174) Discovering audio files in /Volumes/G-RAID/iTunes
[15-01-24 23:38:11.7207] Slim::Utils::Scanner::Local::__ANON__ (257) Removing deleted audio files (0)
[15-01-24 23:38:11.7679] Slim::Utils::Scanner::Local::__ANON__ (335) Scanning new audio files (0)
[15-01-24 23:38:11.7683] Slim::Utils::Scanner::Local::__ANON__ (413) Rescanning changed audio files (0)
[15-01-24 23:38:11.7708] Slim::Music::Import::endImporter (620) Completed Slim::Media::MediaFolderScan Scan in 797 seconds.
[15-01-24 23:38:12.2121] Slim::Music::Import::runImporter (488) Starting Slim::Plugin::iTunes::Importer scan
[15-01-24 23:39:44.4532] Slim::Music::Import::endImporter (620) Completed Slim::Plugin::iTunes::Importer Scan in 92 seconds.
[15-01-24 23:39:44.4542] Slim::Music::Import::runArtworkImporter (511) Starting Slim::Plugin::iTunes::Importer::Artwork::OSX artwork scan
[15-01-24 23:40:00.0833] Slim::Music::Artwork::updateStandaloneArtwork (204) Starting updateStandaloneArtwork for 9692 albums
[15-01-24 23:41:44.5358] Slim::Music::Artwork::__ANON__ (302) updateStandaloneArtwork finished in 104.449398994446
[15-01-24 23:41:45.2455] Slim::Music::Artwork::precacheAllArtwork (608) Starting precacheArtwork for 989 albums
[15-01-24 23:48:26.5192] Slim::Music::Artwork::__ANON__ (727) precacheArtwork finished in 401.269305944443
[15-01-24 23:48:26.5358] Slim::Music::Import::endImporter (620) Completed precacheArtwork Scan in 401 seconds.
[15-01-24 23:49:15.7031] Slim::Music::Import::runScanPostProcessing (403) Starting Database optimization.
[15-01-24 23:59:47.7003] Slim::Music::Import::endImporter (620) Completed dbOptimize Scan in 631 seconds.

gershbec
2015-01-26, 19:39
It looks like my post with the server log didn't go through - here it is.

[15-01-25 21:45:39.1141] main::init (368) Starting Logitech Media Server (v7.8.1, 1421915369, Thu Jan 22 19:08:05 PST 2015) perl 5.016002
[15-01-25 21:45:39.1139] main::init (368) Starting Logitech Media Server (v7.8.1, 1421915369, Thu Jan 22 19:08:05 PST 2015) perl 5.016002
[15-01-25 21:47:36.0487] Slim::Formats::XML::gotErrorViaHTTP (356) Error: getting http://opml.radiotime.com/Index.aspx?partnerId=16
Timed out waiting for data
[15-01-25 21:47:36.0489] Slim::Plugin::InternetRadio::Plugin::_gotRadioErro r (78) Unable to retrieve radio directory from SN: Timed out waiting for data
[15-01-25 21:47:36.1011] Slim::Networking::SqueezeNetwork::_error (604) Unable to login to SN: Timed out waiting for data
[15-01-25 21:47:36.1015] Slim::Networking::SqueezeNetwork::_init_error (213) Unable to login to mysqueezebox.com, sync is disabled: Timed out waiting for data (http://www.mysqueezebox.com)
[15-01-25 21:47:36.1019] Slim::Networking::SqueezeNetwork::_init_error (227) mysqueezebox.com sync init failed: Timed out waiting for data, will retry in 300 (http://www.mysqueezebox.com)
[15-01-25 21:58:29.6688] Slim::Networking::SqueezeNetwork::Players::_player s_error (337) Unable to get players from SN: Timed out waiting for data, retrying in 60 seconds
[15-01-25 22:01:18.2578] Slim::Networking::SqueezeNetwork::_error (604) Unable to login to SN: Timed out waiting for data
[15-01-25 22:01:18.2582] Slim::Networking::SqueezeNetwork::Players::_player s_error (337) Unable to get players from SN: Timed out waiting for data, retrying in 120 seconds
[15-01-25 22:15:17.9528] Slim::Web::Cometd::handler (201) Invalid request without clientId - discarding remaining requests in packet
[15-01-25 21:47:36.0486] Slim::Formats::XML::gotErrorViaHTTP (356) Error: getting http://opml.radiotime.com/Index.aspx?partnerId=16
Timed out waiting for data
[15-01-25 21:47:36.0488] Slim::Plugin::InternetRadio::Plugin::_gotRadioErro r (78) Unable to retrieve radio directory from SN: Timed out waiting for data
[15-01-25 21:47:36.1009] Slim::Networking::SqueezeNetwork::_error (604) Unable to login to SN: Timed out waiting for data
[15-01-25 21:47:36.1013] Slim::Networking::SqueezeNetwork::_init_error (213) Unable to login to mysqueezebox.com, sync is disabled: Timed out waiting for data (http://www.mysqueezebox.com)
[15-01-25 21:47:36.1018] Slim::Networking::SqueezeNetwork::_init_error (227) mysqueezebox.com sync init failed: Timed out waiting for data, will retry in 300 (http://www.mysqueezebox.com)
[15-01-25 21:58:29.6687] Slim::Networking::SqueezeNetwork::Players::_player s_error (337) Unable to get players from SN: Timed out waiting for data, retrying in 60 seconds
[15-01-25 22:01:18.2577] Slim::Networking::SqueezeNetwork::_error (604) Unable to login to SN: Timed out waiting for data
[15-01-25 22:01:18.2581] Slim::Networking::SqueezeNetwork::Players::_player s_error (337) Unable to get players from SN: Timed out waiting for data, retrying in 120 seconds
[15-01-25 22:15:17.9526] Slim::Web::Cometd::handler (201) Invalid request without clientId - discarding remaining requests in packet
/Library/PreferencePanes/Squeezebox.prefPane/Contents/server/Bin/darwin/sox FAIL sox: `-' error writing output file: Broken pipe
/Library/PreferencePanes/Squeezebox.prefPane/Contents/server/Bin/darwin/sox FAIL sox: `-' error writing output file: Broken pipe
[15-01-25 22:39:19.0499] Slim::Networking::IO::Select::__ANON__ (147) Error: Select task failed calling Slim::Web::HTTP::processHTTP: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Library/PreferencePanes/Squeezebox.prefPane/Contents/server/Slim/Networking/IO/Select.pm line 150.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x7ff3366b11c8 )
[15-01-25 22:39:19.1133] Slim::Web::Cometd::handler (201) Invalid request without clientId - discarding remaining requests in packet
[15-01-25 22:39:52.8919] Slim::Web::Cometd::handler (201) Invalid request without clientId - discarding remaining requests in packet
/Library/PreferencePanes/Squeezebox.prefPane/Contents/server/Bin/darwin/sox FAIL sox: `-' error writing output file: Broken pipe
[15-01-25 22:39:19.0497] Slim::Networking::IO::Select::__ANON__ (147) Error: Select task failed calling Slim::Web::HTTP::processHTTP: illegal file descriptor or filehandle (either no attached file descriptor or illegal value): at /Library/PreferencePanes/Squeezebox.prefPane/Contents/server/Slim/Networking/IO/Select.pm line 150.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0x7ff3366b11c8 )
[15-01-25 22:39:19.1132] Slim::Web::Cometd::handler (201) Invalid request without clientId - discarding remaining requests in packet
[15-01-25 22:39:52.8918] Slim::Web::Cometd::handler (201) Invalid request without clientId - discarding remaining requests in packet
sh: fork: Resource temporarily unavailable
sh: fork: Resource temporarily unavailable
sh: fork: Resource temporarily unavailable
sh: fork: Resource temporarily unavailable
sh: fork: Resource temporarily unavailable

gershbec
2015-01-26, 19:39
BTW, I've tried to submit the server log but for some reason it needs to be approved (because it has urls?) Anyway, hopefully that will appear here soon.

Mnyb
2015-01-26, 22:23
BTW, I've tried to submit the server log but for some reason it needs to be approved (because it has urls?) Anyway, hopefully that will appear here soon.

You can take the complete log files and zip them and post here ( or add the txt files if they are small enough ) , just not copy excerpts from the web UI .

Then you can post the full log .

If the scan does not finish there is no hope of any decent functionality . So the system needs to have complete scan that's completed trouble free .

Did you try with as few plugins as possible ? With or without the iTunes integration on ? You can piont LMS directly to the files in its basic settings and not use the iTunes integration .

Another tip seems to be to delete all .dB and .wal files in the cache directory and restart LMS and let it finish its scan .

Mavericks do a search on that , and don't know if the fixes made to get LMS to work with Mavericks is done to anything less than >7.8.1 or is it even 7.9 I haven't followed which server version that fits which OSX version .

gershbec
2015-01-27, 08:14
I've got iTunes integration on. I can try turning it off but will I lose track gain?

I've turned off the plugins that I knew I wasn't using but I'll try turning off more of the radio ones tonight (as well as deleting the suggested files).

Here is the log
1723517235