-- Logs begin at Tue 2025-05-20 19:04:20 CEST, end at Tue 2025-05-20 19:59:19 CEST. -- May 20 19:58:01 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 20 19:58:01 volumio volumio[11450]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 May 20 19:58:01 volumio volumio[11450]: info: CoreCommandRouter::volumioGetState May 20 19:58:01 volumio volumio[11450]: info: CorePlayQueue::getTrack 0 May 20 19:58:01 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 20 19:58:01 volumio volumio[11450]: info: CURURI: albums:// May 20 19:58:01 volumio volumio[11450]: info: listAlbums - loading Albums from cache May 20 19:58:02 volumio volumio[11450]: info: Preload queue cleared May 20 19:58:06 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 19:58:06 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 19:58:06 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam May 20 19:58:06 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 20 19:58:06 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 20 19:58:06 volumio volumio[11450]: info: CoreCommandRouter::volumioGetBrowseSources May 20 19:58:06 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 20 19:58:06 volumio volumio[11450]: error: MyVolumio Plugin failed to authenticate in a timely fashion May 20 19:58:06 volumio volumio[11450]: info: Completed starting MyVolumio Plugin May 20 19:58:06 volumio volumio[11450]: [Metrics] CommandRouter: 32s 153.81ms May 20 19:58:06 volumio volumio[11450]: info: CoreCommandRouter::volumiosetStartupVolume May 20 19:58:06 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 19:58:06 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 19:58:06 volumio volumio[11450]: info: CoreCommandRouter::Close All Modals sent May 20 19:58:06 volumio volumio[11450]: info: CoreCommandRouter::Close All Modals sent May 20 19:58:06 volumio volumio[11450]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 20 19:58:06 volumio volumio[11450]: info: FusionDsp - ---- read samplerate from file: 44100 May 20 19:58:06 volumio volumio[11450]: info: camilladsp stopping service pid 11683... May 20 19:58:06 volumio volumio[11450]: info: camilladsp service terminated, instance 1 May 20 19:58:06 volumio volumio[11450]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 20 19:58:06 volumio volumio[11450]: info: camilladsp service started and running in background, instance 1 May 20 19:58:06 volumio volumio[11450]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 20 19:58:06 volumio volumio[11450]: info: FusionDsp - ---- read samplerate from file: 44100 May 20 19:58:06 volumio volumio[11450]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 20 19:58:06 volumio volumio[11450]: error: FusionDsp - WebSocket error: [object Object] May 20 19:58:06 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 20 19:58:06 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 19:58:06 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 20 19:58:06 volumio volumio-remote-updater[785]: No test mode May 20 19:58:06 volumio volumio-remote-updater[785]: No alpha test mode May 20 19:58:06 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 20 19:58:06 volumio volumio[11450]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 20 19:58:06 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 20 19:58:07 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 20 19:58:07 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 20 19:58:07 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 20 19:58:08 volumio volumio[11450]: info: CoreCommandRouter::volumioGetState May 20 19:58:08 volumio volumio[11450]: info: CorePlayQueue::getTrack 0 May 20 19:58:09 volumio volumio[11450]: info: CoreCommandRouter::getUIConfigOnPlugin May 20 19:58:09 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 20 19:58:10 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork May 20 19:58:10 volumio sudo[11834]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 May 20 19:58:10 volumio sudo[11834]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 19:58:10 volumio sudo[11840]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 20 19:58:10 volumio sudo[11840]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 19:58:10 volumio sudo[11840]: pam_unix(sudo:session): session closed for user root May 20 19:58:10 volumio sudo[11847]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 20 19:58:10 volumio sudo[11847]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 19:58:10 volumio sudo[11834]: pam_unix(sudo:session): session closed for user root May 20 19:58:10 volumio sudo[11847]: pam_unix(sudo:session): session closed for user root May 20 19:58:10 volumio sudo[11854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 20 19:58:10 volumio sudo[11854]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 19:58:10 volumio sudo[11854]: pam_unix(sudo:session): session closed for user root May 20 19:58:10 volumio sudo[11859]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 20 19:58:10 volumio sudo[11859]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 19:58:10 volumio sudo[11859]: pam_unix(sudo:session): session closed for user root May 20 19:58:10 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache May 20 19:58:10 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks May 20 19:58:10 volumio sudo[11863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 20 19:58:10 volumio sudo[11863]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 19:58:10 volumio sudo[11863]: pam_unix(sudo:session): session closed for user root May 20 19:58:10 volumio sudo[11866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 20 19:58:10 volumio sudo[11866]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 19:58:10 volumio sudo[11866]: pam_unix(sudo:session): session closed for user root May 20 19:58:10 volumio volumio[11450]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan May 20 19:58:10 volumio volumio[11450]: wlan0 Interface doesn't support scanning : Operation not supported May 20 19:58:10 volumio volumio[11450]: info: Cannot use regular scanning, forcing with ap-force May 20 19:58:10 volumio sudo[11869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force May 20 19:58:10 volumio sudo[11869]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 19:58:10 volumio sudo[11869]: pam_unix(sudo:session): session closed for user root May 20 19:58:10 volumio volumio[11450]: command failed: Operation not supported (-95) May 20 19:58:10 volumio volumio[11450]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force May 20 19:58:10 volumio volumio[11450]: command failed: Operation not supported (-95) May 20 19:58:13 volumio volumio[11450]: info: BOOT COMPLETED May 20 19:58:13 volumio volumio[11450]: info: mpdhttpout ---Boot completed detected! Patching mpd now! May 20 19:58:13 volumio volumio[11450]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. May 20 19:58:13 volumio volumio[11450]: info: CoreCommandRouter::volumioGetState May 20 19:58:13 volumio volumio[11450]: info: CorePlayQueue::getTrack 0 May 20 19:58:13 volumio volumio[11450]: info: CoreCommandRouter::volumioPause May 20 19:58:13 volumio volumio[11450]: info: CoreStateMachine::pause May 20 19:58:13 volumio volumio[11450]: info: mpdhttpout --- Volumio set on pause May 20 19:58:15 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd May 20 19:58:15 volumio sudo[11893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 20 19:58:15 volumio sudo[11893]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 19:58:15 volumio systemd[1]: Stopping Music Player Daemon... May 20 19:58:15 volumio systemd[1]: mpd.service: Succeeded. May 20 19:58:15 volumio systemd[1]: Stopped Music Player Daemon. May 20 19:58:15 volumio systemd[1]: Starting Music Player Daemon... May 20 19:58:15 volumio sudo[11895]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 20 19:58:15 volumio sudo[11895]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 19:58:15 volumio sudo[11895]: pam_unix(sudo:session): session closed for user root May 20 19:58:16 volumio mpd[11897]: May 20 19:58 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 20 19:58:16 volumio systemd[1]: Started Music Player Daemon. May 20 19:58:16 volumio sudo[11893]: pam_unix(sudo:session): session closed for user root May 20 19:58:16 volumio volumio[11450]: error: updateQueue error: null May 20 19:58:23 volumio volumio[11450]: info: CoreCommandRouter::volumioGetState May 20 19:58:23 volumio volumio[11450]: info: CorePlayQueue::getTrack 0 May 20 19:58:26 volumio volumio[11450]: info: CoreCommandRouter::getUIConfigOnPlugin May 20 19:58:26 volumio volumio[11450]: info: CoreCommandRouter::getUIConfigOnPlugin May 20 19:58:26 volumio volumio[11450]: info: Retrieving Cloud Streaming UI May 20 19:58:26 volumio volumio[11450]: info: Getting Tidal Cloud Configuration May 20 19:58:26 volumio volumio[11450]: info: CoreCommandRouter::getUIConfigOnPlugin May 20 19:58:26 volumio volumio[11450]: info: Getting Qobuz Cloud Configuration May 20 19:58:26 volumio volumio[11450]: info: Asking plugin for UI Config May 20 19:58:26 volumio volumio[11450]: info: CoreCommandRouter::getUIConfigOnPlugin May 20 19:58:26 volumio volumio[11450]: info: Getting Spotify Cloud Configuration May 20 19:58:26 volumio volumio[11450]: info: Asking plugin for UI Config May 20 19:58:26 volumio volumio[11450]: info: CoreCommandRouter::getUIConfigOnPlugin May 20 19:58:26 volumio volumio[11450]: info: Saving Spotify Acccount May 20 19:58:26 volumio volumio[11450]: info: Got Tidal Cloud Configuration May 20 19:58:26 volumio volumio[11450]: info: Got it May 20 19:58:26 volumio volumio[11450]: info: Got it May 20 19:58:26 volumio volumio[11450]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 20 19:58:26 volumio volumio[11450]: info: CoreCommandRouter::getUIConfigOnPlugin May 20 19:58:26 volumio volumio[11450]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 20 19:58:26 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 20 19:58:26 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 20 19:58:26 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 20 19:58:26 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 20 19:58:26 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 20 19:58:26 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 20 19:58:26 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 20 19:58:26 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 20 19:58:26 volumio volumio[11450]: info: CoreCommandRouter::volumioGetBrowseSources May 20 19:58:26 volumio volumio[11450]: info: CoreCommandRouter::volumioGetBrowseSources May 20 19:58:26 volumio volumio[11450]: info: CoreCommandRouter::volumioGetBrowseSources May 20 19:58:27 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 20 19:58:27 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 20 19:58:31 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 20 19:58:35 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 20 19:58:39 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 20 19:58:43 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 20 19:58:47 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 20 19:58:51 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 20 19:58:55 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 20 19:58:59 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 20 19:59:03 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 20 19:59:05 volumio volumio[11450]: info: Enabling MyMusic plugin bluetooth May 20 19:59:05 volumio volumio[11450]: info: [MyVolumio PluginManager] Enabling and starting plugin audio_interface bluetooth May 20 19:59:05 volumio volumio[11450]: info: [MyVolumio PluginManager] Plugin audio_interface bluetooth not in user plan, not enabling May 20 19:59:05 volumio volumio[11450]: info: Error: Plugin audio_interface bluetooth not in user plan, not enabling May 20 19:59:05 volumio volumio[11450]: error: Could not Enable MyMusic Plugin: Error May 20 19:59:07 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 20 19:59:11 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 20 19:59:14 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 20 19:59:14 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 20 19:59:15 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 20 19:59:15 volumio volumio[11450]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L Maison103.local. May 20 19:59:15 volumio volumio[11450]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L Bureaux103.local. May 20 19:59:15 volumio volumio[11450]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L Time-Capsule.local. May 20 19:59:16 volumio volumio[11450]: info: Error browsing device Maison103 for shares: Command failed: smbclient --no-pass --debuglevel=0 -L Maison103.local. May 20 19:59:16 volumio volumio[11450]: Unable to initialize messaging context May 20 19:59:17 volumio volumio[11450]: info: Error browsing device Bureaux103 for shares: Command failed: smbclient --no-pass --debuglevel=0 -L Bureaux103.local. May 20 19:59:17 volumio volumio[11450]: Unable to initialize messaging context May 20 19:59:19 volumio volumio[11450]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 20 19:59:19 volumio volumio[11450]: info: Error browsing device Time Capsule for shares: Command failed: smbclient --no-pass --debuglevel=0 -L Time-Capsule.local. May 20 19:59:19 volumio volumio[11450]: Unable to initialize messaging context May 20 19:59:19 volumio volumio[11450]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 20 19:59:19 volumio volumio[11450]: Error: dns service error: unknown May 20 19:59:19 volumio volumio[11450]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) May 20 19:59:19 volumio volumio[11450]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { May 20 19:59:19 volumio volumio[11450]: errorCode: -65537 May 20 19:59:19 volumio volumio[11450]: } May 20 19:59:19 volumio volumio[11450]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 20 19:59:19 volumio sudo[12086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-20 19:58 May 20 19:59:19 volumio sudo[12086]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"