-- Logs begin at Thu 2019-02-14 05:11:59 EST, end at Sat 2026-08-29 15:21:08 EDT. -- Aug 29 15:20:01 volumio volumio5-onboarding[1544]: time=2026-08-29T15:20:01.013-04:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.2.23:50128 @ 0x3095080" latency=-563.726986ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Aug 29 15:20:01 volumio volumio5-onboarding[1544]: time=2026-08-29T15:20:01.030-04:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.23:50128 @ 0x3095080" latency=-569.535819ms timeout=10s Aug 29 15:20:01 volumio volumio5-onboarding[1544]: time=2026-08-29T15:20:01.049-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.23:50128 @ 0x3095080" latency=-569.535819ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=18.741706ms Aug 29 15:20:01 volumio volumio5-onboarding[1544]: time=2026-08-29T15:20:01.071-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.23:50128 @ 0x3095080" latency=-569.535819ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=40.139647ms Aug 29 15:20:01 volumio volumio5-onboarding[1544]: time=2026-08-29T15:20:01.079-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.23:50128 @ 0x3095080" latency=-569.535819ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=48.402982ms Aug 29 15:20:01 volumio volumio5-onboarding[1544]: time=2026-08-29T15:20:01.085-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.23:50128 @ 0x3095080" latency=-569.535819ms timeout=10s endpoint=https://securetoken.googleapis.com duration=53.606907ms Aug 29 15:20:01 volumio volumio5-onboarding[1544]: time=2026-08-29T15:20:01.091-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.23:50128 @ 0x3095080" latency=-569.535819ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=59.312757ms Aug 29 15:20:01 volumio volumio5-onboarding[1544]: time=2026-08-29T15:20:01.111-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.23:50128 @ 0x3095080" latency=-569.535819ms timeout=10s endpoint=https://functions.volumio.cloud duration=78.934147ms Aug 29 15:20:01 volumio volumio5-onboarding[1544]: time=2026-08-29T15:20:01.117-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.23:50128 @ 0x3095080" latency=-569.535819ms timeout=10s endpoint=https://database.volumio.cloud duration=85.42822ms Aug 29 15:20:01 volumio volumio5-onboarding[1544]: time=2026-08-29T15:20:01.123-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.23:50128 @ 0x3095080" latency=-569.535819ms timeout=10s endpoint=https://functions.volumio.cloud duration=92.356563ms Aug 29 15:20:01 volumio volumio5-onboarding[1544]: time=2026-08-29T15:20:01.141-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.23:50128 @ 0x3095080" latency=-569.535819ms timeout=10s endpoint=http://pushupdates.volumio.org duration=110.206349ms Aug 29 15:20:01 volumio volumio5-onboarding[1544]: time=2026-08-29T15:20:01.145-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.23:50128 @ 0x3095080" latency=-569.535819ms timeout=10s endpoint=https://www.googleapis.com duration=113.821743ms Aug 29 15:20:01 volumio volumio5-onboarding[1544]: time=2026-08-29T15:20:01.293-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.23:50128 @ 0x3095080" latency=-569.535819ms timeout=10s endpoint=https://google.com duration=262.629206ms Aug 29 15:20:01 volumio volumio5-onboarding[1544]: time=2026-08-29T15:20:01.543-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.23:50128 @ 0x3095080" latency=-569.535819ms timeout=10s endpoint=http://plugins.volumio.org duration=511.745214ms Aug 29 15:20:01 volumio volumio5-onboarding[1544]: time=2026-08-29T15:20:01.577-04:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.2.23:50128 @ 0x3095080" latency=-569.535819ms timeout=10s endpoint=http://cddb.volumio.org duration=546.107813ms Aug 29 15:20:02 volumio sudo[2790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 29 15:20:02 volumio sudo[2790]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:20:02 volumio sudo[2790]: pam_unix(sudo:session): session closed for user root Aug 29 15:20:02 volumio sudo[2792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 29 15:20:02 volumio sudo[2792]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:20:02 volumio sudo[2792]: pam_unix(sudo:session): session closed for user root Aug 29 15:20:02 volumio volumio[976]: verbose: New Socket.io Connection to 192.168.2.35 from 192.168.2.23 UA: Mozilla/5.0 (Linux; Android 17; Pixel 8 Build/CP2A.260805.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/151.0.7922.199 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Aug 29 15:20:02 volumio sudo[2797]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 29 15:20:02 volumio sudo[2797]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:20:02 volumio sudo[2797]: pam_unix(sudo:session): session closed for user root Aug 29 15:20:02 volumio sudo[2799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 29 15:20:02 volumio sudo[2799]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 15:20:02 volumio sudo[2799]: pam_unix(sudo:session): session closed for user root Aug 29 15:20:02 volumio volumio[976]: verbose: New Socket.io Connection to 192.168.2.35 from 192.168.2.23 UA: Mozilla/5.0 (Linux; Android 17; Pixel 8 Build/CP2A.260805.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/151.0.7922.199 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Aug 29 15:20:02 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 29 15:20:02 volumio volumio[976]: info: CoreCommandRouter::volumioGetVisibleSources Aug 29 15:20:02 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 15:20:02 volumio volumio[976]: info: CoreCommandRouter::volumioGetState Aug 29 15:20:02 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Aug 29 15:20:02 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 29 15:20:02 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 29 15:20:02 volumio volumio[976]: info: Received Get System Info Aug 29 15:20:02 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 15:20:02 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 15:20:02 volumio volumio[976]: info: Discovery: Getting this device information Aug 29 15:20:02 volumio volumio[976]: info: CoreCommandRouter::volumioGetState Aug 29 15:20:02 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Aug 29 15:20:02 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 15:20:02 volumio volumio[976]: info: CoreCommandRouter::volumioGetState Aug 29 15:20:02 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Aug 29 15:20:02 volumio volumio[976]: info: Listing playlists Aug 29 15:20:02 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 29 15:20:02 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 29 15:20:02 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 29 15:20:04 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 29 15:20:04 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 29 15:20:04 volumio volumio[976]: info: Received Get System Info Aug 29 15:20:04 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 15:20:04 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 15:20:04 volumio volumio[976]: info: Discovery: Getting this device information Aug 29 15:20:04 volumio volumio[976]: info: CoreCommandRouter::volumioGetState Aug 29 15:20:04 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Aug 29 15:20:04 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 15:20:04 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 29 15:20:04 volumio volumio[976]: info: Received Get System Info Aug 29 15:20:04 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 15:20:04 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 15:20:04 volumio volumio[976]: info: Discovery: Getting this device information Aug 29 15:20:04 volumio volumio[976]: info: CoreCommandRouter::volumioGetState Aug 29 15:20:04 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Aug 29 15:20:04 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 15:20:07 volumio volumio[976]: info: CoreCommandRouter::volumioGetQueue Aug 29 15:20:07 volumio volumio[976]: info: CoreStateMachine::getQueue Aug 29 15:20:07 volumio volumio[976]: info: CorePlayQueue::getQueue Aug 29 15:20:09 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Aug 29 15:20:09 volumio volumio[976]: info: In handleBrowseUri, curUri=spotify Aug 29 15:20:09 volumio volumio[976]: info: Preload queue cleared Aug 29 15:20:09 volumio volumio[976]: info: Preload queue cleared Aug 29 15:20:09 volumio volumio[976]: info: Preload queue cleared Aug 29 15:20:09 volumio volumio[976]: info: Preload queue cleared Aug 29 15:20:12 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 29 15:20:17 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Aug 29 15:20:17 volumio volumio[976]: info: In handleBrowseUri, curUri=spotify/myrecentlyplayedtracks Aug 29 15:20:17 volumio volumio[976]: info: Preload queue cleared Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:1AtanU6Ga0oH4iI32qurZy Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:3MNj8WKXCuduChszKpXw45 Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:3lh3iiiJeiBXHSZw6u0kh6 Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:4KU1AZfXvTPhrr9ptpVVPp Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:56lhDZNQ5J47aog6mGKeGk Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:7tRIpQDyq22qkjdk4mzBrq Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:20mvEa8wRNsdU7diadzRGg Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:6puA3V4iUFow4GMGFDf7qF Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:1LDz5dqGxxWSOxNWjuzclb Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:1Ulh5rWbhhV3PltDadTBZC Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:408tTuSDxIr3zDR90Zmcw2 Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:2ohcpZDvcIRdCE3lWxu6Tc Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:4eQQGTTbcKl5abbaIM0OxW Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:1Vp8U39YNsDfd6yVuaUq12 Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:7GDIQqD5pdHCda5rpZ98Ie Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:7GDIQqD5pdHCda5rpZ98Ie Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:2et6PSk5Qageoz0L9mCsMM Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:524rxTETDSE7zacWTyRgEl Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:3Jt0ilhAzxBNYsrzn8nAyA Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:0epkPH6UUNBc0jzFyPFQXJ Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:5ZtPofuIcSv3Lov9TiNyiE Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:5ZtPofuIcSv3Lov9TiNyiE Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:2rn0BxTTRIMlkpI23aVCFR Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:54GEQQ5ChXNbCbNyNGIheE Aug 29 15:20:17 volumio volumio[976]: info: Preloading song: spotify:track:6wG6QtkQk7p8Ua0J3Ok7Px Aug 29 15:20:17 volumio volumio[976]: info: Exploding uri spotify:track:1AtanU6Ga0oH4iI32qurZy in service spop Aug 29 15:20:17 volumio volumio[976]: info: Exploding uri spotify:track:3MNj8WKXCuduChszKpXw45 in service spop Aug 29 15:20:17 volumio volumio[976]: info: Exploding uri spotify:track:3lh3iiiJeiBXHSZw6u0kh6 in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:4KU1AZfXvTPhrr9ptpVVPp in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:56lhDZNQ5J47aog6mGKeGk in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:7tRIpQDyq22qkjdk4mzBrq in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:20mvEa8wRNsdU7diadzRGg in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:6puA3V4iUFow4GMGFDf7qF in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:1LDz5dqGxxWSOxNWjuzclb in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:1Ulh5rWbhhV3PltDadTBZC in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:408tTuSDxIr3zDR90Zmcw2 in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:2ohcpZDvcIRdCE3lWxu6Tc in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:4eQQGTTbcKl5abbaIM0OxW in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:1Vp8U39YNsDfd6yVuaUq12 in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:7GDIQqD5pdHCda5rpZ98Ie in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:7GDIQqD5pdHCda5rpZ98Ie in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:2et6PSk5Qageoz0L9mCsMM in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:524rxTETDSE7zacWTyRgEl in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:3Jt0ilhAzxBNYsrzn8nAyA in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:0epkPH6UUNBc0jzFyPFQXJ in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:5ZtPofuIcSv3Lov9TiNyiE in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:5ZtPofuIcSv3Lov9TiNyiE in service spop Aug 29 15:20:18 volumio volumio[976]: info: Exploding uri spotify:track:2rn0BxTTRIMlkpI23aVCFR in service spop Aug 29 15:20:19 volumio volumio[976]: info: Exploding uri spotify:track:54GEQQ5ChXNbCbNyNGIheE in service spop Aug 29 15:20:19 volumio volumio[976]: info: Exploding uri spotify:track:6wG6QtkQk7p8Ua0J3Ok7Px in service spop Aug 29 15:20:20 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 29 15:20:21 volumio volumio[976]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 29 15:20:21 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 29 15:20:21 volumio volumio[976]: info: Received Get System Version Aug 29 15:20:21 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 29 15:20:21 volumio volumio[976]: info: Received Get System Info Aug 29 15:20:21 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 29 15:20:21 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 29 15:20:21 volumio volumio[976]: info: Discovery: Getting this device information Aug 29 15:20:21 volumio volumio[976]: info: CoreCommandRouter::volumioGetState Aug 29 15:20:21 volumio volumio[976]: info: CorePlayQueue::getTrack 0 Aug 29 15:20:21 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 29 15:20:26 volumio volumio[976]: info: Preload queue cleared Aug 29 15:20:26 volumio volumio[976]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 29 15:20:26 volumio volumio[976]: info: CoreStateMachine::ClearQueue Aug 29 15:20:26 volumio volumio[976]: info: CoreStateMachine::stop Aug 29 15:20:26 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 15:20:26 volumio volumio[976]: info: CorePlayQueue::clearPlayQueue Aug 29 15:20:26 volumio volumio[976]: info: CorePlayQueue::saveQueue Aug 29 15:20:26 volumio volumio[976]: info: CoreCommandRouter::volumioPushQueue Aug 29 15:20:26 volumio volumio[976]: info: CoreStateMachine::addQueueItems Aug 29 15:20:26 volumio volumio[976]: info: CorePlayQueue::addQueueItems Aug 29 15:20:26 volumio volumio[976]: info: Preload queue cleared Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:1AtanU6Ga0oH4iI32qurZy Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:1AtanU6Ga0oH4iI32qurZy Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:3MNj8WKXCuduChszKpXw45 Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:3MNj8WKXCuduChszKpXw45 Aug 29 15:20:26 volumio volumio[976]: info: CoreCommandRouter::volumioPushQueue Aug 29 15:20:26 volumio volumio[976]: info: CorePlayQueue::saveQueue Aug 29 15:20:26 volumio volumio[976]: info: CoreStateMachine::updateTrackBlock Aug 29 15:20:26 volumio volumio[976]: info: CorePlayQueue::getTrackBlock Aug 29 15:20:26 volumio volumio[976]: info: CoreCommandRouter::volumioPlay Aug 29 15:20:26 volumio volumio[976]: info: CoreStateMachine::play index 1 Aug 29 15:20:26 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 15:20:26 volumio volumio[976]: info: CoreStateMachine::addQueueItems Aug 29 15:20:26 volumio volumio[976]: info: CorePlayQueue::addQueueItems Aug 29 15:20:26 volumio volumio[976]: info: Preload queue cleared Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:3lh3iiiJeiBXHSZw6u0kh6 Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:3lh3iiiJeiBXHSZw6u0kh6 Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:4KU1AZfXvTPhrr9ptpVVPp Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:4KU1AZfXvTPhrr9ptpVVPp Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:56lhDZNQ5J47aog6mGKeGk Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:56lhDZNQ5J47aog6mGKeGk Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:7tRIpQDyq22qkjdk4mzBrq Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:7tRIpQDyq22qkjdk4mzBrq Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:20mvEa8wRNsdU7diadzRGg Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:20mvEa8wRNsdU7diadzRGg Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:6puA3V4iUFow4GMGFDf7qF Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:6puA3V4iUFow4GMGFDf7qF Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:1LDz5dqGxxWSOxNWjuzclb Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:1LDz5dqGxxWSOxNWjuzclb Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:1Ulh5rWbhhV3PltDadTBZC Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:1Ulh5rWbhhV3PltDadTBZC Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:408tTuSDxIr3zDR90Zmcw2 Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:408tTuSDxIr3zDR90Zmcw2 Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:2ohcpZDvcIRdCE3lWxu6Tc Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:2ohcpZDvcIRdCE3lWxu6Tc Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:4eQQGTTbcKl5abbaIM0OxW Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:4eQQGTTbcKl5abbaIM0OxW Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:1Vp8U39YNsDfd6yVuaUq12 Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:1Vp8U39YNsDfd6yVuaUq12 Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:7GDIQqD5pdHCda5rpZ98Ie Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:7GDIQqD5pdHCda5rpZ98Ie Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:7GDIQqD5pdHCda5rpZ98Ie Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:7GDIQqD5pdHCda5rpZ98Ie Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:2et6PSk5Qageoz0L9mCsMM Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:2et6PSk5Qageoz0L9mCsMM Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:524rxTETDSE7zacWTyRgEl Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:524rxTETDSE7zacWTyRgEl Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:3Jt0ilhAzxBNYsrzn8nAyA Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:3Jt0ilhAzxBNYsrzn8nAyA Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:0epkPH6UUNBc0jzFyPFQXJ Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:0epkPH6UUNBc0jzFyPFQXJ Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:5ZtPofuIcSv3Lov9TiNyiE Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:5ZtPofuIcSv3Lov9TiNyiE Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:5ZtPofuIcSv3Lov9TiNyiE Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:5ZtPofuIcSv3Lov9TiNyiE Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:2rn0BxTTRIMlkpI23aVCFR Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:2rn0BxTTRIMlkpI23aVCFR Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:54GEQQ5ChXNbCbNyNGIheE Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:54GEQQ5ChXNbCbNyNGIheE Aug 29 15:20:26 volumio volumio[976]: info: Adding Item to queue: spotify:track:6wG6QtkQk7p8Ua0J3Ok7Px Aug 29 15:20:26 volumio volumio[976]: info: Using cached record of: spotify:track:6wG6QtkQk7p8Ua0J3Ok7Px Aug 29 15:20:26 volumio volumio[976]: info: CoreStateMachine::stop Aug 29 15:20:26 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 15:20:26 volumio volumio[976]: info: CoreCommandRouter::volumioPushQueue Aug 29 15:20:26 volumio volumio[976]: info: CorePlayQueue::saveQueue Aug 29 15:20:26 volumio volumio[976]: info: CoreStateMachine::play index undefined Aug 29 15:20:26 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 15:20:26 volumio volumio[976]: info: CoreStateMachine::updateTrackBlock Aug 29 15:20:26 volumio volumio[976]: info: CorePlayQueue::getTrackBlock Aug 29 15:20:26 volumio volumio[976]: info: CorePlayQueue::getTrack 1 Aug 29 15:20:26 volumio volumio[976]: info: CoreStateMachine::startPlaybackTimer Aug 29 15:20:26 volumio volumio[976]: info: CorePlayQueue::getTrack 1 Aug 29 15:20:26 volumio volumio[976]: info: [1788031226416] ControllerSpotify::clearAddPlayTrack Aug 29 15:20:26 volumio volumio[976]: info: Sending Spotify command with payload to local API: /player/play Aug 29 15:20:29 volumio volumio[976]: info: Preload queue cleared Aug 29 15:20:29 volumio volumio[976]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 29 15:20:29 volumio volumio[976]: info: CoreStateMachine::ClearQueue Aug 29 15:20:29 volumio volumio[976]: info: CoreStateMachine::stop Aug 29 15:20:29 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 15:20:29 volumio volumio[976]: info: CorePlayQueue::clearPlayQueue Aug 29 15:20:29 volumio volumio[976]: info: CorePlayQueue::saveQueue Aug 29 15:20:29 volumio volumio[976]: info: CoreCommandRouter::volumioPushQueue Aug 29 15:20:29 volumio volumio[976]: info: CoreStateMachine::addQueueItems Aug 29 15:20:29 volumio volumio[976]: info: CorePlayQueue::addQueueItems Aug 29 15:20:29 volumio volumio[976]: info: Preload queue cleared Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:1AtanU6Ga0oH4iI32qurZy Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:1AtanU6Ga0oH4iI32qurZy Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:3MNj8WKXCuduChszKpXw45 Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:3MNj8WKXCuduChszKpXw45 Aug 29 15:20:29 volumio volumio[976]: info: CoreCommandRouter::volumioPushQueue Aug 29 15:20:29 volumio volumio[976]: info: CorePlayQueue::saveQueue Aug 29 15:20:29 volumio volumio[976]: info: CoreStateMachine::updateTrackBlock Aug 29 15:20:29 volumio volumio[976]: info: CorePlayQueue::getTrackBlock Aug 29 15:20:29 volumio volumio[976]: info: CoreCommandRouter::volumioPlay Aug 29 15:20:29 volumio volumio[976]: info: CoreStateMachine::play index 1 Aug 29 15:20:29 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 15:20:29 volumio volumio[976]: info: CoreStateMachine::addQueueItems Aug 29 15:20:29 volumio volumio[976]: info: CorePlayQueue::addQueueItems Aug 29 15:20:29 volumio volumio[976]: info: Preload queue cleared Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:3lh3iiiJeiBXHSZw6u0kh6 Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:3lh3iiiJeiBXHSZw6u0kh6 Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:4KU1AZfXvTPhrr9ptpVVPp Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:4KU1AZfXvTPhrr9ptpVVPp Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:56lhDZNQ5J47aog6mGKeGk Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:56lhDZNQ5J47aog6mGKeGk Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:7tRIpQDyq22qkjdk4mzBrq Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:7tRIpQDyq22qkjdk4mzBrq Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:20mvEa8wRNsdU7diadzRGg Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:20mvEa8wRNsdU7diadzRGg Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:6puA3V4iUFow4GMGFDf7qF Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:6puA3V4iUFow4GMGFDf7qF Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:1LDz5dqGxxWSOxNWjuzclb Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:1LDz5dqGxxWSOxNWjuzclb Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:1Ulh5rWbhhV3PltDadTBZC Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:1Ulh5rWbhhV3PltDadTBZC Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:408tTuSDxIr3zDR90Zmcw2 Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:408tTuSDxIr3zDR90Zmcw2 Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:2ohcpZDvcIRdCE3lWxu6Tc Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:2ohcpZDvcIRdCE3lWxu6Tc Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:4eQQGTTbcKl5abbaIM0OxW Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:4eQQGTTbcKl5abbaIM0OxW Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:1Vp8U39YNsDfd6yVuaUq12 Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:1Vp8U39YNsDfd6yVuaUq12 Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:7GDIQqD5pdHCda5rpZ98Ie Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:7GDIQqD5pdHCda5rpZ98Ie Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:7GDIQqD5pdHCda5rpZ98Ie Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:7GDIQqD5pdHCda5rpZ98Ie Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:2et6PSk5Qageoz0L9mCsMM Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:2et6PSk5Qageoz0L9mCsMM Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:524rxTETDSE7zacWTyRgEl Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:524rxTETDSE7zacWTyRgEl Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:3Jt0ilhAzxBNYsrzn8nAyA Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:3Jt0ilhAzxBNYsrzn8nAyA Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:0epkPH6UUNBc0jzFyPFQXJ Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:0epkPH6UUNBc0jzFyPFQXJ Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:5ZtPofuIcSv3Lov9TiNyiE Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:5ZtPofuIcSv3Lov9TiNyiE Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:5ZtPofuIcSv3Lov9TiNyiE Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:5ZtPofuIcSv3Lov9TiNyiE Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:2rn0BxTTRIMlkpI23aVCFR Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:2rn0BxTTRIMlkpI23aVCFR Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:54GEQQ5ChXNbCbNyNGIheE Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:54GEQQ5ChXNbCbNyNGIheE Aug 29 15:20:29 volumio volumio[976]: info: Adding Item to queue: spotify:track:6wG6QtkQk7p8Ua0J3Ok7Px Aug 29 15:20:29 volumio volumio[976]: info: Using cached record of: spotify:track:6wG6QtkQk7p8Ua0J3Ok7Px Aug 29 15:20:29 volumio volumio[976]: info: CoreStateMachine::stop Aug 29 15:20:29 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 15:20:29 volumio volumio[976]: info: CoreCommandRouter::volumioPushQueue Aug 29 15:20:29 volumio volumio[976]: info: CorePlayQueue::saveQueue Aug 29 15:20:29 volumio volumio[976]: info: CoreStateMachine::play index undefined Aug 29 15:20:29 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 15:20:29 volumio volumio[976]: info: CoreStateMachine::updateTrackBlock Aug 29 15:20:29 volumio volumio[976]: info: CorePlayQueue::getTrackBlock Aug 29 15:20:29 volumio volumio[976]: info: CorePlayQueue::getTrack 1 Aug 29 15:20:29 volumio volumio[976]: info: CoreStateMachine::startPlaybackTimer Aug 29 15:20:29 volumio volumio[976]: info: CorePlayQueue::getTrack 1 Aug 29 15:20:29 volumio volumio[976]: info: [1788031229440] ControllerSpotify::clearAddPlayTrack Aug 29 15:20:29 volumio volumio[976]: info: Sending Spotify command with payload to local API: /player/play Aug 29 15:20:33 volumio volumio[976]: info: Preload queue cleared Aug 29 15:20:33 volumio volumio[976]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 29 15:20:33 volumio volumio[976]: info: CoreStateMachine::ClearQueue Aug 29 15:20:33 volumio volumio[976]: info: CoreStateMachine::stop Aug 29 15:20:33 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 15:20:33 volumio volumio[976]: info: CorePlayQueue::clearPlayQueue Aug 29 15:20:33 volumio volumio[976]: info: CorePlayQueue::saveQueue Aug 29 15:20:33 volumio volumio[976]: info: CoreCommandRouter::volumioPushQueue Aug 29 15:20:33 volumio volumio[976]: info: CoreStateMachine::addQueueItems Aug 29 15:20:33 volumio volumio[976]: info: CorePlayQueue::addQueueItems Aug 29 15:20:33 volumio volumio[976]: info: Preload queue cleared Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:1AtanU6Ga0oH4iI32qurZy Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:1AtanU6Ga0oH4iI32qurZy Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:3MNj8WKXCuduChszKpXw45 Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:3MNj8WKXCuduChszKpXw45 Aug 29 15:20:33 volumio volumio[976]: info: CoreCommandRouter::volumioPushQueue Aug 29 15:20:33 volumio volumio[976]: info: CorePlayQueue::saveQueue Aug 29 15:20:33 volumio volumio[976]: info: CoreStateMachine::updateTrackBlock Aug 29 15:20:33 volumio volumio[976]: info: CorePlayQueue::getTrackBlock Aug 29 15:20:33 volumio volumio[976]: info: CoreCommandRouter::volumioPlay Aug 29 15:20:33 volumio volumio[976]: info: CoreStateMachine::play index 1 Aug 29 15:20:33 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 15:20:33 volumio volumio[976]: info: CoreStateMachine::addQueueItems Aug 29 15:20:33 volumio volumio[976]: info: CorePlayQueue::addQueueItems Aug 29 15:20:33 volumio volumio[976]: info: Preload queue cleared Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:3lh3iiiJeiBXHSZw6u0kh6 Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:3lh3iiiJeiBXHSZw6u0kh6 Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:4KU1AZfXvTPhrr9ptpVVPp Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:4KU1AZfXvTPhrr9ptpVVPp Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:56lhDZNQ5J47aog6mGKeGk Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:56lhDZNQ5J47aog6mGKeGk Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:7tRIpQDyq22qkjdk4mzBrq Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:7tRIpQDyq22qkjdk4mzBrq Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:20mvEa8wRNsdU7diadzRGg Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:20mvEa8wRNsdU7diadzRGg Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:6puA3V4iUFow4GMGFDf7qF Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:6puA3V4iUFow4GMGFDf7qF Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:1LDz5dqGxxWSOxNWjuzclb Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:1LDz5dqGxxWSOxNWjuzclb Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:1Ulh5rWbhhV3PltDadTBZC Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:1Ulh5rWbhhV3PltDadTBZC Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:408tTuSDxIr3zDR90Zmcw2 Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:408tTuSDxIr3zDR90Zmcw2 Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:2ohcpZDvcIRdCE3lWxu6Tc Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:2ohcpZDvcIRdCE3lWxu6Tc Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:4eQQGTTbcKl5abbaIM0OxW Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:4eQQGTTbcKl5abbaIM0OxW Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:1Vp8U39YNsDfd6yVuaUq12 Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:1Vp8U39YNsDfd6yVuaUq12 Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:7GDIQqD5pdHCda5rpZ98Ie Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:7GDIQqD5pdHCda5rpZ98Ie Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:7GDIQqD5pdHCda5rpZ98Ie Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:7GDIQqD5pdHCda5rpZ98Ie Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:2et6PSk5Qageoz0L9mCsMM Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:2et6PSk5Qageoz0L9mCsMM Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:524rxTETDSE7zacWTyRgEl Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:524rxTETDSE7zacWTyRgEl Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:3Jt0ilhAzxBNYsrzn8nAyA Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:3Jt0ilhAzxBNYsrzn8nAyA Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:0epkPH6UUNBc0jzFyPFQXJ Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:0epkPH6UUNBc0jzFyPFQXJ Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:5ZtPofuIcSv3Lov9TiNyiE Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:5ZtPofuIcSv3Lov9TiNyiE Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:5ZtPofuIcSv3Lov9TiNyiE Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:5ZtPofuIcSv3Lov9TiNyiE Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:2rn0BxTTRIMlkpI23aVCFR Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:2rn0BxTTRIMlkpI23aVCFR Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:54GEQQ5ChXNbCbNyNGIheE Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:54GEQQ5ChXNbCbNyNGIheE Aug 29 15:20:33 volumio volumio[976]: info: Adding Item to queue: spotify:track:6wG6QtkQk7p8Ua0J3Ok7Px Aug 29 15:20:33 volumio volumio[976]: info: Using cached record of: spotify:track:6wG6QtkQk7p8Ua0J3Ok7Px Aug 29 15:20:33 volumio volumio[976]: info: CoreStateMachine::stop Aug 29 15:20:33 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 15:20:33 volumio volumio[976]: info: CoreCommandRouter::volumioPushQueue Aug 29 15:20:33 volumio volumio[976]: info: CorePlayQueue::saveQueue Aug 29 15:20:33 volumio volumio[976]: info: CoreStateMachine::play index undefined Aug 29 15:20:33 volumio volumio[976]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 15:20:33 volumio volumio[976]: info: CoreStateMachine::updateTrackBlock Aug 29 15:20:33 volumio volumio[976]: info: CorePlayQueue::getTrackBlock Aug 29 15:20:33 volumio volumio[976]: info: CorePlayQueue::getTrack 1 Aug 29 15:20:33 volumio volumio[976]: info: CoreStateMachine::startPlaybackTimer Aug 29 15:20:33 volumio volumio[976]: info: CorePlayQueue::getTrack 1 Aug 29 15:20:33 volumio volumio[976]: info: [1788031233296] ControllerSpotify::clearAddPlayTrack Aug 29 15:20:33 volumio volumio[976]: info: Sending Spotify command with payload to local API: /player/play Aug 29 15:20:53 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Aug 29 15:20:53 volumio volumio[976]: info: In handleBrowseUri, curUri=spotify/playlists Aug 29 15:20:53 volumio volumio[976]: info: Preload queue cleared Aug 29 15:21:04 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 29 15:21:04 volumio volumio[976]: info: CURURI: artists:// Aug 29 15:21:04 volumio volumio[976]: info: Preload queue cleared Aug 29 15:21:08 volumio volumio[976]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 29 15:21:08 volumio volumio[976]: TypeError: Cannot read property 'slice' of null Aug 29 15:21:08 volumio volumio[976]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Aug 29 15:21:08 volumio volumio[976]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Aug 29 15:21:08 volumio volumio[976]: at Object.onceWrapper (events.js:422:26) Aug 29 15:21:08 volumio volumio[976]: at ClientRequest.emit (events.js:315:20) Aug 29 15:21:08 volumio volumio[976]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Aug 29 15:21:08 volumio volumio[976]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Aug 29 15:21:08 volumio volumio[976]: at TLSSocket.socketOnData (_http_client.js:509:22) Aug 29 15:21:08 volumio volumio[976]: at TLSSocket.emit (events.js:315:20) Aug 29 15:21:08 volumio volumio[976]: at addChunk (internal/streams/readable.js:309:12) Aug 29 15:21:08 volumio volumio[976]: at readableAddChunk (internal/streams/readable.js:284:9) Aug 29 15:21:08 volumio volumio[976]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Aug 29 15:21:08 volumio volumio[976]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Aug 29 15:21:08 volumio volumio[976]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 29 15:21:08 volumio sudo[2955]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-29 15:20 Aug 29 15:21:08 volumio sudo[2955]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"