Feb 08 08:49:05 volumio volumio[1337]: verbose: New Socket.io Connection to 192.168.1.177:3000 from 192.168.1.217 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 08:49:05 volumio volumio[1337]: info: Discovery: Getting this device information Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 08:49:05 volumio volumio[1337]: info: Discovery: Getting this device information Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Feb 08 08:49:05 volumio sudo[3007]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Feb 08 08:49:05 volumio sudo[3012]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 08 08:49:05 volumio sudo[3012]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 08:49:05 volumio sudo[3007]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 08:49:05 volumio sudo[3012]: pam_unix(sudo:session): session closed for user root Feb 08 08:49:05 volumio sudo[3018]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 08 08:49:05 volumio sudo[3018]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 08:49:05 volumio sudo[3023]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Feb 08 08:49:05 volumio sudo[3023]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 08:49:05 volumio sudo[3018]: pam_unix(sudo:session): session closed for user root Feb 08 08:49:05 volumio sudo[3023]: pam_unix(sudo:session): session closed for user root Feb 08 08:49:05 volumio sudo[3007]: pam_unix(sudo:session): session closed for user root Feb 08 08:49:05 volumio sudo[3030]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 08:49:05 volumio sudo[3030]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 08:49:05 volumio sudo[3030]: pam_unix(sudo:session): session closed for user root Feb 08 08:49:05 volumio sudo[3034]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 08:49:05 volumio sudo[3034]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 08:49:05 volumio sudo[3034]: pam_unix(sudo:session): session closed for user root Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 08:49:05 volumio volumio[1337]: info: Discovery: Getting this device information Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 08:49:05 volumio volumio[1337]: info: Discovery: Getting this device information Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 08:49:05 volumio volumio[1337]: info: Discovery: Getting this device information Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:05 volumio volumio[1337]: verbose: New Socket.io Connection to 192.168.1.177:3000 from 192.168.1.217 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 08:49:05 volumio volumio[1337]: verbose: New Socket.io Connection to 192.168.1.177:3000 from 192.168.1.217 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 08:49:05 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 08:49:06 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 08:49:06 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 08:49:06 volumio sudo[3040]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 08:49:06 volumio sudo[3040]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 08:49:06 volumio sudo[3040]: pam_unix(sudo:session): session closed for user root Feb 08 08:49:06 volumio sudo[3042]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 08:49:06 volumio sudo[3042]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 08:49:06 volumio sudo[3042]: pam_unix(sudo:session): session closed for user root Feb 08 08:49:06 volumio volumio[1337]: verbose: New Socket.io Connection to 192.168.1.177 from 192.168.1.217 UA: Mozilla/5.0 (Linux; Android 16; 24129PN74G Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Feb 08 08:49:06 volumio sudo[3046]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 08:49:06 volumio sudo[3046]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 08:49:06 volumio sudo[3046]: pam_unix(sudo:session): session closed for user root Feb 08 08:49:06 volumio sudo[3048]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 08:49:06 volumio sudo[3048]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 08:49:06 volumio sudo[3048]: pam_unix(sudo:session): session closed for user root Feb 08 08:49:07 volumio volumio[1337]: verbose: New Socket.io Connection to 192.168.1.177 from 192.168.1.217 UA: Mozilla/5.0 (Linux; Android 16; 24129PN74G Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Feb 08 08:49:07 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 08 08:49:07 volumio volumio[1337]: info: CoreCommandRouter::volumioGetVisibleSources Feb 08 08:49:07 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 08:49:07 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:07 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 08 08:49:07 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 08 08:49:07 volumio volumio[1337]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 08 08:49:07 volumio volumio[1337]: info: Received Get System Info Feb 08 08:49:07 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 08:49:07 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 08:49:07 volumio volumio[1337]: info: Discovery: Getting this device information Feb 08 08:49:07 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:07 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 08:49:07 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:07 volumio volumio[1337]: info: Listing playlists Feb 08 08:49:07 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 08 08:49:07 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 08 08:49:07 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 08 08:49:08 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 08 08:49:08 volumio volumio[1337]: info: CoreCommandRouter::volumioGetQueue Feb 08 08:49:08 volumio volumio[1337]: info: CoreStateMachine::getQueue Feb 08 08:49:08 volumio volumio[1337]: info: CorePlayQueue::getQueue Feb 08 08:49:08 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 08:49:08 volumio volumio[1337]: info: Received Get System Info Feb 08 08:49:08 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 08:49:08 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 08:49:08 volumio volumio[1337]: info: Discovery: Getting this device information Feb 08 08:49:08 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:08 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 08:49:10 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 08 08:49:10 volumio volumio[1337]: info: Received Get System Info Feb 08 08:49:10 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 08:49:10 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 08:49:10 volumio volumio[1337]: info: Discovery: Getting this device information Feb 08 08:49:10 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:10 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 08:49:11 volumio volumio[1337]: info: Preload queue cleared Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::ClearQueue Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::stop Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::serviceStop Feb 08 08:49:11 volumio volumio[1337]: info: Received STOP, but no service to execute it Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::clearPlayQueue Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::saveQueue Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::volumioPushQueue Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::addQueueItems Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::addQueueItems Feb 08 08:49:11 volumio volumio[1337]: info: Preload queue cleared Feb 08 08:49:11 volumio volumio[1337]: info: Adding Item to queue: webrp/0 Feb 08 08:49:11 volumio volumio[1337]: info: Exploding uri webrp/0 in service radio_paradise Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::volumioPushQueue Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::saveQueue Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::updateTrackBlock Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrackBlock Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::volumioPlay Feb 08 08:49:11 volumio volumio[1337]: verbose: UNSET VOLATILE: Service: undefined Feb 08 08:49:11 volumio volumio[1337]: ------------------------------------ BT MESSAGE: [FUNC] detachBluetooth Feb 08 08:49:11 volumio volumio[1337]: ------------------------------------ BT MESSAGE: [FUNC] btAudioOutput Feb 08 08:49:11 volumio volumio[1337]: ------------------------------------ BT MESSAGE: [dbus-next] Disabling Bluetooth Audio Output Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::play index 0 Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 08 08:49:11 volumio volumio[1337]: ------------------------------------ BT MESSAGE: Bluetooth audio output disabled. Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::stop Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::resetVolumioState Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::getcurrentVolume Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::play index undefined Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::volumioStop Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::stop Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::startPlaybackTimer Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::volumioGetVisibleSources Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 08 08:49:11 volumio volumio[1337]: info: [RadioParadise] Matched station: Radio Paradise Main Mix (FLAC), chan=0 Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand stop Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand stop took 2 milliseconds Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand clear Feb 08 08:49:11 volumio volumio[1337]: info: Feb 08 08:49:11 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Feb 08 08:49:11 volumio volumio[1337]: info: Ignoring MPD Status Update Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand clear took 1 milliseconds Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand consume 1 Feb 08 08:49:11 volumio volumio[1337]: info: Feb 08 08:49:11 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Feb 08 08:49:11 volumio volumio[1337]: info: Ignoring MPD Status Update Feb 08 08:49:11 volumio volumio[1337]: error: updateQueue error: null Feb 08 08:49:11 volumio volumio[1337]: info: Feb 08 08:49:11 volumio volumio[1337]: ---------------------------- MPD announces state update: options Feb 08 08:49:11 volumio volumio[1337]: error: updateQueue error: null Feb 08 08:49:11 volumio volumio[1337]: info: ------------------------------ 2ms Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand consume 1 took 1 milliseconds Feb 08 08:49:11 volumio volumio[1337]: info: ControllerMpd::getState Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Feb 08 08:49:11 volumio volumio[1337]: info: ------------------------------ 1ms Feb 08 08:49:11 volumio volumio[1337]: info: [1770536951197] [RadioParadise] set to consume mode, adding url: https://stream.radioparadise.com/flacm Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand add "https://stream.radioparadise.com/flacm" Feb 08 08:49:11 volumio volumio[1337]: info: Feb 08 08:49:11 volumio volumio[1337]: ---------------------------- MPD announces state update: options Feb 08 08:49:11 volumio volumio[1337]: info: ControllerMpd::getState Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Feb 08 08:49:11 volumio volumio[1337]: info: Feb 08 08:49:11 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Feb 08 08:49:11 volumio volumio[1337]: info: Ignoring MPD Status Update Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand status took 8 milliseconds Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand add "https://stream.radioparadise.com/flacm" took 7 milliseconds Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand status took 7 milliseconds Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::parseState Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand play Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::parseState Feb 08 08:49:11 volumio volumio[1337]: info: ControllerMpd::pushState Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::pushState Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Feb 08 08:49:11 volumio volumio[1337]: info: MRS: Pushing multiroomSync output update for this device Feb 08 08:49:11 volumio volumio[1337]: info: MRS: Pushing multiroomSync output Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Feb 08 08:49:11 volumio volumio[1337]: info: ControllerMpd::pushState Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::pushState Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Feb 08 08:49:11 volumio volumio[1337]: info: MRS: Pushing multiroomSync output update for this device Feb 08 08:49:11 volumio volumio[1337]: info: MRS: Pushing multiroomSync output Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Feb 08 08:49:11 volumio volumio[1337]: info: ------------------------------ 18ms Feb 08 08:49:11 volumio volumio[1337]: info: ------------------------------ 20ms Feb 08 08:49:11 volumio volumio[1337]: info: ------------------------------ 14ms Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand play took 11 milliseconds Feb 08 08:49:11 volumio volumio[1337]: info: [RadioParadise] Using metadata URL: https://api.radioparadise.com/api/now_playing?chan=0 Feb 08 08:49:11 volumio volumio[1337]: info: [1770536951218] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=0 Feb 08 08:49:11 volumio volumio[1337]: info: Feb 08 08:49:11 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Feb 08 08:49:11 volumio volumio[1337]: info: Ignoring MPD Status Update Feb 08 08:49:11 volumio volumio[1337]: info: VolumeController:: Volume=100 Mute =false Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::pushState Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Feb 08 08:49:11 volumio volumio[1337]: info: MRS: Pushing multiroomSync output update for this device Feb 08 08:49:11 volumio volumio[1337]: info: MRS: Pushing multiroomSync output Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::updateTrackBlock Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrackBlock Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 08:49:11 volumio volumio[1337]: info: ------------------------------ 17ms Feb 08 08:49:11 volumio volumio[1337]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 08:49:11 volumio volumio[1337]: info: VolumeController:: Volume=100 Mute =false Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::pushState Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Feb 08 08:49:11 volumio volumio[1337]: info: MRS: Pushing multiroomSync output update for this device Feb 08 08:49:11 volumio volumio[1337]: info: MRS: Pushing multiroomSync output Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 08:49:11 volumio volumio[1337]: info: Feb 08 08:49:11 volumio volumio[1337]: ---------------------------- MPD announces state update: player Feb 08 08:49:11 volumio volumio[1337]: info: ControllerMpd::getState Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Feb 08 08:49:11 volumio volumio[1337]: info: Feb 08 08:49:11 volumio volumio[1337]: ---------------------------- MPD announces state update: player Feb 08 08:49:11 volumio volumio[1337]: info: ControllerMpd::getState Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand status took 5 milliseconds Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::parseState Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 08 08:49:11 volumio volumio[1337]: info: Feb 08 08:49:11 volumio volumio[1337]: ---------------------------- MPD announces state update: player Feb 08 08:49:11 volumio volumio[1337]: info: ControllerMpd::getState Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Feb 08 08:49:11 volumio volumio[1337]: info: Feb 08 08:49:11 volumio volumio[1337]: ---------------------------- MPD announces state update: player Feb 08 08:49:11 volumio volumio[1337]: info: ControllerMpd::getState Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand status took 7 milliseconds Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand status took 1 milliseconds Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::parseState Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::parseState Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 08 08:49:11 volumio volumio[1337]: info: ControllerMpd::pushState Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Feb 08 08:49:11 volumio volumio[1337]: info: ------------------------------ 9ms Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand status took 2 milliseconds Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::parseState Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Feb 08 08:49:11 volumio volumio[1337]: info: ControllerMpd::pushState Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Feb 08 08:49:11 volumio volumio[1337]: info: ControllerMpd::pushState Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Feb 08 08:49:11 volumio volumio[1337]: info: ------------------------------ 11ms Feb 08 08:49:11 volumio volumio[1337]: info: ------------------------------ 5ms Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Feb 08 08:49:11 volumio volumio[1337]: info: ControllerMpd::pushState Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Feb 08 08:49:11 volumio volumio[1337]: info: ------------------------------ 4ms Feb 08 08:49:11 volumio volumio[1337]: info: Feb 08 08:49:11 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Feb 08 08:49:11 volumio volumio[1337]: info: Ignoring MPD Status Update Feb 08 08:49:11 volumio volumio[1337]: info: Feb 08 08:49:11 volumio volumio[1337]: ---------------------------- MPD announces state update: player Feb 08 08:49:11 volumio volumio[1337]: info: ControllerMpd::getState Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Feb 08 08:49:11 volumio volumio[1337]: info: Feb 08 08:49:11 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Feb 08 08:49:11 volumio volumio[1337]: info: Ignoring MPD Status Update Feb 08 08:49:11 volumio volumio[1337]: info: Feb 08 08:49:11 volumio volumio[1337]: ---------------------------- MPD announces state update: player Feb 08 08:49:11 volumio volumio[1337]: info: ControllerMpd::getState Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Feb 08 08:49:11 volumio volumio[1337]: info: ------------------------------ 1ms Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand status took 1 milliseconds Feb 08 08:49:11 volumio volumio[1337]: info: ------------------------------ 1ms Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand status took 1 milliseconds Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::parseState Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::parseState Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 08 08:49:11 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Feb 08 08:49:11 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Feb 08 08:49:11 volumio volumio[1337]: info: ControllerMpd::pushState Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Feb 08 08:49:11 volumio volumio[1337]: info: ControllerMpd::pushState Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Feb 08 08:49:11 volumio volumio[1337]: info: ------------------------------ 4ms Feb 08 08:49:11 volumio volumio[1337]: info: ------------------------------ 3ms Feb 08 08:49:11 volumio volumio[1337]: info: [1770536951818] [RadioParadise] received new metadata: {"time":5,"artist":"Etta Marcus","title":"Skin Parade","album":"The Death of Summer & Other Promises","year":"2024","cover":"https://img.radioparadise.com/covers/l/18866.jpg","cover_med":"https://img.radioparadise.com/covers/m/18866.jpg","cover_small":"https://img.radioparadise.com/covers/s/18866.jpg"} Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Feb 08 08:49:11 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:11 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"","albumart":"https://img.radioparadise.com/covers/l/18866.jpg","uri":"https://stream.radioparadise.com/flacm","name":"Skin Parade","title":"Skin Parade","artist":"Etta Marcus","album":"The Death of Summer & Other Promises","streaming":true,"disableUiControls":true,"duration":10,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Feb 08 08:49:11 volumio volumio[1337]: verbose: CURRENT POSITION 0 Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Feb 08 08:49:11 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus stop Feb 08 08:49:11 volumio volumio[1337]: info: [1770536951819] [RadioParadise] setting new timer with duration of 10000 seconds. Feb 08 08:49:12 volumio nmbd[1223]: [2026/02/08 08:49:12.425343, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Feb 08 08:49:12 volumio nmbd[1223]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.177 for name WORKGROUP<1d>. Feb 08 08:49:12 volumio nmbd[1223]: This response was from IP 192.168.1.14, reporting an IP address of 192.168.1.14. Feb 08 08:49:12 volumio volumio[1337]: info: Feb 08 08:49:12 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Feb 08 08:49:12 volumio volumio[1337]: info: Ignoring MPD Status Update Feb 08 08:49:12 volumio volumio[1337]: info: Feb 08 08:49:12 volumio volumio[1337]: ---------------------------- MPD announces state update: player Feb 08 08:49:12 volumio volumio[1337]: info: ControllerMpd::getState Feb 08 08:49:12 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Feb 08 08:49:12 volumio volumio[1337]: info: Feb 08 08:49:12 volumio volumio[1337]: ---------------------------- MPD announces system playlist update Feb 08 08:49:12 volumio volumio[1337]: info: Ignoring MPD Status Update Feb 08 08:49:12 volumio volumio[1337]: info: Feb 08 08:49:12 volumio volumio[1337]: ---------------------------- MPD announces state update: player Feb 08 08:49:12 volumio volumio[1337]: info: ControllerMpd::getState Feb 08 08:49:12 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Feb 08 08:49:12 volumio volumio[1337]: info: ------------------------------ 1ms Feb 08 08:49:12 volumio volumio[1337]: info: sendMpdCommand status took 1 milliseconds Feb 08 08:49:12 volumio volumio[1337]: info: ------------------------------ 1ms Feb 08 08:49:12 volumio volumio[1337]: info: sendMpdCommand status took 1 milliseconds Feb 08 08:49:12 volumio volumio[1337]: verbose: ControllerMpd::parseState Feb 08 08:49:12 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 08 08:49:12 volumio volumio[1337]: verbose: ControllerMpd::parseState Feb 08 08:49:12 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 08 08:49:12 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 08 08:49:12 volumio volumio[1337]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 08 08:49:12 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Feb 08 08:49:12 volumio volumio[1337]: verbose: ControllerMpd::parseTrackInfo Feb 08 08:49:12 volumio volumio[1337]: info: ControllerMpd::pushState Feb 08 08:49:12 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Feb 08 08:49:12 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:12 volumio volumio[1337]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Feb 08 08:49:12 volumio volumio[1337]: info: ControllerMpd::pushState Feb 08 08:49:12 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Feb 08 08:49:12 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:12 volumio volumio[1337]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Feb 08 08:49:12 volumio volumio[1337]: info: ------------------------------ 4ms Feb 08 08:49:12 volumio volumio[1337]: info: ------------------------------ 3ms Feb 08 08:49:15 volumio volumio[1337]: info: Tunnel connection is inactive, restarting it Feb 08 08:49:15 volumio volumio[1337]: info: Starting Tunnel 1 Feb 08 08:49:15 volumio volumio[1337]: info: Starting Tunnel Connection Checker Feb 08 08:49:15 volumio sudo[3080]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Feb 08 08:49:15 volumio sudo[3080]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 08:49:15 volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Feb 08 08:49:15 volumio sudo[3080]: pam_unix(sudo:session): session closed for user root Feb 08 08:49:15 volumio volumio[1337]: info: Remote SSH Started Feb 08 08:49:15 volumio autossh[3083]: port set to 0, monitoring disabled Feb 08 08:49:15 volumio autossh[3083]: starting ssh (count 1) Feb 08 08:49:15 volumio autossh[3083]: ssh child pid is 3086 Feb 08 08:49:15 volumio volumio[1337]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 08 08:49:15 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:15 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:15 volumio volumiossh-tunnel[3086]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Feb 08 08:49:15 volumio autossh[3083]: ssh exited prematurely with status 255; autossh exiting Feb 08 08:49:15 volumio systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Feb 08 08:49:15 volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Feb 08 08:49:15 volumio systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 1. Feb 08 08:49:15 volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Feb 08 08:49:15 volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Feb 08 08:49:15 volumio autossh[3088]: port set to 0, monitoring disabled Feb 08 08:49:15 volumio autossh[3088]: starting ssh (count 1) Feb 08 08:49:15 volumio autossh[3088]: ssh child pid is 3091 Feb 08 08:49:15 volumio volumiossh-tunnel[3091]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Feb 08 08:49:15 volumio autossh[3088]: ssh exited prematurely with status 255; autossh exiting Feb 08 08:49:15 volumio systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Feb 08 08:49:15 volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Feb 08 08:49:16 volumio systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 2. Feb 08 08:49:16 volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Feb 08 08:49:16 volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Feb 08 08:49:16 volumio autossh[3093]: port set to 0, monitoring disabled Feb 08 08:49:16 volumio autossh[3093]: starting ssh (count 1) Feb 08 08:49:16 volumio autossh[3093]: ssh child pid is 3096 Feb 08 08:49:16 volumio volumiossh-tunnel[3096]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Feb 08 08:49:16 volumio autossh[3093]: ssh exited prematurely with status 255; autossh exiting Feb 08 08:49:16 volumio systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Feb 08 08:49:16 volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Feb 08 08:49:16 volumio systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 3. Feb 08 08:49:16 volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Feb 08 08:49:16 volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Feb 08 08:49:16 volumio autossh[3098]: port set to 0, monitoring disabled Feb 08 08:49:16 volumio autossh[3098]: starting ssh (count 1) Feb 08 08:49:16 volumio autossh[3098]: ssh child pid is 3101 Feb 08 08:49:16 volumio volumiossh-tunnel[3101]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Feb 08 08:49:16 volumio autossh[3098]: ssh exited prematurely with status 255; autossh exiting Feb 08 08:49:16 volumio systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Feb 08 08:49:16 volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Feb 08 08:49:16 volumio systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 4. Feb 08 08:49:16 volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Feb 08 08:49:16 volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Feb 08 08:49:16 volumio autossh[3103]: port set to 0, monitoring disabled Feb 08 08:49:16 volumio autossh[3103]: starting ssh (count 1) Feb 08 08:49:16 volumio autossh[3103]: ssh child pid is 3106 Feb 08 08:49:16 volumio volumiossh-tunnel[3106]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Feb 08 08:49:16 volumio autossh[3103]: ssh exited prematurely with status 255; autossh exiting Feb 08 08:49:16 volumio systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Feb 08 08:49:16 volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Feb 08 08:49:16 volumio systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 5. Feb 08 08:49:16 volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Feb 08 08:49:16 volumio systemd[1]: sshtunnel.service: Start request repeated too quickly. Feb 08 08:49:16 volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Feb 08 08:49:16 volumio systemd[1]: Failed to start sshtunnel.service - MyVolumio SSH Tunnel. Feb 08 08:49:17 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 08 08:49:17 volumio volumio[1337]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 08:49:17 volumio volumio[1337]: info: CoreCommandRouter::Close All Modals sent Feb 08 08:49:21 volumio volumio[1337]: info: [1770536961820] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=0 Feb 08 08:49:22 volumio volumio[1337]: info: [1770536962400] [RadioParadise] received new metadata: {"time":5,"artist":"Etta Marcus","title":"Skin Parade","album":"The Death of Summer & Other Promises","year":"2024","cover":"https://img.radioparadise.com/covers/l/18866.jpg","cover_med":"https://img.radioparadise.com/covers/m/18866.jpg","cover_small":"https://img.radioparadise.com/covers/s/18866.jpg"} Feb 08 08:49:22 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:22 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Feb 08 08:49:22 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:22 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"","albumart":"https://img.radioparadise.com/covers/l/18866.jpg","uri":"https://stream.radioparadise.com/flacm","name":"Skin Parade","title":"Skin Parade","artist":"Etta Marcus","album":"The Death of Summer & Other Promises","streaming":true,"disableUiControls":true,"duration":10,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Feb 08 08:49:22 volumio volumio[1337]: verbose: CURRENT POSITION 0 Feb 08 08:49:22 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Feb 08 08:49:22 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Feb 08 08:49:22 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Feb 08 08:49:22 volumio volumio[1337]: info: CoreStateMachine::pushState Feb 08 08:49:22 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:22 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 08 08:49:22 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Feb 08 08:49:22 volumio volumio[1337]: info: MRS: Pushing multiroomSync output update for this device Feb 08 08:49:22 volumio volumio[1337]: info: MRS: Pushing multiroomSync output Feb 08 08:49:22 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:22 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:22 volumio volumio[1337]: info: CoreStateMachine::pushState Feb 08 08:49:22 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:22 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Feb 08 08:49:22 volumio volumio[1337]: info: MRS: Pushing multiroomSync output update for this device Feb 08 08:49:22 volumio volumio[1337]: info: MRS: Pushing multiroomSync output Feb 08 08:49:22 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:22 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:22 volumio volumio[1337]: info: [1770536962408] [RadioParadise] setting new timer with duration of 10000 seconds. Feb 08 08:49:22 volumio volumio[1337]: info: CoreCommandRouter::volumioGetQueue Feb 08 08:49:22 volumio volumio[1337]: info: CoreStateMachine::getQueue Feb 08 08:49:22 volumio volumio[1337]: info: CorePlayQueue::getQueue Feb 08 08:49:22 volumio volumio[1337]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 08:49:22 volumio volumio[1337]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 08:49:23 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 08:49:23 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 08:49:23 volumio volumio[1337]: info: Discovery: Getting this device information Feb 08 08:49:23 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:23 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:23 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 08:49:23 volumio volumio[1337]: verbose: New Socket.io Connection to 192.168.1.177:3000 from 192.168.1.217 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Feb 08 08:49:23 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 08 08:49:23 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 08 08:49:26 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 08 08:49:26 volumio volumio[1337]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 08 08:49:26 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 08 08:49:26 volumio volumio[1337]: info: Received Get System Version Feb 08 08:49:26 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 08:49:26 volumio volumio[1337]: info: Received Get System Info Feb 08 08:49:26 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 08 08:49:26 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 08 08:49:26 volumio volumio[1337]: info: Discovery: Getting this device information Feb 08 08:49:26 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:26 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:26 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 08 08:49:27 volumio volumio[1337]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 08:49:27 volumio volumio[1337]: info: CoreCommandRouter::Close All Modals sent Feb 08 08:49:32 volumio volumio[1337]: info: [1770536972408] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=0 Feb 08 08:49:32 volumio volumio[1337]: info: [1770536972979] [RadioParadise] received new metadata: {"time":5,"artist":"The Lumineers","title":"Ophelia","album":"Cleopatra","year":"2016","cover":"https://img.radioparadise.com/covers/l/11309.jpg","cover_med":"https://img.radioparadise.com/covers/m/11309.jpg","cover_small":"https://img.radioparadise.com/covers/s/11309.jpg"} Feb 08 08:49:32 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:32 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Feb 08 08:49:32 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:32 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"","albumart":"https://img.radioparadise.com/covers/l/11309.jpg","uri":"https://stream.radioparadise.com/flacm","name":"Ophelia","title":"Ophelia","artist":"The Lumineers","album":"Cleopatra","streaming":true,"disableUiControls":true,"duration":10,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Feb 08 08:49:32 volumio volumio[1337]: verbose: CURRENT POSITION 0 Feb 08 08:49:32 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Feb 08 08:49:32 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Feb 08 08:49:32 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Feb 08 08:49:32 volumio volumio[1337]: info: CoreStateMachine::pushState Feb 08 08:49:32 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:32 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 08 08:49:32 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Feb 08 08:49:32 volumio volumio[1337]: info: MRS: Pushing multiroomSync output update for this device Feb 08 08:49:32 volumio volumio[1337]: info: MRS: Pushing multiroomSync output Feb 08 08:49:32 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:32 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:32 volumio volumio[1337]: info: CoreStateMachine::pushState Feb 08 08:49:32 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:32 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Feb 08 08:49:32 volumio volumio[1337]: info: MRS: Pushing multiroomSync output update for this device Feb 08 08:49:32 volumio volumio[1337]: info: MRS: Pushing multiroomSync output Feb 08 08:49:32 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:32 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:32 volumio volumio[1337]: info: [1770536972986] [RadioParadise] setting new timer with duration of 10000 seconds. Feb 08 08:49:32 volumio volumio[1337]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 08:49:32 volumio volumio[1337]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 08:49:38 volumio volumio[1337]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 08:49:38 volumio volumio[1337]: info: CoreCommandRouter::Close All Modals sent Feb 08 08:49:42 volumio volumio[1337]: info: [1770536982986] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=0 Feb 08 08:49:43 volumio volumio[1337]: info: [1770536983563] [RadioParadise] received new metadata: {"time":5,"artist":"The Lumineers","title":"Ophelia","album":"Cleopatra","year":"2016","cover":"https://img.radioparadise.com/covers/l/11309.jpg","cover_med":"https://img.radioparadise.com/covers/m/11309.jpg","cover_small":"https://img.radioparadise.com/covers/s/11309.jpg"} Feb 08 08:49:43 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:43 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Feb 08 08:49:43 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:43 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"","albumart":"https://img.radioparadise.com/covers/l/11309.jpg","uri":"https://stream.radioparadise.com/flacm","name":"Ophelia","title":"Ophelia","artist":"The Lumineers","album":"Cleopatra","streaming":true,"disableUiControls":true,"duration":10,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Feb 08 08:49:43 volumio volumio[1337]: verbose: CURRENT POSITION 0 Feb 08 08:49:43 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Feb 08 08:49:43 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Feb 08 08:49:43 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Feb 08 08:49:43 volumio volumio[1337]: info: CoreStateMachine::pushState Feb 08 08:49:43 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:43 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Feb 08 08:49:43 volumio volumio[1337]: info: MRS: Pushing multiroomSync output update for this device Feb 08 08:49:43 volumio volumio[1337]: info: MRS: Pushing multiroomSync output Feb 08 08:49:43 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:43 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:43 volumio volumio[1337]: info: CoreStateMachine::pushState Feb 08 08:49:43 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:43 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Feb 08 08:49:43 volumio volumio[1337]: info: MRS: Pushing multiroomSync output update for this device Feb 08 08:49:43 volumio volumio[1337]: info: MRS: Pushing multiroomSync output Feb 08 08:49:43 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:43 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:43 volumio volumio[1337]: info: [1770536983570] [RadioParadise] setting new timer with duration of 10000 seconds. Feb 08 08:49:43 volumio volumio[1337]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 08:49:43 volumio volumio[1337]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 08:49:47 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 08 08:49:47 volumio volumio[1337]: info: CURURI: music-library Feb 08 08:49:47 volumio volumio[1337]: info: Preload queue cleared Feb 08 08:49:49 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 08 08:49:49 volumio volumio[1337]: info: CURURI: music-library/NAS Feb 08 08:49:51 volumio volumio[1337]: info: Preload queue cleared Feb 08 08:49:51 volumio volumio[1337]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 08:49:51 volumio volumio[1337]: info: CoreCommandRouter::Close All Modals sent Feb 08 08:49:51 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 08 08:49:51 volumio volumio[1337]: info: CURURI: music-library/NAS/Public Feb 08 08:49:51 volumio volumio[1337]: info: Preload queue cleared Feb 08 08:49:53 volumio volumio[1337]: info: [1770536993574] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=0 Feb 08 08:49:54 volumio volumio[1337]: info: [1770536994537] [RadioParadise] received new metadata: {"time":5,"artist":"The Lumineers","title":"Ophelia","album":"Cleopatra","year":"2016","cover":"https://img.radioparadise.com/covers/l/11309.jpg","cover_med":"https://img.radioparadise.com/covers/m/11309.jpg","cover_small":"https://img.radioparadise.com/covers/s/11309.jpg"} Feb 08 08:49:54 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:54 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Feb 08 08:49:54 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:54 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"","albumart":"https://img.radioparadise.com/covers/l/11309.jpg","uri":"https://stream.radioparadise.com/flacm","name":"Ophelia","title":"Ophelia","artist":"The Lumineers","album":"Cleopatra","streaming":true,"disableUiControls":true,"duration":10,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Feb 08 08:49:54 volumio volumio[1337]: verbose: CURRENT POSITION 0 Feb 08 08:49:54 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Feb 08 08:49:54 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Feb 08 08:49:54 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Feb 08 08:49:54 volumio volumio[1337]: info: CoreStateMachine::pushState Feb 08 08:49:54 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:54 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Feb 08 08:49:54 volumio volumio[1337]: info: MRS: Pushing multiroomSync output update for this device Feb 08 08:49:54 volumio volumio[1337]: info: MRS: Pushing multiroomSync output Feb 08 08:49:54 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:54 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:54 volumio volumio[1337]: info: CoreStateMachine::pushState Feb 08 08:49:54 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:54 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Feb 08 08:49:54 volumio volumio[1337]: info: MRS: Pushing multiroomSync output update for this device Feb 08 08:49:54 volumio volumio[1337]: info: MRS: Pushing multiroomSync output Feb 08 08:49:54 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:49:54 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:49:54 volumio volumio[1337]: info: [1770536994545] [RadioParadise] setting new timer with duration of 10000 seconds. Feb 08 08:49:54 volumio volumio[1337]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 08:49:54 volumio volumio[1337]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 08:49:55 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 08 08:49:55 volumio volumio[1337]: info: CURURI: music-library/NAS/Public/Skunk anansie Feb 08 08:49:55 volumio volumio[1337]: info: Preload queue cleared Feb 08 08:49:59 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 08 08:49:59 volumio volumio[1337]: info: CURURI: music-library/NAS/Public/Skunk anansie/Skunk Anansie - Post Orgasmic Chill Flac Feb 08 08:49:59 volumio volumio[1337]: info: Preload queue cleared Feb 08 08:50:00 volumio volumio[1337]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 08:50:00 volumio volumio[1337]: info: CoreCommandRouter::Close All Modals sent Feb 08 08:50:04 volumio volumio[1337]: info: [1770537004545] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=0 Feb 08 08:50:05 volumio volumio[1337]: info: [1770537005120] [RadioParadise] received new metadata: {"time":5,"artist":"The Lumineers","title":"Ophelia","album":"Cleopatra","year":"2016","cover":"https://img.radioparadise.com/covers/l/11309.jpg","cover_med":"https://img.radioparadise.com/covers/m/11309.jpg","cover_small":"https://img.radioparadise.com/covers/s/11309.jpg"} Feb 08 08:50:05 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:50:05 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Feb 08 08:50:05 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:50:05 volumio volumio[1337]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"","albumart":"https://img.radioparadise.com/covers/l/11309.jpg","uri":"https://stream.radioparadise.com/flacm","name":"Ophelia","title":"Ophelia","artist":"The Lumineers","album":"Cleopatra","streaming":true,"disableUiControls":true,"duration":10,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Feb 08 08:50:05 volumio volumio[1337]: verbose: CURRENT POSITION 0 Feb 08 08:50:05 volumio volumio[1337]: info: CoreStateMachine::syncState stateService play Feb 08 08:50:05 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus play Feb 08 08:50:05 volumio volumio[1337]: info: Received an update from plugin. extracting info from payload Feb 08 08:50:05 volumio volumio[1337]: info: CoreStateMachine::pushState Feb 08 08:50:05 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:50:05 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Feb 08 08:50:05 volumio volumio[1337]: info: MRS: Pushing multiroomSync output update for this device Feb 08 08:50:05 volumio volumio[1337]: info: MRS: Pushing multiroomSync output Feb 08 08:50:05 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:50:05 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:50:05 volumio volumio[1337]: info: CoreStateMachine::pushState Feb 08 08:50:05 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:50:05 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Feb 08 08:50:05 volumio volumio[1337]: info: MRS: Pushing multiroomSync output update for this device Feb 08 08:50:05 volumio volumio[1337]: info: MRS: Pushing multiroomSync output Feb 08 08:50:05 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:50:05 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:50:05 volumio volumio[1337]: info: [1770537005127] [RadioParadise] setting new timer with duration of 10000 seconds. Feb 08 08:50:05 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:50:05 volumio volumio[1337]: info: CorePlayQueue::getTrack 1 Feb 08 08:50:05 volumio volumio[1337]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 08:50:05 volumio volumio[1337]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 08:50:08 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 08 08:50:08 volumio volumio[1337]: info: CURURI: music-library/NAS/Public/Skunk anansie Feb 08 08:50:08 volumio volumio[1337]: info: Preload queue cleared Feb 08 08:50:10 volumio volumio[1337]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 08 08:50:10 volumio volumio[1337]: info: CoreCommandRouter::Close All Modals sent Feb 08 08:50:10 volumio volumio[1337]: info: Preload queue cleared Feb 08 08:50:10 volumio volumio[1337]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 08 08:50:10 volumio volumio[1337]: info: CoreStateMachine::ClearQueue Feb 08 08:50:10 volumio volumio[1337]: info: CoreStateMachine::stop Feb 08 08:50:10 volumio volumio[1337]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 08 08:50:10 volumio volumio[1337]: info: CoreStateMachine::stPlaybackTimer Feb 08 08:50:10 volumio volumio[1337]: info: CoreStateMachine::updateTrackBlock Feb 08 08:50:10 volumio volumio[1337]: info: CorePlayQueue::getTrackBlock Feb 08 08:50:10 volumio volumio[1337]: info: CoreStateMachine::pushState Feb 08 08:50:10 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:50:10 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 08 08:50:10 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Feb 08 08:50:10 volumio volumio[1337]: info: MRS: Pushing multiroomSync output update for this device Feb 08 08:50:10 volumio volumio[1337]: info: MRS: Pushing multiroomSync output Feb 08 08:50:10 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:50:10 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:50:10 volumio volumio[1337]: info: CoreStateMachine::serviceStop Feb 08 08:50:10 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:50:10 volumio volumio[1337]: info: CoreCommandRouter::serviceStop Feb 08 08:50:10 volumio volumio[1337]: info: ControllerMpd::stop Feb 08 08:50:10 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand stop Feb 08 08:50:10 volumio volumio[1337]: info: CorePlayQueue::clearPlayQueue Feb 08 08:50:10 volumio volumio[1337]: info: CorePlayQueue::saveQueue Feb 08 08:50:10 volumio volumio[1337]: info: CoreCommandRouter::volumioPushQueue Feb 08 08:50:10 volumio volumio[1337]: info: CoreStateMachine::addQueueItems Feb 08 08:50:10 volumio volumio[1337]: info: CorePlayQueue::addQueueItems Feb 08 08:50:10 volumio volumio[1337]: info: Preload queue cleared Feb 08 08:50:10 volumio volumio[1337]: info: Adding Item to queue: music-library/NAS/Public/Skunk anansie/Skunk Anansie - Post Orgasmic Chill Flac Feb 08 08:50:10 volumio volumio[1337]: info: Exploding uri music-library/NAS/Public/Skunk anansie/Skunk Anansie - Post Orgasmic Chill Flac in service mpd Feb 08 08:50:10 volumio volumio[1337]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 08:50:10 volumio volumio[1337]: info: sendMpdCommand stop took 151 milliseconds Feb 08 08:50:10 volumio volumio[1337]: info: CoreCommandRouter::servicePushState Feb 08 08:50:10 volumio volumio[1337]: info: CoreStateMachine::pushState Feb 08 08:50:10 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:50:10 volumio volumio[1337]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 08 08:50:10 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Feb 08 08:50:10 volumio volumio[1337]: info: MRS: Pushing multiroomSync output update for this device Feb 08 08:50:10 volumio volumio[1337]: info: MRS: Pushing multiroomSync output Feb 08 08:50:10 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:50:10 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:50:10 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:50:10 volumio volumio[1337]: verbose: STATE SERVICE {"status":"stop","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"","albumart":"https://img.radioparadise.com/covers/l/11309.jpg","uri":"https://stream.radioparadise.com/flacm","name":"Ophelia","title":"Ophelia","artist":"The Lumineers","album":"Cleopatra","streaming":true,"disableUiControls":true,"duration":10,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Feb 08 08:50:10 volumio volumio[1337]: verbose: CURRENT POSITION 0 Feb 08 08:50:10 volumio volumio[1337]: info: CoreStateMachine::syncState stateService stop Feb 08 08:50:10 volumio volumio[1337]: info: CoreStateMachine::syncState currentStatus stop Feb 08 08:50:10 volumio volumio[1337]: info: CoreStateMachine::pushState Feb 08 08:50:10 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:50:10 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Feb 08 08:50:10 volumio volumio[1337]: info: MRS: Pushing multiroomSync output update for this device Feb 08 08:50:10 volumio volumio[1337]: info: MRS: Pushing multiroomSync output Feb 08 08:50:10 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:50:10 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:50:10 volumio volumio[1337]: info: No code Feb 08 08:50:10 volumio volumio[1337]: info: CoreStateMachine::pushState Feb 08 08:50:10 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:50:10 volumio volumio[1337]: info: CoreCommandRouter::volumioPushState Feb 08 08:50:10 volumio volumio[1337]: info: MRS: Pushing multiroomSync output update for this device Feb 08 08:50:10 volumio volumio[1337]: info: MRS: Pushing multiroomSync output Feb 08 08:50:10 volumio volumio[1337]: info: CoreCommandRouter::volumioGetState Feb 08 08:50:10 volumio volumio[1337]: info: CorePlayQueue::getTrack 0 Feb 08 08:50:10 volumio volumio[1337]: info: Feb 08 08:50:10 volumio volumio[1337]: ---------------------------- MPD announces state update: player Feb 08 08:50:10 volumio volumio[1337]: info: ControllerMpd::getState Feb 08 08:50:10 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Feb 08 08:50:10 volumio volumio[1337]: info: Feb 08 08:50:10 volumio volumio[1337]: ---------------------------- MPD announces state update: player Feb 08 08:50:10 volumio volumio[1337]: info: ControllerMpd::getState Feb 08 08:50:10 volumio volumio[1337]: verbose: ControllerMpd::sendMpdCommand status Feb 08 08:50:10 volumio volumio[1337]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 08:50:10 volumio volumio[1337]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 08:50:10 volumio volumio[1337]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 08 08:50:10 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=194&web=Skunk%20Anansie/Post%20Orgasmic%20Chill/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSkunk%20anansie%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%20Flac%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%2F01%20-%20Skunk%20Anansie%20-%20Charlie%20Big%20Potato.flac&metadata=false Feb 08 08:50:10 volumio volumio[1337]: info: URI /mnt/NAS/Public/Skunk anansie/Skunk Anansie - Post Orgasmic Chill Flac/Skunk Anansie - Post Orgasmic Chill/01 - Skunk Anansie - Charlie Big Potato.flac Feb 08 08:50:10 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=194&web=Skunk%20Anansie/Post%20Orgasmic%20Chill/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSkunk%20anansie%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%20Flac%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%2F02%20-%20Skunk%20Anansie%20-%20On%20My%20Hotel%20T.V..flac&metadata=false Feb 08 08:50:10 volumio volumio[1337]: info: URI /mnt/NAS/Public/Skunk anansie/Skunk Anansie - Post Orgasmic Chill Flac/Skunk Anansie - Post Orgasmic Chill/02 - Skunk Anansie - On My Hotel T.V..flac Feb 08 08:50:10 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=194&web=Skunk%20Anansie/Post%20Orgasmic%20Chill/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSkunk%20anansie%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%20Flac%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%2F03%20-%20Skunk%20Anansie%20-%20We%20Don't%20Need%20Who%20You%20Think%20You%20Are.flac&metadata=false Feb 08 08:50:10 volumio volumio[1337]: info: URI /mnt/NAS/Public/Skunk anansie/Skunk Anansie - Post Orgasmic Chill Flac/Skunk Anansie - Post Orgasmic Chill/03 - Skunk Anansie - We Don't Need Who You Think You Are.flac Feb 08 08:50:10 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=194&web=Skunk%20Anansie/Post%20Orgasmic%20Chill/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSkunk%20anansie%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%20Flac%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%2F04%20-%20Skunk%20Anansie%20-%20Tracy's%20Flaw.flac&metadata=false Feb 08 08:50:10 volumio volumio[1337]: info: URI /mnt/NAS/Public/Skunk anansie/Skunk Anansie - Post Orgasmic Chill Flac/Skunk Anansie - Post Orgasmic Chill/04 - Skunk Anansie - Tracy's Flaw.flac Feb 08 08:50:10 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=194&web=Skunk%20Anansie/Post%20Orgasmic%20Chill/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSkunk%20anansie%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%20Flac%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%2F05%20-%20Skunk%20Anansie%20-%20The%20Skank%20Heads.flac&metadata=false Feb 08 08:50:10 volumio volumio[1337]: info: URI /mnt/NAS/Public/Skunk anansie/Skunk Anansie - Post Orgasmic Chill Flac/Skunk Anansie - Post Orgasmic Chill/05 - Skunk Anansie - The Skank Heads.flac Feb 08 08:50:10 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=194&web=Skunk%20Anansie/Post%20Orgasmic%20Chill/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSkunk%20anansie%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%20Flac%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%2F06%20-%20Skunk%20Anansie%20-%20Lately.flac&metadata=false Feb 08 08:50:10 volumio volumio[1337]: info: URI /mnt/NAS/Public/Skunk anansie/Skunk Anansie - Post Orgasmic Chill Flac/Skunk Anansie - Post Orgasmic Chill/06 - Skunk Anansie - Lately.flac Feb 08 08:50:10 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=194&web=Skunk%20Anansie/Post%20Orgasmic%20Chill/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSkunk%20anansie%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%20Flac%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%2F07%20-%20Skunk%20Anansie%20-%20Secretly.flac&metadata=false Feb 08 08:50:10 volumio volumio[1337]: info: URI /mnt/NAS/Public/Skunk anansie/Skunk Anansie - Post Orgasmic Chill Flac/Skunk Anansie - Post Orgasmic Chill/07 - Skunk Anansie - Secretly.flac Feb 08 08:50:10 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=194&web=Skunk%20Anansie/Post%20Orgasmic%20Chill/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSkunk%20anansie%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%20Flac%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%2F08%20-%20Skunk%20Anansie%20-%20Good%20Things%20Don't%20Always%20Come%20To%20You.flac&metadata=false Feb 08 08:50:10 volumio volumio[1337]: info: URI /mnt/NAS/Public/Skunk anansie/Skunk Anansie - Post Orgasmic Chill Flac/Skunk Anansie - Post Orgasmic Chill/08 - Skunk Anansie - Good Things Don't Always Come To You.flac Feb 08 08:50:10 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=194&web=Skunk%20Anansie/Post%20Orgasmic%20Chill/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSkunk%20anansie%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%20Flac%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%2F09%20-%20Skunk%20Anansie%20-%20Cheap%20Honesty.flac&metadata=false Feb 08 08:50:10 volumio volumio[1337]: info: URI /mnt/NAS/Public/Skunk anansie/Skunk Anansie - Post Orgasmic Chill Flac/Skunk Anansie - Post Orgasmic Chill/09 - Skunk Anansie - Cheap Honesty.flac Feb 08 08:50:10 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=194&web=Skunk%20Anansie/Post%20Orgasmic%20Chill/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSkunk%20anansie%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%20Flac%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%2F10%20-%20Skunk%20Anansie%20-%20You'll%20Follow%20Me%20Down.flac&metadata=false Feb 08 08:50:10 volumio volumio[1337]: info: URI /mnt/NAS/Public/Skunk anansie/Skunk Anansie - Post Orgasmic Chill Flac/Skunk Anansie - Post Orgasmic Chill/10 - Skunk Anansie - You'll Follow Me Down.flac Feb 08 08:50:10 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=194&web=Skunk%20Anansie/Post%20Orgasmic%20Chill/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSkunk%20anansie%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%20Flac%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%2F11%20-%20Skunk%20Anansie%20-%20And%20This%20Is%20Nothing%20That%20I%20Thought%20I%20Had.flac&metadata=false Feb 08 08:50:10 volumio volumio[1337]: info: URI /mnt/NAS/Public/Skunk anansie/Skunk Anansie - Post Orgasmic Chill Flac/Skunk Anansie - Post Orgasmic Chill/11 - Skunk Anansie - And This Is Nothing That I Thought I Had.flac Feb 08 08:50:10 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=194&web=Skunk%20Anansie/Post%20Orgasmic%20Chill/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSkunk%20anansie%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%20Flac%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%2F12%20-%20Skunk%20Anansie%20-%20I'm%20Not%20Afraid.flac&metadata=false Feb 08 08:50:10 volumio volumio[1337]: info: URI /mnt/NAS/Public/Skunk anansie/Skunk Anansie - Post Orgasmic Chill Flac/Skunk Anansie - Post Orgasmic Chill/12 - Skunk Anansie - I'm Not Afraid.flac Feb 08 08:50:10 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=194&web=Skunk%20Anansie/Post%20Orgasmic%20Chill/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSkunk%20anansie%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%20Flac%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%2F13%20-%20Skunk%20Anansie%20-%20Post%20Orgasmic%20Sleep.flac&metadata=false Feb 08 08:50:10 volumio volumio[1337]: info: URI /mnt/NAS/Public/Skunk anansie/Skunk Anansie - Post Orgasmic Chill Flac/Skunk Anansie - Post Orgasmic Chill/13 - Skunk Anansie - Post Orgasmic Sleep.flac Feb 08 08:50:10 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=194&web=Skunk%20Anansie/Post%20Orgasmic%20Chill/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSkunk%20anansie%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%20Flac%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill.cue&metadata=false Feb 08 08:50:10 volumio volumio[1337]: info: URI /mnt/NAS/Public/Skunk anansie/Skunk Anansie - Post Orgasmic Chill Flac/Skunk Anansie - Post Orgasmic Chill.cue Feb 08 08:50:10 volumio volumio[1337]: info: ALBUMART /albumart?cacheid=194&web=Skunk%20Anansie/Post%20Orgasmic%20Chill/extralarge&path=%2Fmnt%2FNAS%2FPublic%2FSkunk%20anansie%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill%20Flac%2FSkunk%20Anansie%20-%20Post%20Orgasmic%20Chill.cue&metadata=false Feb 08 08:50:10 volumio volumio[1337]: info: URI /mnt/NAS/Public/Skunk anansie/Skunk Anansie - Post Orgasmic Chill Flac/Skunk Anansie - Post Orgasmic Chill.cue Feb 08 08:50:10 volumio volumio[1337]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 08:50:10 volumio volumio[1337]: Error: Unable to resolve or reject the same promise twice Feb 08 08:50:10 volumio volumio[1337]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Feb 08 08:50:10 volumio volumio[1337]: at /volumio/app/plugins/music_service/mpd/index.js:2569:21 Feb 08 08:50:10 volumio volumio[1337]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Feb 08 08:50:10 volumio volumio[1337]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Feb 08 08:50:10 volumio volumio[1337]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Feb 08 08:50:10 volumio volumio[1337]: at Socket.emit (node:events:514:28) Feb 08 08:50:10 volumio volumio[1337]: at addChunk (node:internal/streams/readable:343:12) Feb 08 08:50:10 volumio volumio[1337]: at readableAddChunk (node:internal/streams/readable:312:11) Feb 08 08:50:10 volumio volumio[1337]: at Readable.push (node:internal/streams/readable:253:10) Feb 08 08:50:10 volumio volumio[1337]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Feb 08 08:50:10 volumio volumio[1337]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 08:50:11 volumio sudo[3241]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-08 08:49' Feb 08 08:50:11 volumio sudo[3241]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"