Created attachment 7267 [details]
scanning never ends...

Maybe a related error in scanner.log:

[11-05-10 06:13:26.9988] Slim::Utils::SQLiteHelper::updateProgress (500) Notify to server: [
  "progress:1305000513.37439-importer-precacheArtwork-3844-4027-",
]
[11-05-10 06:13:31.9989] Slim::Utils::SQLiteHelper::updateProgress (516) Notify to server failed: 500 read timeout

Created attachment 7268 [details]
No images in web ui after failed scanning

No images in web ui after failed scanning (Or in squeezeplay, ipeng etc.)

Please add comments if you are seeing this issue.

I'm experiencing this issue frequently... Is there something I can do to help?

I haven't seen this happening since the recent nightly builts, 23/05/2011, and later.

Spoke too soon, it happened again. Version: 7.6.0 - r32492

When the scanner is succesfull there are no 'failed' messages in the log...

Version: 7.6.0 - r32499: problems again.

scanner.log:
[11-06-03 06:10:27.3962] Slim::Utils::SQLiteHelper::updateProgress (500) Notify to server: [
  "progress:1307074085.16544-importer-precacheArtwork-1464-4095-",
]
[11-06-03 06:10:32.3994] Slim::Utils::SQLiteHelper::updateProgress (516) Notify to server failed: 500 read timeout

server.log:
[11-06-03 06:10:22.3915] Slim::Utils::SQLiteHelper::_notifyFromScanner (579) Notify from scanner: progress:1307074085.16544-importer-precacheArtwork-1401-4095-
[11-06-03 06:10:22.8882] Slim::Web::Graphics::artworkRequest (83) Artwork request: html/images/Players/squeezebox3_250x250.png
[11-06-03 06:11:10.3056] Slim::Networking::IO::Select::__ANON__ (147) Error: Select task failed calling Slim::Web::HTTP::processHTTP: DBD::SQLite::st execute failed: database is locked at /<C:\PROGRA~2\SQUEEZ~1\server\SqueezeSvr.exe>Slim/Utils/ArtworkCache.pm line 132.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0xe413434)
[11-06-03 06:11:10.3434] Slim::Utils::SQLiteHelper::_notifyFromScanner (579) Notify from scanner: progress:1307074085.16544-importer-precacheArtwork-1464-4095-
[11-06-03 06:11:10.3590] Slim::Utils::SQLiteHelper::_notifyFromScanner (579) Notify from scanner: progress:1307074085.16544-importer-precacheArtwork-1465-4095-

So if the problems occur there are failed messages in both scanner.log and server.log

A friend looked at my Squeezeboxserver the other day and noticed that all my album art showed red crosses. He immediately asked if by any chance I installed Squeezeboxserver 7.6...

I think you're just seeing the results of the external scanner crashing before it gets to the point where it resizes and pre-caches artwork. Scanner crashes are being reported by the dozens in both 7.5.x and 7.6 beta.

If that's the case, then the bug here is that the server isn't able recover and serve images after the scanner crash. Pre-caching artwork isn't actually necessary, so you shouldn't have missing artwork when you browse the library.

Have you tried running any 'new & changed' scans after the 'clear & rescan' has failed? If not, try it.

Jim,

I think you're right, it's just the results of the external scanner crashing. However, on my computer (Windows 7, x64), this only happens in the 'Pre-Caching Artwork' stage.

I've tried running any 'new & changed' scan after the 'clear & rescan' has
failed, but this doesn't resolve the problems with the artwork. A simple reboot of the PC will resolve the problems with the artwork. (Without a rescan)

I think this bug is quite easy to reproduce: Just enable 'Rescan Music Library' and set the rescan type to "Clear library and rescan everything"

I hoped that with https://bugs-archive.lyrion.org/show_bug.cgi?id=17173 fixed, this problem would als be solved. I can confirm it hasn't been solved :-(

And still the same error messages:

Slim::Control::Request::notify (2079) Error: Failed notify: Can't call method "get" on an undefined value at C:\ProgramData\Squeezebox\Cache\InstalledPlugins/Plugins/SugarCube/Plugin.pm line 894.
Slim::Networking::IO::Select::__ANON__ (147) Error: Select task failed calling Slim::Web::HTTP::processHTTP: DBD::SQLite::st execute failed: database is locked at /<C:\PROGRA~2\SQUEEZ~1\server\SqueezeSvr.exe>Slim/Utils/ArtworkCache.pm line 132.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0xcc4a7b4)
Slim::Networking::IO::Select::__ANON__ (147) Error: Select task failed calling Slim::Web::HTTP::processHTTP: DBD::SQLite::st fetchrow_array failed: database is locked at /<C:\PROGRA~2\SQUEEZ~1\server\SqueezeSvr.exe>Slim/Utils/ArtworkCache.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0xca3a49c)

I think when the pc has been rebooted, the lock also has been removed. The strange thing is that all artwork has been restored after the reboot of the pc, without a new rescan.

Dennis - could you please try to reproduce this issue without any 3rd party plugin? I see that one of the conflicting calls comes from SugarCube.

That's what I noticed too. Removed my 3rd party plugins (Sugarcube & Trackstat). Guess what? No images again...

scanner log:
Slim::Utils::SQLiteHelper::updateProgress (500) Notify to server: [
  "progress:1311650684.01855-importer-precacheArtwork-879-4126-",
]
Slim::Utils::SQLiteHelper::updateProgress (516) Notify to server failed: 500 read timeout
Slim::Music::Artwork::__ANON__ (508) Pre-caching artwork for In het Teken van de Ram from D:\Music\Astrid Nijgh\In het Teken van de Ram\cover.jpg
Slim::Utils::SQLiteHelper::updateProgress (500) Notify to server: [
  "progress:1311650684.01855-importer-precacheArtwork-880-4126-",
]
Slim::Utils::SQLiteHelper::updateProgress (516) Notify to server failed: 500 read timeout
Slim::Music::Artwork::__ANON__ (508) Pre-caching artwork for Mensen Zijn Je Beste Vrienden from D:\Music\Astrid Nijgh\Mensen Zijn Je Beste Vrienden\cover.jpg
Slim::Utils::SQLiteHelper::updateProgress (500) Notify to server: [
  "progress:1311650684.01855-importer-precacheArtwork-881-4126-",
]
Slim::Utils::SQLiteHelper::updateProgress (516) Notify to server failed: 500 read timeout
Slim::Music::Artwork::__ANON__ (508) Pre-caching artwork for Tegen Het Lijf from D:\Music\Astrid Nijgh\Tegen Het Lijf\cover.jpg
Slim::Utils::SQLiteHelper::updateProgress (500) Notify to server: [
  "progress:1311650684.01855-importer-precacheArtwork-882-4126-",
]
Slim::Utils::SQLiteHelper::updateProgress (516) Notify to server failed: 500 read timeout
Slim::Music::Artwork::__ANON__ (508) Pre-caching artwork for Waterfall from D:\Music\Atlantic Ocean\Waterfall\cover.jpg
Slim::Utils::SQLiteHelper::updateProgress (500) Notify to server: [
  "progress:1311650684.01855-importer-precacheArtwork-883-4126-",
]
Slim::Utils::SQLiteHelper::updateProgress (516) Notify to server failed: 500 read timeout
Slim::Music::Artwork::__ANON__ (508) Pre-caching artwork for Exotic Robotics: Pleasure141x from D:\Music\Atmospherex\Exotic Robotics; Pleasure141x\cover.jpg
Slim::Utils::SQLiteHelper::updateProgress (500) Notify to server: [
  "progress:1311650684.01855-importer-precacheArtwork-884-4126-",
]
Slim::Utils::SQLiteHelper::updateProgress (516) Notify to server failed: 500 read timeout

server log:
Slim::Networking::IO::Select::__ANON__ (147) Error: Select task failed calling Slim::Web::HTTP::processHTTP: DBD::SQLite::st fetchrow_array failed: database is locked at /<C:\PROGRA~2\SQUEEZ~1\server\SqueezeSvr.exe>Slim/Utils/ArtworkCache.pm line 134.
; fh=Slim::Web::HTTP::ClientConn=GLOB(0xb275164)

I only need to stop & start the Squeezebox Server service to correct the problem. Not the PC, as I initionally thought.

When this happens, are you doing anything with SBS, eg. browse the collection? Or does it happen even if you don't touch it?

I've scheduled a daily clear & rescan at 05:00 am in the morning, so normally I'm not doing anything :-).

It doesn't happen each and every time. Sometimes it works for several days in a row. I think it fails ever 2 out of 3 times.

Other user with same problem?
http://forums.slimdevices.com/showthread.php?p=643261#post643261

and:
http://forums.slimdevices.com/showthread.php?t=89045

Has anyone with this problem tried if it works correctly in the 7.6.1 nightly beta build ?

I've seen it once last week, but it used to happen almost every day (during my daile clear & rescan schedule). I wouldn't call it fixed, but it happens not as often anymore.

*** This bug has been confirmed by popular vote. ***

Ronald, Dennis - could you please re-test with the latest 7.6.2 nightly build? There have been more fixes which might be related to this issue.

This week I've switched from Squeezeboxserver 7.6.2 to Logitech Media Server 7.7. I haven't experienced this issue since the last time I replied here. I normally install nightlies when they're released.

Unassigned bugs cannot have a priority.