-- Logs begin at Tue 2025-05-20 19:05:16 UTC, end at Sun 2025-05-25 08:20:39 UTC. -- May 25 08:19:30 volumiowk sudo[9206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 08:19:30 volumiowk sudo[9206]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:19:30 volumiowk sudo[9206]: pam_unix(sudo:session): session closed for user root May 25 08:19:30 volumiowk sudo[9210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 08:19:30 volumiowk sudo[9210]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:19:30 volumiowk sudo[9210]: pam_unix(sudo:session): session closed for user root May 25 08:19:31 volumiowk volumio[951]: info: CoreCommandRouter::volumioGetState May 25 08:19:31 volumiowk volumio[951]: info: CoreCommandRouter::volumioGetQueue May 25 08:19:31 volumiowk volumio[951]: info: CoreStateMachine::getQueue May 25 08:19:31 volumiowk volumio[951]: info: CorePlayQueue::getQueue May 25 08:19:31 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 25 08:19:31 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 25 08:19:31 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 25 08:19:31 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 25 08:19:31 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 25 08:19:37 volumiowk volumio[951]: info: Listing playlists May 25 08:19:39 volumiowk volumio[951]: info: CoreCommandRouter::volumioGetVisibleSources May 25 08:19:39 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 08:19:42 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 25 08:19:46 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 25 08:19:49 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 25 08:19:49 volumiowk volumio[951]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 25 08:19:49 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 25 08:19:49 volumiowk volumio[951]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio May 25 08:19:49 volumiowk volumio[951]: info: Received Get System Version May 25 08:19:49 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 08:19:50 volumiowk volumio[951]: info: CoreCommandRouter::volumioReplaceandPlayItems May 25 08:19:50 volumiowk volumio[951]: info: CoreStateMachine::ClearQueue May 25 08:19:50 volumiowk volumio[951]: info: CoreStateMachine::stop May 25 08:19:50 volumiowk volumio[951]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 08:19:50 volumiowk volumio[951]: verbose: UNSET VOLATILE May 25 08:19:50 volumiowk volumio[951]: info: CoreStateMachine::stPlaybackTimer May 25 08:19:50 volumiowk volumio[951]: info: CoreStateMachine::updateTrackBlock May 25 08:19:50 volumiowk volumio[951]: info: CorePlayQueue::getTrackBlock May 25 08:19:50 volumiowk volumio[951]: info: CoreStateMachine::pushState May 25 08:19:50 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:19:50 volumiowk volumio[951]: info: CoreCommandRouter::volumioPushState May 25 08:19:50 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 08:19:50 volumiowk volumio[951]: info: CoreStateMachine::serviceStop May 25 08:19:50 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:19:50 volumiowk volumio[951]: info: CoreCommandRouter::serviceStop May 25 08:19:50 volumiowk volumio[951]: info: [1748161190730] ControllerWebradio::stop May 25 08:19:50 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand stop May 25 08:19:50 volumiowk volumio[951]: info: CorePlayQueue::clearPlayQueue May 25 08:19:50 volumiowk volumio[951]: info: CorePlayQueue::saveQueue May 25 08:19:50 volumiowk volumio[951]: info: CoreCommandRouter::volumioPushState May 25 08:19:50 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 08:19:50 volumiowk volumio[951]: info: CoreCommandRouter::volumioPushQueue May 25 08:19:50 volumiowk volumio[951]: info: CoreStateMachine::addQueueItems May 25 08:19:50 volumiowk volumio[951]: info: CorePlayQueue::addQueueItems May 25 08:19:50 volumiowk volumio[951]: info: Adding Item to queue: http://streams.robstenders.nl:8063/bonanza_mp3 May 25 08:19:50 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 25 08:19:50 volumiowk volumio[951]: info: CorePlayQueue::saveQueue May 25 08:19:50 volumiowk volumio[951]: info: CoreCommandRouter::volumioPushQueue May 25 08:19:50 volumiowk volumio[951]: info: CoreStateMachine::updateTrackBlock May 25 08:19:50 volumiowk volumio[951]: info: CorePlayQueue::getTrackBlock May 25 08:19:50 volumiowk volumio[951]: info: CoreCommandRouter::volumioPlay May 25 08:19:50 volumiowk volumio[951]: verbose: UNSET VOLATILE May 25 08:19:50 volumiowk volumio[951]: info: CoreStateMachine::play index 0 May 25 08:19:50 volumiowk volumio[951]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 08:19:50 volumiowk volumio[951]: info: CoreStateMachine::stop May 25 08:19:50 volumiowk volumio[951]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 08:19:50 volumiowk volumio[951]: verbose: UNSET VOLATILE May 25 08:19:50 volumiowk volumio[951]: info: CoreStateMachine::play index undefined May 25 08:19:50 volumiowk volumio[951]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 08:19:50 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:19:50 volumiowk volumio[951]: info: CoreStateMachine::startPlaybackTimer May 25 08:19:50 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:19:50 volumiowk volumio[951]: info: [1748161190761] ControllerWebradio::clearAddPlayTrack May 25 08:19:50 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand stop May 25 08:19:50 volumiowk volumio[951]: info: May 25 08:19:50 volumiowk volumio[951]: ---------------------------- MPD announces state update: player May 25 08:19:50 volumiowk volumio[951]: info: sendMpdCommand stop took 59 milliseconds May 25 08:19:50 volumiowk volumio[951]: info: ControllerMpd::getState May 25 08:19:50 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand status May 25 08:19:50 volumiowk volumio[951]: info: sendMpdCommand stop took 28 milliseconds May 25 08:19:50 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand clear May 25 08:19:50 volumiowk volumio[951]: info: May 25 08:19:50 volumiowk volumio[951]: ---------------------------- MPD announces system playlist update May 25 08:19:50 volumiowk volumio[951]: info: Ignoring MPD Status Update May 25 08:19:50 volumiowk volumio[951]: info: sendMpdCommand status took 30 milliseconds May 25 08:19:50 volumiowk volumio[951]: info: sendMpdCommand clear took 29 milliseconds May 25 08:19:50 volumiowk volumio[951]: verbose: ControllerMpd::parseState May 25 08:19:50 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 08:19:50 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand load "http://streams.robstenders.nl:8063/bonanza_mp3" May 25 08:19:50 volumiowk volumio[951]: error: updateQueue error: null May 25 08:19:50 volumiowk volumio[951]: info: ------------------------------ 9ms May 25 08:19:50 volumiowk volumio[951]: info: sendMpdCommand playlistinfo took 6 milliseconds May 25 08:19:50 volumiowk volumio[951]: verbose: ControllerMpd::parseTrackInfo May 25 08:19:50 volumiowk volumio[951]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 25 08:19:50 volumiowk volumio[951]: info: ------------------------------ 44ms May 25 08:19:50 volumiowk volumio[951]: info: touch_display: Setting screensaver timeout to 120 seconds. May 25 08:19:50 volumiowk volumio[951]: info: CoreCommandRouter::volumioGetState May 25 08:19:50 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:19:51 volumiowk volumio[951]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 May 25 08:19:51 volumiowk volumio[951]: info: touch_display: Setting screensaver timeout to 120 seconds. May 25 08:19:51 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand add "http://streams.robstenders.nl:8063/bonanza_mp3" May 25 08:19:51 volumiowk volumio[951]: info: May 25 08:19:51 volumiowk volumio[951]: ---------------------------- MPD announces system playlist update May 25 08:19:51 volumiowk volumio[951]: info: Ignoring MPD Status Update May 25 08:19:51 volumiowk volumio[951]: info: sendMpdCommand add "http://streams.robstenders.nl:8063/bonanza_mp3" took 3 milliseconds May 25 08:19:51 volumiowk volumio[951]: info: CoreStateMachine::setConsumeUpdateService mpd May 25 08:19:51 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand play May 25 08:19:51 volumiowk volumio[951]: info: ------------------------------ 5ms May 25 08:19:51 volumiowk volumio[951]: info: sendMpdCommand play took 3 milliseconds May 25 08:19:51 volumiowk volumio[951]: info: May 25 08:19:51 volumiowk volumio[951]: ---------------------------- MPD announces state update: player May 25 08:19:51 volumiowk volumio[951]: info: ControllerMpd::getState May 25 08:19:51 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand status May 25 08:19:51 volumiowk volumio[951]: info: May 25 08:19:51 volumiowk volumio[951]: ---------------------------- MPD announces system playlist update May 25 08:19:51 volumiowk volumio[951]: info: Ignoring MPD Status Update May 25 08:19:51 volumiowk volumio[951]: info: May 25 08:19:51 volumiowk volumio[951]: ---------------------------- MPD announces state update: player May 25 08:19:51 volumiowk volumio[951]: info: sendMpdCommand status took 6 milliseconds May 25 08:19:51 volumiowk volumio[951]: info: ControllerMpd::getState May 25 08:19:51 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand status May 25 08:19:51 volumiowk volumio[951]: verbose: ControllerMpd::parseState May 25 08:19:51 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 08:19:51 volumiowk volumio[951]: info: May 25 08:19:51 volumiowk volumio[951]: ---------------------------- MPD announces system playlist update May 25 08:19:51 volumiowk volumio[951]: info: Ignoring MPD Status Update May 25 08:19:51 volumiowk volumio[951]: info: May 25 08:19:51 volumiowk volumio[951]: ---------------------------- MPD announces state update: player May 25 08:19:51 volumiowk volumio[951]: info: ControllerMpd::getState May 25 08:19:51 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand status May 25 08:19:51 volumiowk volumio[951]: info: ------------------------------ 9ms May 25 08:19:51 volumiowk volumio[951]: info: sendMpdCommand status took 5 milliseconds May 25 08:19:51 volumiowk volumio[951]: info: sendMpdCommand playlistinfo took 5 milliseconds May 25 08:19:51 volumiowk volumio[951]: verbose: ControllerMpd::parseState May 25 08:19:51 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 08:19:51 volumiowk volumio[951]: verbose: ControllerMpd::parseTrackInfo May 25 08:19:51 volumiowk volumio[951]: info: ControllerMpd::pushState May 25 08:19:51 volumiowk volumio[951]: info: CoreCommandRouter::servicePushState May 25 08:19:51 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:19:51 volumiowk volumio[951]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"jackson browne - running on empty","artist":"XXL Stenders","album":null,"uri":"http://streams.robstenders.nl:8063/bonanza_mp3","trackType":""} May 25 08:19:51 volumiowk volumio[951]: verbose: CURRENT POSITION 0 May 25 08:19:51 volumiowk volumio[951]: info: CoreStateMachine::syncState stateService play May 25 08:19:51 volumiowk volumio[951]: info: CoreStateMachine::syncState currentStatus stop May 25 08:19:51 volumiowk volumio[951]: info: CoreStateMachine::pushState May 25 08:19:51 volumiowk volumio[951]: info: CoreCommandRouter::volumioPushState May 25 08:19:51 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 08:19:51 volumiowk volumio[951]: info: ------------------------------ 37ms May 25 08:19:51 volumiowk volumio[951]: info: ------------------------------ 23ms May 25 08:19:51 volumiowk volumio[951]: info: sendMpdCommand status took 22 milliseconds May 25 08:19:51 volumiowk volumio[951]: info: sendMpdCommand playlistinfo took 19 milliseconds May 25 08:19:51 volumiowk volumio[951]: verbose: ControllerMpd::parseState May 25 08:19:51 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 08:19:51 volumiowk volumio[951]: verbose: ControllerMpd::parseTrackInfo May 25 08:19:51 volumiowk volumio[951]: info: ControllerMpd::pushState May 25 08:19:51 volumiowk volumio[951]: info: CoreCommandRouter::servicePushState May 25 08:19:51 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:19:51 volumiowk volumio[951]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"jackson browne - running on empty","artist":"XXL Stenders","album":null,"uri":"http://streams.robstenders.nl:8063/bonanza_mp3","trackType":""} May 25 08:19:51 volumiowk volumio[951]: verbose: CURRENT POSITION 0 May 25 08:19:51 volumiowk volumio[951]: info: CoreStateMachine::syncState stateService play May 25 08:19:51 volumiowk volumio[951]: info: CoreStateMachine::syncState currentStatus play May 25 08:19:51 volumiowk volumio[951]: info: Received an update from plugin. extracting info from payload May 25 08:19:51 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 25 08:19:51 volumiowk volumio[951]: info: CoreStateMachine::pushState May 25 08:19:51 volumiowk volumio[951]: info: CoreCommandRouter::volumioPushState May 25 08:19:51 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 08:19:51 volumiowk volumio[951]: info: CoreStateMachine::pushState May 25 08:19:51 volumiowk volumio[951]: info: CoreCommandRouter::volumioPushState May 25 08:19:51 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 08:19:51 volumiowk volumio[951]: info: ------------------------------ 58ms May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "API_KEY" is not set. May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "API_SECRET" is not set. May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "username" is not set. May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "authToken" is not set. May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "API_KEY" is not set. May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "API_SECRET" is not set. May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "username" is not set. May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "authToken" is not set. May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "API_KEY" is not set. May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "API_SECRET" is not set. May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "username" is not set. May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "authToken" is not set. May 25 08:19:51 volumiowk volumio[951]: info: sendMpdCommand playlistinfo took 85 milliseconds May 25 08:19:51 volumiowk volumio[951]: verbose: ControllerMpd::parseTrackInfo May 25 08:19:51 volumiowk volumio[951]: info: ControllerMpd::pushState May 25 08:19:51 volumiowk volumio[951]: info: CoreCommandRouter::servicePushState May 25 08:19:51 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:19:51 volumiowk volumio[951]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"jackson browne - running on empty","artist":"XXL Stenders","album":null,"uri":"http://streams.robstenders.nl:8063/bonanza_mp3","trackType":""} May 25 08:19:51 volumiowk volumio[951]: verbose: CURRENT POSITION 0 May 25 08:19:51 volumiowk volumio[951]: info: CoreStateMachine::syncState stateService play May 25 08:19:51 volumiowk volumio[951]: info: CoreStateMachine::syncState currentStatus play May 25 08:19:51 volumiowk volumio[951]: info: Received an update from plugin. extracting info from payload May 25 08:19:51 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 25 08:19:51 volumiowk volumio[951]: info: CoreStateMachine::pushState May 25 08:19:51 volumiowk volumio[951]: info: CoreCommandRouter::volumioPushState May 25 08:19:51 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 08:19:51 volumiowk volumio[951]: info: CoreStateMachine::pushState May 25 08:19:51 volumiowk volumio[951]: info: CoreCommandRouter::volumioPushState May 25 08:19:51 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 08:19:51 volumiowk volumio[951]: info: ------------------------------ 134ms May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "API_KEY" is not set. May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "API_SECRET" is not set. May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "username" is not set. May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "authToken" is not set. May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "API_KEY" is not set. May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "API_SECRET" is not set. May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "username" is not set. May 25 08:19:51 volumiowk volumio[951]: info: [LastFM] configuration error; "authToken" is not set. May 25 08:19:52 volumiowk volumio[951]: info: touch_display: Setting screensaver timeout to 0 seconds. May 25 08:20:11 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri May 25 08:20:11 volumiowk volumio[951]: info: [1748161211360] [80s80s] handleBrowseUri curUri: 80s80s May 25 08:20:14 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri May 25 08:20:14 volumiowk volumio[951]: info: [1748161214141] [80s80s] handleBrowseUri curUri: 80s80s/eighties May 25 08:20:14 volumiowk volumio[951]: info: [1748161214142] [80s80s] getRadioContent url: eighties May 25 08:20:29 volumiowk volumio[951]: info: May 25 08:20:29 volumiowk volumio[951]: ---------------------------- MPD announces system playlist update May 25 08:20:29 volumiowk volumio[951]: info: Ignoring MPD Status Update May 25 08:20:29 volumiowk volumio[951]: info: May 25 08:20:29 volumiowk volumio[951]: ---------------------------- MPD announces state update: player May 25 08:20:29 volumiowk volumio[951]: info: ControllerMpd::getState May 25 08:20:29 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand status May 25 08:20:29 volumiowk volumio[951]: info: ------------------------------ 3ms May 25 08:20:29 volumiowk volumio[951]: info: sendMpdCommand status took 2 milliseconds May 25 08:20:29 volumiowk volumio[951]: verbose: ControllerMpd::parseState May 25 08:20:29 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 08:20:29 volumiowk volumio[951]: info: sendMpdCommand playlistinfo took 2 milliseconds May 25 08:20:29 volumiowk volumio[951]: verbose: ControllerMpd::parseTrackInfo May 25 08:20:29 volumiowk volumio[951]: info: ControllerMpd::pushState May 25 08:20:29 volumiowk volumio[951]: info: CoreCommandRouter::servicePushState May 25 08:20:29 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:20:29 volumiowk volumio[951]: verbose: STATE SERVICE {"status":"play","position":0,"seek":38478,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"ginger ninja - sunshine","artist":"XXL Stenders","album":null,"uri":"http://streams.robstenders.nl:8063/bonanza_mp3","trackType":""} May 25 08:20:29 volumiowk volumio[951]: verbose: CURRENT POSITION 0 May 25 08:20:29 volumiowk volumio[951]: info: CoreStateMachine::syncState stateService play May 25 08:20:29 volumiowk volumio[951]: info: CoreStateMachine::syncState currentStatus play May 25 08:20:29 volumiowk volumio[951]: info: Received an update from plugin. extracting info from payload May 25 08:20:29 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 25 08:20:29 volumiowk volumio[951]: info: CoreStateMachine::pushState May 25 08:20:29 volumiowk volumio[951]: info: CoreCommandRouter::volumioPushState May 25 08:20:29 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 08:20:29 volumiowk volumio[951]: info: CoreStateMachine::pushState May 25 08:20:29 volumiowk volumio[951]: info: CoreCommandRouter::volumioPushState May 25 08:20:29 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 08:20:29 volumiowk volumio[951]: info: ------------------------------ 25ms May 25 08:20:29 volumiowk volumio[951]: info: [LastFM] configuration error; "API_KEY" is not set. May 25 08:20:29 volumiowk volumio[951]: info: [LastFM] configuration error; "API_SECRET" is not set. May 25 08:20:29 volumiowk volumio[951]: info: [LastFM] configuration error; "username" is not set. May 25 08:20:29 volumiowk volumio[951]: info: [LastFM] configuration error; "authToken" is not set. May 25 08:20:29 volumiowk volumio[951]: info: [LastFM] configuration error; "API_KEY" is not set. May 25 08:20:29 volumiowk volumio[951]: info: [LastFM] configuration error; "API_SECRET" is not set. May 25 08:20:29 volumiowk volumio[951]: info: [LastFM] configuration error; "username" is not set. May 25 08:20:29 volumiowk volumio[951]: info: [LastFM] configuration error; "authToken" is not set. May 25 08:20:31 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri May 25 08:20:31 volumiowk volumio[951]: info: [1748161231389] [80s80s] handleBrowseUri curUri: 80s80s/nineties May 25 08:20:31 volumiowk volumio[951]: info: [1748161231389] [80s80s] getRadioContent url: nineties May 25 08:20:36 volumiowk volumio[951]: info: CoreCommandRouter::volumioReplaceandPlayItems May 25 08:20:36 volumiowk volumio[951]: info: CoreStateMachine::ClearQueue May 25 08:20:36 volumiowk volumio[951]: info: CoreStateMachine::stop May 25 08:20:36 volumiowk volumio[951]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 08:20:36 volumiowk volumio[951]: verbose: UNSET VOLATILE May 25 08:20:36 volumiowk volumio[951]: info: CoreStateMachine::stPlaybackTimer May 25 08:20:36 volumiowk volumio[951]: info: CoreStateMachine::updateTrackBlock May 25 08:20:36 volumiowk volumio[951]: info: CorePlayQueue::getTrackBlock May 25 08:20:36 volumiowk volumio[951]: info: CoreStateMachine::pushState May 25 08:20:36 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:20:36 volumiowk volumio[951]: info: CoreCommandRouter::volumioPushState May 25 08:20:36 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 08:20:36 volumiowk volumio[951]: info: CoreStateMachine::serviceStop May 25 08:20:36 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:20:36 volumiowk volumio[951]: info: CoreCommandRouter::serviceStop May 25 08:20:36 volumiowk volumio[951]: info: [1748161236869] ControllerWebradio::stop May 25 08:20:36 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand stop May 25 08:20:36 volumiowk volumio[951]: info: CorePlayQueue::clearPlayQueue May 25 08:20:36 volumiowk volumio[951]: info: CorePlayQueue::saveQueue May 25 08:20:36 volumiowk volumio[951]: info: CoreCommandRouter::volumioPushState May 25 08:20:36 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 08:20:36 volumiowk volumio[951]: info: CoreCommandRouter::volumioPushQueue May 25 08:20:36 volumiowk volumio[951]: info: CoreStateMachine::addQueueItems May 25 08:20:36 volumiowk volumio[951]: info: CorePlayQueue::addQueueItems May 25 08:20:36 volumiowk volumio[951]: info: Adding Item to queue: webnineties/1 May 25 08:20:36 volumiowk volumio[951]: info: Exploding uri webnineties/1 in service 80s80s May 25 08:20:36 volumiowk volumio[951]: info: [1748161236876] [80s80s] explodeUri: webnineties/1 May 25 08:20:36 volumiowk volumio[951]: info: CorePlayQueue::saveQueue May 25 08:20:36 volumiowk volumio[951]: info: CoreCommandRouter::volumioPushQueue May 25 08:20:36 volumiowk volumio[951]: info: CoreStateMachine::updateTrackBlock May 25 08:20:36 volumiowk volumio[951]: info: CorePlayQueue::getTrackBlock May 25 08:20:36 volumiowk volumio[951]: info: CoreCommandRouter::volumioPlay May 25 08:20:36 volumiowk volumio[951]: verbose: UNSET VOLATILE May 25 08:20:36 volumiowk volumio[951]: info: CoreStateMachine::play index 0 May 25 08:20:36 volumiowk volumio[951]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 08:20:36 volumiowk volumio[951]: info: CoreStateMachine::stop May 25 08:20:36 volumiowk volumio[951]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 08:20:36 volumiowk volumio[951]: verbose: UNSET VOLATILE May 25 08:20:36 volumiowk volumio[951]: info: CoreStateMachine::play index undefined May 25 08:20:36 volumiowk volumio[951]: info: CoreStateMachine::setConsumeUpdateService undefined May 25 08:20:36 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:20:36 volumiowk volumio[951]: info: CoreStateMachine::startPlaybackTimer May 25 08:20:36 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:20:36 volumiowk volumio[951]: info: [1748161236902] [80s80s] clearAddPlayTrack url: http://streams.90s90s.de/grunge/mp3-192/volumio May 25 08:20:36 volumiowk volumio[951]: info: [1748161236904] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=253&count=2 May 25 08:20:36 volumiowk volumio[951]: info: May 25 08:20:36 volumiowk volumio[951]: ---------------------------- MPD announces state update: player May 25 08:20:36 volumiowk volumio[951]: info: sendMpdCommand stop took 56 milliseconds May 25 08:20:36 volumiowk volumio[951]: info: ControllerMpd::getState May 25 08:20:36 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand status May 25 08:20:36 volumiowk volumio[951]: info: sendMpdCommand status took 29 milliseconds May 25 08:20:36 volumiowk volumio[951]: verbose: ControllerMpd::parseState May 25 08:20:36 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 08:20:36 volumiowk volumio[951]: info: sendMpdCommand playlistinfo took 15 milliseconds May 25 08:20:36 volumiowk volumio[951]: verbose: ControllerMpd::parseTrackInfo May 25 08:20:36 volumiowk volumio[951]: info: ControllerMpd::pushState May 25 08:20:36 volumiowk volumio[951]: info: CoreCommandRouter::servicePushState May 25 08:20:36 volumiowk volumio[951]: info: CoreStateMachine::pushState May 25 08:20:36 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:20:36 volumiowk volumio[951]: info: CoreCommandRouter::volumioPushState May 25 08:20:36 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 08:20:36 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:20:36 volumiowk volumio[951]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd May 25 08:20:36 volumiowk volumio[951]: info: ------------------------------ 71ms May 25 08:20:37 volumiowk volumio[951]: info: touch_display: Setting screensaver timeout to 120 seconds. May 25 08:20:37 volumiowk volumio[951]: info: [1748161237152] [80s80s] received new event containing 2 songs. May 25 08:20:37 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand stop May 25 08:20:37 volumiowk volumio[951]: info: sendMpdCommand stop took 2 milliseconds May 25 08:20:37 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand clear May 25 08:20:37 volumiowk volumio[951]: info: May 25 08:20:37 volumiowk volumio[951]: ---------------------------- MPD announces system playlist update May 25 08:20:37 volumiowk volumio[951]: info: Ignoring MPD Status Update May 25 08:20:37 volumiowk volumio[951]: info: sendMpdCommand clear took 2 milliseconds May 25 08:20:37 volumiowk volumio[951]: info: [1748161237160] [80s80s] adding url: http://streams.90s90s.de/grunge/mp3-192/volumio May 25 08:20:37 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand add "http://streams.90s90s.de/grunge/mp3-192/volumio" May 25 08:20:37 volumiowk volumio[951]: error: updateQueue error: null May 25 08:20:37 volumiowk volumio[951]: info: May 25 08:20:37 volumiowk volumio[951]: ---------------------------- MPD announces system playlist update May 25 08:20:37 volumiowk volumio[951]: info: Ignoring MPD Status Update May 25 08:20:37 volumiowk volumio[951]: info: ------------------------------ 6ms May 25 08:20:37 volumiowk volumio[951]: info: sendMpdCommand add "http://streams.90s90s.de/grunge/mp3-192/volumio" took 4 milliseconds May 25 08:20:37 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand play May 25 08:20:37 volumiowk volumio[951]: info: ------------------------------ 9ms May 25 08:20:37 volumiowk volumio[951]: info: sendMpdCommand play took 3 milliseconds May 25 08:20:37 volumiowk volumio[951]: info: [1748161237176] [80s80s] Pushing the next song state: Bush - Comedown May 25 08:20:37 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:20:37 volumiowk volumio[951]: info: CoreCommandRouter::servicePushState May 25 08:20:37 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:20:37 volumiowk volumio[951]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is2-ssl.mzstatic.com/image/thumb/Music124/v4/35/65/7b/35657b9e-1767-76c6-24c4-7c591a946f99/source/600x600bb.jpg","name":"Bush - Comedown","title":"Comedown","artist":"90s90s Grunge","album":"","streaming":true,"disableUiControls":true,"duration":"237","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} May 25 08:20:37 volumiowk volumio[951]: verbose: CURRENT POSITION 0 May 25 08:20:37 volumiowk volumio[951]: info: CoreStateMachine::syncState stateService play May 25 08:20:37 volumiowk volumio[951]: info: CoreStateMachine::syncState currentStatus stop May 25 08:20:37 volumiowk volumio[951]: info: CoreStateMachine::pushState May 25 08:20:37 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:20:37 volumiowk volumio[951]: info: CoreCommandRouter::volumioPushState May 25 08:20:37 volumiowk volumio[951]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 08:20:37 volumiowk volumio[951]: info: [1748161237196] [80s80s] getContentOfUrl started with url http://ntp-a4.nict.go.jp/cgi-bin/json May 25 08:20:37 volumiowk volumio[951]: info: [LastFM] configuration error; "API_KEY" is not set. May 25 08:20:37 volumiowk volumio[951]: info: [LastFM] configuration error; "API_SECRET" is not set. May 25 08:20:37 volumiowk volumio[951]: info: [LastFM] configuration error; "username" is not set. May 25 08:20:37 volumiowk volumio[951]: info: [LastFM] configuration error; "authToken" is not set. May 25 08:20:37 volumiowk volumio[951]: info: touch_display: Setting screensaver timeout to 0 seconds. May 25 08:20:37 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:20:37 volumiowk volumio[951]: info: CorePlayQueue::getTrack 1 May 25 08:20:38 volumiowk volumio[951]: info: May 25 08:20:38 volumiowk volumio[951]: ---------------------------- MPD announces state update: player May 25 08:20:38 volumiowk volumio[951]: info: ControllerMpd::getState May 25 08:20:38 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand status May 25 08:20:38 volumiowk volumio[951]: info: May 25 08:20:38 volumiowk volumio[951]: ---------------------------- MPD announces system playlist update May 25 08:20:38 volumiowk volumio[951]: info: Ignoring MPD Status Update May 25 08:20:38 volumiowk volumio[951]: info: May 25 08:20:38 volumiowk volumio[951]: ---------------------------- MPD announces state update: player May 25 08:20:38 volumiowk volumio[951]: info: ControllerMpd::getState May 25 08:20:38 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand status May 25 08:20:38 volumiowk volumio[951]: info: sendMpdCommand status took 3 milliseconds May 25 08:20:38 volumiowk volumio[951]: verbose: ControllerMpd::parseState May 25 08:20:38 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 08:20:38 volumiowk volumio[951]: info: ------------------------------ 5ms May 25 08:20:38 volumiowk volumio[951]: info: sendMpdCommand status took 4 milliseconds May 25 08:20:38 volumiowk volumio[951]: info: sendMpdCommand playlistinfo took 2 milliseconds May 25 08:20:38 volumiowk volumio[951]: verbose: ControllerMpd::parseState May 25 08:20:38 volumiowk volumio[951]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 25 08:20:38 volumiowk volumio[951]: verbose: ControllerMpd::parseTrackInfo May 25 08:20:38 volumiowk volumio[951]: info: ControllerMpd::pushState May 25 08:20:38 volumiowk volumio[951]: info: CoreCommandRouter::servicePushState May 25 08:20:38 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:20:38 volumiowk volumio[951]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd May 25 08:20:38 volumiowk volumio[951]: info: ------------------------------ 11ms May 25 08:20:38 volumiowk volumio[951]: info: sendMpdCommand playlistinfo took 3 milliseconds May 25 08:20:38 volumiowk volumio[951]: verbose: ControllerMpd::parseTrackInfo May 25 08:20:38 volumiowk volumio[951]: info: ControllerMpd::pushState May 25 08:20:38 volumiowk volumio[951]: info: CoreCommandRouter::servicePushState May 25 08:20:38 volumiowk volumio[951]: info: CorePlayQueue::getTrack 0 May 25 08:20:38 volumiowk volumio[951]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd May 25 08:20:38 volumiowk volumio[951]: info: ------------------------------ 11ms May 25 08:20:38 volumiowk volumio[951]: info: [1748161238597] [80s80s] Failed to query api, status code: 404 May 25 08:20:38 volumiowk volumio[951]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 08:20:38 volumiowk volumio[951]: ReferenceError: station is not defined May 25 08:20:38 volumiowk volumio[951]: at ClientRequest.http.get (/data/plugins/music_service/80s80s/index.js:478:26) May 25 08:20:38 volumiowk volumio[951]: at Object.onceWrapper (events.js:315:30) May 25 08:20:38 volumiowk volumio[951]: at emitOne (events.js:116:13) May 25 08:20:38 volumiowk volumio[951]: at ClientRequest.emit (events.js:211:7) May 25 08:20:38 volumiowk volumio[951]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:551:21) May 25 08:20:38 volumiowk volumio[951]: at HTTPParser.parserOnHeadersComplete (_http_common.js:115:23) May 25 08:20:38 volumiowk volumio[951]: at Socket.socketOnData (_http_client.js:440:20) May 25 08:20:38 volumiowk volumio[951]: at emitOne (events.js:116:13) May 25 08:20:38 volumiowk volumio[951]: at Socket.emit (events.js:211:7) May 25 08:20:38 volumiowk volumio[951]: at addChunk (_stream_readable.js:263:12) May 25 08:20:38 volumiowk volumio[951]: at readableAddChunk (_stream_readable.js:250:11) May 25 08:20:38 volumiowk volumio[951]: at Socket.Readable.push (_stream_readable.js:208:10) May 25 08:20:38 volumiowk volumio[951]: at TCP.onread (net.js:607:20) May 25 08:20:38 volumiowk volumio[951]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 08:20:39 volumiowk sudo[9421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-25 08:19 May 25 08:20:39 volumiowk sudo[9421]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 30 22:42:09 CEST 2021" VOLUMIO_VERSION="2.915" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="02ee61bb422c79b6e5c0b6d1847a78d9"