-- Logs begin at Wed 2025-05-07 22:07:32 CEST, end at Wed 2025-05-07 22:28:53 CEST. -- May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:27:00 volumio volumio[971]: info: Retrieving Cloud Streaming UI May 07 22:27:00 volumio volumio[971]: info: Getting Tidal Cloud Configuration May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:27:00 volumio volumio[971]: info: Getting Qobuz Cloud Configuration May 07 22:27:00 volumio volumio[971]: info: Asking plugin for UI Config May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:27:00 volumio volumio[971]: info: Getting Spotify Cloud Configuration May 07 22:27:00 volumio volumio[971]: info: Asking plugin for UI Config May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:27:00 volumio volumio[971]: info: Saving Spotify Acccount May 07 22:27:00 volumio volumio[971]: info: Got Tidal Cloud Configuration May 07 22:27:00 volumio volumio[971]: info: Got it May 07 22:27:00 volumio volumio[971]: info: Got it May 07 22:27:00 volumio volumio[971]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:27:00 volumio volumio[971]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::volumioGetBrowseSources May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::volumioGetBrowseSources May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::volumioGetBrowseSources May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 22:27:00 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 07 22:27:01 volumio kernel: hwmon hwmon1: Undervoltage detected! May 07 22:27:03 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 07 22:27:03 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 07 22:27:04 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 22:27:04 volumio volumio[971]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L fritz.box. May 07 22:27:04 volumio volumio[971]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L fritz.box. May 07 22:27:04 volumio volumio[971]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L Netzwerkplatte.local. May 07 22:27:05 volumio volumio[971]: info: Error browsing device fritz-box for shares: Command failed: smbclient --no-pass --debuglevel=0 -L fritz.box. May 07 22:27:05 volumio volumio[971]: Unable to initialize messaging context May 07 22:27:05 volumio volumio[971]: info: Error browsing device 192-168-178-1 for shares: Command failed: smbclient --no-pass --debuglevel=0 -L fritz.box. May 07 22:27:05 volumio volumio[971]: Unable to initialize messaging context May 07 22:27:08 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 22:27:09 volumio kernel: hwmon hwmon1: Voltage normalised May 07 22:27:11 volumio kernel: hwmon hwmon1: Undervoltage detected! May 07 22:27:12 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 22:27:13 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare May 07 22:27:13 volumio volumio[971]: info: Adding a new share May 07 22:27:13 volumio volumio[971]: info: Checking key NasMounts.444aef75-0a80-42a8-88b8-82abd491556a May 07 22:27:13 volumio volumio[971]: info: No correspondence found in configuration for share Volume_1 on IP 192.168.178.49 May 07 22:27:13 volumio volumio[971]: info: Executing SMB command: smbclient --debuglevel=4 -L 192.168.178.49 -N May 07 22:27:13 volumio volumio[971]: info: Negotiated SMB version with Volume_1: NT1 May 07 22:27:13 volumio volumio[971]: info: Detected device Volume_1 with version NT1 May 07 22:27:13 volumio volumio[971]: info: Set SMB version 1.0 in CIFS options: vers=1.0 May 07 22:27:13 volumio sudo[4501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=1.0 //192.168.178.49/Volume_1 /mnt/NAS/Volume_1 May 07 22:27:13 volumio sudo[4501]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:27:13 volumio kernel: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers May 07 22:27:13 volumio kernel: CIFS: VFS: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers May 07 22:27:13 volumio kernel: CIFS: Attempting to mount //192.168.178.49/Volume_1 May 07 22:27:13 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 22:27:13 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 22:27:13 volumio volumio[971]: info: Discovery: Getting this device information May 07 22:27:13 volumio volumio[971]: info: CoreCommandRouter::volumioGetState May 07 22:27:13 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 22:27:14 volumio sudo[4501]: pam_unix(sudo:session): session closed for user root May 07 22:27:14 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand status May 07 22:27:14 volumio volumio[971]: info: May 07 22:27:14 volumio volumio[971]: ---------------------------- MPD announces state update: update May 07 22:27:14 volumio volumio[971]: info: ControllerMpd::getState May 07 22:27:14 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand status May 07 22:27:14 volumio volumio[971]: info: sendMpdCommand status took 3 milliseconds May 07 22:27:14 volumio volumio[971]: info: sendMpdCommand status took 2 milliseconds May 07 22:27:14 volumio volumio[971]: verbose: ControllerMpd::parseState May 07 22:27:14 volumio volumio[971]: info: Command Router : Notfying DB Updatetrue May 07 22:27:14 volumio volumio[971]: info: CoreCommandRouter::Close All Modals sent May 07 22:27:14 volumio volumio[971]: verbose: ControllerMpd::parseState May 07 22:27:14 volumio volumio[971]: info: ControllerMpd::pushState May 07 22:27:14 volumio volumio[971]: info: CoreCommandRouter::servicePushState May 07 22:27:14 volumio volumio[971]: info: CoreStateMachine::pushState May 07 22:27:14 volumio volumio[971]: info: CoreCommandRouter::volumioPushState May 07 22:27:14 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:27:14 volumio volumio[971]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 07 22:27:14 volumio volumio[971]: verbose: CURRENT POSITION 0 May 07 22:27:14 volumio volumio[971]: info: CoreStateMachine::syncState stateService stop May 07 22:27:14 volumio volumio[971]: info: CoreStateMachine::syncState currentStatus pause May 07 22:27:14 volumio volumio[971]: info: CoreStateMachine::pushState May 07 22:27:14 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 07 22:27:14 volumio volumio[971]: info: CoreCommandRouter::volumioPushState May 07 22:27:14 volumio volumio[971]: info: ------------------------------ 75ms May 07 22:27:14 volumio volumio[971]: info: [1746649634245] Database update started May 07 22:27:14 volumio volumio[971]: info: CoreCommandRouter::volumioGetQueue May 07 22:27:14 volumio volumio[971]: info: CoreStateMachine::getQueue May 07 22:27:14 volumio volumio[971]: info: CorePlayQueue::getQueue May 07 22:27:14 volumio volumio[971]: info: CoreCommandRouter::volumioGetQueue May 07 22:27:14 volumio volumio[971]: info: CoreStateMachine::getQueue May 07 22:27:14 volumio volumio[971]: info: CorePlayQueue::getQueue May 07 22:27:15 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 07 22:27:16 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 22:27:17 volumio wpa_supplicant[863]: RRM: Ignoring radio measurement request: Not RRM network May 07 22:27:21 volumio wpa_supplicant[863]: RRM: Ignoring radio measurement request: Not RRM network May 07 22:27:22 volumio volumio[971]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:27:22 volumio volumio[971]: info: Retrieving Cloud Streaming UI May 07 22:27:22 volumio volumio[971]: info: Getting Tidal Cloud Configuration May 07 22:27:22 volumio volumio[971]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:27:22 volumio volumio[971]: info: Getting Qobuz Cloud Configuration May 07 22:27:22 volumio volumio[971]: info: Asking plugin for UI Config May 07 22:27:22 volumio volumio[971]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:27:22 volumio volumio[971]: info: Getting Spotify Cloud Configuration May 07 22:27:22 volumio volumio[971]: info: Asking plugin for UI Config May 07 22:27:22 volumio volumio[971]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:27:22 volumio volumio[971]: info: Saving Spotify Acccount May 07 22:27:22 volumio volumio[971]: info: Got Tidal Cloud Configuration May 07 22:27:22 volumio volumio[971]: info: Got it May 07 22:27:22 volumio volumio[971]: info: Got it May 07 22:27:22 volumio volumio[971]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 07 22:27:22 volumio volumio[971]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:27:22 volumio volumio[971]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 07 22:27:22 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 07 22:27:22 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 07 22:27:22 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 07 22:27:22 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 07 22:27:22 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:27:22 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:27:22 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:27:22 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:27:22 volumio volumio[971]: info: CoreCommandRouter::volumioGetBrowseSources May 07 22:27:22 volumio volumio[971]: info: CoreCommandRouter::volumioGetBrowseSources May 07 22:27:22 volumio volumio[971]: info: CoreCommandRouter::volumioGetBrowseSources May 07 22:27:22 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 22:27:22 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 07 22:27:26 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 22:27:30 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 22:27:34 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 22:27:36 volumio kernel: hwmon hwmon1: Voltage normalised May 07 22:27:41 volumio kernel: hwmon hwmon1: Undervoltage detected! May 07 22:27:43 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 22:27:43 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 22:27:43 volumio volumio[971]: info: Discovery: Getting this device information May 07 22:27:43 volumio volumio[971]: info: CoreCommandRouter::volumioGetState May 07 22:27:43 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 22:27:47 volumio kernel: hwmon hwmon1: Voltage normalised May 07 22:27:49 volumio kernel: hwmon hwmon1: Undervoltage detected! May 07 22:27:55 volumio kernel: hwmon hwmon1: Voltage normalised May 07 22:28:01 volumio volumio[971]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 22:28:01 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 07 22:28:01 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:28:01 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 07 22:28:01 volumio volumio[971]: info: Getting Alsa Cards List without I2S DAC May 07 22:28:01 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber May 07 22:28:01 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 22:28:01 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:28:01 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:28:01 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:28:01 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:28:01 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:28:01 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:28:01 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 22:28:01 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 07 22:28:01 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 07 22:28:01 volumio kernel: hwmon hwmon1: Undervoltage detected! May 07 22:28:08 volumio volumio[971]: info: CoreCommandRouter::volumioPlay May 07 22:28:08 volumio volumio[971]: info: CoreStateMachine::play index undefined May 07 22:28:08 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined May 07 22:28:08 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:08 volumio volumio[971]: info: CoreStateMachine::startPlaybackTimer May 07 22:28:08 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:08 volumio volumio[971]: info: [1746649688733] ControllerUPNPBrowser::resume May 07 22:28:08 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand play May 07 22:28:08 volumio volumio[971]: info: sendMpdCommand play took 1 milliseconds May 07 22:28:09 volumio volumio[971]: info: CoreCommandRouter::volumioPlay May 07 22:28:09 volumio volumio[971]: info: CoreStateMachine::play index undefined May 07 22:28:09 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined May 07 22:28:09 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:09 volumio volumio[971]: info: CoreStateMachine::startPlaybackTimer May 07 22:28:09 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:09 volumio volumio[971]: info: [1746649689479] ControllerUPNPBrowser::resume May 07 22:28:09 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand play May 07 22:28:09 volumio volumio[971]: info: sendMpdCommand play took 1 milliseconds May 07 22:28:10 volumio volumio[971]: info: CoreCommandRouter::volumioPlay May 07 22:28:10 volumio volumio[971]: info: CoreStateMachine::play index undefined May 07 22:28:10 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined May 07 22:28:10 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:10 volumio volumio[971]: info: CoreStateMachine::startPlaybackTimer May 07 22:28:10 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:10 volumio volumio[971]: info: [1746649690010] ControllerUPNPBrowser::resume May 07 22:28:10 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand play May 07 22:28:10 volumio volumio[971]: info: sendMpdCommand play took 1 milliseconds May 07 22:28:10 volumio volumio[971]: info: CoreCommandRouter::volumioPlay May 07 22:28:10 volumio volumio[971]: info: CoreStateMachine::play index undefined May 07 22:28:10 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined May 07 22:28:10 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:10 volumio volumio[971]: info: CoreStateMachine::startPlaybackTimer May 07 22:28:10 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:10 volumio volumio[971]: info: [1746649690169] ControllerUPNPBrowser::resume May 07 22:28:10 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand play May 07 22:28:10 volumio volumio[971]: info: sendMpdCommand play took 1 milliseconds May 07 22:28:10 volumio volumio[971]: info: CoreCommandRouter::volumioPlay May 07 22:28:10 volumio volumio[971]: info: CoreStateMachine::play index undefined May 07 22:28:10 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined May 07 22:28:10 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:10 volumio volumio[971]: info: CoreStateMachine::startPlaybackTimer May 07 22:28:10 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:10 volumio volumio[971]: info: [1746649690333] ControllerUPNPBrowser::resume May 07 22:28:10 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand play May 07 22:28:10 volumio volumio[971]: info: sendMpdCommand play took 1 milliseconds May 07 22:28:10 volumio volumio[971]: info: CoreCommandRouter::volumioPlay May 07 22:28:10 volumio volumio[971]: info: CoreStateMachine::play index undefined May 07 22:28:10 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined May 07 22:28:10 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:10 volumio volumio[971]: info: CoreStateMachine::startPlaybackTimer May 07 22:28:10 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:10 volumio volumio[971]: info: [1746649690502] ControllerUPNPBrowser::resume May 07 22:28:10 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand play May 07 22:28:10 volumio volumio[971]: info: sendMpdCommand play took 1 milliseconds May 07 22:28:10 volumio volumio[971]: info: CoreCommandRouter::volumioPlay May 07 22:28:10 volumio volumio[971]: info: CoreStateMachine::play index undefined May 07 22:28:10 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined May 07 22:28:10 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:10 volumio volumio[971]: info: CoreStateMachine::startPlaybackTimer May 07 22:28:10 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:10 volumio volumio[971]: info: [1746649690639] ControllerUPNPBrowser::resume May 07 22:28:10 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand play May 07 22:28:10 volumio volumio[971]: info: sendMpdCommand play took 0 milliseconds May 07 22:28:11 volumio volumio[971]: info: CoreCommandRouter::volumioPlay May 07 22:28:11 volumio volumio[971]: info: CoreStateMachine::play index undefined May 07 22:28:11 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined May 07 22:28:11 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:11 volumio volumio[971]: info: CoreStateMachine::startPlaybackTimer May 07 22:28:11 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:11 volumio volumio[971]: info: [1746649691116] ControllerUPNPBrowser::resume May 07 22:28:11 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand play May 07 22:28:11 volumio volumio[971]: info: sendMpdCommand play took 2 milliseconds May 07 22:28:13 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 22:28:13 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 22:28:13 volumio volumio[971]: info: Discovery: Getting this device information May 07 22:28:13 volumio volumio[971]: info: CoreCommandRouter::volumioGetState May 07 22:28:13 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:13 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 22:28:15 volumio volumio[971]: info: CoreCommandRouter::volumioRemoveQueueItem May 07 22:28:15 volumio volumio[971]: info: CoreStateMachine::removeQueueItem May 07 22:28:15 volumio volumio[971]: info: CoreStateMachine::stop May 07 22:28:15 volumio volumio[971]: info: CoreStateMachine::setConsumeUpdateService undefined May 07 22:28:15 volumio volumio[971]: info: CoreStateMachine::updateTrackBlock May 07 22:28:15 volumio volumio[971]: info: CorePlayQueue::getTrackBlock May 07 22:28:15 volumio volumio[971]: info: CoreStateMachine::stPlaybackTimer May 07 22:28:15 volumio volumio[971]: info: CoreStateMachine::pushState May 07 22:28:15 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:15 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 07 22:28:15 volumio volumio[971]: info: CoreCommandRouter::volumioPushState May 07 22:28:15 volumio volumio[971]: info: CoreStateMachine::serviceStop May 07 22:28:15 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:15 volumio volumio[971]: info: CoreCommandRouter::serviceStop May 07 22:28:15 volumio volumio[971]: info: [1746649695414] ControllerUPNPBrowser::stop May 07 22:28:15 volumio volumio[971]: verbose: ControllerMpd::sendMpdCommand stop May 07 22:28:15 volumio volumio[971]: info: CorePlayQueue::removeQueueItem 0 May 07 22:28:15 volumio volumio[971]: info: CorePlayQueue::saveQueue May 07 22:28:15 volumio volumio[971]: info: CoreCommandRouter::volumioPushQueue May 07 22:28:15 volumio volumio[971]: info: sendMpdCommand stop took 18 milliseconds May 07 22:28:16 volumio kernel: hwmon hwmon1: Voltage normalised May 07 22:28:18 volumio kernel: hwmon hwmon1: Undervoltage detected! May 07 22:28:24 volumio kernel: hwmon hwmon1: Voltage normalised May 07 22:28:29 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 07 22:28:29 volumio volumio[971]: info: Preload queue cleared May 07 22:28:31 volumio kernel: hwmon hwmon1: Undervoltage detected! May 07 22:28:31 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 07 22:28:31 volumio volumio[971]: error: Error browsing0:Error: Did not get expected response from server:{"html":{"$":{"xmlns":"http://www.w3.org/1999/xhtml","xml:lang":"en","lang":"en"},"head":[{"title":[{"_":"404 - Not Found"}]}],"body":[{"h1":[{"_":"404 - Not Found"}]}]}} May 07 22:28:31 volumio volumio[971]: error: Failed to execute browseSource: May 07 22:28:33 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 07 22:28:33 volumio volumio[971]: error: Error browsing0:Error: Did not get expected response from server:{"html":{"$":{"xmlns":"http://www.w3.org/1999/xhtml","xml:lang":"en","lang":"en"},"head":[{"title":[{"_":"404 - Not Found"}]}],"body":[{"h1":[{"_":"404 - Not Found"}]}]}} May 07 22:28:33 volumio volumio[971]: error: Failed to execute browseSource: May 07 22:28:33 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 07 22:28:33 volumio volumio[971]: error: Error browsing0:Error: Did not get expected response from server:{"html":{"$":{"xmlns":"http://www.w3.org/1999/xhtml","xml:lang":"en","lang":"en"},"head":[{"title":[{"_":"404 - Not Found"}]}],"body":[{"h1":[{"_":"404 - Not Found"}]}]}} May 07 22:28:33 volumio volumio[971]: error: Failed to execute browseSource: May 07 22:28:35 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 07 22:28:35 volumio volumio[971]: error: Error browsing0:Error: Did not get expected response from server:{"html":{"$":{"xmlns":"http://www.w3.org/1999/xhtml","xml:lang":"en","lang":"en"},"head":[{"title":[{"_":"404 - Not Found"}]}],"body":[{"h1":[{"_":"404 - Not Found"}]}]}} May 07 22:28:35 volumio volumio[971]: error: Failed to execute browseSource: May 07 22:28:41 volumio volumio[971]: info: CoreCommandRouter::volumioGetState May 07 22:28:41 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:41 volumio sudo[4727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 07 22:28:41 volumio sudo[4727]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:28:41 volumio sudo[4727]: pam_unix(sudo:session): session closed for user root May 07 22:28:41 volumio sudo[4729]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 07 22:28:41 volumio sudo[4729]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:28:41 volumio sudo[4729]: pam_unix(sudo:session): session closed for user root May 07 22:28:41 volumio volumio[971]: verbose: New Socket.io Connection to 192.168.178.27 from 192.168.178.75 UA: Mozilla/5.0 (Linux; Android 14; moto g84 5G Build/U1TCS34.22-64-19-4-4; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 May 07 22:28:42 volumio sudo[4733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 07 22:28:42 volumio sudo[4733]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:28:42 volumio sudo[4733]: pam_unix(sudo:session): session closed for user root May 07 22:28:42 volumio sudo[4735]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 07 22:28:42 volumio sudo[4735]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 22:28:42 volumio sudo[4735]: pam_unix(sudo:session): session closed for user root May 07 22:28:42 volumio volumio[971]: verbose: New Socket.io Connection to 192.168.178.27 from 192.168.178.75 UA: Mozilla/5.0 (Linux; Android 14; moto g84 5G Build/U1TCS34.22-64-19-4-4; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.60 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 May 07 22:28:42 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 07 22:28:42 volumio volumio[971]: info: CoreCommandRouter::volumioGetVisibleSources May 07 22:28:42 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 22:28:42 volumio volumio[971]: info: CoreCommandRouter::volumioGetState May 07 22:28:42 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:42 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 07 22:28:42 volumio volumio[971]: info: CoreCommandRouter::volumioGetQueue May 07 22:28:42 volumio volumio[971]: info: CoreStateMachine::getQueue May 07 22:28:42 volumio volumio[971]: info: CorePlayQueue::getQueue May 07 22:28:42 volumio volumio[971]: info: Listing playlists May 07 22:28:42 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 07 22:28:42 volumio volumio[971]: info: Received Get System Info May 07 22:28:42 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 22:28:42 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 22:28:42 volumio volumio[971]: info: Discovery: Getting this device information May 07 22:28:42 volumio volumio[971]: info: CoreCommandRouter::volumioGetState May 07 22:28:42 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:42 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 22:28:42 volumio volumio[971]: info: CoreCommandRouter::volumioGetState May 07 22:28:42 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:42 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 07 22:28:42 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 07 22:28:42 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 07 22:28:43 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 22:28:43 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 22:28:43 volumio volumio[971]: info: Discovery: Getting this device information May 07 22:28:43 volumio volumio[971]: info: CoreCommandRouter::volumioGetState May 07 22:28:43 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:43 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 22:28:44 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 07 22:28:44 volumio volumio[971]: info: Received Get System Info May 07 22:28:44 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 22:28:44 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 22:28:44 volumio volumio[971]: info: Discovery: Getting this device information May 07 22:28:44 volumio volumio[971]: info: CoreCommandRouter::volumioGetState May 07 22:28:44 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:44 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 22:28:44 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 07 22:28:44 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 07 22:28:44 volumio volumio[971]: info: Received Get System Info May 07 22:28:44 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 22:28:44 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 22:28:44 volumio volumio[971]: info: Discovery: Getting this device information May 07 22:28:44 volumio volumio[971]: info: CoreCommandRouter::volumioGetState May 07 22:28:44 volumio volumio[971]: info: CorePlayQueue::getTrack 0 May 07 22:28:44 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 22:28:45 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 07 22:28:45 volumio volumio[971]: error: Error browsing0:Error: Did not get expected response from server:{"html":{"$":{"xmlns":"http://www.w3.org/1999/xhtml","xml:lang":"en","lang":"en"},"head":[{"title":[{"_":"404 - Not Found"}]}],"body":[{"h1":[{"_":"404 - Not Found"}]}]}} May 07 22:28:45 volumio volumio[971]: error: Failed to execute browseSource: May 07 22:28:47 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 07 22:28:47 volumio volumio[971]: info: Preload queue cleared May 07 22:28:50 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 07 22:28:50 volumio volumio[971]: info: Preload queue cleared May 07 22:28:52 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 07 22:28:52 volumio volumio[971]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 07 22:28:52 volumio volumio[971]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 07 22:28:52 volumio volumio[971]: TypeError: Cannot read property 'length' of undefined May 07 22:28:52 volumio volumio[971]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 May 07 22:28:52 volumio volumio[971]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 May 07 22:28:52 volumio volumio[971]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) May 07 22:28:52 volumio volumio[971]: at Parser.emit (events.js:315:20) May 07 22:28:52 volumio volumio[971]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) May 07 22:28:52 volumio volumio[971]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) May 07 22:28:52 volumio volumio[971]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) May 07 22:28:52 volumio volumio[971]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) May 07 22:28:52 volumio volumio[971]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) May 07 22:28:52 volumio volumio[971]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) May 07 22:28:52 volumio volumio[971]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) May 07 22:28:52 volumio volumio[971]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) May 07 22:28:52 volumio volumio[971]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) May 07 22:28:52 volumio volumio[971]: at IncomingMessage.emit (events.js:327:22) May 07 22:28:52 volumio volumio[971]: at endReadableNT (internal/streams/readable.js:1327:12) May 07 22:28:52 volumio volumio[971]: at processTicksAndRejections (internal/process/task_queues.js:80:21) May 07 22:28:52 volumio volumio[971]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 07 22:28:53 volumio sudo[4762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-07 22:27 May 07 22:28:53 volumio sudo[4762]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 09:33:57 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="354f95cf0a6c2cbcd57b1aca3179c81c"