-- Logs begin at Wed 2025-07-16 16:46:21 CEST, end at Thu 2025-07-17 16:55:16 CEST. -- Jul 17 16:54:23 volumio go-librespot[8717]: time="2025-07-17T16:54:23+02:00" level=trace msg="emitting websocket event: not_playing" Jul 17 16:54:23 volumio go-librespot[8717]: time="2025-07-17T16:54:23+02:00" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:2tCTxCTAwsUJB6aUdGpGpP" Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:0wuxOBMmwRRgJi3gXse0QD","play_origin":"go-librespot"}} Jul 17 16:54:23 volumio volumio[935]: error: Failed to decode event: not_playing Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:0wuxOBMmwRRgJi3gXse0QD","play_origin":"go-librespot"}} Jul 17 16:54:23 volumio volumio[935]: error: Failed to decode event: not_playing Jul 17 16:54:23 volumio go-librespot[8717]: time="2025-07-17T16:54:23+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jul 17 16:54:23 volumio go-librespot[8717]: time="2025-07-17T16:54:23+02:00" level=trace msg="emitting websocket event: will_play" Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","play_origin":"go-librespot"}} Jul 17 16:54:23 volumio go-librespot[8717]: time="2025-07-17T16:54:23+02:00" level=info msg="loaded track \"Promise\" (paused: false, position: 0ms, duration: 259907ms, prefetched: true)" uri="spotify:track:2tCTxCTAwsUJB6aUdGpGpP" Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","play_origin":"go-librespot"}} Jul 17 16:54:23 volumio go-librespot[8717]: time="2025-07-17T16:54:23+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jul 17 16:54:23 volumio go-librespot[8717]: time="2025-07-17T16:54:23+02:00" level=trace msg="scheduling prefetch in 230s" Jul 17 16:54:23 volumio go-librespot[8717]: time="2025-07-17T16:54:23+02:00" level=trace msg="emitting websocket event: metadata" Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","name":"Promise","artist_names":["HAEVN"],"album_name":"Wide Awake","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02bbc2ddda9a1bfe3226b83e95","position":0,"duration":259907,"release_date":"year:2024 month:10 day:11","track_number":1,"disc_number":1}} Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","name":"Promise","artist_names":["HAEVN"],"album_name":"Wide Awake","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02bbc2ddda9a1bfe3226b83e95","position":0,"duration":259907,"release_date":"year:2024 month:10 day:11","track_number":1,"disc_number":1}} Jul 17 16:54:23 volumio go-librespot[8717]: time="2025-07-17T16:54:23+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jul 17 16:54:23 volumio go-librespot[8717]: time="2025-07-17T16:54:23+02:00" level=trace msg="emitting websocket event: playing" Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","play_origin":"go-librespot"}} Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: PUSH STATE SPOTIFY Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: {"status":"play","service":"spop","title":"Promise","artist":"HAEVN","album":"Wide Awake","albumart":"https://i.scdn.co/image/ab67616d00001e02bbc2ddda9a1bfe3226b83e95","uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","trackType":"spotify","seek":1000,"duration":259,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Jul 17 16:54:23 volumio volumio[935]: info: CoreCommandRouter::servicePushState Jul 17 16:54:23 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:23 volumio volumio[935]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Promise","artist":"HAEVN","album":"Wide Awake","albumart":"https://i.scdn.co/image/ab67616d00001e02bbc2ddda9a1bfe3226b83e95","uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","trackType":"spotify","seek":1000,"duration":259,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Jul 17 16:54:23 volumio volumio[935]: verbose: CURRENT POSITION 3 Jul 17 16:54:23 volumio volumio[935]: info: CoreStateMachine::syncState stateService play Jul 17 16:54:23 volumio volumio[935]: info: CoreStateMachine::syncState currentStatus play Jul 17 16:54:23 volumio volumio[935]: info: Received an update from plugin. extracting info from payload Jul 17 16:54:23 volumio volumio[935]: info: CoreStateMachine::pushState Jul 17 16:54:23 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:23 volumio volumio[935]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 16:54:23 volumio volumio[935]: info: CoreCommandRouter::volumioPushState Jul 17 16:54:23 volumio volumio[935]: info: CoreStateMachine::pushState Jul 17 16:54:23 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:23 volumio volumio[935]: info: CoreCommandRouter::volumioPushState Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","play_origin":"go-librespot"}} Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: PUSH STATE SPOTIFY Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: {"status":"play","service":"spop","title":"Promise","artist":"HAEVN","album":"Wide Awake","albumart":"https://i.scdn.co/image/ab67616d00001e02bbc2ddda9a1bfe3226b83e95","uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","trackType":"spotify","seek":1000,"duration":259,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Jul 17 16:54:23 volumio volumio[935]: info: CoreCommandRouter::servicePushState Jul 17 16:54:23 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:23 volumio volumio[935]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Promise","artist":"HAEVN","album":"Wide Awake","albumart":"https://i.scdn.co/image/ab67616d00001e02bbc2ddda9a1bfe3226b83e95","uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","trackType":"spotify","seek":1000,"duration":259,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Jul 17 16:54:23 volumio volumio[935]: verbose: CURRENT POSITION 3 Jul 17 16:54:23 volumio volumio[935]: info: CoreStateMachine::syncState stateService play Jul 17 16:54:23 volumio volumio[935]: info: CoreStateMachine::syncState currentStatus play Jul 17 16:54:23 volumio volumio[935]: info: Received an update from plugin. extracting info from payload Jul 17 16:54:23 volumio volumio[935]: info: CoreStateMachine::pushState Jul 17 16:54:23 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:23 volumio volumio[935]: info: CoreCommandRouter::volumioPushState Jul 17 16:54:23 volumio volumio[935]: info: CoreStateMachine::pushState Jul 17 16:54:23 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:23 volumio volumio[935]: info: CoreCommandRouter::volumioPushState Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75 Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75 Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75 Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75 Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: PUSH STATE SPOTIFY Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: {"status":"play","service":"spop","title":"Promise","artist":"HAEVN","album":"Wide Awake","albumart":"https://i.scdn.co/image/ab67616d00001e02bbc2ddda9a1bfe3226b83e95","uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","trackType":"spotify","seek":1000,"duration":259,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Jul 17 16:54:23 volumio volumio[935]: info: CoreCommandRouter::servicePushState Jul 17 16:54:23 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:23 volumio volumio[935]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Promise","artist":"HAEVN","album":"Wide Awake","albumart":"https://i.scdn.co/image/ab67616d00001e02bbc2ddda9a1bfe3226b83e95","uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","trackType":"spotify","seek":1000,"duration":259,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Jul 17 16:54:23 volumio volumio[935]: verbose: CURRENT POSITION 3 Jul 17 16:54:23 volumio volumio[935]: info: CoreStateMachine::syncState stateService play Jul 17 16:54:23 volumio volumio[935]: info: CoreStateMachine::syncState currentStatus play Jul 17 16:54:23 volumio volumio[935]: info: Received an update from plugin. extracting info from payload Jul 17 16:54:23 volumio volumio[935]: info: CoreStateMachine::pushState Jul 17 16:54:23 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:23 volumio volumio[935]: info: CoreCommandRouter::volumioPushState Jul 17 16:54:23 volumio volumio[935]: info: CoreStateMachine::pushState Jul 17 16:54:23 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:23 volumio volumio[935]: info: CoreCommandRouter::volumioPushState Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75 Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75 Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: PUSH STATE SPOTIFY Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: {"status":"play","service":"spop","title":"Promise","artist":"HAEVN","album":"Wide Awake","albumart":"https://i.scdn.co/image/ab67616d00001e02bbc2ddda9a1bfe3226b83e95","uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","trackType":"spotify","seek":1000,"duration":259,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Jul 17 16:54:23 volumio volumio[935]: info: CoreCommandRouter::servicePushState Jul 17 16:54:23 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:23 volumio volumio[935]: verbose: STATE SERVICE {"status":"play","service":"spop","title":"Promise","artist":"HAEVN","album":"Wide Awake","albumart":"https://i.scdn.co/image/ab67616d00001e02bbc2ddda9a1bfe3226b83e95","uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","trackType":"spotify","seek":1000,"duration":259,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Jul 17 16:54:23 volumio volumio[935]: verbose: CURRENT POSITION 3 Jul 17 16:54:23 volumio volumio[935]: info: CoreStateMachine::syncState stateService play Jul 17 16:54:23 volumio volumio[935]: info: CoreStateMachine::syncState currentStatus play Jul 17 16:54:23 volumio volumio[935]: info: Received an update from plugin. extracting info from payload Jul 17 16:54:23 volumio volumio[935]: info: CoreStateMachine::pushState Jul 17 16:54:23 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:23 volumio volumio[935]: info: CoreCommandRouter::volumioPushState Jul 17 16:54:23 volumio volumio[935]: info: CoreStateMachine::pushState Jul 17 16:54:23 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:23 volumio volumio[935]: info: CoreCommandRouter::volumioPushState Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75 Jul 17 16:54:23 volumio volumio[935]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75 Jul 17 16:54:26 volumio go-librespot[8717]: time="2025-07-17T16:54:26+02:00" level=trace msg="sent dealer ping" Jul 17 16:54:26 volumio go-librespot[8717]: time="2025-07-17T16:54:26+02:00" level=trace msg="received dealer pong" Jul 17 16:54:38 volumio go-librespot[8717]: time="2025-07-17T16:54:38+02:00" level=debug msg="fetched chunk 4/19, size: 524288" uri="spotify:track:2tCTxCTAwsUJB6aUdGpGpP" Jul 17 16:54:43 volumio volumio[935]: verbose: New Socket.io Connection to 192.168.1.250 from 192.168.1.71 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:140.0) Gecko/20100101 Firefox/140.0 Engine version: 3 Transport: polling Total Clients: 6 Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::volumioGetState Jul 17 16:54:43 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:43 volumio volumio[935]: info: Received Get System Info Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 16:54:43 volumio volumio[935]: info: Discovery: Getting this device information Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::volumioGetState Jul 17 16:54:43 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::volumioGetState Jul 17 16:54:43 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::volumioGetVisibleSources Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::volumioGetState Jul 17 16:54:43 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::volumioGetState Jul 17 16:54:43 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 17 16:54:43 volumio volumio[935]: info: Received Get System Info Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 16:54:43 volumio volumio[935]: info: Discovery: Getting this device information Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::volumioGetState Jul 17 16:54:43 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::volumioGetState Jul 17 16:54:43 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:43 volumio volumio[935]: info: Listing playlists Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::volumioGetQueue Jul 17 16:54:43 volumio volumio[935]: info: CoreStateMachine::getQueue Jul 17 16:54:43 volumio volumio[935]: info: CorePlayQueue::getQueue Jul 17 16:54:43 volumio volumio[935]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 17 16:54:48 volumio volumio[935]: info: VolumeController::SetAlsaVolume+ Jul 17 16:54:48 volumio volumio[935]: info: CoreStateMachine::pushState Jul 17 16:54:48 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:54:48 volumio volumio[935]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 16:54:48 volumio volumio[935]: info: CoreCommandRouter::volumioPushState Jul 17 16:54:48 volumio volumio[935]: SPOTIFY: RECEIVED VOLUMIO VOLUME 76 Jul 17 16:54:48 volumio volumio[935]: SPOTIFY: SPOTIFY VOLUME 75 Jul 17 16:54:48 volumio volumio[935]: SPOTIFY: VOLUMIO VOLUME 76 Jul 17 16:54:48 volumio volumio[935]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 17 16:54:52 volumio volumio[935]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Jul 17 16:54:52 volumio volumio[935]: info: In handleBrowseUri, curUri=spotify:user:spotify:playlist:41cHArqgqJYLjgVsdmt58S Jul 17 16:54:52 volumio go-librespot[8717]: time="2025-07-17T16:54:52+02:00" level=debug msg="fetched chunk 5/19, size: 524288" uri="spotify:track:2tCTxCTAwsUJB6aUdGpGpP" Jul 17 16:54:56 volumio go-librespot[8717]: time="2025-07-17T16:54:56+02:00" level=trace msg="received accesspoint ping" Jul 17 16:54:56 volumio go-librespot[8717]: time="2025-07-17T16:54:56+02:00" level=trace msg="received accesspoint pong ack" Jul 17 16:54:56 volumio go-librespot[8717]: time="2025-07-17T16:54:56+02:00" level=trace msg="sent dealer ping" Jul 17 16:54:56 volumio go-librespot[8717]: time="2025-07-17T16:54:56+02:00" level=trace msg="received dealer pong" Jul 17 16:55:07 volumio go-librespot[8717]: time="2025-07-17T16:55:07+02:00" level=debug msg="fetched chunk 6/19, size: 524288" uri="spotify:track:2tCTxCTAwsUJB6aUdGpGpP" Jul 17 16:55:08 volumio volumio[935]: info: Preload queue cleared Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:2symit4kuMT20g9dHuvSi7 Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:5nElKcToiCR3UADbd02kaP Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:1iLBWOFDhSgyzJZ4gTGpnh Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:1PiZgi6Pe8yzL6IaBR1Ld9 Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:5Y1UB1f7vTytavRCw8PzaS Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:1Sjsp4RMTHdCOpYKna7zYX Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:1p1ECuYJbpruHdfBoD3B38 Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:5qWCZ0QQ9Xq4s8E5uOiNhG Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:7ePrHHS6xME7NuQkqjKWy6 Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:0A5wAwjDcfHvD6RVCNbmGZ Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:4eJsGX9rhsU33HVz0hXGLS Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:0NvJy5gPR591Qh2z22EAak Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:1omLbJcba5NIGISJTlbzz1 Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:1OoFnLri3YXLnA2ip6rojP Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:3mIkPJ47lUFnc9KRO635KE Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:5ZO4gjA1fMk0cD4EFkPSYT Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:1HPJOoIVdUPuaebxzMrVaD Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:2kOupHwtD01Wle9xOYfD3V Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:01jBLs7IZQzPt3dVdn5rDa Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:7aS418hRnOnYrXeyrZilwk Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:6kJmK6N95GBuZa1574EcBA Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:6qq81RT4TUfyJcHb1gdYHq Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:6kURXiIFcBrvfh11Soiwqv Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:5jCOeqjJRnRo27b9Hb8xHp Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:4mZbFgDwrC0VJRn3qThjNT Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:4eN8JSVLHfMqvmPlKM834H Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:0IShtR9YLRJqrPpUHX9aTq Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:5lMRS9GFQYfxhflty2E1ad Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:3OgmD7U0OBKsGk8Iqm5mps Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:2Yc8IZFWqbXwNNd8BvlodL Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:7dHkbdKXGkDwkVzliPX1Wh Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:1CBAT4X5dra5qqHc3JRVmk Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:15Cybrudu0gdBeP4Ko6NRx Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:7hDVN6GisA47ym0H93NA1Z Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:4ijNab1GM0JSZoe0I2KCOd Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:0zCNuyeXYbmxl6xlvkjvKi Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:008CIaOIsiLvjerJhLxetZ Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:1KtMazpCseJ2TjKPas4d7h Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:5aQfUmnxj8x1zYc37Wit9w Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:29Znt9AbEH9FSsw86zPAYT Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:1WdFxpAg4jkMzrWOgIcwnq Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:1KJjENQCSp74UPKErcGxFW Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:6gkr8wk9pIr1PCNEne3m4J Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:6dO3t1e3pb7sxyDQbDyVNX Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:782a3KaWiC0NI5VzTJznRq Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:752q3k1ds8JckA7tIakICn Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:3yvlcIteooc31cPjyWPTw1 Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:3Nd41wvVOjMlmxbwgdGiJp Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:5VYB1J9aXyYxjE5Z8kXRgK Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:6N2WYiDhLdn5ikzEuzaYLn Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:0RjuP2ncb70tx4f6RdwaCB Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:0I0CVZi0p78WJMDftfXeGM Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:4IXqI5Aarv1FCeWMJU43Rm Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:7b0jIq2MLFo1XidMy4nAAS Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:3YXXsOPhcKBw9Q256TQ3lV Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:6hWq7cWHyXVyg6FjG3xqBI Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:2BOdEwU54cnQhWpAqMUQqg Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:2d8D7uk3tbAThjRkdfrx9c Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:73y37SV7hFy3VcBUEOuVey Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:41bdgBL7tjwQOl7RpwubKU Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:4WBfY2Hhv9W7ZAfWEBOycZ Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:6SsP9PE7JT83QZA8kEYHVV Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:3NldGYmhDLK98kOOo4J1lg Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:7tEDqanTZ8NWxV7zzqth3m Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:4eVn09zU0R160zxNLJU7Jl Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:3OmEIZ6bYHqlReQ1YLaRHV Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:1X78fBuMBoZe9z3dAMUhH7 Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:0X4LJtBwKXMjmaz1hFYs8D Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:0qi4b1l0eT3jpzeNHeFXDT Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:4Pxoi6E5P0aE9LjYiL4Dad Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:33fp2NopvrTQ9vyB1zKxHA Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:4ATJ4DmCmJXDx2qPMbr50Y Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:0WbrOgZJb6yHPumYXEbs5U Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:1RCtHLyq1xIbgGMrYRrKJ2 Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:5vhnFFKN8THC4zNxh7bC4m Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:60TmG8cFPMBo7kTTFOLiAB Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:0FrCX7P2C2hcRTcuhjEvK4 Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:6GhqhdkrscDjFdGh8K5bmU Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:3uAmMs4sWGV7m9IT3GWVXW Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:4mtcHbrISkHtX3kaeM5vMo Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:1gpHMfSpviLSP9CNAeb5xt Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:6aZek8wwuNiN0YppeyckHZ Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:6OUExuMUOP3mJGnS2eA0Rx Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:17I97bDgzf5GrFzpG8GV8H Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:0pIPIsnQEwqKshMjMcraR7 Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:36ND2j1I4fAwsIcQJXka3P Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:191yfYj7Gb3YfT18i9lx5i Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:5itqAWiPW1961LJSXhz1s9 Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:4AmULZtflj3SktU5MPB6EK Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:0s6iS2J9wQUsXgtdVncNdW Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:4OwMnNi3kC2DEIrxMTHc3M Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:3gXczlFOo7RUsamtdYzb2j Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:0FoYHGrCnI8zF4utpPiHWx Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:0bPI35n8OO8MQeU3TYAdtd Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:6G3afsR0udhKnAU0Tut25j Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:5agxCIWiABK6l4ltmCAHoH Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:0YPXkQthLWrhNGoKTbwCJ8 Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:62GncHY2Zlet2US2ZCtaBU Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:0pUVeEgZuNyFzIMKp67RbS Jul 17 16:55:08 volumio volumio[935]: info: Preloading song: spotify:track:515VKgxO6v56qLdfynIFoE Jul 17 16:55:08 volumio volumio[935]: info: Exploding uri spotify:track:2symit4kuMT20g9dHuvSi7 in service spop Jul 17 16:55:08 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:2symit4kuMT20g9dHuvSi7 Jul 17 16:55:08 volumio volumio[935]: info: Exploding uri spotify:track:5nElKcToiCR3UADbd02kaP in service spop Jul 17 16:55:08 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:5nElKcToiCR3UADbd02kaP Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:1iLBWOFDhSgyzJZ4gTGpnh in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:1iLBWOFDhSgyzJZ4gTGpnh Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:1PiZgi6Pe8yzL6IaBR1Ld9 in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:1PiZgi6Pe8yzL6IaBR1Ld9 Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:2symit4kuMT20g9dHuvSi7","service":"spop","name":"The Race - Remastered 2005","artist":"Yello","album":"Flag (Remastered 2005)","type":"song","duration":489,"albumart":"https://i.scdn.co/image/ab67616d0000b2732533ae52589c1be228dc5bd5","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5nElKcToiCR3UADbd02kaP","service":"spop","name":"You Spin Me Round (Like a Record)","artist":"Dead Or Alive","album":"Haynes Ultimate Guide to 80s","type":"song","duration":197,"albumart":"https://i.scdn.co/image/ab67616d0000b2739f91441df3f04a6556896f11","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:5Y1UB1f7vTytavRCw8PzaS in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:5Y1UB1f7vTytavRCw8PzaS Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:1Sjsp4RMTHdCOpYKna7zYX in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:1Sjsp4RMTHdCOpYKna7zYX Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1iLBWOFDhSgyzJZ4gTGpnh","service":"spop","name":"Nowhere Girl (Extended)","artist":"B-Movie","album":"Climate Of Fear - Deluxe Edition","type":"song","duration":388,"albumart":"https://i.scdn.co/image/ab67616d0000b273ca082f14d416838b10275ea0","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1PiZgi6Pe8yzL6IaBR1Ld9","service":"spop","name":"Toffee","artist":"Emotional G","album":"DJ Valdi, Vol. 2 (El DJ Del Hormiguero)","type":"song","duration":252,"albumart":"https://i.scdn.co/image/ab67616d0000b273bf2ea387bda8148e48112c39","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:1p1ECuYJbpruHdfBoD3B38 in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:1p1ECuYJbpruHdfBoD3B38 Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5Y1UB1f7vTytavRCw8PzaS","service":"spop","name":"Toffee - 20th Anniversary","artist":"Alex Karr","album":"Éxitos Dance – Dance Hits 2013","type":"song","duration":346,"albumart":"https://i.scdn.co/image/ab67616d0000b273c7beeb54b7db587c7416acb0","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:5qWCZ0QQ9Xq4s8E5uOiNhG in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:5qWCZ0QQ9Xq4s8E5uOiNhG Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:7ePrHHS6xME7NuQkqjKWy6 in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:7ePrHHS6xME7NuQkqjKWy6 Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1Sjsp4RMTHdCOpYKna7zYX","service":"spop","name":"Outside Looking In","artist":"Dream Sequence","album":"Outside Looking In","type":"song","duration":238,"albumart":"https://i.scdn.co/image/ab67616d0000b273800664dd87b46047d87b927e","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:0A5wAwjDcfHvD6RVCNbmGZ in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:0A5wAwjDcfHvD6RVCNbmGZ Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:4eJsGX9rhsU33HVz0hXGLS in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:4eJsGX9rhsU33HVz0hXGLS Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:0NvJy5gPR591Qh2z22EAak in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:0NvJy5gPR591Qh2z22EAak Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:1omLbJcba5NIGISJTlbzz1 in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:1omLbJcba5NIGISJTlbzz1 Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:1OoFnLri3YXLnA2ip6rojP in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:1OoFnLri3YXLnA2ip6rojP Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:3mIkPJ47lUFnc9KRO635KE in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:3mIkPJ47lUFnc9KRO635KE Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:5ZO4gjA1fMk0cD4EFkPSYT in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:5ZO4gjA1fMk0cD4EFkPSYT Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:1HPJOoIVdUPuaebxzMrVaD in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:1HPJOoIVdUPuaebxzMrVaD Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:2kOupHwtD01Wle9xOYfD3V in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:2kOupHwtD01Wle9xOYfD3V Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:01jBLs7IZQzPt3dVdn5rDa in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:01jBLs7IZQzPt3dVdn5rDa Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:7aS418hRnOnYrXeyrZilwk in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:7aS418hRnOnYrXeyrZilwk Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:6kJmK6N95GBuZa1574EcBA in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:6kJmK6N95GBuZa1574EcBA Jul 17 16:55:09 volumio volumio[935]: info: Exploding uri spotify:track:6qq81RT4TUfyJcHb1gdYHq in service spop Jul 17 16:55:09 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:6qq81RT4TUfyJcHb1gdYHq Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:6kURXiIFcBrvfh11Soiwqv in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:6kURXiIFcBrvfh11Soiwqv Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:5jCOeqjJRnRo27b9Hb8xHp in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:5jCOeqjJRnRo27b9Hb8xHp Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:4mZbFgDwrC0VJRn3qThjNT in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:4mZbFgDwrC0VJRn3qThjNT Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:4eN8JSVLHfMqvmPlKM834H in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:4eN8JSVLHfMqvmPlKM834H Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:0IShtR9YLRJqrPpUHX9aTq in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:0IShtR9YLRJqrPpUHX9aTq Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:5lMRS9GFQYfxhflty2E1ad in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:5lMRS9GFQYfxhflty2E1ad Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:3OgmD7U0OBKsGk8Iqm5mps in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:3OgmD7U0OBKsGk8Iqm5mps Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:2Yc8IZFWqbXwNNd8BvlodL in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:2Yc8IZFWqbXwNNd8BvlodL Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:7dHkbdKXGkDwkVzliPX1Wh in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:7dHkbdKXGkDwkVzliPX1Wh Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:1CBAT4X5dra5qqHc3JRVmk in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:1CBAT4X5dra5qqHc3JRVmk Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:15Cybrudu0gdBeP4Ko6NRx in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:15Cybrudu0gdBeP4Ko6NRx Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:7hDVN6GisA47ym0H93NA1Z in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:7hDVN6GisA47ym0H93NA1Z Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:4ijNab1GM0JSZoe0I2KCOd in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:4ijNab1GM0JSZoe0I2KCOd Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:0zCNuyeXYbmxl6xlvkjvKi in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:0zCNuyeXYbmxl6xlvkjvKi Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:008CIaOIsiLvjerJhLxetZ in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:008CIaOIsiLvjerJhLxetZ Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:1KtMazpCseJ2TjKPas4d7h in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:1KtMazpCseJ2TjKPas4d7h Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:5aQfUmnxj8x1zYc37Wit9w in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:5aQfUmnxj8x1zYc37Wit9w Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:29Znt9AbEH9FSsw86zPAYT in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:29Znt9AbEH9FSsw86zPAYT Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:1WdFxpAg4jkMzrWOgIcwnq in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:1WdFxpAg4jkMzrWOgIcwnq Jul 17 16:55:10 volumio volumio[935]: info: Exploding uri spotify:track:1KJjENQCSp74UPKErcGxFW in service spop Jul 17 16:55:10 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:1KJjENQCSp74UPKErcGxFW Jul 17 16:55:11 volumio volumio[935]: info: Exploding uri spotify:track:6gkr8wk9pIr1PCNEne3m4J in service spop Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:6gkr8wk9pIr1PCNEne3m4J Jul 17 16:55:11 volumio volumio[935]: info: Exploding uri spotify:track:6dO3t1e3pb7sxyDQbDyVNX in service spop Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:6dO3t1e3pb7sxyDQbDyVNX Jul 17 16:55:11 volumio volumio[935]: info: Exploding uri spotify:track:782a3KaWiC0NI5VzTJznRq in service spop Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:782a3KaWiC0NI5VzTJznRq Jul 17 16:55:11 volumio volumio[935]: info: Exploding uri spotify:track:752q3k1ds8JckA7tIakICn in service spop Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:752q3k1ds8JckA7tIakICn Jul 17 16:55:11 volumio volumio[935]: info: Exploding uri spotify:track:3yvlcIteooc31cPjyWPTw1 in service spop Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:3yvlcIteooc31cPjyWPTw1 Jul 17 16:55:11 volumio volumio[935]: info: Exploding uri spotify:track:3Nd41wvVOjMlmxbwgdGiJp in service spop Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:3Nd41wvVOjMlmxbwgdGiJp Jul 17 16:55:11 volumio volumio[935]: info: Exploding uri spotify:track:5VYB1J9aXyYxjE5Z8kXRgK in service spop Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:track:5VYB1J9aXyYxjE5Z8kXRgK Jul 17 16:55:11 volumio volumio[935]: info: Preload queue cleared Jul 17 16:55:11 volumio volumio[935]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 17 16:55:11 volumio volumio[935]: info: CoreStateMachine::ClearQueue Jul 17 16:55:11 volumio volumio[935]: info: CoreStateMachine::stop Jul 17 16:55:11 volumio volumio[935]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 16:55:11 volumio volumio[935]: info: CoreStateMachine::stPlaybackTimer Jul 17 16:55:11 volumio volumio[935]: info: CoreStateMachine::updateTrackBlock Jul 17 16:55:11 volumio volumio[935]: info: CorePlayQueue::getTrackBlock Jul 17 16:55:11 volumio volumio[935]: info: CoreStateMachine::pushState Jul 17 16:55:11 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:55:11 volumio volumio[935]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 16:55:11 volumio volumio[935]: info: CoreCommandRouter::volumioPushState Jul 17 16:55:11 volumio volumio[935]: info: CoreStateMachine::serviceStop Jul 17 16:55:11 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:55:11 volumio volumio[935]: info: CoreCommandRouter::serviceStop Jul 17 16:55:11 volumio volumio[935]: info: Spotify Stop Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: SPOTIFY STOP Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: {"status":"play","position":3,"title":"Depeche Mode - Black Celebration","artist":"80s80s Depeche Mode","album":"","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music114/v4/39/68/f6/3968f6da-b5da-615e-9e1d-4f625dcde426/source/600x600bb.jpg","uri":"spotify:track:0cL6f54xJgTToLjECbnYiA","trackType":"80s80s Radio","codec":"ogg","seek":26016,"duration":259,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":null,"repeat":null,"repeatSingle":false,"consume":false,"volume":76,"dbVolume":null,"disableVolumeControl":false,"mute":false,"stream":"80s80s Radio","volatile":false,"service":"spop"} Jul 17 16:55:11 volumio volumio[935]: info: Sending Spotify command to local API: /player/pause Jul 17 16:55:11 volumio volumio[935]: info: CorePlayQueue::clearPlayQueue Jul 17 16:55:11 volumio volumio[935]: info: CorePlayQueue::saveQueue Jul 17 16:55:11 volumio volumio[935]: info: CoreCommandRouter::volumioPushQueue Jul 17 16:55:11 volumio volumio[935]: info: CoreStateMachine::addQueueItems Jul 17 16:55:11 volumio volumio[935]: info: CorePlayQueue::addQueueItems Jul 17 16:55:11 volumio volumio[935]: info: Preload queue cleared Jul 17 16:55:11 volumio volumio[935]: info: Adding Item to queue: spotify:user:spotify:playlist:41cHArqgqJYLjgVsdmt58S Jul 17 16:55:11 volumio volumio[935]: info: Exploding uri spotify:user:spotify:playlist:41cHArqgqJYLjgVsdmt58S in service spop Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: EXPLODING URI:spotify:user:spotify:playlist:41cHArqgqJYLjgVsdmt58S Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: RECEIVED VOLUMIO VOLUME 76 Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: SPOTIFY VOLUME 75 Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: VOLUMIO VOLUME 76 Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 17 16:55:11 volumio go-librespot[8717]: time="2025-07-17T16:55:11+02:00" level=debug msg="pause track at 48001ms" Jul 17 16:55:11 volumio go-librespot[8717]: time="2025-07-17T16:55:11+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jul 17 16:55:11 volumio go-librespot[8717]: time="2025-07-17T16:55:11+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jul 17 16:55:11 volumio go-librespot[8717]: time="2025-07-17T16:55:11+02:00" level=trace msg="emitting websocket event: paused" Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","play_origin":"go-librespot"}} Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: PUSH STATE SPOTIFY Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: {"status":"pause","service":"spop","title":"Promise","artist":"HAEVN","album":"Wide Awake","albumart":"https://i.scdn.co/image/ab67616d00001e02bbc2ddda9a1bfe3226b83e95","uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","trackType":"spotify","seek":49000,"duration":259,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Jul 17 16:55:11 volumio volumio[935]: info: CoreCommandRouter::servicePushState Jul 17 16:55:11 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:55:11 volumio volumio[935]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"Promise","artist":"HAEVN","album":"Wide Awake","albumart":"https://i.scdn.co/image/ab67616d00001e02bbc2ddda9a1bfe3226b83e95","uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","trackType":"spotify","seek":49000,"duration":259,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Jul 17 16:55:11 volumio volumio[935]: verbose: CURRENT POSITION 3 Jul 17 16:55:11 volumio volumio[935]: info: CoreStateMachine::syncState stateService pause Jul 17 16:55:11 volumio volumio[935]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:55:11 volumio volumio[935]: info: CoreStateMachine::pushState Jul 17 16:55:11 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:55:11 volumio volumio[935]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 16:55:11 volumio volumio[935]: info: CoreCommandRouter::volumioPushState Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","play_origin":"go-librespot"}} Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: PUSH STATE SPOTIFY Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: {"status":"pause","service":"spop","title":"Promise","artist":"HAEVN","album":"Wide Awake","albumart":"https://i.scdn.co/image/ab67616d00001e02bbc2ddda9a1bfe3226b83e95","uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","trackType":"spotify","seek":49000,"duration":259,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Jul 17 16:55:11 volumio volumio[935]: info: CoreCommandRouter::servicePushState Jul 17 16:55:11 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:55:11 volumio volumio[935]: verbose: STATE SERVICE {"status":"pause","service":"spop","title":"Promise","artist":"HAEVN","album":"Wide Awake","albumart":"https://i.scdn.co/image/ab67616d00001e02bbc2ddda9a1bfe3226b83e95","uri":"spotify:track:2tCTxCTAwsUJB6aUdGpGpP","trackType":"spotify","seek":49000,"duration":259,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Jul 17 16:55:11 volumio volumio[935]: verbose: CURRENT POSITION 3 Jul 17 16:55:11 volumio volumio[935]: info: CoreStateMachine::syncState stateService pause Jul 17 16:55:11 volumio volumio[935]: info: CoreStateMachine::syncState currentStatus stop Jul 17 16:55:11 volumio volumio[935]: info: CoreStateMachine::pushState Jul 17 16:55:11 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:55:11 volumio volumio[935]: info: CoreCommandRouter::volumioPushState Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: RECEIVED VOLUMIO VOLUME 76 Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: SPOTIFY VOLUME 75 Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: VOLUMIO VOLUME 76 Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: RECEIVED VOLUMIO VOLUME 76 Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: SPOTIFY VOLUME 75 Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: VOLUMIO VOLUME 76 Jul 17 16:55:11 volumio volumio[935]: SPOTIFY: DELTA VOLUME ENOUGH: false Jul 17 16:55:14 volumio volumio[935]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1p1ECuYJbpruHdfBoD3B38","service":"spop","name":"Just Another Lover","artist":"Ray Guell","album":"90's Love Songs","type":"song","duration":348,"albumart":"https://i.scdn.co/image/ab67616d0000b2734127ac68c37e56780d474083","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Jul 17 16:55:14 volumio volumio[935]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:0A5wAwjDcfHvD6RVCNbmGZ","service":"spop","name":"Joey","artist":"Concrete Blonde","album":"Bloodletting","type":"song","duration":248,"albumart":"https://i.scdn.co/image/ab67616d0000b273b954e4e028475c874ce236b3","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Jul 17 16:55:14 volumio volumio[935]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:4eJsGX9rhsU33HVz0hXGLS","service":"spop","name":"What Will I Do","artist":"Timmy T","album":"Time After Time","type":"song","duration":248,"albumart":"https://i.scdn.co/image/ab67616d0000b273ccfe352a0ebd4fdb7b438d0c","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Jul 17 16:55:14 volumio volumio[935]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:0NvJy5gPR591Qh2z22EAak","service":"spop","name":"Bizarre Love Triangle '94","artist":"New Order","album":"The Best of New Order","type":"song","duration":234,"albumart":"https://i.scdn.co/image/ab67616d0000b273c621e025f32cc28a1ec86e3b","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Jul 17 16:55:14 volumio volumio[935]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:1omLbJcba5NIGISJTlbzz1","service":"spop","name":"Misterious Song","artist":"K.R.B","album":"Sonido De Valencia - 1990 - 1999","type":"song","duration":255,"albumart":"https://i.scdn.co/image/ab67616d0000b273a289308bda95d69e1e3de35c","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Jul 17 16:55:14 volumio volumio[935]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:7ePrHHS6xME7NuQkqjKWy6","service":"spop","name":"Fantasy Girl","artist":"Johnny O.","album":"Featuring Fantasy Girl","type":"song","duration":475,"albumart":"https://i.scdn.co/image/ab67616d0000b2730ca1d1f2e08806fe03b290e7","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Jul 17 16:55:14 volumio volumio[935]: SPOTIFY: GET TRACK: [{"uri":"spotify:track:5qWCZ0QQ9Xq4s8E5uOiNhG","service":"spop","name":"Once In A Lifetime","artist":"Wolfsheim","album":"Spectators","type":"song","duration":221,"albumart":"https://i.scdn.co/image/ab67616d0000b27350785c797a732c29fe6ef05a","samplerate":"320 kbps","bitdepth":"16 bit","bitrate":"","codec":"ogg","trackType":"spotify"}] Jul 17 16:55:16 volumio volumio[935]: info: [1752764116094] [80s80s] Pushing the next song state Depeche Mode - Stripped and getting next track. Jul 17 16:55:16 volumio volumio[935]: info: CorePlayQueue::getTrack 3 Jul 17 16:55:16 volumio volumio[935]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 16:55:16 volumio volumio[935]: TypeError: Cannot set property 'name' of undefined Jul 17 16:55:16 volumio volumio[935]: at Controller80s80s.pushSongState (/data/plugins/music_service/80s80s/index.js:565:20) Jul 17 16:55:16 volumio volumio[935]: at Controller80s80s.playNextTrack (/data/plugins/music_service/80s80s/index.js:665:34) Jul 17 16:55:16 volumio volumio[935]: at NanoTimer.setTimeout (/data/plugins/music_service/80s80s/node_modules/nanotimer/lib/nanotimer.js:343:9) Jul 17 16:55:16 volumio volumio[935]: at Immediate. (/data/plugins/music_service/80s80s/node_modules/nanotimer/lib/nanotimer.js:327:66) Jul 17 16:55:16 volumio volumio[935]: at processImmediate (internal/timers.js:461:21) Jul 17 16:55:16 volumio volumio[935]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 16:55:16 volumio sudo[4781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-17 16:54 Jul 17 16:55:16 volumio sudo[4781]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST" VOLUMIO_VERSION="3.819" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"