Apr 11 15:23:13 volumio volumio[1242]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 11 15:23:13 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 11 15:23:13 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
Apr 11 15:23:13 volumio sudo[8429]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0
Apr 11 15:23:13 volumio sudo[8429]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 15:23:13 volumio sudo[8434]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Apr 11 15:23:13 volumio sudo[8434]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 15:23:13 volumio sudo[8434]: pam_unix(sudo:session): session closed for user root
Apr 11 15:23:13 volumio sudo[8441]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Apr 11 15:23:13 volumio sudo[8441]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 15:23:13 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Apr 11 15:23:13 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Apr 11 15:23:13 volumio sudo[8445]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Apr 11 15:23:13 volumio sudo[8445]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 15:23:13 volumio sudo[8429]: pam_unix(sudo:session): session closed for user root
Apr 11 15:23:13 volumio sudo[8441]: pam_unix(sudo:session): session closed for user root
Apr 11 15:23:13 volumio sudo[8445]: pam_unix(sudo:session): session closed for user root
Apr 11 15:23:13 volumio sudo[8451]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 11 15:23:13 volumio sudo[8451]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 15:23:13 volumio sudo[8451]: pam_unix(sudo:session): session closed for user root
Apr 11 15:23:13 volumio sudo[8454]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 11 15:23:13 volumio sudo[8454]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 15:23:13 volumio sudo[8454]: pam_unix(sudo:session): session closed for user root
Apr 11 15:23:13 volumio sudo[8460]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 11 15:23:13 volumio sudo[8460]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 11 15:23:15 volumio sudo[8460]: pam_unix(sudo:session): session closed for user root
Apr 11 15:23:16 volumio volumio[1242]: info: Received Get System Info
Apr 11 15:23:16 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 11 15:23:16 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 11 15:23:16 volumio volumio[1242]: info: Discovery: Getting this device information
Apr 11 15:23:16 volumio volumio[1242]: info: CoreCommandRouter::volumioGetState
Apr 11 15:23:16 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:23:16 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 11 15:23:16 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 11 15:23:16 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 11 15:23:17 volumio volumio5-onboarding[2213]: time=2026-04-11T15:23:17.352+02:00 level=INFO msg="service successfully established" component=discovery/localnet
Apr 11 15:23:56 volumio volumio[1242]: info: Received Get System Info
Apr 11 15:23:56 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 11 15:23:56 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 11 15:23:56 volumio volumio[1242]: info: Discovery: Getting this device information
Apr 11 15:23:56 volumio volumio[1242]: info: CoreCommandRouter::volumioGetState
Apr 11 15:23:56 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:23:56 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 11 15:23:56 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 11 15:23:56 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 11 15:23:56 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service...
Apr 11 15:23:56 volumio volumio5-onboarding[2213]: time=2026-04-11T15:23:56.834+02:00 level=INFO msg="service successfully established" component=discovery/localnet
Apr 11 15:23:57 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully.
Apr 11 15:23:57 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service.
Apr 11 15:24:00 volumio volumio[1242]: info: CoreCommandRouter::volumioPlay
Apr 11 15:24:00 volumio volumio[1242]: info: CoreStateMachine::play index undefined
Apr 11 15:24:00 volumio volumio[1242]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 15:24:00 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:24:12 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Apr 11 15:24:12 volumio volumio[1242]: info: CoreCommandRouter::volumioGetQueue
Apr 11 15:24:12 volumio volumio[1242]: info: CoreStateMachine::getQueue
Apr 11 15:24:12 volumio volumio[1242]: info: CorePlayQueue::getQueue
Apr 11 15:24:12 volumio volumio[1242]: info: Preload queue cleared
Apr 11 15:24:32 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Apr 11 15:24:33 volumio volumio[1242]: info: Preload queue cleared
Apr 11 15:24:37 volumio volumio[1242]: info: Preload queue cleared
Apr 11 15:24:37 volumio volumio[1242]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 11 15:24:37 volumio volumio[1242]: info: CoreStateMachine::ClearQueue
Apr 11 15:24:37 volumio volumio[1242]: info: CoreStateMachine::stop
Apr 11 15:24:37 volumio volumio[1242]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 15:24:37 volumio volumio[1242]: info: CorePlayQueue::clearPlayQueue
Apr 11 15:24:37 volumio volumio[1242]: info: CorePlayQueue::saveQueue
Apr 11 15:24:37 volumio volumio[1242]: info: CoreCommandRouter::volumioPushQueue
Apr 11 15:24:37 volumio volumio[1242]: info: CoreStateMachine::addQueueItems
Apr 11 15:24:37 volumio volumio[1242]: info: CorePlayQueue::addQueueItems
Apr 11 15:24:37 volumio volumio[1242]: info: Preload queue cleared
Apr 11 15:24:37 volumio volumio[1242]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320
Apr 11 15:24:37 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Apr 11 15:24:37 volumio volumio[1242]: info: CoreCommandRouter::volumioPushQueue
Apr 11 15:24:37 volumio volumio[1242]: info: CorePlayQueue::saveQueue
Apr 11 15:24:37 volumio volumio[1242]: info: CoreStateMachine::updateTrackBlock
Apr 11 15:24:37 volumio volumio[1242]: info: CorePlayQueue::getTrackBlock
Apr 11 15:24:37 volumio volumio[1242]: info: CoreCommandRouter::volumioPlay
Apr 11 15:24:37 volumio volumio[1242]: info: CoreStateMachine::play index 0
Apr 11 15:24:37 volumio volumio[1242]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 15:24:37 volumio volumio[1242]: info: CoreStateMachine::stop
Apr 11 15:24:37 volumio volumio[1242]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 15:24:37 volumio volumio[1242]: info: CoreStateMachine::play index undefined
Apr 11 15:24:37 volumio volumio[1242]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 15:24:37 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:24:37 volumio volumio[1242]: info: CoreStateMachine::startPlaybackTimer
Apr 11 15:24:37 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:24:37 volumio volumio[1242]: info: [1775913877659] ControllerWebradio::clearAddPlayTrack
Apr 11 15:24:37 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 15:24:37 volumio volumio[1242]: info: sendMpdCommand stop took 3 milliseconds
Apr 11 15:24:37 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand clear
Apr 11 15:24:37 volumio volumio[1242]: info: sendMpdCommand clear took 1 milliseconds
Apr 11 15:24:37 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320"
Apr 11 15:24:37 volumio upmpdcli[1979]: :3:../src/mpdcli.cxx:148::MPDCli::startEventLoop: already started
Apr 11 15:24:37 volumio volumio[1242]: info:
Apr 11 15:24:37 volumio volumio[1242]: ---------------------------- MPD announces system playlist update
Apr 11 15:24:37 volumio volumio[1242]: info: Ignoring MPD Status Update
Apr 11 15:24:37 volumio volumio[1242]: info:
Apr 11 15:24:37 volumio volumio[1242]: ---------------------------- MPD announces system playlist update
Apr 11 15:24:37 volumio volumio[1242]: info: Ignoring MPD Status Update
Apr 11 15:24:37 volumio volumio[1242]: info:
Apr 11 15:24:37 volumio volumio[1242]: ---------------------------- MPD announces system playlist update
Apr 11 15:24:37 volumio volumio[1242]: info: Ignoring MPD Status Update
Apr 11 15:24:37 volumio volumio[1242]: info:
Apr 11 15:24:37 volumio volumio[1242]: ---------------------------- MPD announces system playlist update
Apr 11 15:24:37 volumio volumio[1242]: info: Ignoring MPD Status Update
Apr 11 15:24:37 volumio volumio[1242]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 194 milliseconds
Apr 11 15:24:37 volumio volumio[1242]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 11 15:24:37 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand play
Apr 11 15:24:37 volumio volumio[1242]: info: ------------------------------ 196ms
Apr 11 15:24:37 volumio volumio[1242]: info: ------------------------------ 195ms
Apr 11 15:24:37 volumio volumio[1242]: info: ------------------------------ 193ms
Apr 11 15:24:37 volumio volumio[1242]: info:
Apr 11 15:24:37 volumio volumio[1242]: ---------------------------- MPD announces system playlist update
Apr 11 15:24:37 volumio volumio[1242]: info: Ignoring MPD Status Update
Apr 11 15:24:37 volumio volumio[1242]: info:
Apr 11 15:24:37 volumio volumio[1242]: ---------------------------- MPD announces system playlist update
Apr 11 15:24:37 volumio volumio[1242]: info: Ignoring MPD Status Update
Apr 11 15:24:37 volumio volumio[1242]: info: ------------------------------ 8ms
Apr 11 15:24:37 volumio volumio[1242]: info: sendMpdCommand play took 6 milliseconds
Apr 11 15:24:37 volumio volumio[1242]: info: ------------------------------ 4ms
Apr 11 15:24:37 volumio volumio[1242]: info: ------------------------------ 3ms
Apr 11 15:24:38 volumio volumio[1242]: info:
Apr 11 15:24:38 volumio volumio[1242]: ---------------------------- MPD announces state update: player
Apr 11 15:24:38 volumio volumio[1242]: info: ControllerMpd::getState
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 15:24:38 volumio volumio[1242]: info:
Apr 11 15:24:38 volumio volumio[1242]: ---------------------------- MPD announces state update: player
Apr 11 15:24:38 volumio volumio[1242]: info: ControllerMpd::getState
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 15:24:38 volumio volumio[1242]: info:
Apr 11 15:24:38 volumio volumio[1242]: ---------------------------- MPD announces state update: player
Apr 11 15:24:38 volumio volumio[1242]: info: ControllerMpd::getState
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 15:24:38 volumio volumio[1242]: info:
Apr 11 15:24:38 volumio volumio[1242]: ---------------------------- MPD announces state update: player
Apr 11 15:24:38 volumio volumio[1242]: info: ControllerMpd::getState
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 15:24:38 volumio volumio[1242]: info:
Apr 11 15:24:38 volumio volumio[1242]: ---------------------------- MPD announces state update: player
Apr 11 15:24:38 volumio volumio[1242]: info: ControllerMpd::getState
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 15:24:38 volumio volumio[1242]: info:
Apr 11 15:24:38 volumio volumio[1242]: ---------------------------- MPD announces state update: player
Apr 11 15:24:38 volumio volumio[1242]: info: sendMpdCommand status took 11 milliseconds
Apr 11 15:24:38 volumio volumio[1242]: info: sendMpdCommand status took 9 milliseconds
Apr 11 15:24:38 volumio volumio[1242]: info: ControllerMpd::getState
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 15:24:38 volumio volumio[1242]: info: sendMpdCommand status took 8 milliseconds
Apr 11 15:24:38 volumio volumio[1242]: info: sendMpdCommand status took 6 milliseconds
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::parseState
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::parseState
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::parseState
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::parseState
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 15:24:38 volumio volumio[1242]: info: sendMpdCommand status took 10 milliseconds
Apr 11 15:24:38 volumio volumio[1242]: info: sendMpdCommand status took 6 milliseconds
Apr 11 15:24:38 volumio volumio[1242]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 11 15:24:38 volumio volumio[1242]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 11 15:24:38 volumio volumio[1242]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 11 15:24:38 volumio volumio[1242]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::parseState
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::parseState
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::parseTrackInfo
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::parseTrackInfo
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::parseTrackInfo
Apr 11 15:24:38 volumio volumio[1242]: verbose: ControllerMpd::parseTrackInfo
Apr 11 15:24:38 volumio volumio[1242]: info: ControllerMpd::pushState
Apr 11 15:24:38 volumio volumio[1242]: info: CoreCommandRouter::servicePushState
Apr 11 15:24:38 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:24:38 volumio volumio[1242]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5518/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 11 15:24:38 volumio volumio[1242]: verbose: CURRENT POSITION 0
Apr 11 15:24:38 volumio volumio[1242]: info: CoreStateMachine::syncState stateService play
Apr 11 15:24:38 volumio volumio[1242]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 15:24:38 volumio volumio[1242]: info: ControllerMpd::pushState
Apr 11 15:24:38 volumio volumio[1242]: info: CoreCommandRouter::servicePushState
Apr 11 15:24:38 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:24:38 volumio volumio[1242]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5518/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 11 15:24:38 volumio volumio[1242]: verbose: CURRENT POSITION 0
Apr 11 15:24:38 volumio volumio[1242]: info: CoreStateMachine::syncState stateService play
Apr 11 15:24:38 volumio volumio[1242]: info: CoreStateMachine::syncState currentStatus play
Apr 11 15:24:38 volumio volumio[1242]: info: Received an update from plugin. extracting info from payload
Apr 11 15:24:38 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 11 15:24:38 volumio volumio[1242]: info: CoreStateMachine::pushState
Apr 11 15:24:38 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:24:38 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 15:24:38 volumio volumio[1242]: info: CoreCommandRouter::volumioPushState
Apr 11 15:24:38 volumio volumio[1242]: info: CoreStateMachine::pushState
Apr 11 15:24:38 volumio volumio[1242]: info: CoreCommandRouter::volumioPushState
Apr 11 15:24:39 volumio volumio[1242]: info: ControllerMpd::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::servicePushState
Apr 11 15:24:39 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:24:39 volumio volumio[1242]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5518/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 11 15:24:39 volumio volumio[1242]: verbose: CURRENT POSITION 0
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::syncState stateService play
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::syncState currentStatus play
Apr 11 15:24:39 volumio volumio[1242]: info: Received an update from plugin. extracting info from payload
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::volumioPushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::volumioPushState
Apr 11 15:24:39 volumio volumio[1242]: info: ControllerMpd::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::servicePushState
Apr 11 15:24:39 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:24:39 volumio volumio[1242]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5518/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 11 15:24:39 volumio volumio[1242]: verbose: CURRENT POSITION 0
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::syncState stateService play
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::syncState currentStatus play
Apr 11 15:24:39 volumio volumio[1242]: info: Received an update from plugin. extracting info from payload
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::volumioPushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::volumioPushState
Apr 11 15:24:39 volumio volumio[1242]: info: ------------------------------ 52ms
Apr 11 15:24:39 volumio volumio[1242]: info: ------------------------------ 76ms
Apr 11 15:24:39 volumio volumio[1242]: info: ------------------------------ 76ms
Apr 11 15:24:39 volumio volumio[1242]: info: ------------------------------ 75ms
Apr 11 15:24:39 volumio volumio[1242]: info:
Apr 11 15:24:39 volumio volumio[1242]: ---------------------------- MPD announces system playlist update
Apr 11 15:24:39 volumio volumio[1242]: info: Ignoring MPD Status Update
Apr 11 15:24:39 volumio volumio[1242]: info:
Apr 11 15:24:39 volumio volumio[1242]: ---------------------------- MPD announces state update: player
Apr 11 15:24:39 volumio volumio[1242]: info: sendMpdCommand playlistinfo took 66 milliseconds
Apr 11 15:24:39 volumio volumio[1242]: info: sendMpdCommand playlistinfo took 67 milliseconds
Apr 11 15:24:39 volumio volumio[1242]: info: ControllerMpd::getState
Apr 11 15:24:39 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 15:24:39 volumio volumio[1242]: verbose: ControllerMpd::parseTrackInfo
Apr 11 15:24:39 volumio volumio[1242]: verbose: ControllerMpd::parseTrackInfo
Apr 11 15:24:39 volumio volumio[1242]: info: ControllerMpd::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::servicePushState
Apr 11 15:24:39 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:24:39 volumio volumio[1242]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5518/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 11 15:24:39 volumio volumio[1242]: verbose: CURRENT POSITION 0
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::syncState stateService play
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::syncState currentStatus play
Apr 11 15:24:39 volumio volumio[1242]: info: Received an update from plugin. extracting info from payload
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::volumioPushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::volumioPushState
Apr 11 15:24:39 volumio volumio[1242]: info: ControllerMpd::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::servicePushState
Apr 11 15:24:39 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:24:39 volumio volumio[1242]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5518/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 11 15:24:39 volumio volumio[1242]: verbose: CURRENT POSITION 0
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::syncState stateService play
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::syncState currentStatus play
Apr 11 15:24:39 volumio volumio[1242]: info: Received an update from plugin. extracting info from payload
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::volumioPushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::volumioPushState
Apr 11 15:24:39 volumio volumio[1242]: info: ------------------------------ 130ms
Apr 11 15:24:39 volumio volumio[1242]: info: ------------------------------ 130ms
Apr 11 15:24:39 volumio volumio[1242]: info:
Apr 11 15:24:39 volumio volumio[1242]: ---------------------------- MPD announces system playlist update
Apr 11 15:24:39 volumio volumio[1242]: info: Ignoring MPD Status Update
Apr 11 15:24:39 volumio volumio[1242]: info:
Apr 11 15:24:39 volumio volumio[1242]: ---------------------------- MPD announces state update: player
Apr 11 15:24:39 volumio volumio[1242]: info: ControllerMpd::getState
Apr 11 15:24:39 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 15:24:39 volumio volumio[1242]: info:
Apr 11 15:24:39 volumio volumio[1242]: ---------------------------- MPD announces system playlist update
Apr 11 15:24:39 volumio volumio[1242]: info: Ignoring MPD Status Update
Apr 11 15:24:39 volumio volumio[1242]: info:
Apr 11 15:24:39 volumio volumio[1242]: ---------------------------- MPD announces state update: player
Apr 11 15:24:39 volumio volumio[1242]: info: ControllerMpd::getState
Apr 11 15:24:39 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 15:24:39 volumio volumio[1242]: info: ------------------------------ 125ms
Apr 11 15:24:39 volumio volumio[1242]: info: sendMpdCommand status took 119 milliseconds
Apr 11 15:24:39 volumio volumio[1242]: info: ------------------------------ 69ms
Apr 11 15:24:39 volumio volumio[1242]: info: sendMpdCommand status took 65 milliseconds
Apr 11 15:24:39 volumio volumio[1242]: info: ------------------------------ 64ms
Apr 11 15:24:39 volumio volumio[1242]: info: sendMpdCommand status took 55 milliseconds
Apr 11 15:24:39 volumio volumio[1242]: verbose: ControllerMpd::parseState
Apr 11 15:24:39 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 15:24:39 volumio volumio[1242]: verbose: ControllerMpd::parseState
Apr 11 15:24:39 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 15:24:39 volumio volumio[1242]: verbose: ControllerMpd::parseState
Apr 11 15:24:39 volumio volumio[1242]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 15:24:39 volumio volumio[1242]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 11 15:24:39 volumio volumio[1242]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 11 15:24:39 volumio volumio[1242]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 11 15:24:39 volumio volumio[1242]: verbose: ControllerMpd::parseTrackInfo
Apr 11 15:24:39 volumio volumio[1242]: verbose: ControllerMpd::parseTrackInfo
Apr 11 15:24:39 volumio volumio[1242]: verbose: ControllerMpd::parseTrackInfo
Apr 11 15:24:39 volumio volumio[1242]: info: ControllerMpd::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::servicePushState
Apr 11 15:24:39 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:24:39 volumio volumio[1242]: verbose: STATE SERVICE {"status":"play","position":0,"seek":866,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 11 15:24:39 volumio volumio[1242]: verbose: CURRENT POSITION 0
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::syncState stateService play
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::syncState currentStatus play
Apr 11 15:24:39 volumio volumio[1242]: info: Received an update from plugin. extracting info from payload
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::volumioPushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::volumioPushState
Apr 11 15:24:39 volumio volumio[1242]: info: ControllerMpd::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::servicePushState
Apr 11 15:24:39 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:24:39 volumio volumio[1242]: verbose: STATE SERVICE {"status":"play","position":0,"seek":974,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 11 15:24:39 volumio volumio[1242]: verbose: CURRENT POSITION 0
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::syncState stateService play
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::syncState currentStatus play
Apr 11 15:24:39 volumio volumio[1242]: info: Received an update from plugin. extracting info from payload
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::volumioPushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::volumioPushState
Apr 11 15:24:39 volumio volumio[1242]: info: ControllerMpd::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::servicePushState
Apr 11 15:24:39 volumio volumio[1242]: info: CorePlayQueue::getTrack 0
Apr 11 15:24:39 volumio volumio[1242]: verbose: STATE SERVICE {"status":"play","position":0,"seek":974,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 11 15:24:39 volumio volumio[1242]: verbose: CURRENT POSITION 0
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::syncState stateService play
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::syncState currentStatus play
Apr 11 15:24:39 volumio volumio[1242]: info: Received an update from plugin. extracting info from payload
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::volumioPushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreStateMachine::pushState
Apr 11 15:24:39 volumio volumio[1242]: info: CoreCommandRouter::volumioPushState
Apr 11 15:24:39 volumio volumio[1242]: info: ------------------------------ 192ms
Apr 11 15:24:39 volumio volumio[1242]: info: ------------------------------ 137ms
Apr 11 15:24:39 volumio volumio[1242]: info: ------------------------------ 126ms
Apr 11 15:24:39 volumio volumio[1242]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 15:24:39 volumio volumio[1242]: TypeError: Cannot read properties of null (reading 'slice')
Apr 11 15:24:39 volumio volumio[1242]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41)
Apr 11 15:24:39 volumio volumio[1242]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7)
Apr 11 15:24:39 volumio volumio[1242]: at Object.onceWrapper (node:events:629:26)
Apr 11 15:24:39 volumio volumio[1242]: at ClientRequest.emit (node:events:514:28)
Apr 11 15:24:39 volumio volumio[1242]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27)
Apr 11 15:24:39 volumio volumio[1242]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17)
Apr 11 15:24:39 volumio volumio[1242]: at TLSSocket.socketOnData (node:_http_client:535:22)
Apr 11 15:24:39 volumio volumio[1242]: at TLSSocket.emit (node:events:514:28)
Apr 11 15:24:39 volumio volumio[1242]: at addChunk (node:internal/streams/readable:343:12)
Apr 11 15:24:39 volumio volumio[1242]: at readableAddChunk (node:internal/streams/readable:316:9)
Apr 11 15:24:39 volumio volumio[1242]: at Readable.push (node:internal/streams/readable:253:10)
Apr 11 15:24:39 volumio volumio[1242]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23)
Apr 11 15:24:39 volumio volumio[1242]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 15:24:40 volumio sudo[8725]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-11 15:23'
Apr 11 15:24:40 volumio sudo[8725]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026"
VOLUMIO_VERSION="4.119"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"