anyone else having issues with new version 3.804 not scanning the nas music library completly , ive installed a old version and its scanned all my music 10 000+ tracks now with the new version it goes until it reaches 4566 tracks then just stop’s update or rescan dosent do nothing
Please post a log right after the scan aborts.
I spent last evening debugging this issue for my setup and can share the following for those with similar problems.
In my case the update was running extremely slowly as it was encountering media files that required inordinate processing time to get metadata from. I can only assume that this happens in later releases as the packages now include wider file type support and are actually being processed instead of skipped.
So this turned out not to be rocket science, but I had some video type files mixed in with my music library directories. I have the same file set on NAS and locally attached USB and the behaviour was the same for both locations, so I could rule out SMB issues or access speed.
I had also installed the nmon package to see what was happening to system resources during the updates. It showed that one processor was 100% waiting on disk access, with almost no other cpu activity, but almost no disk or network activity. This was quite odd and seemed to indicate a hung process.
To debug I had to enable ssh on the volumio machine from the dev console. Then ssh in and increase the log level output for mpd by editing /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl
and setting the log level line as
log_level “verbose”
Then restart volumio.
The output of the mpd logs in in /var/log/mpd.log, so I tailed the logs there and started the update process manually by the command
mpc update
in another terminal window.
What I could see was that there were file types of m2ts, mkv and mp4 which were being inspected and producing hundreds of log lines. So I did two things:-
- locate and remove the .m2ts files, as they were just experiments for multichannel audio packaging.
- cd to /var/lib/mpd/music and edit the .mpdignore file and add lines for
*.mkv
*.mp4
This instructs mpd to not process these file types. I needed that as these are ATMOS audio files which rightly live in my Music file system, and are shared elsewhere for different renderers.
After these changes the update process across both file locations (around 1.3TB) took only a few minutes to fully process. I was left with a set of logs which tell me that I have few DSF files with missing or incomplete metatdata, that I have to fix, but they are not interrupting the update process.
I hope this helps.
Hi
I have for few weeks problem with my volumio setup dont want to scan and save my nas library .
I switch to moode but cant handle constant issues , so I come back to volumio and I find out oldest 2.599 (i have on my server) scans library very quick and no problem .
I find out weird behavior of volumio if using older version :
-update of library takes like 10 min
-no plugins on 2.9
-version 3.7 works perfect with plugins and library update
-if player is connected to network it update self and after next start i have newest version and no library and endless scan
-I can keep it offline but cant download screen plugin (if trying download plugin also will download latest version of volumio)
-my free volumio have no access to plugins anymore on latest version
is anyone try it that way?
here is the log keeps on saying info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats but still not scanning more then 5356 songs the only way i can get it to scan the 40 000 tracks i have is i need to installer volumio 3.6 scan my files and then update to the latest version if i go with the most recent version it stops scanning after 5356 tracks
Starting Live Log...
receive: Unexpected origin timestamp 0xed6160d3.e813e500 does not match aorg 0000000000.00000000 from server@23.133.168.246 xmt 0xed6160d4.58d1f516
receive: Unexpected origin timestamp 0xed6160d3.e818aebb does not match aorg 0000000000.00000000 from server@216.197.156.83 xmt 0xed6160d4.58e1b436
receive: Unexpected origin timestamp 0xed6160d3.e816f64e does not match aorg 0000000000.00000000 from server@216.232.132.19 xmt 0xed6160d4.5c4f5aef
receive: Unexpected origin timestamp 0xed6160d3.e81b366c does not match aorg 0000000000.00000000 from server@199.182.221.110 xmt 0xed6160d4.5bdabe74
/lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Reloading.
/lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
info: CALLMETHOD: system_controller system enableLiveLog true
info: CoreCommandRouter::executeOnPlugin: system , enableLiveLog
info: Launching a new LiveLog session
pam_unix(sudo:session): session closed for user root
info: enable SSH service success
volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
pam_unix(sudo:session): session opened for user root by (uid=0)
pam_unix(sudo:session): session closed for user root
volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
pam_unix(sudo:session): session opened for user root by (uid=0)
pam_unix(sudo:session): session closed for user root
volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
pam_unix(sudo:session): session opened for user root by (uid=0)
pam_unix(sudo:session): session closed for user root
volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
pam_unix(sudo:session): session opened for user root by (uid=0)
pam_unix(sudo:session): session closed for user root
info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
info: CoreCommandRouter::volumioGetVisibleSources
info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
info: CoreCommandRouter::volumioGetState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
info: Received Get System Info
info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
info: Discovery: Getting this device information
info: CoreCommandRouter::volumioGetState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
info: CoreCommandRouter::volumioGetState
info: CorePlayQueue::getTrack 0
info: Listing playlists
info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
info: CoreCommandRouter::volumioGetState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
info: Received Get System Info
info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
info: Discovery: Getting this device information
info: CoreCommandRouter::volumioGetState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
info: Received Get System Info
info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
info: Discovery: Getting this device information
info: CoreCommandRouter::volumioGetState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
info: CoreCommandRouter::getUIConfigOnPlugin
info: CoreCommandRouter::getUIConfigOnPlugin
info: Retrieving Cloud Streaming UI
info: Getting Tidal Cloud Configuration
info: CoreCommandRouter::getUIConfigOnPlugin
info: Getting Qobuz Cloud Configuration
info: Asking plugin for UI Config
info: CoreCommandRouter::getUIConfigOnPlugin
info: Getting Spotify Cloud Configuration
info: Asking plugin for UI Config
info: CoreCommandRouter::getUIConfigOnPlugin
info: Saving Spotify Acccount
info: Got Tidal Cloud Configuration
info: Got it
info: Got it
error: Could not retrieve Spotify Config from plugin Spotify: no section found
info: CoreCommandRouter::getUIConfigOnPlugin
error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
info: CoreCommandRouter::volumioGetBrowseSources
info: CoreCommandRouter::volumioGetBrowseSources
info: CoreCommandRouter::volumioGetBrowseSources
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::Close All Modals sent
info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
info: Received Get System Version
info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
info: Received Get System Info
info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
info: Discovery: Getting this device information
info: CoreCommandRouter::volumioGetState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: networkfs , addShare
info: Adding a new share
info: No correspondence found in configuration for share nas on IP 192.168.2.34
info: Executing SMB command: smbclient --debuglevel=4 -L 192.168.2.34 -N -m SMB3_11
info: Negotiated SMB version with nas: SMB3_11
info: Detected device nas with version SMB3_11
info: Version SMB3_11 detected, but user has specified version in options
volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=guest,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.0 //192.168.2.34/music /mnt/NAS/nas
pam_unix(sudo:session): session opened for user root by (uid=0)
Key type cifs.spnego registered
Key type cifs.idmap registered
CIFS: Attempting to mount //192.168.2.34/music
[2026/03/15 12:46:56.915562, 0] ../source3/param/loadparm.c:3362(process_usershare_file)
process_usershare_file: stat of /var/lib/samba/usershares/music failed. Permission denied
[2026/03/15 12:46:56.916275, 0] ../source3/param/loadparm.c:3362(process_usershare_file)
process_usershare_file: stat of /var/lib/samba/usershares/music failed. No such file or directory
CIFS: VFS: BAD_NETWORK_NAME: \\192.168.2.34\music
CIFS: VFS: cifs_mount failed w/return code = -2
pam_unix(sudo:session): session closed for user root
info: Error mounting nas on IP 192.168.2.34 : (2): No such file or directory
Refer to the mount.cifs(8) manual page (e.g. man mount.cifs)
info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: networkfs , editShare
info: Share nas successfully unmounted
volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=guest,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.0 //192.168.2.34//music /mnt/NAS/nas
pam_unix(sudo:session): session opened for user root by (uid=0)
pam_unix(sudo:session): session closed for user root
Malformed UNC in devname
CIFS: VFS: Malformed UNC in devname
info: An error occurred mounting the new share. Rolling back configuration
info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: networkfs , addShare
info: Adding a new share
info: Checking key NasMounts.16095c88-ca2a-48d6-9db0-f59825d12ab7
info: No correspondence found in configuration for share Nas on IP 192.168.2.33
info: Executing SMB command: smbclient --debuglevel=4 -L 192.168.2.33 -N -m SMB3_11
info: Negotiated SMB version with Nas: SMB3_11
info: Detected device Nas with version SMB3_11
info: Version SMB3_11 detected, but user has specified version in options
volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=guest,password=,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.0 //192.168.2.33/music /mnt/NAS/Nas
pam_unix(sudo:session): session opened for user root by (uid=0)
CIFS: Attempting to mount //192.168.2.33/music
pam_unix(sudo:session): session closed for user root
info:
---------------------------- MPD announces state update: update
info: ControllerMpd::getState
info: sendMpdCommand status took 5 milliseconds
info: sendMpdCommand status took 2 milliseconds
info: Command Router : Notfying DB Updatetrue
info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::volumioPushState
info: CorePlayQueue::getTrack 0
info: CoreStateMachine::syncState stateService stop
info: CoreStateMachine::syncState currentStatus stop
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: No code
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::volumioPushState
info: ------------------------------ 70ms
info:
---------------------------- MPD announces state update: update
info: ControllerMpd::getState
info: [1773593261809] Database update started
info: sendMpdCommand status took 8 milliseconds
info: sendMpdCommand status took 7 milliseconds
info: Command Router : Notfying DB Updatetrue
info: CoreCommandRouter::Close All Modals sent
info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::volumioPushState
info: CorePlayQueue::getTrack 0
info: CoreStateMachine::syncState stateService stop
info: CoreStateMachine::syncState currentStatus stop
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::volumioPushState
info: No code
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::volumioPushState
info: ------------------------------ 65ms
info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare
info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
[log edited by moderator for readability purposes]
Please post a full log, when scanning fails or appears to be complete. These snippets are missing all crucial information.
I see different IP’s with different errors, I will not do a guessing game.
info: No correspondence found in configuration for share nas on IP 192.168.2.34
info: Executing SMB command: smbclient --debuglevel=4 -L 192.168.2.34 -N -m SMB3_11
CIFS: VFS: BAD_NETWORK_NAME: \\192.168.2.34\music
info: Executing SMB command: smbclient --debuglevel=4 -L 192.168.2.33 -N -m SMB3_11
A lot of security improvements are made in BW for SMB (Kernel, not by Volumio)
- What type of NAS are you using and does it support smb V3.11?
- Does the user that you connect with, have the proper rights on all files and folders on your NAS?
- What is the correct Ip?
it’s not really a nas it’s a 8tb hard drive in my windows 11 computer and when i add it to the list i specify vers=3.0 and the .34 ip is wrong that was the volumio ip that i entered by mistake ,33 is the right one and theres no error’s it just stops scanning but still saying info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats even after 2 hours of letting it do its thing , so went back to version 3.61 the only one thats scan’s all my 44 670 tracks
did not help for me it crashed my install of volumio so went back to version 3.61 the only one thats works for me and the 44670 track i have in my windows pc
Without any logs, I can’t support.
no problem , i got the problem fixed by installing the test version 3.913 it had no problem finding my 44 000 tracks of flac and dsd on my smb share on my windows 11 computer but thanks for trying to help anyway
