Media scan exits without collecting error in scanner or server debug logs #1401
Description
Describe the bug
The past few weeks the scanner kept crashing with this UI message: Media scan terminated unexpectedly (Scanning Progress). After examining the logs I noticed that it terminated at the same file each time: lms | [25-06-03 14:02:23.1890] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2013]%20[Universal%20Music%20Digital%20Services]%20[24B%20192%20kHz]/06.%20Norah%20Jones%20-%20Shoot%20the%20Moon.flac.
When running ffprobe on the file, it returned errors and Navidrome refused to play the file. After deleting the file in question Lyrion completed the scan without issue. Unfortunately, I did not have the foresight to keep this file so I am unable to provide it for this issue.
I am opening this issue to request that errors such as this do not interrupt the scanner and/or the error be included in the log so its easier to find the problem. I am guessing the issue is the scanner exits before collecting the error ffprobe returns? I spent more time than I would like to admit trying to determine if it was my machine, NFS connection, docker compose, etc and I would guess this is not an uncommon issue. Or I am the oddball 😆
To Reproduce
Steps to reproduce the behavior:
- Have corrupted FLAC file
- Run clean or new file scan
Media scan terminated unexpectedly (Scanning Progress)
Expected behavior
Scan completes. If there is a problematic file, an error is logged and reported in the UI without interrupting the scan.
System Information (please complete the following information):
- OS on which you're running LMS: Debian Host - Docker Container
- Web skin used: Material
- Browser: Firefox/Ungoogled Chromium
- LMS Versions: 9.0.2, 9.0.3, 9.1.x (dev branch)
Additional context
server.log
scanner.log
[...snippet of debug scanner.log...]
lms | [25-06-03 14:02:23.0140] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2002]%20[Blue%20Note]%20[16B%2044.1%20kHz]/01.%20Norah%20Jones%20-%20Don%27t%20Know%20Why.flac
lms | [25-06-03 14:02:23.0264] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2002]%20[Blue%20Note]%20[16B%2044.1%20kHz]/02.%20Norah%20Jones%20-%20Seven%20Years.flac
lms | [25-06-03 14:02:23.0327] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2002]%20[Blue%20Note]%20[16B%2044.1%20kHz]/03.%20Norah%20Jones%20-%20Cold%20Cold%20Heart.flac
lms | [25-06-03 14:02:23.0390] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2002]%20[Blue%20Note]%20[16B%2044.1%20kHz]/04.%20Norah%20Jones%20-%20Feelin%27%20the%20Same%20Way.flac
lms | [25-06-03 14:02:23.0459] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2002]%20[Blue%20Note]%20[16B%2044.1%20kHz]/05.%20Norah%20Jones%20-%20Come%20Away%20With%20Me.flac
lms | [25-06-03 14:02:23.0552] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2002]%20[Blue%20Note]%20[16B%2044.1%20kHz]/06.%20Norah%20Jones%20-%20Shoot%20the%20Moon.flac
lms | [25-06-03 14:02:23.0654] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2002]%20[Blue%20Note]%20[16B%2044.1%20kHz]/07.%20Norah%20Jones%20-%20Turn%20Me%20On.flac
lms | [25-06-03 14:02:23.0741] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2002]%20[Blue%20Note]%20[16B%2044.1%20kHz]/08.%20Norah%20Jones%20-%20Lonestar.flac
lms | [25-06-03 14:02:23.0805] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2002]%20[Blue%20Note]%20[16B%2044.1%20kHz]/09.%20Norah%20Jones%20-%20I%27ve%20Got%20to%20See%20You%20Again.flac
lms | [25-06-03 14:02:23.0863] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2002]%20[Blue%20Note]%20[16B%2044.1%20kHz]/10.%20Norah%20Jones%20-%20Painter%20Song.flac
lms | [25-06-03 14:02:23.0917] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2002]%20[Blue%20Note]%20[16B%2044.1%20kHz]/11.%20Norah%20Jones%20-%20One%20Flight%20Down.flac
lms | [25-06-03 14:02:23.1036] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2002]%20[Blue%20Note]%20[16B%2044.1%20kHz]/12.%20Norah%20Jones%20-%20Nightingale.flac
lms | [25-06-03 14:02:23.1096] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2002]%20[Blue%20Note]%20[16B%2044.1%20kHz]/13.%20Norah%20Jones%20-%20The%20Long%20Day%20Is%20Over.flac
lms | [25-06-03 14:02:23.1145] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2002]%20[Blue%20Note]%20[16B%2044.1%20kHz]/14.%20Norah%20Jones%20-%20The%20Nearness%20of%20You.flac
lms | [25-06-03 14:02:23.1237] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2013]%20[Universal%20Music%20Digital%20Services]%20[24B%20192%20kHz]/01.%20Norah%20Jones%20-%20Don%27t%20Know%20Why.1.flac
lms | [25-06-03 14:02:23.1371] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2013]%20[Universal%20Music%20Digital%20Services]%20[24B%20192%20kHz]/01.%20Norah%20Jones%20-%20Don%27t%20Know%20Why.flac
lms | [25-06-03 14:02:23.1428] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2013]%20[Universal%20Music%20Digital%20Services]%20[24B%20192%20kHz]/02.%20Norah%20Jones%20-%20Seven%20Years.1.flac
lms | [25-06-03 14:02:23.1485] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2013]%20[Universal%20Music%20Digital%20Services]%20[24B%20192%20kHz]/02.%20Norah%20Jones%20-%20Seven%20Years.flac
lms | [25-06-03 14:02:23.1536] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2013]%20[Universal%20Music%20Digital%20Services]%20[24B%20192%20kHz]/03.%20Norah%20Jones%20-%20Cold%20Cold%20Heart.1.flac
lms | [25-06-03 14:02:23.1587] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2013]%20[Universal%20Music%20Digital%20Services]%20[24B%20192%20kHz]/03.%20Norah%20Jones%20-%20Cold%20Cold%20Heart.flac
lms | [25-06-03 14:02:23.1637] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2013]%20[Universal%20Music%20Digital%20Services]%20[24B%20192%20kHz]/04.%20Norah%20Jones%20-%20Feelin%27%20the%20Same%20Way.1.flac
lms | [25-06-03 14:02:23.1687] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2013]%20[Universal%20Music%20Digital%20Services]%20[24B%20192%20kHz]/04.%20Norah%20Jones%20-%20Feelin%27%20the%20Same%20Way.flac
lms | [25-06-03 14:02:23.1737] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2013]%20[Universal%20Music%20Digital%20Services]%20[24B%20192%20kHz]/05.%20Norah%20Jones%20-%20Come%20Away%20With%20Me.1.flac
lms | [25-06-03 14:02:23.1784] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2013]%20[Universal%20Music%20Digital%20Services]%20[24B%20192%20kHz]/05.%20Norah%20Jones%20-%20Come%20Away%20With%20Me.flac
lms | [25-06-03 14:02:23.1842] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2013]%20[Universal%20Music%20Digital%20Services]%20[24B%20192%20kHz]/06.%20Norah%20Jones%20-%20Shoot%20the%20Moon.1.flac
lms | [25-06-03 14:02:23.1890] Slim::Utils::Scanner::Local::new (935) Handling new audio track file:///music/music1/Norah%20Jones/Come%20Away%20With%20Me%20-%20Norah%20Jones%20[2013]%20[Universal%20Music%20Digital%20Services]%20[24B%20192%20kHz]/06.%20Norah%20Jones%20-%20Shoot%20the%20Moon.flac
[end of log - this is where it 'stopped unexpectedly']