-- Logs begin at Mon 2025-05-05 11:05:47 CEST, end at Fri 2025-05-09 15:27:06 CEST. -- May 09 15:26:10 volumiopi4 wpa_supplicant[913]: RRM: Ignoring radio measurement request: Not RRM network May 09 15:26:30 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 15:26:30 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 15:26:30 volumiopi4 volumio[1034]: info: Discovery: Getting this device information May 09 15:26:30 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioGetState May 09 15:26:30 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:30 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 15:26:30 volumiopi4 volumio[1034]: verbose: New Socket.io Connection to 192.168.1.13:3000 from 192.168.1.11 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 May 09 15:26:30 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioGetState May 09 15:26:30 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:30 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 09 15:26:30 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 09 15:26:31 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 15:26:31 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 15:26:31 volumiopi4 volumio[1034]: info: Discovery: Getting this device information May 09 15:26:31 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioGetState May 09 15:26:31 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:31 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 15:26:33 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioGetState May 09 15:26:33 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:35 volumiopi4 sudo[12383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 09 15:26:35 volumiopi4 sudo[12383]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 15:26:35 volumiopi4 sudo[12383]: pam_unix(sudo:session): session closed for user root May 09 15:26:35 volumiopi4 sudo[12387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 15:26:35 volumiopi4 sudo[12387]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 15:26:35 volumiopi4 sudo[12387]: pam_unix(sudo:session): session closed for user root May 09 15:26:35 volumiopi4 volumio[1034]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Linux; Android 10; SM-G960F Build/QP1A.190711.020; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.37 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 May 09 15:26:36 volumiopi4 sudo[12390]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 09 15:26:36 volumiopi4 sudo[12390]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 15:26:36 volumiopi4 sudo[12390]: pam_unix(sudo:session): session closed for user root May 09 15:26:36 volumiopi4 sudo[12393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 15:26:36 volumiopi4 sudo[12393]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 15:26:36 volumiopi4 sudo[12393]: pam_unix(sudo:session): session closed for user root May 09 15:26:36 volumiopi4 volumio[1034]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.11 UA: Mozilla/5.0 (Linux; Android 10; SM-G960F Build/QP1A.190711.020; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.37 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 May 09 15:26:36 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 09 15:26:36 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioGetVisibleSources May 09 15:26:36 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 09 15:26:36 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioGetState May 09 15:26:36 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:36 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 09 15:26:36 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 09 15:26:36 volumiopi4 volumio[1034]: info: Received Get System Info May 09 15:26:36 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 15:26:36 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 15:26:36 volumiopi4 volumio[1034]: info: Discovery: Getting this device information May 09 15:26:36 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioGetState May 09 15:26:36 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:36 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 15:26:36 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioGetState May 09 15:26:36 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:36 volumiopi4 volumio[1034]: info: Listing playlists May 09 15:26:36 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 09 15:26:36 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 09 15:26:36 volumiopi4 volumio[1034]: info: CoreCommandRouter::getUIConfigOnPlugin May 09 15:26:36 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 09 15:26:38 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 09 15:26:38 volumiopi4 volumio[1034]: info: Received Get System Info May 09 15:26:38 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 15:26:38 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 15:26:38 volumiopi4 volumio[1034]: info: Discovery: Getting this device information May 09 15:26:38 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioGetState May 09 15:26:38 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:38 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 15:26:38 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 09 15:26:39 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioGetQueue May 09 15:26:39 volumiopi4 volumio[1034]: info: CoreStateMachine::getQueue May 09 15:26:39 volumiopi4 volumio[1034]: info: CorePlayQueue::getQueue May 09 15:26:39 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 09 15:26:39 volumiopi4 volumio[1034]: info: Received Get System Info May 09 15:26:39 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 15:26:39 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 15:26:39 volumiopi4 volumio[1034]: info: Discovery: Getting this device information May 09 15:26:39 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioGetState May 09 15:26:39 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:39 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 15:26:41 volumiopi4 volumio[1034]: info: VolumeController::SetAlsaVolume67 May 09 15:26:41 volumiopi4 volumio[1034]: info: CoreStateMachine::pushState May 09 15:26:41 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:41 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:26:41 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 09 15:26:43 volumiopi4 volumio[1034]: info: Preload queue cleared May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioReplaceandPlayItems May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::ClearQueue May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::stop May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::stPlaybackTimer May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::updateTrackBlock May 09 15:26:43 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrackBlock May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::pushState May 09 15:26:43 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::serviceStop May 09 15:26:43 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreCommandRouter::serviceStop May 09 15:26:43 volumiopi4 volumio[1034]: info: ControllerMpd::stop May 09 15:26:43 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand stop May 09 15:26:43 volumiopi4 volumio[1034]: info: CorePlayQueue::clearPlayQueue May 09 15:26:43 volumiopi4 volumio[1034]: info: CorePlayQueue::saveQueue May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushQueue May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::addQueueItems May 09 15:26:43 volumiopi4 volumio[1034]: info: CorePlayQueue::addQueueItems May 09 15:26:43 volumiopi4 volumio[1034]: info: Preload queue cleared May 09 15:26:43 volumiopi4 volumio[1034]: info: Adding Item to queue: webeighties/0 May 09 15:26:43 volumiopi4 volumio[1034]: info: Exploding uri webeighties/0 in service 80s80s May 09 15:26:43 volumiopi4 volumio[1034]: info: [1746797203170] [80s80s] explodeUri: webeighties/0 May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushQueue May 09 15:26:43 volumiopi4 volumio[1034]: info: CorePlayQueue::saveQueue May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::updateTrackBlock May 09 15:26:43 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrackBlock May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPlay May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::play index 0 May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::stop May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::play index undefined May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:26:43 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::startPlaybackTimer May 09 15:26:43 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:43 volumiopi4 volumio[1034]: info: [1746797203182] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/web/mp3-192/volumio May 09 15:26:43 volumiopi4 volumio[1034]: info: [1746797203182] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=62&count=2 May 09 15:26:43 volumiopi4 volumio[1034]: info: sendMpdCommand stop took 21 milliseconds May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreCommandRouter::servicePushState May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::pushState May 09 15:26:43 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 09 15:26:43 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:43 volumiopi4 volumio[1034]: verbose: STATE SERVICE {"status":"stop","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is3-ssl.mzstatic.com/image/thumb/Music122/v4/56/a5/e6/56a5e64f-f7bb-4c70-1030-98eff02ab50a/source/600x600bb.jpg","name":"Steel Mind - Bad Passion","title":"Bad Passion","artist":"80s80s Italo Disco","album":"","streaming":true,"disableUiControls":true,"duration":"377","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} May 09 15:26:43 volumiopi4 volumio[1034]: verbose: CURRENT POSITION 0 May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::syncState stateService stop May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::syncState currentStatus stop May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::pushState May 09 15:26:43 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 09 15:26:43 volumiopi4 volumio[1034]: info: No code May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::pushState May 09 15:26:43 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 09 15:26:43 volumiopi4 volumio[1034]: info: [1746797203848] [80s80s] received new event containing 2 songs. May 09 15:26:43 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand stop May 09 15:26:43 volumiopi4 volumio[1034]: info: sendMpdCommand stop took 0 milliseconds May 09 15:26:43 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand clear May 09 15:26:43 volumiopi4 volumio[1034]: info: May 09 15:26:43 volumiopi4 volumio[1034]: ---------------------------- MPD announces system playlist update May 09 15:26:43 volumiopi4 volumio[1034]: info: Ignoring MPD Status Update May 09 15:26:43 volumiopi4 volumio[1034]: info: sendMpdCommand clear took 1 milliseconds May 09 15:26:43 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:26:43 volumiopi4 volumio[1034]: error: updateQueue error: null May 09 15:26:43 volumiopi4 volumio[1034]: info: ------------------------------ 3ms May 09 15:26:43 volumiopi4 volumio[1034]: info: sendMpdCommand consume 1 took 2 milliseconds May 09 15:26:43 volumiopi4 volumio[1034]: info: [1746797203854] [80s80s] adding url: http://streams.80s80s.de/web/mp3-192/volumio May 09 15:26:43 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/web/mp3-192/volumio" May 09 15:26:43 volumiopi4 volumio[1034]: info: May 09 15:26:43 volumiopi4 volumio[1034]: ---------------------------- MPD announces system playlist update May 09 15:26:43 volumiopi4 volumio[1034]: info: Ignoring MPD Status Update May 09 15:26:43 volumiopi4 volumio[1034]: info: sendMpdCommand add "http://streams.80s80s.de/web/mp3-192/volumio" took 1 milliseconds May 09 15:26:43 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand play May 09 15:26:43 volumiopi4 volumio[1034]: info: ------------------------------ 3ms May 09 15:26:43 volumiopi4 volumio[1034]: info: sendMpdCommand play took 2 milliseconds May 09 15:26:43 volumiopi4 volumio[1034]: info: [1746797203859] [80s80s] Pushing the next song state: a-ha - The Sun Always Shines On TV May 09 15:26:43 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreCommandRouter::servicePushState May 09 15:26:43 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:43 volumiopi4 volumio[1034]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is3-ssl.mzstatic.com/image/thumb/Music124/v4/55/46/e5/5546e546-3c03-bcc3-f97f-fcad78347e9a/source/600x600bb.jpg","name":"a-ha - The Sun Always Shines On TV","title":"The Sun Always Shines On TV","artist":"80s80s Real 80s Radio","album":"","streaming":true,"disableUiControls":true,"duration":"289","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} May 09 15:26:43 volumiopi4 volumio[1034]: verbose: CURRENT POSITION 0 May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::syncState stateService play May 09 15:26:43 volumiopi4 volumio[1034]: info: CoreStateMachine::syncState currentStatus stop May 09 15:26:43 volumiopi4 volumio[1034]: info: [1746797203860] [80s80s] PlayNextTrack API delay: 30 May 09 15:26:43 volumiopi4 volumio[1034]: info: [1746797203866] [80s80s] Setting timer to: 289000 milliseconds. May 09 15:26:43 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:43 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 1 May 09 15:26:46 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 09 15:26:46 volumiopi4 volumio[1034]: info: May 09 15:26:46 volumiopi4 volumio[1034]: ---------------------------- MPD announces state update: player May 09 15:26:46 volumiopi4 volumio[1034]: info: ControllerMpd::getState May 09 15:26:46 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 09 15:26:46 volumiopi4 volumio[1034]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 09 15:26:46 volumiopi4 volumio[1034]: info: FusionDsp - ---- read samplerate from file: 44100 May 09 15:26:46 volumiopi4 volumio[1034]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 09 15:26:46 volumiopi4 volumio[1034]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 09 15:26:46 volumiopi4 volumio[1034]: info: FusionDsp - ---- read samplerate from file: 44100 May 09 15:26:46 volumiopi4 volumio[1034]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 09 15:26:46 volumiopi4 volumio[1034]: info: May 09 15:26:46 volumiopi4 volumio[1034]: ---------------------------- MPD announces state update: player May 09 15:26:46 volumiopi4 volumio[1034]: info: sendMpdCommand status took 30 milliseconds May 09 15:26:46 volumiopi4 volumio[1034]: info: ControllerMpd::getState May 09 15:26:46 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 09 15:26:46 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseState May 09 15:26:46 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:26:46 volumiopi4 volumio[1034]: info: sendMpdCommand status took 2 milliseconds May 09 15:26:46 volumiopi4 volumio[1034]: info: sendMpdCommand playlistinfo took 1 milliseconds May 09 15:26:46 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseState May 09 15:26:46 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:26:46 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 09 15:26:46 volumiopi4 volumio[1034]: info: ControllerMpd::pushState May 09 15:26:46 volumiopi4 volumio[1034]: info: CoreCommandRouter::servicePushState May 09 15:26:46 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:46 volumiopi4 volumio[1034]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd May 09 15:26:46 volumiopi4 volumio[1034]: info: ------------------------------ 36ms May 09 15:26:46 volumiopi4 volumio[1034]: info: sendMpdCommand playlistinfo took 2 milliseconds May 09 15:26:46 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 09 15:26:46 volumiopi4 volumio[1034]: info: ControllerMpd::pushState May 09 15:26:46 volumiopi4 volumio[1034]: info: CoreCommandRouter::servicePushState May 09 15:26:46 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:46 volumiopi4 volumio[1034]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd May 09 15:26:46 volumiopi4 volumio[1034]: info: ------------------------------ 7ms May 09 15:26:46 volumiopi4 volumio[1034]: info: FusionDsp - {"Reload":{"result":"Ok"}} May 09 15:26:46 volumiopi4 volumio[1034]: info: FusionDsp - {"Reload":{"result":"Ok"}} May 09 15:26:46 volumiopi4 volumio[1034]: info: May 09 15:26:46 volumiopi4 volumio[1034]: ---------------------------- MPD announces system playlist update May 09 15:26:46 volumiopi4 volumio[1034]: info: Ignoring MPD Status Update May 09 15:26:46 volumiopi4 volumio[1034]: info: May 09 15:26:46 volumiopi4 volumio[1034]: ---------------------------- MPD announces state update: player May 09 15:26:46 volumiopi4 volumio[1034]: info: ControllerMpd::getState May 09 15:26:46 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 09 15:26:46 volumiopi4 volumio[1034]: info: ------------------------------ 1ms May 09 15:26:46 volumiopi4 volumio[1034]: info: sendMpdCommand status took 1 milliseconds May 09 15:26:46 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseState May 09 15:26:46 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:26:46 volumiopi4 volumio[1034]: info: sendMpdCommand playlistinfo took 1 milliseconds May 09 15:26:46 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 09 15:26:46 volumiopi4 volumio[1034]: info: ControllerMpd::pushState May 09 15:26:46 volumiopi4 volumio[1034]: info: CoreCommandRouter::servicePushState May 09 15:26:46 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:46 volumiopi4 volumio[1034]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd May 09 15:26:46 volumiopi4 volumio[1034]: info: ------------------------------ 6ms May 09 15:26:46 volumiopi4 volumio[1034]: info: May 09 15:26:46 volumiopi4 volumio[1034]: ---------------------------- MPD announces system playlist update May 09 15:26:46 volumiopi4 volumio[1034]: info: Ignoring MPD Status Update May 09 15:26:46 volumiopi4 volumio[1034]: info: May 09 15:26:46 volumiopi4 volumio[1034]: ---------------------------- MPD announces state update: player May 09 15:26:46 volumiopi4 volumio[1034]: info: ControllerMpd::getState May 09 15:26:46 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 09 15:26:46 volumiopi4 volumio[1034]: info: ------------------------------ 2ms May 09 15:26:46 volumiopi4 volumio[1034]: info: sendMpdCommand status took 1 milliseconds May 09 15:26:46 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseState May 09 15:26:46 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:26:46 volumiopi4 volumio[1034]: info: sendMpdCommand playlistinfo took 1 milliseconds May 09 15:26:46 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 09 15:26:46 volumiopi4 volumio[1034]: info: ControllerMpd::pushState May 09 15:26:46 volumiopi4 volumio[1034]: info: CoreCommandRouter::servicePushState May 09 15:26:46 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:46 volumiopi4 volumio[1034]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd May 09 15:26:46 volumiopi4 volumio[1034]: info: ------------------------------ 3ms May 09 15:26:49 volumiopi4 volumio[1034]: info: VolumeController::SetAlsaVolume88 May 09 15:26:49 volumiopi4 volumio[1034]: info: CoreStateMachine::pushState May 09 15:26:49 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:49 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:26:49 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 09 15:26:51 volumiopi4 volumio[1034]: info: Preload queue cleared May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioReplaceandPlayItems May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::ClearQueue May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::stop May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::stPlaybackTimer May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::updateTrackBlock May 09 15:26:51 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrackBlock May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::pushState May 09 15:26:51 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::serviceStop May 09 15:26:51 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreCommandRouter::serviceStop May 09 15:26:51 volumiopi4 volumio[1034]: info: ControllerMpd::stop May 09 15:26:51 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand stop May 09 15:26:51 volumiopi4 volumio[1034]: info: CorePlayQueue::clearPlayQueue May 09 15:26:51 volumiopi4 volumio[1034]: info: CorePlayQueue::saveQueue May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushQueue May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::addQueueItems May 09 15:26:51 volumiopi4 volumio[1034]: info: CorePlayQueue::addQueueItems May 09 15:26:51 volumiopi4 volumio[1034]: info: Preload queue cleared May 09 15:26:51 volumiopi4 volumio[1034]: info: Adding Item to queue: webeighties/3 May 09 15:26:51 volumiopi4 volumio[1034]: info: Exploding uri webeighties/3 in service 80s80s May 09 15:26:51 volumiopi4 volumio[1034]: info: [1746797211366] [80s80s] explodeUri: webeighties/3 May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushQueue May 09 15:26:51 volumiopi4 volumio[1034]: info: CorePlayQueue::saveQueue May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::updateTrackBlock May 09 15:26:51 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrackBlock May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPlay May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::play index 0 May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::stop May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::play index undefined May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:26:51 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::startPlaybackTimer May 09 15:26:51 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:51 volumiopi4 volumio[1034]: info: [1746797211372] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/party/mp3-192/volumio May 09 15:26:51 volumiopi4 volumio[1034]: info: [1746797211372] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=252&count=2 May 09 15:26:51 volumiopi4 volumio[1034]: info: May 09 15:26:51 volumiopi4 volumio[1034]: ---------------------------- MPD announces state update: player May 09 15:26:51 volumiopi4 volumio[1034]: info: sendMpdCommand stop took 10 milliseconds May 09 15:26:51 volumiopi4 volumio[1034]: info: ControllerMpd::getState May 09 15:26:51 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreCommandRouter::servicePushState May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::pushState May 09 15:26:51 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 09 15:26:51 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:51 volumiopi4 volumio[1034]: verbose: STATE SERVICE {"status":"stop","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is3-ssl.mzstatic.com/image/thumb/Music124/v4/55/46/e5/5546e546-3c03-bcc3-f97f-fcad78347e9a/source/600x600bb.jpg","name":"a-ha - The Sun Always Shines On TV","title":"The Sun Always Shines On TV","artist":"80s80s Real 80s Radio","album":"","streaming":true,"disableUiControls":true,"duration":"289","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} May 09 15:26:51 volumiopi4 volumio[1034]: verbose: CURRENT POSITION 0 May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::syncState stateService stop May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::syncState currentStatus stop May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::pushState May 09 15:26:51 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 09 15:26:51 volumiopi4 volumio[1034]: info: No code May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::pushState May 09 15:26:51 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 09 15:26:51 volumiopi4 volumio[1034]: info: sendMpdCommand status took 11 milliseconds May 09 15:26:51 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseState May 09 15:26:51 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:26:51 volumiopi4 volumio[1034]: info: sendMpdCommand playlistinfo took 1 milliseconds May 09 15:26:51 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 09 15:26:51 volumiopi4 volumio[1034]: info: ControllerMpd::pushState May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreCommandRouter::servicePushState May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreStateMachine::pushState May 09 15:26:51 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:51 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 09 15:26:51 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:51 volumiopi4 volumio[1034]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd May 09 15:26:51 volumiopi4 volumio[1034]: info: ------------------------------ 16ms May 09 15:26:52 volumiopi4 volumio[1034]: info: camilladsp spawned new process with pid 12418, instance 1, run: true May 09 15:26:54 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 09 15:26:54 volumiopi4 volumio[1034]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 09 15:26:54 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 09 15:26:54 volumiopi4 volumio[1034]: info: Received Get System Version May 09 15:26:54 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 09 15:26:54 volumiopi4 volumio[1034]: info: Received Get System Info May 09 15:26:54 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 15:26:54 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 15:26:54 volumiopi4 volumio[1034]: info: Discovery: Getting this device information May 09 15:26:54 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioGetState May 09 15:26:54 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:54 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 15:26:58 volumiopi4 volumio[1034]: info: Preload queue cleared May 09 15:26:58 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioReplaceandPlayItems May 09 15:26:58 volumiopi4 volumio[1034]: info: CoreStateMachine::ClearQueue May 09 15:26:58 volumiopi4 volumio[1034]: info: CoreStateMachine::stop May 09 15:26:58 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:26:58 volumiopi4 volumio[1034]: info: CorePlayQueue::clearPlayQueue May 09 15:26:58 volumiopi4 volumio[1034]: info: CorePlayQueue::saveQueue May 09 15:26:58 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushQueue May 09 15:26:58 volumiopi4 volumio[1034]: info: CoreStateMachine::addQueueItems May 09 15:26:58 volumiopi4 volumio[1034]: info: CorePlayQueue::addQueueItems May 09 15:26:58 volumiopi4 volumio[1034]: info: Preload queue cleared May 09 15:26:58 volumiopi4 volumio[1034]: info: Adding Item to queue: webeighties/5 May 09 15:26:58 volumiopi4 volumio[1034]: info: Exploding uri webeighties/5 in service 80s80s May 09 15:26:58 volumiopi4 volumio[1034]: info: [1746797218865] [80s80s] explodeUri: webeighties/5 May 09 15:26:58 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushQueue May 09 15:26:58 volumiopi4 volumio[1034]: info: CorePlayQueue::saveQueue May 09 15:26:58 volumiopi4 volumio[1034]: info: CoreStateMachine::updateTrackBlock May 09 15:26:58 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrackBlock May 09 15:26:58 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPlay May 09 15:26:58 volumiopi4 volumio[1034]: info: CoreStateMachine::play index 0 May 09 15:26:58 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:26:58 volumiopi4 volumio[1034]: info: CoreStateMachine::stop May 09 15:26:58 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:26:58 volumiopi4 volumio[1034]: info: CoreStateMachine::play index undefined May 09 15:26:58 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:26:58 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:58 volumiopi4 volumio[1034]: info: CoreStateMachine::startPlaybackTimer May 09 15:26:58 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:58 volumiopi4 volumio[1034]: info: [1746797218869] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio May 09 15:26:58 volumiopi4 volumio[1034]: info: [1746797218869] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2 May 09 15:26:59 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 15:26:59 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 15:26:59 volumiopi4 volumio[1034]: info: Discovery: Getting this device information May 09 15:26:59 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioGetState May 09 15:26:59 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:26:59 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 15:27:00 volumiopi4 volumio[1034]: info: Preload queue cleared May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioReplaceandPlayItems May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::ClearQueue May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::stop May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:27:00 volumiopi4 volumio[1034]: info: CorePlayQueue::clearPlayQueue May 09 15:27:00 volumiopi4 volumio[1034]: info: CorePlayQueue::saveQueue May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushQueue May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::addQueueItems May 09 15:27:00 volumiopi4 volumio[1034]: info: CorePlayQueue::addQueueItems May 09 15:27:00 volumiopi4 volumio[1034]: info: Preload queue cleared May 09 15:27:00 volumiopi4 volumio[1034]: info: Adding Item to queue: webeighties/5 May 09 15:27:00 volumiopi4 volumio[1034]: info: Using cached record of: webeighties/5 May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushQueue May 09 15:27:00 volumiopi4 volumio[1034]: info: CorePlayQueue::saveQueue May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::updateTrackBlock May 09 15:27:00 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrackBlock May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPlay May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::play index 0 May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::stop May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::play index undefined May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:27:00 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::startPlaybackTimer May 09 15:27:00 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:00 volumiopi4 volumio[1034]: info: [1746797220016] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio May 09 15:27:00 volumiopi4 volumio[1034]: info: [1746797220016] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2 May 09 15:27:00 volumiopi4 volumio[1034]: info: Preload queue cleared May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioReplaceandPlayItems May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::ClearQueue May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::stop May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:27:00 volumiopi4 volumio[1034]: info: CorePlayQueue::clearPlayQueue May 09 15:27:00 volumiopi4 volumio[1034]: info: CorePlayQueue::saveQueue May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushQueue May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::addQueueItems May 09 15:27:00 volumiopi4 volumio[1034]: info: CorePlayQueue::addQueueItems May 09 15:27:00 volumiopi4 volumio[1034]: info: Preload queue cleared May 09 15:27:00 volumiopi4 volumio[1034]: info: Adding Item to queue: webeighties/5 May 09 15:27:00 volumiopi4 volumio[1034]: info: Using cached record of: webeighties/5 May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushQueue May 09 15:27:00 volumiopi4 volumio[1034]: info: CorePlayQueue::saveQueue May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::updateTrackBlock May 09 15:27:00 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrackBlock May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPlay May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::play index 0 May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::stop May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::play index undefined May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 15:27:00 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:00 volumiopi4 volumio[1034]: info: CoreStateMachine::startPlaybackTimer May 09 15:27:00 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:00 volumiopi4 volumio[1034]: info: [1746797220249] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/italohits/mp3-192/volumio May 09 15:27:00 volumiopi4 volumio[1034]: info: [1746797220249] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=283&count=2 May 09 15:27:01 volumiopi4 volumio[1034]: info: [1746797221273] [80s80s] received new event containing 2 songs. May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand stop May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand stop took 1 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand clear May 09 15:27:01 volumiopi4 volumio[1034]: info: May 09 15:27:01 volumiopi4 volumio[1034]: ---------------------------- MPD announces system playlist update May 09 15:27:01 volumiopi4 volumio[1034]: info: Ignoring MPD Status Update May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand clear took 1 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:27:01 volumiopi4 volumio[1034]: error: updateQueue error: null May 09 15:27:01 volumiopi4 volumio[1034]: info: ------------------------------ 1ms May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand consume 1 took 0 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: info: [1746797221277] [80s80s] adding url: http://streams.80s80s.de/italohits/mp3-192/volumio May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/italohits/mp3-192/volumio" May 09 15:27:01 volumiopi4 volumio[1034]: info: May 09 15:27:01 volumiopi4 volumio[1034]: ---------------------------- MPD announces system playlist update May 09 15:27:01 volumiopi4 volumio[1034]: info: Ignoring MPD Status Update May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand add "http://streams.80s80s.de/italohits/mp3-192/volumio" took 0 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand play May 09 15:27:01 volumiopi4 volumio[1034]: info: ------------------------------ 3ms May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand play took 2 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: info: [1746797221281] [80s80s] Pushing the next song state: Koto - Visitors May 09 15:27:01 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:01 volumiopi4 volumio[1034]: info: CoreCommandRouter::servicePushState May 09 15:27:01 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:01 volumiopi4 volumio[1034]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is3-ssl.mzstatic.com/image/thumb/Music/v4/2f/af/0f/2faf0fba-5985-3b3e-fb34-0eb5c31e39f8/source/600x600bb.jpg","name":"Koto - Visitors","title":"Visitors","artist":"80s80s Italo Disco","album":"","streaming":true,"disableUiControls":true,"duration":"204","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} May 09 15:27:01 volumiopi4 volumio[1034]: verbose: CURRENT POSITION 0 May 09 15:27:01 volumiopi4 volumio[1034]: info: CoreStateMachine::syncState stateService play May 09 15:27:01 volumiopi4 volumio[1034]: info: CoreStateMachine::syncState currentStatus stop May 09 15:27:01 volumiopi4 volumio[1034]: info: [1746797221281] [80s80s] PlayNextTrack API delay: 30 May 09 15:27:01 volumiopi4 volumio[1034]: info: [1746797221285] [80s80s] Setting timer to: 204000 milliseconds. May 09 15:27:01 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:01 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 1 May 09 15:27:01 volumiopi4 volumio[1034]: info: [1746797221479] [80s80s] received new event containing 2 songs. May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand stop May 09 15:27:01 volumiopi4 volumio[1034]: info: May 09 15:27:01 volumiopi4 volumio[1034]: ---------------------------- MPD announces state update: player May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand stop took 1 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: info: ControllerMpd::getState May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand clear May 09 15:27:01 volumiopi4 volumio[1034]: info: May 09 15:27:01 volumiopi4 volumio[1034]: ---------------------------- MPD announces system playlist update May 09 15:27:01 volumiopi4 volumio[1034]: info: Ignoring MPD Status Update May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand status took 1 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand clear took 1 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseState May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:27:01 volumiopi4 volumio[1034]: error: updateQueue error: null May 09 15:27:01 volumiopi4 volumio[1034]: info: ------------------------------ 2ms May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand playlistinfo took 1 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand consume 1 took 1 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 09 15:27:01 volumiopi4 volumio[1034]: info: [1746797221484] [80s80s] adding url: http://streams.80s80s.de/italohits/mp3-192/volumio May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/italohits/mp3-192/volumio" May 09 15:27:01 volumiopi4 volumio[1034]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 09 15:27:01 volumiopi4 volumio[1034]: info: ------------------------------ 4ms May 09 15:27:01 volumiopi4 volumio[1034]: info: May 09 15:27:01 volumiopi4 volumio[1034]: ---------------------------- MPD announces system playlist update May 09 15:27:01 volumiopi4 volumio[1034]: info: Ignoring MPD Status Update May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand add "http://streams.80s80s.de/italohits/mp3-192/volumio" took 1 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand play May 09 15:27:01 volumiopi4 volumio[1034]: info: ------------------------------ 2ms May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand play took 1 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: info: [1746797221488] [80s80s] Pushing the next song state: Koto - Visitors May 09 15:27:01 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:01 volumiopi4 volumio[1034]: info: CoreCommandRouter::servicePushState May 09 15:27:01 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:01 volumiopi4 volumio[1034]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is3-ssl.mzstatic.com/image/thumb/Music/v4/2f/af/0f/2faf0fba-5985-3b3e-fb34-0eb5c31e39f8/source/600x600bb.jpg","name":"Koto - Visitors","title":"Visitors","artist":"80s80s Italo Disco","album":"","streaming":true,"disableUiControls":true,"duration":"204","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} May 09 15:27:01 volumiopi4 volumio[1034]: verbose: CURRENT POSITION 0 May 09 15:27:01 volumiopi4 volumio[1034]: info: CoreStateMachine::syncState stateService play May 09 15:27:01 volumiopi4 volumio[1034]: info: CoreStateMachine::syncState currentStatus play May 09 15:27:01 volumiopi4 volumio[1034]: info: Received an update from plugin. extracting info from payload May 09 15:27:01 volumiopi4 volumio[1034]: info: CoreStateMachine::pushState May 09 15:27:01 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:01 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:27:01 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 09 15:27:01 volumiopi4 volumio[1034]: info: CoreStateMachine::pushState May 09 15:27:01 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:01 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 09 15:27:01 volumiopi4 volumio[1034]: info: [1746797221493] [80s80s] PlayNextTrack API delay: 30 May 09 15:27:01 volumiopi4 volumio[1034]: info: [1746797221494] [80s80s] Setting timer to: 204000 milliseconds. May 09 15:27:01 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:01 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 1 May 09 15:27:01 volumiopi4 volumio[1034]: info: [1746797221579] [80s80s] received new event containing 2 songs. May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand stop May 09 15:27:01 volumiopi4 volumio[1034]: info: May 09 15:27:01 volumiopi4 volumio[1034]: ---------------------------- MPD announces state update: player May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand stop took 1 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: info: ControllerMpd::getState May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand clear May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand status took 1 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand clear took 1 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseState May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand consume 1 May 09 15:27:01 volumiopi4 volumio[1034]: info: May 09 15:27:01 volumiopi4 volumio[1034]: ---------------------------- MPD announces system playlist update May 09 15:27:01 volumiopi4 volumio[1034]: info: Ignoring MPD Status Update May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand playlistinfo took 1 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand consume 1 took 1 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 09 15:27:01 volumiopi4 volumio[1034]: info: [1746797221583] [80s80s] adding url: http://streams.80s80s.de/italohits/mp3-192/volumio May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/italohits/mp3-192/volumio" May 09 15:27:01 volumiopi4 volumio[1034]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 09 15:27:01 volumiopi4 volumio[1034]: info: ------------------------------ 3ms May 09 15:27:01 volumiopi4 volumio[1034]: error: updateQueue error: null May 09 15:27:01 volumiopi4 volumio[1034]: info: May 09 15:27:01 volumiopi4 volumio[1034]: ---------------------------- MPD announces system playlist update May 09 15:27:01 volumiopi4 volumio[1034]: info: Ignoring MPD Status Update May 09 15:27:01 volumiopi4 volumio[1034]: info: ------------------------------ 2ms May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand add "http://streams.80s80s.de/italohits/mp3-192/volumio" took 1 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand play May 09 15:27:01 volumiopi4 volumio[1034]: info: ------------------------------ 2ms May 09 15:27:01 volumiopi4 volumio[1034]: info: sendMpdCommand play took 1 milliseconds May 09 15:27:01 volumiopi4 volumio[1034]: info: [1746797221587] [80s80s] Pushing the next song state: Koto - Visitors May 09 15:27:01 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:01 volumiopi4 volumio[1034]: info: CoreCommandRouter::servicePushState May 09 15:27:01 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:01 volumiopi4 volumio[1034]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is3-ssl.mzstatic.com/image/thumb/Music/v4/2f/af/0f/2faf0fba-5985-3b3e-fb34-0eb5c31e39f8/source/600x600bb.jpg","name":"Koto - Visitors","title":"Visitors","artist":"80s80s Italo Disco","album":"","streaming":true,"disableUiControls":true,"duration":"204","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} May 09 15:27:01 volumiopi4 volumio[1034]: verbose: CURRENT POSITION 0 May 09 15:27:01 volumiopi4 volumio[1034]: info: CoreStateMachine::syncState stateService play May 09 15:27:01 volumiopi4 volumio[1034]: info: CoreStateMachine::syncState currentStatus play May 09 15:27:01 volumiopi4 volumio[1034]: info: Received an update from plugin. extracting info from payload May 09 15:27:01 volumiopi4 volumio[1034]: info: CoreStateMachine::pushState May 09 15:27:01 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:01 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 09 15:27:01 volumiopi4 volumio[1034]: info: CoreStateMachine::pushState May 09 15:27:01 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:01 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 09 15:27:01 volumiopi4 volumio[1034]: info: [1746797221592] [80s80s] PlayNextTrack API delay: 30 May 09 15:27:01 volumiopi4 volumio[1034]: info: [1746797221592] [80s80s] Setting timer to: 204000 milliseconds. May 09 15:27:01 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:01 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 1 May 09 15:27:02 volumiopi4 volumio[1034]: info: May 09 15:27:02 volumiopi4 volumio[1034]: ---------------------------- MPD announces state update: player May 09 15:27:02 volumiopi4 volumio[1034]: info: ControllerMpd::getState May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 09 15:27:02 volumiopi4 volumio[1034]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 09 15:27:02 volumiopi4 volumio[1034]: info: FusionDsp - ---- read samplerate from file: 44100 May 09 15:27:02 volumiopi4 volumio[1034]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 09 15:27:02 volumiopi4 volumio[1034]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 09 15:27:02 volumiopi4 volumio[1034]: info: FusionDsp - ---- read samplerate from file: 44100 May 09 15:27:02 volumiopi4 volumio[1034]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 09 15:27:02 volumiopi4 volumio[1034]: info: May 09 15:27:02 volumiopi4 volumio[1034]: ---------------------------- MPD announces state update: player May 09 15:27:02 volumiopi4 volumio[1034]: info: sendMpdCommand status took 21 milliseconds May 09 15:27:02 volumiopi4 volumio[1034]: info: ControllerMpd::getState May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseState May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:27:02 volumiopi4 volumio[1034]: info: sendMpdCommand status took 1 milliseconds May 09 15:27:02 volumiopi4 volumio[1034]: info: sendMpdCommand playlistinfo took 1 milliseconds May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseState May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 09 15:27:02 volumiopi4 volumio[1034]: info: ControllerMpd::pushState May 09 15:27:02 volumiopi4 volumio[1034]: info: CoreCommandRouter::servicePushState May 09 15:27:02 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:02 volumiopi4 volumio[1034]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd May 09 15:27:02 volumiopi4 volumio[1034]: info: ------------------------------ 24ms May 09 15:27:02 volumiopi4 volumio[1034]: info: sendMpdCommand playlistinfo took 1 milliseconds May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 09 15:27:02 volumiopi4 volumio[1034]: info: ControllerMpd::pushState May 09 15:27:02 volumiopi4 volumio[1034]: info: CoreCommandRouter::servicePushState May 09 15:27:02 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:02 volumiopi4 volumio[1034]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd May 09 15:27:02 volumiopi4 volumio[1034]: info: ------------------------------ 4ms May 09 15:27:02 volumiopi4 volumio[1034]: info: FusionDsp - {"Reload":{"result":"Ok"}} May 09 15:27:02 volumiopi4 volumio[1034]: info: FusionDsp - {"Reload":{"result":"Ok"}} May 09 15:27:02 volumiopi4 volumio[1034]: info: May 09 15:27:02 volumiopi4 volumio[1034]: ---------------------------- MPD announces system playlist update May 09 15:27:02 volumiopi4 volumio[1034]: info: Ignoring MPD Status Update May 09 15:27:02 volumiopi4 volumio[1034]: info: May 09 15:27:02 volumiopi4 volumio[1034]: ---------------------------- MPD announces state update: player May 09 15:27:02 volumiopi4 volumio[1034]: info: ControllerMpd::getState May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 09 15:27:02 volumiopi4 volumio[1034]: info: ------------------------------ 1ms May 09 15:27:02 volumiopi4 volumio[1034]: info: May 09 15:27:02 volumiopi4 volumio[1034]: ---------------------------- MPD announces system playlist update May 09 15:27:02 volumiopi4 volumio[1034]: info: Ignoring MPD Status Update May 09 15:27:02 volumiopi4 volumio[1034]: info: May 09 15:27:02 volumiopi4 volumio[1034]: ---------------------------- MPD announces state update: player May 09 15:27:02 volumiopi4 volumio[1034]: info: sendMpdCommand status took 3 milliseconds May 09 15:27:02 volumiopi4 volumio[1034]: info: ControllerMpd::getState May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseState May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:27:02 volumiopi4 volumio[1034]: info: ------------------------------ 2ms May 09 15:27:02 volumiopi4 volumio[1034]: info: sendMpdCommand status took 2 milliseconds May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseState May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:27:02 volumiopi4 volumio[1034]: info: sendMpdCommand playlistinfo took 2 milliseconds May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 09 15:27:02 volumiopi4 volumio[1034]: info: ControllerMpd::pushState May 09 15:27:02 volumiopi4 volumio[1034]: info: CoreCommandRouter::servicePushState May 09 15:27:02 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:02 volumiopi4 volumio[1034]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd May 09 15:27:02 volumiopi4 volumio[1034]: info: ------------------------------ 7ms May 09 15:27:02 volumiopi4 volumio[1034]: info: sendMpdCommand playlistinfo took 1 milliseconds May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 09 15:27:02 volumiopi4 volumio[1034]: info: ControllerMpd::pushState May 09 15:27:02 volumiopi4 volumio[1034]: info: CoreCommandRouter::servicePushState May 09 15:27:02 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:02 volumiopi4 volumio[1034]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd May 09 15:27:02 volumiopi4 volumio[1034]: info: ------------------------------ 5ms May 09 15:27:02 volumiopi4 volumio[1034]: info: May 09 15:27:02 volumiopi4 volumio[1034]: ---------------------------- MPD announces system playlist update May 09 15:27:02 volumiopi4 volumio[1034]: info: Ignoring MPD Status Update May 09 15:27:02 volumiopi4 volumio[1034]: info: May 09 15:27:02 volumiopi4 volumio[1034]: ---------------------------- MPD announces state update: player May 09 15:27:02 volumiopi4 volumio[1034]: info: ControllerMpd::getState May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand status May 09 15:27:02 volumiopi4 volumio[1034]: info: ------------------------------ 1ms May 09 15:27:02 volumiopi4 volumio[1034]: info: sendMpdCommand status took 1 milliseconds May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseState May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 15:27:02 volumiopi4 volumio[1034]: info: sendMpdCommand playlistinfo took 0 milliseconds May 09 15:27:02 volumiopi4 volumio[1034]: verbose: ControllerMpd::parseTrackInfo May 09 15:27:02 volumiopi4 volumio[1034]: info: ControllerMpd::pushState May 09 15:27:02 volumiopi4 volumio[1034]: info: CoreCommandRouter::servicePushState May 09 15:27:02 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:02 volumiopi4 volumio[1034]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd May 09 15:27:02 volumiopi4 volumio[1034]: info: ------------------------------ 3ms May 09 15:27:06 volumiopi4 volumio[1034]: info: VolumeController::SetAlsaVolume100 May 09 15:27:06 volumiopi4 volumio[1034]: info: CoreStateMachine::pushState May 09 15:27:06 volumiopi4 volumio[1034]: info: CorePlayQueue::getTrack 0 May 09 15:27:06 volumiopi4 volumio[1034]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 15:27:06 volumiopi4 volumio[1034]: info: CoreCommandRouter::volumioPushState May 09 15:27:06 volumiopi4 volumio[1034]: info: [1746797226573] [80s80s] Failed to query api, status code: 504 May 09 15:27:06 volumiopi4 volumio[1034]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 15:27:06 volumiopi4 volumio[1034]: Error: ENOENT: no such file or directory, open '/data/plugins/music_service/80s80s/fake-data.json' May 09 15:27:06 volumiopi4 volumio[1034]: at Object.openSync (fs.js:476:3) May 09 15:27:06 volumiopi4 volumio[1034]: at Object.readFileSync (fs.js:377:35) May 09 15:27:06 volumiopi4 volumio[1034]: at ClientRequest. (/data/plugins/music_service/80s80s/index.js:485:23) May 09 15:27:06 volumiopi4 volumio[1034]: at Object.onceWrapper (events.js:422:26) May 09 15:27:06 volumiopi4 volumio[1034]: at ClientRequest.emit (events.js:315:20) May 09 15:27:06 volumiopi4 volumio[1034]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) May 09 15:27:06 volumiopi4 volumio[1034]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) May 09 15:27:06 volumiopi4 volumio[1034]: at HTTPParser.execute () May 09 15:27:06 volumiopi4 volumio[1034]: at Socket.socketOnData (_http_client.js:509:22) May 09 15:27:06 volumiopi4 volumio[1034]: at Socket.emit (events.js:315:20) May 09 15:27:06 volumiopi4 volumio[1034]: at addChunk (internal/streams/readable.js:309:12) May 09 15:27:06 volumiopi4 volumio[1034]: at readableAddChunk (internal/streams/readable.js:284:9) May 09 15:27:06 volumiopi4 volumio[1034]: at Socket.Readable.push (internal/streams/readable.js:223:10) May 09 15:27:06 volumiopi4 volumio[1034]: at TCP.onStreamRead (internal/stream_base_commons.js:188:23) { May 09 15:27:06 volumiopi4 volumio[1034]: errno: -2, May 09 15:27:06 volumiopi4 volumio[1034]: syscall: 'open', May 09 15:27:06 volumiopi4 volumio[1034]: code: 'ENOENT', May 09 15:27:06 volumiopi4 volumio[1034]: path: '/data/plugins/music_service/80s80s/fake-data.json' May 09 15:27:06 volumiopi4 volumio[1034]: } May 09 15:27:06 volumiopi4 volumio[1034]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 15:27:06 volumiopi4 sudo[12470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-09 15:26 May 09 15:27:06 volumiopi4 sudo[12470]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 09:33:57 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="354f95cf0a6c2cbcd57b1aca3179c81c"