-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Tue 2025-02-18 12:07:57 CET. -- Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=debug msg="obtained new client token: AACBtkbNruU5vRNZHmXR80DqX44WUAp3N3LemR24OFWYzqp7us1onhVvXgBh2TJfZPiR9qF6pEZWznT4uXe8cdzoAZ0i6sQ5DIkWQaSFoVFeduCrl0pPjUTRm7Jw5c9NPulpqszP3XQJ+htjFvZ+lUO+VzbUeYp+kAyiA8RzZmRsD+7iOt0azRAYZrOrdh51R4KONkEOtzkWCC566Lyhk9ibEhZFdclHf+NPY4rW6rITKNJz+iNWFQWO" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=debug msg="completed keyexchange" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=debug msg="completed challenge" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=info msg="authenticated AP as shadow-viper" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=info msg="authenticated Login5 as shadow-viper" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=info msg="accepted zeroconf user shadow-viper from iPhone" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=debug msg="dealer connection opened" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=trace msg="starting accesspoint recv loop" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=trace msg="starting dealer recv loop" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=trace msg="received accesspoint ping" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=debug msg="received connection id: NWYyYzllY2YtZTJiOS00OWU3LWI0ZDgtMWI3NDgzZDFjYWE2K2RlYWxlcit0Y3A6Ly8wYWNhNTkwYS5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArODFEOUQ2QzlCNzcxRDA0RTdFRTlGQjk2M0FBMTA2MDMyMTJEMkU4QkMyMDFFNzE4REQzNUM3RDJBMEFDOURDNw==" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=debug msg="put connect state because NEW_DEVICE" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=trace msg="received accesspoint pong ack" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=debug msg="handling transfer player command from 4817a6539547b2c19074071d5f8158d51eb7274e" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=debug msg="resolved context of track" uri="spotify:search:hanging+tree+remix" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=trace msg="fetched new page 0 with 1 items (list: 1)" uri="spotify:search:hanging+tree+remix" Feb 18 12:06:05 volumio go-librespot[2104]: time="2025-02-18T12:06:05+01:00" level=debug msg="loading track (paused: false, position: 5578ms)" uri="spotify:track:2rhSduBNjteGhpqGA55PV1" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=trace msg="emitting websocket event: will_play" Feb 18 12:06:06 volumio volumio[1055]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:2rhSduBNjteGhpqGA55PV1","play_origin":"search"}} Feb 18 12:06:06 volumio volumio[1055]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:2rhSduBNjteGhpqGA55PV1","play_origin":"search"}} Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=debug msg="selected format OGG_VORBIS_320 (9663e9e3a4d55c70ffa7775ec5c47ed1bd8d5a7e)" uri="spotify:track:2rhSduBNjteGhpqGA55PV1" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=debug msg="requested aes key for file 9663e9e3a4d55c70ffa7775ec5c47ed1bd8d5a7e, gid: 2rhSduBNjteGhpqGA55PV1" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 241" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1348" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1118" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=debug msg="fetched first chunk of 15, total size is 7759015 bytes" uri="spotify:track:2rhSduBNjteGhpqGA55PV1" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=trace msg="seek to 5578ms (diff: 210ms, samples: 245989, bytes: 228225)" uri="spotify:track:2rhSduBNjteGhpqGA55PV1" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=debug msg="created new output device" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=debug msg="alsa driver configured, rate = 44100 bps, period time = 124988 us, period size = 5512 frames, buffer time = 500000 us, buffer size = 22050 frames, periods per buffer = 4 frames" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=info msg="loaded track \"Hanging Tree - Future House Remix\" (paused: false, position: 5578ms, duration: 170000ms, prefetched: false)" uri="spotify:track:2rhSduBNjteGhpqGA55PV1" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=debug msg="fetched chunk 2/14, size: 524288" uri="spotify:track:2rhSduBNjteGhpqGA55PV1" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=trace msg="scheduling prefetch in 135s" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=trace msg="emitting websocket event: metadata" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=trace msg="emitting websocket event: active" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=debug msg="sending successful reply for dealer request" Feb 18 12:06:06 volumio volumio[1055]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:2rhSduBNjteGhpqGA55PV1","name":"Hanging Tree - Future House Remix","artist_names":["Danny Darko","Julien Kelland","Alex Great"],"album_name":"Hanging Tree (Future House Remix)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02c4ec506b56da221d0cc85b43","position":5578,"duration":170000,"release_date":"year:2019 month:5 day:10","track_number":1,"disc_number":1}} Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Feb 18 12:06:06 volumio volumio[1055]: SPOTIFY: received: {"type":"active","data":null} Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Feb 18 12:06:06 volumio volumio[1055]: info: Aligning Spotify Volume to Volumio Volume Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Feb 18 12:06:06 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState Feb 18 12:06:06 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 Feb 18 12:06:06 volumio volumio[1055]: info: Setting Spotify Volume from Volumio: 80 Feb 18 12:06:06 volumio volumio[1055]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:2rhSduBNjteGhpqGA55PV1","name":"Hanging Tree - Future House Remix","artist_names":["Danny Darko","Julien Kelland","Alex Great"],"album_name":"Hanging Tree (Future House Remix)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02c4ec506b56da221d0cc85b43","position":5578,"duration":170000,"release_date":"year:2019 month:5 day:10","track_number":1,"disc_number":1}} Feb 18 12:06:06 volumio volumio[1055]: SPOTIFY: received: {"type":"active","data":null} Feb 18 12:06:06 volumio volumio[1055]: info: Aligning Spotify Volume to Volumio Volume Feb 18 12:06:06 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState Feb 18 12:06:06 volumio volumio[1055]: info: CorePlayQueue::getTrack 0 Feb 18 12:06:06 volumio volumio[1055]: info: Setting Spotify Volume from Volumio: 80 Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=debug msg="fetched chunk 3/14, size: 524288" uri="spotify:track:2rhSduBNjteGhpqGA55PV1" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=trace msg="emitting websocket event: playing" Feb 18 12:06:06 volumio volumio[1055]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:2rhSduBNjteGhpqGA55PV1","play_origin":"search"}} Feb 18 12:06:06 volumio volumio[1055]: info: Spotify is playing in volatile mode Feb 18 12:06:06 volumio volumio[1055]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 12:06:06 volumio volumio[1055]: SPOTIFY: UNSET VOLATILE Feb 18 12:06:06 volumio volumio[1055]: SPOTIFY: {"status":"play","position":0,"title":"The Normal - Warm Leatherette","artist":"80s80s Wave","album":"","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music4/v4/d4/e2/a8/d4e2a800-7cb4-7906-4a0f-2eb66a847461/source/600x600bb.jpg","uri":"http://streams.80s80s.de/wave/mp3-192/volumio","trackType":"80s80s Radio","seek":0,"duration":"200","samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":null,"repeat":null,"repeatSingle":false,"consume":false,"volume":80,"dbVolume":null,"disableVolumeControl":false,"mute":false,"stream":"80s80s Radio","volatile":false,"service":"80s80s"} Feb 18 12:06:06 volumio volumio[1055]: info: Setting Spotify stop after unset volatile call Feb 18 12:06:06 volumio volumio[1055]: SPOTIFY: PUSH STATE SPOTIFY Feb 18 12:06:06 volumio volumio[1055]: SPOTIFY: {"status":"play","service":"spop","title":"Hanging Tree - Future House Remix","artist":"Danny Darko, Julien Kelland, Alex Great","album":"Hanging Tree (Future House Remix)","albumart":"https://i.scdn.co/image/ab67616d00001e02c4ec506b56da221d0cc85b43","uri":"spotify:track:2rhSduBNjteGhpqGA55PV1","trackType":"spotify","seek":5578,"duration":170,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Feb 18 12:06:06 volumio volumio[1055]: info: CoreCommandRouter::servicePushState Feb 18 12:06:06 volumio volumio[1055]: info: CoreStateMachine::pushState Feb 18 12:06:06 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 12:06:06 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState Feb 18 12:06:06 volumio go-librespot[2104]: time="2025-02-18T12:06:06+01:00" level=debug msg="fetched chunk 1/14, size: 524288" uri="spotify:track:2rhSduBNjteGhpqGA55PV1" Feb 18 12:06:06 volumio volumio[1055]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:2rhSduBNjteGhpqGA55PV1","play_origin":"search"}} Feb 18 12:06:06 volumio volumio[1055]: info: Spotify is playing in volatile mode Feb 18 12:06:06 volumio volumio[1055]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 18 12:06:06 volumio volumio[1055]: SPOTIFY: UNSET VOLATILE Feb 18 12:06:06 volumio volumio[1055]: SPOTIFY: {"status":"play","position":0,"title":"The Normal - Warm Leatherette","artist":"80s80s Wave","album":"","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music4/v4/d4/e2/a8/d4e2a800-7cb4-7906-4a0f-2eb66a847461/source/600x600bb.jpg","uri":"http://streams.80s80s.de/wave/mp3-192/volumio","trackType":"80s80s Radio","seek":0,"duration":"200","samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":null,"repeat":null,"repeatSingle":false,"consume":false,"volume":80,"dbVolume":null,"disableVolumeControl":false,"mute":false,"stream":"80s80s Radio","volatile":false,"service":"80s80s"} Feb 18 12:06:06 volumio volumio[1055]: info: Setting Spotify stop after unset volatile call Feb 18 12:06:06 volumio volumio[1055]: SPOTIFY: PUSH STATE SPOTIFY Feb 18 12:06:06 volumio volumio[1055]: SPOTIFY: {"status":"play","service":"spop","title":"Hanging Tree - Future House Remix","artist":"Danny Darko, Julien Kelland, Alex Great","album":"Hanging Tree (Future House Remix)","albumart":"https://i.scdn.co/image/ab67616d00001e02c4ec506b56da221d0cc85b43","uri":"spotify:track:2rhSduBNjteGhpqGA55PV1","trackType":"spotify","seek":5578,"duration":170,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Feb 18 12:06:06 volumio volumio[1055]: info: CoreCommandRouter::servicePushState Feb 18 12:06:06 volumio volumio[1055]: info: CoreStateMachine::pushState Feb 18 12:06:06 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState Feb 18 12:06:06 volumio volumio[1055]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Feb 18 12:06:06 volumio volumio[1055]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Feb 18 12:06:07 volumio volumio[1055]: SPOTIFY: PUSH STATE SPOTIFY Feb 18 12:06:07 volumio volumio[1055]: SPOTIFY: {"status":"play","service":"spop","title":"Hanging Tree - Future House Remix","artist":"Danny Darko, Julien Kelland, Alex Great","album":"Hanging Tree (Future House Remix)","albumart":"https://i.scdn.co/image/ab67616d00001e02c4ec506b56da221d0cc85b43","uri":"spotify:track:2rhSduBNjteGhpqGA55PV1","trackType":"spotify","seek":5578,"duration":170,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Feb 18 12:06:07 volumio volumio[1055]: info: CoreCommandRouter::servicePushState Feb 18 12:06:07 volumio volumio[1055]: info: CoreStateMachine::pushState Feb 18 12:06:07 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState Feb 18 12:06:07 volumio volumio[1055]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Feb 18 12:06:07 volumio volumio[1055]: SPOTIFY: PUSH STATE SPOTIFY Feb 18 12:06:07 volumio volumio[1055]: SPOTIFY: {"status":"play","service":"spop","title":"Hanging Tree - Future House Remix","artist":"Danny Darko, Julien Kelland, Alex Great","album":"Hanging Tree (Future House Remix)","albumart":"https://i.scdn.co/image/ab67616d00001e02c4ec506b56da221d0cc85b43","uri":"spotify:track:2rhSduBNjteGhpqGA55PV1","trackType":"spotify","seek":5578,"duration":170,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Feb 18 12:06:07 volumio volumio[1055]: info: CoreCommandRouter::servicePushState Feb 18 12:06:07 volumio volumio[1055]: info: CoreStateMachine::pushState Feb 18 12:06:07 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState Feb 18 12:06:07 volumio volumio[1055]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Feb 18 12:06:07 volumio volumio[1055]: info: Spotify Stop Feb 18 12:06:07 volumio volumio[1055]: SPOTIFY: SPOTIFY STOP Feb 18 12:06:07 volumio volumio[1055]: SPOTIFY: {"status":"play","title":"Hanging Tree - Future House Remix","artist":"Danny Darko, Julien Kelland, Alex Great","album":"Hanging Tree (Future House Remix)","albumart":"https://i.scdn.co/image/ab67616d00001e02c4ec506b56da221d0cc85b43","uri":"spotify:track:2rhSduBNjteGhpqGA55PV1","trackType":"spotify","codec":"ogg","seek":5578,"duration":170,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":null,"repeat":null,"repeatSingle":null,"consume":false,"volume":80,"dbVolume":null,"mute":false,"disableVolumeControl":false,"stream":false,"volatile":true,"service":"spop"} Feb 18 12:06:07 volumio volumio[1055]: info: Spotify Stop Feb 18 12:06:07 volumio volumio[1055]: SPOTIFY: SPOTIFY STOP Feb 18 12:06:07 volumio volumio[1055]: SPOTIFY: {"status":"play","title":"Hanging Tree - Future House Remix","artist":"Danny Darko, Julien Kelland, Alex Great","album":"Hanging Tree (Future House Remix)","albumart":"https://i.scdn.co/image/ab67616d00001e02c4ec506b56da221d0cc85b43","uri":"spotify:track:2rhSduBNjteGhpqGA55PV1","trackType":"spotify","codec":"ogg","seek":5578,"duration":170,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":null,"repeat":null,"repeatSingle":null,"consume":false,"volume":80,"dbVolume":null,"mute":false,"disableVolumeControl":false,"stream":false,"volatile":true,"service":"spop"} Feb 18 12:06:08 volumio volumio[1055]: SPOTIFY: SETTING SPOTIFY VOLUME 80 Feb 18 12:06:08 volumio volumio[1055]: info: Sending Spotify command with payload to local API: /player/volume Feb 18 12:06:08 volumio go-librespot[2104]: time="2025-02-18T12:06:08+01:00" level=debug msg="update volume to 52428/65535" Feb 18 12:06:09 volumio go-librespot[2104]: time="2025-02-18T12:06:09+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Feb 18 12:06:09 volumio go-librespot[2104]: time="2025-02-18T12:06:09+01:00" level=trace msg="emitting websocket event: volume" Feb 18 12:06:09 volumio volumio[1055]: SPOTIFY: received: {"type":"volume","data":{"value":80,"max":100}} Feb 18 12:06:09 volumio volumio[1055]: SPOTIFY: RECEIVED SPOTIFY VOLUME 80 Feb 18 12:06:09 volumio volumio[1055]: SPOTIFY: received: {"type":"volume","data":{"value":80,"max":100}} Feb 18 12:06:09 volumio volumio[1055]: SPOTIFY: RECEIVED SPOTIFY VOLUME 80 Feb 18 12:06:13 volumio go-librespot[2104]: time="2025-02-18T12:06:13+01:00" level=debug msg="fetched chunk 4/14, size: 524288" uri="spotify:track:2rhSduBNjteGhpqGA55PV1" Feb 18 12:06:18 volumio ntpd[760]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Feb 18 12:06:26 volumio go-librespot[2104]: time="2025-02-18T12:06:26+01:00" level=debug msg="fetched chunk 5/14, size: 524288" uri="spotify:track:2rhSduBNjteGhpqGA55PV1" Feb 18 12:06:35 volumio go-librespot[2104]: time="2025-02-18T12:06:35+01:00" level=trace msg="sent dealer ping" Feb 18 12:06:35 volumio go-librespot[2104]: time="2025-02-18T12:06:35+01:00" level=trace msg="received dealer pong" Feb 18 12:06:38 volumio volumio[1055]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 12:06:39 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 18 12:06:39 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 18 12:06:39 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 18 12:06:39 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 12:06:39 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 12:06:39 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 12:06:39 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 12:06:39 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 12:06:39 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 12:06:39 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 18 12:06:39 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 18 12:06:39 volumio go-librespot[2104]: time="2025-02-18T12:06:39+01:00" level=debug msg="fetched chunk 6/14, size: 524288" uri="spotify:track:2rhSduBNjteGhpqGA55PV1" Feb 18 12:06:50 volumio go-librespot[2104]: time="2025-02-18T12:06:50+01:00" level=debug msg="fetched chunk 7/14, size: 524288" uri="spotify:track:2rhSduBNjteGhpqGA55PV1" Feb 18 12:06:58 volumio volumio[1055]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 12:06:58 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 18 12:06:58 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 18 12:06:58 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 18 12:06:58 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 12:06:58 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 12:06:58 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 12:06:58 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 12:06:58 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 12:06:58 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 12:06:58 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 12:06:58 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 18 12:06:58 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 18 12:07:01 volumio go-librespot[2104]: time="2025-02-18T12:07:01+01:00" level=debug msg="fetched chunk 8/14, size: 524288" uri="spotify:track:2rhSduBNjteGhpqGA55PV1" Feb 18 12:07:05 volumio go-librespot[2104]: time="2025-02-18T12:07:05+01:00" level=trace msg="sent dealer ping" Feb 18 12:07:05 volumio go-librespot[2104]: time="2025-02-18T12:07:05+01:00" level=trace msg="received dealer pong" Feb 18 12:07:12 volumio go-librespot[2104]: time="2025-02-18T12:07:12+01:00" level=debug msg="fetched chunk 9/14, size: 524288" uri="spotify:track:2rhSduBNjteGhpqGA55PV1" Feb 18 12:07:23 volumio go-librespot[2104]: time="2025-02-18T12:07:23+01:00" level=debug msg="fetched chunk 10/14, size: 524288" uri="spotify:track:2rhSduBNjteGhpqGA55PV1" Feb 18 12:07:25 volumio volumio[1055]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 12:07:25 volumio volumio[1055]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 12:07:25 volumio volumio[1055]: info: Retrieving Cloud Streaming UI Feb 18 12:07:25 volumio volumio[1055]: info: Getting Tidal Cloud Configuration Feb 18 12:07:25 volumio volumio[1055]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 12:07:25 volumio volumio[1055]: info: Getting Qobuz Cloud Configuration Feb 18 12:07:25 volumio volumio[1055]: info: Asking plugin for UI Config Feb 18 12:07:25 volumio volumio[1055]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 12:07:25 volumio volumio[1055]: info: Getting Spotify Cloud Configuration Feb 18 12:07:25 volumio volumio[1055]: info: Asking plugin for UI Config Feb 18 12:07:25 volumio volumio[1055]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 12:07:25 volumio volumio[1055]: info: Saving Spotify Acccount Feb 18 12:07:25 volumio volumio[1055]: info: Got Tidal Cloud Configuration Feb 18 12:07:25 volumio volumio[1055]: info: Got it Feb 18 12:07:25 volumio volumio[1055]: info: Got it Feb 18 12:07:25 volumio volumio[1055]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 18 12:07:25 volumio volumio[1055]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 12:07:25 volumio volumio[1055]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Feb 18 12:07:25 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 18 12:07:25 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 18 12:07:25 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 18 12:07:25 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 12:07:25 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 12:07:25 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 12:07:25 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 12:07:25 volumio volumio[1055]: info: CoreCommandRouter::volumioGetBrowseSources Feb 18 12:07:25 volumio volumio[1055]: info: CoreCommandRouter::volumioGetBrowseSources Feb 18 12:07:25 volumio volumio[1055]: info: CoreCommandRouter::volumioGetBrowseSources Feb 18 12:07:27 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 18 12:07:27 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 18 12:07:31 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 18 12:07:34 volumio go-librespot[2104]: time="2025-02-18T12:07:34+01:00" level=debug msg="fetched chunk 11/14, size: 524288" uri="spotify:track:2rhSduBNjteGhpqGA55PV1" Feb 18 12:07:35 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 18 12:07:35 volumio go-librespot[2104]: time="2025-02-18T12:07:35+01:00" level=trace msg="sent dealer ping" Feb 18 12:07:35 volumio go-librespot[2104]: time="2025-02-18T12:07:35+01:00" level=trace msg="received dealer pong" Feb 18 12:07:39 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 18 12:07:45 volumio go-librespot[2104]: time="2025-02-18T12:07:45+01:00" level=debug msg="fetched chunk 12/14, size: 524288" uri="spotify:track:2rhSduBNjteGhpqGA55PV1" Feb 18 12:07:47 volumio go-librespot[2104]: time="2025-02-18T12:07:47+01:00" level=debug msg="handling pause player command from 4817a6539547b2c19074071d5f8158d51eb7274e" Feb 18 12:07:47 volumio go-librespot[2104]: time="2025-02-18T12:07:47+01:00" level=debug msg="pause track at 106497ms" Feb 18 12:07:47 volumio go-librespot[2104]: time="2025-02-18T12:07:47+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 18 12:07:47 volumio go-librespot[2104]: time="2025-02-18T12:07:47+01:00" level=debug msg="sending successful reply for dealer request" Feb 18 12:07:47 volumio go-librespot[2104]: time="2025-02-18T12:07:47+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 18 12:07:47 volumio go-librespot[2104]: time="2025-02-18T12:07:47+01:00" level=trace msg="emitting websocket event: paused" Feb 18 12:07:47 volumio volumio[1055]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:2rhSduBNjteGhpqGA55PV1","play_origin":"search"}} Feb 18 12:07:47 volumio volumio[1055]: SPOTIFY: PUSH STATE SPOTIFY Feb 18 12:07:47 volumio volumio[1055]: SPOTIFY: {"status":"pause","service":"spop","title":"Hanging Tree - Future House Remix","artist":"Danny Darko, Julien Kelland, Alex Great","album":"Hanging Tree (Future House Remix)","albumart":"https://i.scdn.co/image/ab67616d00001e02c4ec506b56da221d0cc85b43","uri":"spotify:track:2rhSduBNjteGhpqGA55PV1","trackType":"spotify","seek":106578,"duration":170,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Feb 18 12:07:47 volumio volumio[1055]: info: CoreCommandRouter::servicePushState Feb 18 12:07:47 volumio volumio[1055]: info: CoreStateMachine::pushState Feb 18 12:07:47 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 12:07:47 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState Feb 18 12:07:47 volumio volumio[1055]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:2rhSduBNjteGhpqGA55PV1","play_origin":"search"}} Feb 18 12:07:47 volumio volumio[1055]: SPOTIFY: PUSH STATE SPOTIFY Feb 18 12:07:47 volumio volumio[1055]: SPOTIFY: {"status":"pause","service":"spop","title":"Hanging Tree - Future House Remix","artist":"Danny Darko, Julien Kelland, Alex Great","album":"Hanging Tree (Future House Remix)","albumart":"https://i.scdn.co/image/ab67616d00001e02c4ec506b56da221d0cc85b43","uri":"spotify:track:2rhSduBNjteGhpqGA55PV1","trackType":"spotify","seek":106578,"duration":170,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Feb 18 12:07:47 volumio volumio[1055]: info: CoreCommandRouter::servicePushState Feb 18 12:07:47 volumio volumio[1055]: info: CoreStateMachine::pushState Feb 18 12:07:48 volumio volumio[1055]: info: CoreCommandRouter::volumioPushState Feb 18 12:07:48 volumio volumio[1055]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Feb 18 12:07:48 volumio volumio[1055]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Feb 18 12:07:48 volumio volumio[1055]: info: touch_display: Setting screensaver timeout to 120 seconds. Feb 18 12:07:55 volumio volumio[1055]: info: [1739876875923] [80s80s] Pushing the next song state Blancmange - Living On the Ceiling and getting next track. Feb 18 12:07:55 volumio volumio[1055]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 12:07:55 volumio volumio[1055]: TypeError: Cannot set property 'name' of undefined Feb 18 12:07:55 volumio volumio[1055]: at Controller80s80s.pushSongState (/data/plugins/music_service/80s80s/index.js:565:20) Feb 18 12:07:55 volumio volumio[1055]: at Controller80s80s.playNextTrack (/data/plugins/music_service/80s80s/index.js:665:34) Feb 18 12:07:55 volumio volumio[1055]: at NanoTimer.setTimeout (/data/plugins/music_service/80s80s/node_modules/nanotimer/lib/nanotimer.js:343:9) Feb 18 12:07:55 volumio volumio[1055]: at Immediate. (/data/plugins/music_service/80s80s/node_modules/nanotimer/lib/nanotimer.js:327:66) Feb 18 12:07:55 volumio volumio[1055]: at processImmediate (internal/timers.js:461:21) Feb 18 12:07:55 volumio volumio[1055]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 12:07:57 volumio sudo[2991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-18 12:06 Feb 18 12:07:57 volumio sudo[2991]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"