-- Logs begin at Wed 2025-06-04 23:08:31 UTC, end at Wed 2025-06-04 23:14:47 UTC. -- Jun 04 23:13:03 volumio volumio-streaming-daemon[1085]: Environment: production Jun 04 23:13:05 volumio sudo[1100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 04 23:13:05 volumio sudo[1098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 04 23:13:05 volumio sudo[1098]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 23:13:05 volumio sudo[1100]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 23:13:05 volumio sudo[1100]: pam_unix(sudo:session): session closed for user root Jun 04 23:13:05 volumio sudo[1098]: pam_unix(sudo:session): session closed for user root Jun 04 23:13:06 volumio volumio[851]: info: Fetching Streaming Services browse cache Jun 04 23:13:09 volumio volumio-remote-updater[486]: [2025-06-04 23:13:09] [connect] Successful connection Jun 04 23:13:18 volumio sudo[1123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 04 23:13:18 volumio sudo[1124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 04 23:13:18 volumio sudo[1123]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 23:13:18 volumio sudo[1124]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 04 23:13:18 volumio sudo[1124]: pam_unix(sudo:session): session closed for user root Jun 04 23:13:18 volumio sudo[1123]: pam_unix(sudo:session): session closed for user root Jun 04 23:13:20 volumio volumio[851]: info: CoreCommandRouter::volumioGetState Jun 04 23:13:20 volumio volumio[851]: info: CorePlayQueue::getTrack 0 Jun 04 23:13:20 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 04 23:13:20 volumio volumio[851]: info: Listing playlists Jun 04 23:13:20 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 04 23:13:20 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 04 23:13:20 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 04 23:13:20 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 04 23:13:24 volumio volumio-remote-updater[486]: [2025-06-04 23:13:24] [connect] Successful connection Jun 04 23:13:24 volumio volumio-remote-updater[486]: [2025-06-04 23:13:24] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1749078804 101 Jun 04 23:13:35 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 04 23:13:35 volumio volumio[851]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 04 23:13:35 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 04 23:13:35 volumio volumio[851]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio Jun 04 23:13:35 volumio volumio[851]: info: Received Get System Version Jun 04 23:13:35 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 04 23:13:37 volumio volumio[851]: info: CoreCommandRouter::volumioPlay Jun 04 23:13:37 volumio volumio[851]: verbose: UNSET VOLATILE Jun 04 23:13:37 volumio volumio[851]: info: CoreStateMachine::play index undefined Jun 04 23:13:37 volumio volumio[851]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 04 23:13:37 volumio volumio[851]: info: CorePlayQueue::getTrack 0 Jun 04 23:13:37 volumio volumio[851]: info: CoreStateMachine::startPlaybackTimer Jun 04 23:13:37 volumio volumio[851]: info: CorePlayQueue::getTrack 0 Jun 04 23:13:37 volumio volumio[851]: info: [1749078817752] ControllerWebradio::clearAddPlayTrack Jun 04 23:13:37 volumio volumio[851]: verbose: ControllerMpd::sendMpdCommand stop Jun 04 23:13:41 volumio volumio[851]: info: CoreCommandRouter::volumioPlay Jun 04 23:13:41 volumio volumio[851]: verbose: UNSET VOLATILE Jun 04 23:13:41 volumio volumio[851]: info: CoreStateMachine::play index undefined Jun 04 23:13:41 volumio volumio[851]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 04 23:13:41 volumio volumio[851]: info: CorePlayQueue::getTrack 0 Jun 04 23:13:41 volumio volumio[851]: info: CoreStateMachine::startPlaybackTimer Jun 04 23:13:41 volumio volumio[851]: info: CorePlayQueue::getTrack 0 Jun 04 23:13:41 volumio volumio[851]: info: [1749078821261] ControllerWebradio::clearAddPlayTrack Jun 04 23:13:41 volumio volumio[851]: verbose: ControllerMpd::sendMpdCommand stop Jun 04 23:13:43 volumio volumio[851]: info: CoreCommandRouter::volumioGetQueue Jun 04 23:13:43 volumio volumio[851]: info: CoreStateMachine::getQueue Jun 04 23:13:44 volumio volumio[851]: info: CorePlayQueue::getQueue Jun 04 23:13:44 volumio volumio[851]: info: CoreCommandRouter::volumioGetVisibleSources Jun 04 23:13:44 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 04 23:13:47 volumio volumio[851]: info: CoreCommandRouter::volumioPlay Jun 04 23:13:47 volumio volumio[851]: verbose: UNSET VOLATILE Jun 04 23:13:47 volumio volumio[851]: info: CoreStateMachine::play index 4 Jun 04 23:13:47 volumio volumio[851]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 04 23:13:47 volumio volumio[851]: info: CoreStateMachine::stop Jun 04 23:13:47 volumio volumio[851]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 04 23:13:47 volumio volumio[851]: verbose: UNSET VOLATILE Jun 04 23:13:47 volumio volumio[851]: info: CoreStateMachine::play index undefined Jun 04 23:13:47 volumio volumio[851]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 04 23:13:47 volumio volumio[851]: info: CorePlayQueue::getTrack 4 Jun 04 23:13:47 volumio volumio[851]: info: CoreStateMachine::startPlaybackTimer Jun 04 23:13:47 volumio volumio[851]: info: CorePlayQueue::getTrack 4 Jun 04 23:13:47 volumio volumio[851]: info: [1749078827102] ControllerWebradio::clearAddPlayTrack Jun 04 23:13:47 volumio volumio[851]: verbose: ControllerMpd::sendMpdCommand stop Jun 04 23:13:56 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 04 23:13:56 volumio volumio[851]: info: CURURI: playlists Jun 04 23:13:56 volumio volumio[851]: info: Listing playlists Jun 04 23:14:00 volumio volumio[851]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 04 23:14:00 volumio volumio[851]: info: CoreStateMachine::ClearQueue Jun 04 23:14:00 volumio volumio[851]: info: CoreStateMachine::stop Jun 04 23:14:00 volumio volumio[851]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 04 23:14:00 volumio volumio[851]: verbose: UNSET VOLATILE Jun 04 23:14:00 volumio volumio[851]: info: CorePlayQueue::clearPlayQueue Jun 04 23:14:00 volumio volumio[851]: info: CorePlayQueue::saveQueue Jun 04 23:14:00 volumio volumio[851]: info: CoreCommandRouter::volumioPushState Jun 04 23:14:00 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 04 23:14:01 volumio volumio[851]: info: CoreCommandRouter::volumioPushQueue Jun 04 23:14:01 volumio volumio[851]: info: Play playlist radio Jun 04 23:14:01 volumio volumio[851]: info: CoreCommandRouter::volumioClearQueue Jun 04 23:14:01 volumio volumio[851]: info: CoreStateMachine::ClearQueue Jun 04 23:14:01 volumio volumio[851]: info: CoreStateMachine::stop Jun 04 23:14:01 volumio volumio[851]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 04 23:14:01 volumio volumio[851]: verbose: UNSET VOLATILE Jun 04 23:14:01 volumio volumio[851]: info: CorePlayQueue::clearPlayQueue Jun 04 23:14:01 volumio volumio[851]: info: CorePlayQueue::saveQueue Jun 04 23:14:01 volumio volumio[851]: info: CoreCommandRouter::volumioPushState Jun 04 23:14:01 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 04 23:14:01 volumio volumio[851]: info: CoreCommandRouter::volumioPushQueue Jun 04 23:14:01 volumio volumio[851]: info: CoreCommandRouter::volumioAddQueueItems Jun 04 23:14:01 volumio volumio[851]: info: CoreStateMachine::addQueueItems Jun 04 23:14:01 volumio volumio[851]: info: CorePlayQueue::addQueueItems Jun 04 23:14:01 volumio volumio[851]: info: Adding Item to queue: http://mscp3.live-streams.nl:8250/class-flac.flac Jun 04 23:14:01 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jun 04 23:14:01 volumio volumio[851]: info: Adding Item to queue: http://mscp3.live-streams.nl:8340/jazz-flac.flac Jun 04 23:14:01 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jun 04 23:14:01 volumio volumio[851]: info: Adding Item to queue: http://stream.srg-ssr.ch/m/rsc_de/aacp_96 Jun 04 23:14:01 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jun 04 23:14:01 volumio volumio[851]: info: Adding Item to queue: http://stream.srg-ssr.ch/m/rsj/aacp_96 Jun 04 23:14:01 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jun 04 23:14:01 volumio volumio[851]: info: Adding Item to queue: https://radio4.vip-radios.fm:18039/stream-128kmp3-HealingMusic Jun 04 23:14:01 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jun 04 23:14:01 volumio volumio[851]: info: CorePlayQueue::saveQueue Jun 04 23:14:01 volumio volumio[851]: info: CoreCommandRouter::volumioPushQueue Jun 04 23:14:01 volumio volumio[851]: info: CoreStateMachine::updateTrackBlock Jun 04 23:14:01 volumio volumio[851]: info: CorePlayQueue::getTrackBlock Jun 04 23:14:01 volumio volumio[851]: info: CoreCommandRouter::volumioPlay Jun 04 23:14:02 volumio volumio[851]: verbose: UNSET VOLATILE Jun 04 23:14:02 volumio volumio[851]: info: CoreStateMachine::play index 0 Jun 04 23:14:02 volumio volumio[851]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 04 23:14:02 volumio volumio[851]: info: CoreStateMachine::stop Jun 04 23:14:02 volumio volumio[851]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 04 23:14:02 volumio volumio[851]: verbose: UNSET VOLATILE Jun 04 23:14:02 volumio volumio[851]: info: CoreStateMachine::play index undefined Jun 04 23:14:02 volumio volumio[851]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 04 23:14:02 volumio volumio[851]: info: CorePlayQueue::getTrack 0 Jun 04 23:14:02 volumio volumio[851]: info: CoreStateMachine::startPlaybackTimer Jun 04 23:14:02 volumio volumio[851]: info: CorePlayQueue::getTrack 0 Jun 04 23:14:02 volumio volumio[851]: info: [1749078842070] ControllerWebradio::clearAddPlayTrack Jun 04 23:14:02 volumio volumio[851]: verbose: ControllerMpd::sendMpdCommand stop Jun 04 23:14:22 volumio systemd[1]: mpd.service start operation timed out. Terminating. Jun 04 23:14:22 volumio volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 04 23:14:22 volumio volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 04 23:14:22 volumio volumio[851]: info: Retrieving Cloud Streaming UI Jun 04 23:14:23 volumio volumio[851]: info: Getting Tidal Cloud Configuration Jun 04 23:14:23 volumio volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 04 23:14:23 volumio volumio[851]: info: Getting Qobuz Cloud Configuration Jun 04 23:14:23 volumio volumio[851]: info: Asking plugin for UI Config Jun 04 23:14:23 volumio volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 04 23:14:23 volumio volumio[851]: info: Getting Spotify Cloud Configuration Jun 04 23:14:23 volumio volumio[851]: info: Asking plugin for UI Config Jun 04 23:14:23 volumio volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 04 23:14:23 volumio volumio[851]: info: Saving Spotify Acccount Jun 04 23:14:23 volumio volumio[851]: info: Got Tidal Cloud Configuration Jun 04 23:14:23 volumio volumio[851]: info: Got it Jun 04 23:14:23 volumio volumio[851]: info: Got it Jun 04 23:14:23 volumio volumio[851]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jun 04 23:14:23 volumio volumio[851]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 04 23:14:23 volumio volumio[851]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jun 04 23:14:23 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 04 23:14:23 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 04 23:14:23 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 04 23:14:23 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 04 23:14:23 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 04 23:14:23 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 04 23:14:23 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 04 23:14:23 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 04 23:14:23 volumio volumio[851]: info: CoreCommandRouter::volumioGetBrowseSources Jun 04 23:14:24 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 04 23:14:24 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 04 23:14:26 volumio volumio[851]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Jun 04 23:14:26 volumio volumio[851]: verbose: ControllerMpd::sendMpdCommand rescan Jun 04 23:14:26 volumio volumio[851]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 04 23:14:27 volumio volumio[851]: TypeError: Cannot read property 'then' of undefined Jun 04 23:14:27 volumio volumio[851]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:330:6) Jun 04 23:14:27 volumio volumio[851]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1825:15) Jun 04 23:14:27 volumio volumio[851]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1052:32) Jun 04 23:14:27 volumio volumio[851]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:907:26) Jun 04 23:14:27 volumio volumio[851]: at emitTwo (events.js:126:13) Jun 04 23:14:27 volumio volumio[851]: at Socket.emit (events.js:214:7) Jun 04 23:14:27 volumio volumio[851]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Jun 04 23:14:27 volumio volumio[851]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jun 04 23:14:27 volumio volumio[851]: at process._tickCallback (internal/process/next_tick.js:180:9) Jun 04 23:14:27 volumio volumio[851]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 04 23:14:35 volumio systemd[1]: Failed to start Music Player Daemon. Jun 04 23:14:35 volumio systemd[1]: Unit mpd.service entered failed state. Jun 04 23:14:35 volumio systemd[1]: Starting Music Player Daemon... Jun 04 23:14:46 volumio sudo[1183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-04 23:13 Jun 04 23:14:47 volumio sudo[1183]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"