Oct 14 10:08:02 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:02.963-07:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.140:42372 Oct 14 10:08:02 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:02.992-07:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.1.140:42372 @ 0x3000510" latency=560.200957ms platform=PLATFORM_ANDROID version=6.260930.0 Oct 14 10:08:02 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:02.992-07:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.1.140:42372 @ 0x3000510" latency=558.707636ms timeout=20s included=[] excluded=[] Oct 14 10:08:02 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:02.992-07:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" Oct 14 10:08:02 volumio volumio[1229]: info: Received Get System Info Oct 14 10:08:02 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 14 10:08:02 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 14 10:08:02 volumio volumio[1229]: info: Discovery: Getting this device information Oct 14 10:08:02 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 14 10:08:02 volumio volumio[1229]: info: CorePlayQueue::getTrack 2 Oct 14 10:08:02 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 14 10:08:02 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:02.995-07:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" name=Volumio Oct 14 10:08:02 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:02.996-07:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" language=en Oct 14 10:08:02 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Oct 14 10:08:02 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:02.997-07:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" timezone=America/Los_Angeles Oct 14 10:08:02 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:02.998-07:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" available=true connected=true macAddress=e4:5f:01:c2:22:c1 ip4Address=192.168.1.75/24 ip6Address= Oct 14 10:08:03 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:03.000-07:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Oct 14 10:08:03 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:03.000-07:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" setupComplete=true Oct 14 10:08:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Oct 14 10:08:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 14 10:08:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 10:08:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 14 10:08:03 volumio volumio[1229]: amixer -c 0 info | grep "bcm2835 ALSA" Oct 14 10:08:03 volumio volumio[1229]: amixer -c 1 info | grep "bcm2835 Headphones" Oct 14 10:08:03 volumio volumio[1229]: Card sysdefault:1 'Headphones'/'bcm2835 Headphones' Oct 14 10:08:03 volumio volumio[1229]: amixer -c 2 info | grep "Allo DigiOne" Oct 14 10:08:03 volumio volumio[1229]: amixer -c 2 info | grep "snd_allo_digione" Oct 14 10:08:03 volumio volumio[1229]: Card sysdefault:2 'sndallodigione'/'snd_allo_digione' Oct 14 10:08:03 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:03.176-07:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" selectedOutputId=2 Oct 14 10:08:03 volumio volumio[1229]: info: Received Get System Info Oct 14 10:08:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 14 10:08:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 14 10:08:03 volumio volumio[1229]: info: Discovery: Getting this device information Oct 14 10:08:03 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 14 10:08:03 volumio volumio[1229]: info: CorePlayQueue::getTrack 2 Oct 14 10:08:03 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 14 10:08:03 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:03.189-07:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" currentVersion=4.204 latestVersion=4.204 Oct 14 10:08:03 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:03.190-07:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.1.140:42372 @ 0x3000510" status=UPDATE_STATUS_NONE progress=0 Oct 14 10:08:03 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:03.190-07:00 level=INFO msg="emitting user changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" userId= Oct 14 10:08:03 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:03.190-07:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" providers=3 Oct 14 10:08:03 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:03.190-07:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" plugins=87 Oct 14 10:08:03 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 14 10:08:03 volumio volumio[1229]: info: CorePlayQueue::getTrack 2 Oct 14 10:08:03 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:03.193-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" state=STATUS_PLAYING positionMs=113954 volume=100 Oct 14 10:08:03 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:03.193-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" id="mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/03. psychofreak.flac" title="3 - psychofreak" Oct 14 10:08:06 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:06.489-07:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.1.140:42372 @ 0x3000510" latency=547.221617ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Oct 14 10:08:06 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:06.540-07:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.140:42372 @ 0x3000510" latency=543.496554ms timeout=10s Oct 14 10:08:06 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:06.791-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.140:42372 @ 0x3000510" latency=543.496554ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=251.070855ms Oct 14 10:08:06 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:06.933-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.140:42372 @ 0x3000510" latency=543.496554ms timeout=10s endpoint=https://securetoken.googleapis.com duration=390.258897ms Oct 14 10:08:07 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:07.025-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.140:42372 @ 0x3000510" latency=543.496554ms timeout=10s endpoint=https://google.com duration=484.469594ms Oct 14 10:08:07 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:07.026-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.140:42372 @ 0x3000510" latency=543.496554ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=484.080266ms Oct 14 10:08:07 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:07.037-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.140:42372 @ 0x3000510" latency=543.496554ms timeout=10s endpoint=https://www.googleapis.com duration=495.164789ms Oct 14 10:08:07 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:07.075-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.140:42372 @ 0x3000510" latency=543.496554ms timeout=10s endpoint=http://pushupdates.volumio.org duration=533.74091ms Oct 14 10:08:07 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:07.124-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.140:42372 @ 0x3000510" latency=543.496554ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=581.487983ms Oct 14 10:08:07 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:07.143-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.140:42372 @ 0x3000510" latency=543.496554ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=602.530042ms Oct 14 10:08:07 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:07.183-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.140:42372 @ 0x3000510" latency=543.496554ms timeout=10s endpoint=http://plugins.volumio.org duration=640.941535ms Oct 14 10:08:07 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:07.416-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.140:42372 @ 0x3000510" latency=543.496554ms timeout=10s endpoint=https://functions.volumio.cloud duration=873.553746ms Oct 14 10:08:07 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:07.416-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.140:42372 @ 0x3000510" latency=543.496554ms timeout=10s endpoint=https://functions.volumio.cloud duration=874.62066ms Oct 14 10:08:07 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:07.600-07:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.140:42372 @ 0x3000510" latency=543.496554ms timeout=10s endpoint=https://database.volumio.cloud duration=1.058314738s Oct 14 10:08:08 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:08.111-07:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.140:42372 @ 0x3000510" latency=543.496554ms timeout=10s endpoint=http://cddb.volumio.org duration=1.569587734s error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 14 10:08:08 volumio sudo[14491]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 14 10:08:08 volumio sudo[14491]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 10:08:08 volumio sudo[14491]: pam_unix(sudo:session): session closed for user root Oct 14 10:08:08 volumio sudo[14493]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 14 10:08:08 volumio sudo[14493]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 10:08:08 volumio sudo[14493]: pam_unix(sudo:session): session closed for user root Oct 14 10:08:08 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.140 UA: Mozilla/5.0 (Linux; Android 14; SM-A526U1 Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/154.0.8037.107 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 7 Oct 14 10:08:08 volumio sudo[14497]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 14 10:08:08 volumio sudo[14497]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 10:08:08 volumio sudo[14497]: pam_unix(sudo:session): session closed for user root Oct 14 10:08:08 volumio sudo[14499]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 14 10:08:08 volumio sudo[14499]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 10:08:08 volumio sudo[14499]: pam_unix(sudo:session): session closed for user root Oct 14 10:08:08 volumio volumio[1229]: verbose: New Socket.io Connection to 192.168.1.75 from 192.168.1.140 UA: Mozilla/5.0 (Linux; Android 14; SM-A526U1 Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/154.0.8037.107 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 8 Oct 14 10:08:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 14 10:08:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 14 10:08:09 volumio volumio[1229]: info: CoreCommandRouter::volumioGetVisibleSources Oct 14 10:08:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 10:08:09 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 14 10:08:09 volumio volumio[1229]: info: CorePlayQueue::getTrack 2 Oct 14 10:08:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 14 10:08:09 volumio volumio[1229]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:08:09 volumio volumio[1229]: info: CoreStateMachine::getQueue Oct 14 10:08:09 volumio volumio[1229]: info: CorePlayQueue::getQueue Oct 14 10:08:09 volumio volumio[1229]: info: Listing playlists Oct 14 10:08:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 14 10:08:09 volumio volumio[1229]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 14 10:08:09 volumio volumio[1229]: info: Received Get System Info Oct 14 10:08:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 14 10:08:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 14 10:08:09 volumio volumio[1229]: info: Discovery: Getting this device information Oct 14 10:08:09 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 14 10:08:09 volumio volumio[1229]: info: CorePlayQueue::getTrack 2 Oct 14 10:08:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 14 10:08:09 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 14 10:08:09 volumio volumio[1229]: info: CorePlayQueue::getTrack 2 Oct 14 10:08:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 14 10:08:09 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 14 10:08:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 14 10:08:10 volumio volumio[1229]: info: Received Get System Info Oct 14 10:08:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 14 10:08:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 14 10:08:10 volumio volumio[1229]: info: Discovery: Getting this device information Oct 14 10:08:10 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 14 10:08:10 volumio volumio[1229]: info: CorePlayQueue::getTrack 2 Oct 14 10:08:10 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 14 10:08:11 volumio volumio[1229]: info: Preload queue cleared Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::ClearQueue Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::stop Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::stPlaybackTimer Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::updateTrackBlock Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::getTrackBlock Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::getTrack 2 Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::serviceStop Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::getTrack 2 Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::serviceStop Oct 14 10:08:11 volumio volumio[1229]: info: ControllerMpd::stop Oct 14 10:08:11 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand stop Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::clearPlayQueue Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::saveQueue Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::volumioPushQueue Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::addQueueItems Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::addQueueItems Oct 14 10:08:11 volumio volumio[1229]: info: Preload queue cleared Oct 14 10:08:11 volumio volumio[1229]: info: Adding Item to queue: music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac Oct 14 10:08:11 volumio volumio[1229]: info: Exploding uri music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac in service mpd Oct 14 10:08:11 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:11.319-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" state=STATUS_STOPPED positionMs=0 volume=100 Oct 14 10:08:11 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:11.320-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" id="mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/03. psychofreak.flac" title="3 - psychofreak" Oct 14 10:08:11 volumio volumio[1229]: info: sendMpdCommand stop took 12 milliseconds Oct 14 10:08:11 volumio volumio[1229]: info: Oct 14 10:08:11 volumio volumio[1229]: ---------------------------- MPD announces state update: player Oct 14 10:08:11 volumio volumio[1229]: info: ALBUMART /albumart?cacheid=248&web=Camila%20Cabello/Familia/extralarge&path=%2Fmnt%2FNAS%2FMusic2%2F04.%20Rocks%20%26%20Pop%2FCamila%20Cabello%2F(2002)%20Familia%2F01.%20Familia.flac&metadata=false Oct 14 10:08:11 volumio volumio[1229]: info: URI /mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac Oct 14 10:08:11 volumio volumio[1229]: info: ControllerMpd::getState Oct 14 10:08:11 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::volumioPushQueue Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::saveQueue Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::updateTrackBlock Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::getTrackBlock Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::volumioPlay Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::play index 0 Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::addQueueItems Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::addQueueItems Oct 14 10:08:11 volumio volumio[1229]: info: Preload queue cleared Oct 14 10:08:11 volumio volumio[1229]: info: Adding Item to queue: music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/02. Celia.flac Oct 14 10:08:11 volumio volumio[1229]: info: Exploding uri music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/02. Celia.flac in service mpd Oct 14 10:08:11 volumio volumio[1229]: info: Adding Item to queue: music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/03. psychofreak.flac Oct 14 10:08:11 volumio volumio[1229]: info: Exploding uri music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/03. psychofreak.flac in service mpd Oct 14 10:08:11 volumio volumio[1229]: info: Adding Item to queue: music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/04. Bam Bam.flac Oct 14 10:08:11 volumio volumio[1229]: info: Exploding uri music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/04. Bam Bam.flac in service mpd Oct 14 10:08:11 volumio volumio[1229]: info: Adding Item to queue: music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/05. La Buena Vida.flac Oct 14 10:08:11 volumio volumio[1229]: info: Exploding uri music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/05. La Buena Vida.flac in service mpd Oct 14 10:08:11 volumio volumio[1229]: info: Adding Item to queue: music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/06. Quiet.flac Oct 14 10:08:11 volumio volumio[1229]: info: Exploding uri music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/06. Quiet.flac in service mpd Oct 14 10:08:11 volumio volumio[1229]: info: Adding Item to queue: music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/07. Boys Don't Cry.flac Oct 14 10:08:11 volumio volumio[1229]: info: Exploding uri music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/07. Boys Don't Cry.flac in service mpd Oct 14 10:08:11 volumio volumio[1229]: info: Adding Item to queue: music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/08. Hasta Los Dientes.flac Oct 14 10:08:11 volumio volumio[1229]: info: Exploding uri music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/08. Hasta Los Dientes.flac in service mpd Oct 14 10:08:11 volumio volumio[1229]: info: Adding Item to queue: music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/09. No Doubt.flac Oct 14 10:08:11 volumio volumio[1229]: info: Exploding uri music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/09. No Doubt.flac in service mpd Oct 14 10:08:11 volumio volumio[1229]: info: Adding Item to queue: music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/10. Don't Go Yet.flac Oct 14 10:08:11 volumio volumio[1229]: info: Exploding uri music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/10. Don't Go Yet.flac in service mpd Oct 14 10:08:11 volumio volumio[1229]: info: Adding Item to queue: music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/11. Lola.flac Oct 14 10:08:11 volumio volumio[1229]: info: Exploding uri music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/11. Lola.flac in service mpd Oct 14 10:08:11 volumio volumio[1229]: info: Adding Item to queue: music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/12. everyone at this party.flac Oct 14 10:08:11 volumio volumio[1229]: info: Exploding uri music-library/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/12. everyone at this party.flac in service mpd Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::stop Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::play index undefined Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::startPlaybackTimer Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::volumioGetVisibleSources Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 14 10:08:11 volumio volumio[1229]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac Oct 14 10:08:11 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand stop Oct 14 10:08:11 volumio volumio[1229]: info: ALBUMART /albumart?cacheid=248&web=Camila%20Cabello/Familia/extralarge&path=%2Fmnt%2FNAS%2FMusic2%2F04.%20Rocks%20%26%20Pop%2FCamila%20Cabello%2F(2002)%20Familia%2F02.%20Celia.flac&metadata=false Oct 14 10:08:11 volumio volumio[1229]: info: URI /mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/02. Celia.flac Oct 14 10:08:11 volumio volumio[1229]: info: ALBUMART /albumart?cacheid=248&web=Camila%20Cabello/Familia/extralarge&path=%2Fmnt%2FNAS%2FMusic2%2F04.%20Rocks%20%26%20Pop%2FCamila%20Cabello%2F(2002)%20Familia%2F03.%20psychofreak.flac&metadata=false Oct 14 10:08:11 volumio volumio[1229]: info: URI /mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/03. psychofreak.flac Oct 14 10:08:11 volumio volumio[1229]: info: ALBUMART /albumart?cacheid=248&web=Camila%20Cabello/Familia/extralarge&path=%2Fmnt%2FNAS%2FMusic2%2F04.%20Rocks%20%26%20Pop%2FCamila%20Cabello%2F(2002)%20Familia%2F04.%20Bam%20Bam.flac&metadata=false Oct 14 10:08:11 volumio volumio[1229]: info: URI /mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/04. Bam Bam.flac Oct 14 10:08:11 volumio volumio[1229]: info: ALBUMART /albumart?cacheid=248&web=Camila%20Cabello/Familia/extralarge&path=%2Fmnt%2FNAS%2FMusic2%2F04.%20Rocks%20%26%20Pop%2FCamila%20Cabello%2F(2002)%20Familia%2F05.%20La%20Buena%20Vida.flac&metadata=false Oct 14 10:08:11 volumio volumio[1229]: info: URI /mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/05. La Buena Vida.flac Oct 14 10:08:11 volumio volumio[1229]: info: ALBUMART /albumart?cacheid=248&web=Camila%20Cabello/Familia/extralarge&path=%2Fmnt%2FNAS%2FMusic2%2F04.%20Rocks%20%26%20Pop%2FCamila%20Cabello%2F(2002)%20Familia%2F06.%20Quiet.flac&metadata=false Oct 14 10:08:11 volumio volumio[1229]: info: URI /mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/06. Quiet.flac Oct 14 10:08:11 volumio volumio[1229]: info: ALBUMART /albumart?cacheid=248&web=Camila%20Cabello/Familia/extralarge&path=%2Fmnt%2FNAS%2FMusic2%2F04.%20Rocks%20%26%20Pop%2FCamila%20Cabello%2F(2002)%20Familia%2F07.%20Boys%20Don't%20Cry.flac&metadata=false Oct 14 10:08:11 volumio volumio[1229]: info: URI /mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/07. Boys Don't Cry.flac Oct 14 10:08:11 volumio volumio[1229]: info: ALBUMART /albumart?cacheid=248&web=Camila%20Cabello/Familia/extralarge&path=%2Fmnt%2FNAS%2FMusic2%2F04.%20Rocks%20%26%20Pop%2FCamila%20Cabello%2F(2002)%20Familia%2F08.%20Hasta%20Los%20Dientes.flac&metadata=false Oct 14 10:08:11 volumio volumio[1229]: info: URI /mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/08. Hasta Los Dientes.flac Oct 14 10:08:11 volumio volumio[1229]: info: ALBUMART /albumart?cacheid=248&web=Camila%20Cabello/Familia/extralarge&path=%2Fmnt%2FNAS%2FMusic2%2F04.%20Rocks%20%26%20Pop%2FCamila%20Cabello%2F(2002)%20Familia%2F09.%20No%20Doubt.flac&metadata=false Oct 14 10:08:11 volumio volumio[1229]: info: URI /mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/09. No Doubt.flac Oct 14 10:08:11 volumio volumio[1229]: info: ALBUMART /albumart?cacheid=248&web=Camila%20Cabello/Familia/extralarge&path=%2Fmnt%2FNAS%2FMusic2%2F04.%20Rocks%20%26%20Pop%2FCamila%20Cabello%2F(2002)%20Familia%2F10.%20Don't%20Go%20Yet.flac&metadata=false Oct 14 10:08:11 volumio volumio[1229]: info: URI /mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/10. Don't Go Yet.flac Oct 14 10:08:11 volumio volumio[1229]: info: ALBUMART /albumart?cacheid=248&web=Camila%20Cabello/Familia/extralarge&path=%2Fmnt%2FNAS%2FMusic2%2F04.%20Rocks%20%26%20Pop%2FCamila%20Cabello%2F(2002)%20Familia%2F11.%20Lola.flac&metadata=false Oct 14 10:08:11 volumio volumio[1229]: info: URI /mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/11. Lola.flac Oct 14 10:08:11 volumio volumio[1229]: info: ALBUMART /albumart?cacheid=248&web=Camila%20Cabello/Familia/extralarge&path=%2Fmnt%2FNAS%2FMusic2%2F04.%20Rocks%20%26%20Pop%2FCamila%20Cabello%2F(2002)%20Familia%2F12.%20everyone%20at%20this%20party.flac&metadata=false Oct 14 10:08:11 volumio volumio[1229]: info: URI /mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/12. everyone at this party.flac Oct 14 10:08:11 volumio volumio[1229]: info: sendMpdCommand status took 156 milliseconds Oct 14 10:08:11 volumio volumio[1229]: info: sendMpdCommand stop took 3 milliseconds Oct 14 10:08:11 volumio volumio[1229]: verbose: ControllerMpd::parseState Oct 14 10:08:11 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:08:11 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand clear Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::volumioPushQueue Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::saveQueue Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::updateTrackBlock Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::getTrackBlock Oct 14 10:08:11 volumio volumio[1229]: info: Oct 14 10:08:11 volumio volumio[1229]: ---------------------------- MPD announces system playlist update Oct 14 10:08:11 volumio volumio[1229]: info: Ignoring MPD Status Update Oct 14 10:08:11 volumio volumio[1229]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 14 10:08:11 volumio volumio[1229]: info: sendMpdCommand clear took 8 milliseconds Oct 14 10:08:11 volumio volumio[1229]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:08:11 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac" Oct 14 10:08:11 volumio volumio[1229]: info: ControllerMpd::pushState Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::servicePushState Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:11 volumio volumio[1229]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"psychofreak","artist":"Camila Cabello","album":"Familia","uri":"NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/03. psychofreak.flac","trackType":"flac"} Oct 14 10:08:11 volumio volumio[1229]: verbose: CURRENT POSITION 0 Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::syncState stateService stop Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::syncState currentStatus stop Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 14 10:08:11 volumio volumio[1229]: info: No code Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 14 10:08:11 volumio volumio[1229]: info: ------------------------------ 174ms Oct 14 10:08:11 volumio volumio[1229]: error: updateQueue error: null Oct 14 10:08:11 volumio volumio[1229]: info: Oct 14 10:08:11 volumio volumio[1229]: ---------------------------- MPD announces system playlist update Oct 14 10:08:11 volumio volumio[1229]: info: Ignoring MPD Status Update Oct 14 10:08:11 volumio volumio[1229]: info: ------------------------------ 14ms Oct 14 10:08:11 volumio volumio[1229]: info: sendMpdCommand add "NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac" took 13 milliseconds Oct 14 10:08:11 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand play Oct 14 10:08:11 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:11.509-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" state=STATUS_STOPPED positionMs=0 volume=100 Oct 14 10:08:11 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:11.509-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" id="mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac" title="1 - Familia" Oct 14 10:08:11 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:11.510-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" state=STATUS_STOPPED positionMs=0 volume=100 Oct 14 10:08:11 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:11.511-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" id="mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac" title="1 - Familia" Oct 14 10:08:11 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:11.511-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" state=STATUS_STOPPED positionMs=0 volume=100 Oct 14 10:08:11 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:11.511-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" id="mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac" title="1 - Familia" Oct 14 10:08:11 volumio volumio[1229]: info: ------------------------------ 7ms Oct 14 10:08:11 volumio volumio[1229]: info: sendMpdCommand play took 7 milliseconds Oct 14 10:08:11 volumio volumio[1229]: info: Oct 14 10:08:11 volumio volumio[1229]: ---------------------------- MPD announces state update: player Oct 14 10:08:11 volumio volumio[1229]: info: ControllerMpd::getState Oct 14 10:08:11 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:08:11 volumio volumio[1229]: info: Oct 14 10:08:11 volumio volumio[1229]: ---------------------------- MPD announces state update: player Oct 14 10:08:11 volumio volumio[1229]: info: sendMpdCommand status took 3 milliseconds Oct 14 10:08:11 volumio volumio[1229]: info: ControllerMpd::getState Oct 14 10:08:11 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:08:11 volumio volumio[1229]: verbose: ControllerMpd::parseState Oct 14 10:08:11 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:08:11 volumio volumio[1229]: info: sendMpdCommand status took 1 milliseconds Oct 14 10:08:11 volumio volumio[1229]: verbose: ControllerMpd::parseState Oct 14 10:08:11 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:08:11 volumio volumio[1229]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 14 10:08:11 volumio volumio[1229]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 14 10:08:11 volumio volumio[1229]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:08:11 volumio volumio[1229]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:08:11 volumio volumio[1229]: info: ControllerMpd::pushState Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::servicePushState Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:11 volumio volumio[1229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":18,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Familia","artist":"Camila Cabello","album":"Familia","uri":"NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac","trackType":"flac"} Oct 14 10:08:11 volumio volumio[1229]: verbose: CURRENT POSITION 0 Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::syncState stateService play Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::syncState currentStatus stop Oct 14 10:08:11 volumio volumio[1229]: info: ControllerMpd::pushState Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::servicePushState Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:11 volumio volumio[1229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":18,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Familia","artist":"Camila Cabello","album":"Familia","uri":"NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac","trackType":"flac"} Oct 14 10:08:11 volumio volumio[1229]: verbose: CURRENT POSITION 0 Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::syncState stateService play Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:08:11 volumio volumio[1229]: info: Received an update from plugin. extracting info from payload Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:11 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:11.536-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" state=STATUS_PLAYING positionMs=0 volume=100 Oct 14 10:08:11 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:11.536-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" id="mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac" title="1 - Familia" Oct 14 10:08:11 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:11.536-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" state=STATUS_PLAYING positionMs=0 volume=100 Oct 14 10:08:11 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:11.537-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" id="mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac" title="1 - Familia" Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 14 10:08:11 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 14 10:08:11 volumio volumio[1229]: info: ------------------------------ 10ms Oct 14 10:08:11 volumio volumio[1229]: info: ------------------------------ 10ms Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 14 10:08:11 volumio volumio[1229]: info: Received Get System Info Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 14 10:08:11 volumio volumio[1229]: info: Discovery: Getting this device information Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 14 10:08:11 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:11 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 14 10:08:18 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 14 10:08:20 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: metavolumio , setInfinityPlayback Oct 14 10:08:20 volumio volumio[1229]: info: METAVOLUMIO: Enabling Infinity Playback Oct 14 10:08:20 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 14 10:08:20 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:20 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 14 10:08:20 volumio volumio[1229]: info: CoreCommandRouter::volumioRandom Oct 14 10:08:20 volumio volumio[1229]: info: CoreCommandRouter::writePlayerControls Oct 14 10:08:20 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:20 volumio volumio[1229]: info: CoreStateMachine::setRepeat false single false Oct 14 10:08:20 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 14 10:08:20 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:20 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:08:20 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 14 10:08:20 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:20.714-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" state=STATUS_PLAYING positionMs=9003 volume=100 Oct 14 10:08:20 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:20.714-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" id="mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac" title="1 - Familia" Oct 14 10:08:21 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: metavolumio , setInfinityPlayback Oct 14 10:08:21 volumio volumio[1229]: info: METAVOLUMIO: Disabling Infinity Playback Oct 14 10:08:21 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 14 10:08:21 volumio volumio[1229]: info: CoreCommandRouter::volumioRandom Oct 14 10:08:21 volumio volumio[1229]: info: CoreCommandRouter::writePlayerControls Oct 14 10:08:21 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:21 volumio volumio[1229]: info: CoreStateMachine::setRepeat false single false Oct 14 10:08:21 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 14 10:08:21 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:21 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:08:21 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 14 10:08:21 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:21.804-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" state=STATUS_PLAYING positionMs=10253 volume=100 Oct 14 10:08:21 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:21.805-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" id="mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac" title="1 - Familia" Oct 14 10:08:22 volumio volumio[1229]: info: CoreCommandRouter::volumioRandom Oct 14 10:08:22 volumio volumio[1229]: info: CoreCommandRouter::writePlayerControls Oct 14 10:08:22 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:22 volumio volumio[1229]: info: CoreStateMachine::setRandom false Oct 14 10:08:22 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 14 10:08:22 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:22 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:08:22 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 14 10:08:22 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:22.393-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" state=STATUS_PLAYING positionMs=10754 volume=100 Oct 14 10:08:22 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:22.393-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" id="mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac" title="1 - Familia" Oct 14 10:08:24 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:24 volumio volumio[1229]: info: CorePlayQueue::getTrack 1 Oct 14 10:08:24 volumio volumio[1229]: info: Prefetching next song Oct 14 10:08:24 volumio volumio[1229]: info: DOING PREFETCH IN MPD Oct 14 10:08:24 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/02. Celia.flac" Oct 14 10:08:24 volumio volumio[1229]: info: sendMpdCommand add "NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/02. Celia.flac" took 0 milliseconds Oct 14 10:08:24 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 14 10:08:24 volumio volumio[1229]: info: Oct 14 10:08:24 volumio volumio[1229]: ---------------------------- MPD announces system playlist update Oct 14 10:08:24 volumio volumio[1229]: info: Ignoring MPD Status Update Oct 14 10:08:24 volumio volumio[1229]: info: sendMpdCommand consume 1 took 1 milliseconds Oct 14 10:08:24 volumio volumio[1229]: info: ------------------------------ 1ms Oct 14 10:08:25 volumio volumio[1229]: info: CoreCommandRouter::volumioRandom Oct 14 10:08:25 volumio volumio[1229]: info: CoreCommandRouter::writePlayerControls Oct 14 10:08:25 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:25 volumio volumio[1229]: info: CoreStateMachine::setRepeat true single false Oct 14 10:08:25 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 14 10:08:25 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:25 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:08:25 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 14 10:08:25 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:25.937-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" state=STATUS_PLAYING positionMs=14255 volume=100 Oct 14 10:08:25 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:25.937-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" id="mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac" title="1 - Familia" Oct 14 10:08:26 volumio volumio[1229]: info: CoreCommandRouter::volumioRandom Oct 14 10:08:26 volumio volumio[1229]: info: CoreCommandRouter::writePlayerControls Oct 14 10:08:26 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:26 volumio volumio[1229]: info: CoreStateMachine::setRandom true Oct 14 10:08:26 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 14 10:08:26 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:26 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:08:26 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 14 10:08:26 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:26.305-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" state=STATUS_PLAYING positionMs=14756 volume=100 Oct 14 10:08:26 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:26.306-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" id="mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac" title="1 - Familia" Oct 14 10:08:27 volumio volumio[1229]: info: CoreCommandRouter::volumioRandom Oct 14 10:08:27 volumio volumio[1229]: info: CoreCommandRouter::writePlayerControls Oct 14 10:08:27 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:27 volumio volumio[1229]: info: CoreStateMachine::setRepeat true single true Oct 14 10:08:27 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 14 10:08:27 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:27 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:08:27 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 14 10:08:27 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:27.307-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" state=STATUS_PLAYING positionMs=15754 volume=100 Oct 14 10:08:27 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:27.307-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" id="mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac" title="1 - Familia" Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: metavolumio , setInfinityPlayback Oct 14 10:08:28 volumio volumio[1229]: info: METAVOLUMIO: Enabling Infinity Playback Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 14 10:08:28 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::volumioRandom Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::writePlayerControls Oct 14 10:08:28 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:28 volumio volumio[1229]: info: CoreStateMachine::setRepeat false single false Oct 14 10:08:28 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 14 10:08:28 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 14 10:08:28 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:28.034-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" state=STATUS_PLAYING positionMs=16504 volume=100 Oct 14 10:08:28 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:28.034-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" id="mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac" title="1 - Familia" Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 14 10:08:28 volumio volumio[1229]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 14 10:08:28 volumio volumio[1229]: info: Received Get System Version Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 14 10:08:28 volumio volumio[1229]: info: Received Get System Info Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 14 10:08:28 volumio volumio[1229]: info: Discovery: Getting this device information Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::volumioGetState Oct 14 10:08:28 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 14 10:08:28 volumio volumio[1229]: info: Oct 14 10:08:28 volumio volumio[1229]: ---------------------------- MPD announces system playlist update Oct 14 10:08:28 volumio volumio[1229]: info: Ignoring MPD Status Update Oct 14 10:08:28 volumio volumio[1229]: info: Oct 14 10:08:28 volumio volumio[1229]: ---------------------------- MPD announces state update: player Oct 14 10:08:28 volumio volumio[1229]: info: ControllerMpd::getState Oct 14 10:08:28 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:08:28 volumio volumio[1229]: info: ------------------------------ 2ms Oct 14 10:08:28 volumio volumio[1229]: info: sendMpdCommand status took 2 milliseconds Oct 14 10:08:28 volumio volumio[1229]: verbose: ControllerMpd::parseState Oct 14 10:08:28 volumio volumio[1229]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:08:28 volumio volumio[1229]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 14 10:08:28 volumio volumio[1229]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:08:28 volumio volumio[1229]: info: ControllerMpd::pushState Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::servicePushState Oct 14 10:08:28 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:28 volumio volumio[1229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":153,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1438 Kbps","isStreaming":false,"title":"Celia","artist":"Camila Cabello","album":"Familia","uri":"NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/02. Celia.flac","trackType":"flac"} Oct 14 10:08:28 volumio volumio[1229]: verbose: CURRENT POSITION 0 Oct 14 10:08:28 volumio volumio[1229]: info: CoreStateMachine::syncState stateService play Oct 14 10:08:28 volumio volumio[1229]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:08:28 volumio volumio[1229]: info: Received an update from plugin. extracting info from payload Oct 14 10:08:28 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 14 10:08:28 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 14 10:08:28 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 14 10:08:28 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 14 10:08:28 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:28.546-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" state=STATUS_PLAYING positionMs=17006 volume=100 Oct 14 10:08:28 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:28.546-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" id="mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac" title="1 - Familia" Oct 14 10:08:28 volumio volumio[1229]: info: ------------------------------ 11ms Oct 14 10:08:28 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:28.552-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" state=STATUS_PLAYING positionMs=17006 volume=100 Oct 14 10:08:28 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:28.553-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" id="mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac" title="1 - Familia" Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: metavolumio , setInfinityPlayback Oct 14 10:08:28 volumio volumio[1229]: info: METAVOLUMIO: Disabling Infinity Playback Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::volumioRandom Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::writePlayerControls Oct 14 10:08:28 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:28 volumio volumio[1229]: info: CoreStateMachine::setRepeat false single false Oct 14 10:08:28 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 14 10:08:28 volumio volumio[1229]: info: CorePlayQueue::getTrack 0 Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:08:28 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 14 10:08:28 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:28.948-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" state=STATUS_PLAYING positionMs=17255 volume=100 Oct 14 10:08:28 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:28.948-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" id="mnt/NAS/Music2/04. Rocks & Pop/Camila Cabello/(2002) Familia/01. Familia.flac" title="1 - Familia" Oct 14 10:08:29 volumio volumio[1229]: info: CoreStateMachine::startPlaybackTimer Oct 14 10:08:29 volumio volumio[1229]: info: CorePlayQueue::getTrack undefined Oct 14 10:08:29 volumio volumio[1229]: info: CoreStateMachine::pushState Oct 14 10:08:29 volumio volumio[1229]: info: CorePlayQueue::getTrack undefined Oct 14 10:08:29 volumio volumio[1229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:08:29 volumio volumio[1229]: info: CoreCommandRouter::volumioPushState Oct 14 10:08:29 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:29.575-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" state=STATUS_STOPPED positionMs=0 volume=100 Oct 14 10:08:29 volumio volumio5-onboarding[1605]: time=2026-10-14T10:08:29.575-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.140:42372 @ 0x3000510" id= title= Oct 14 10:08:42 volumio volumio[1229]: info: CorePlayQueue::getTrack undefined Oct 14 10:08:42 volumio volumio[1229]: info: CorePlayQueue::getTrack 6 Oct 14 10:08:42 volumio volumio[1229]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 10:08:42 volumio volumio[1229]: TypeError: Cannot read properties of undefined (reading 'service') Oct 14 10:08:42 volumio volumio[1229]: at CoreStateMachine.increasePlaybackTimer (/volumio/app/statemachine.js:458:107) Oct 14 10:08:42 volumio volumio[1229]: at listOnTimeout (node:internal/timers:573:17) Oct 14 10:08:42 volumio volumio[1229]: at process.processTimers (node:internal/timers:514:7) Oct 14 10:08:42 volumio volumio[1229]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 10:08:42 volumio sudo[14564]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-14 10:07' Oct 14 10:08:42 volumio sudo[14564]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="ebd772339e193fb4b3a98c68e63a0009e72d6f27" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0a52c1fb90959ba1872a2fb0225e56fe615b19ac" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Sep 14 07:39:23 UTC 2026" VOLUMIO_VERSION="4.204" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="915e71dafc26fd850574d238b4f947d5"