-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Fri 2024-03-29 07:38:24 CET. -- Mar 29 07:38:15 audioserver ntpd[760]: receive: Unexpected origin timestamp 0xe8dd02f6.c9ffedb1 does not match aorg 0000000000.00000000 from server@149.62.187.162 xmt 0xe9b0e057.479d5f58 Mar 29 07:38:15 audioserver ntpd[760]: receive: Unexpected origin timestamp 0xe8dd02f6.ca01ac7a does not match aorg 0000000000.00000000 from server@212.6.50.243 xmt 0xe9b0e057.4754be21 Mar 29 07:38:15 audioserver systemd[1]: Starting Music Player Daemon... Mar 29 07:38:15 audioserver ntpd[760]: receive: Unexpected origin timestamp 0xe8dd02f6.c9fdd7af does not match aorg 0000000000.00000000 from server@93.94.88.50 xmt 0xe9b0e057.46aa7cd9 Mar 29 07:38:15 audioserver systemd[1]: Starting Daily apt download activities... Mar 29 07:38:15 audioserver volumio[697]: info: AutoStart - onStart Mar 29 07:38:15 audioserver volumio[697]: info: Volumio Calling Home Mar 29 07:38:15 audioserver volumio[697]: info: Completed starting Core Plugins Mar 29 07:38:15 audioserver volumio[697]: info: ------------------------------------------- Mar 29 07:38:15 audioserver volumio[697]: info: ----- MyVolumio plugins startup ---- Mar 29 07:38:15 audioserver volumio[697]: info: ------------------------------------------- Mar 29 07:38:15 audioserver volumio[697]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 29 07:38:15 audioserver volumio[697]: info: MPD Permissions set Mar 29 07:38:15 audioserver volumio[697]: info: Discovery: A device disappeared from network Mar 29 07:38:15 audioserver volumio[697]: info: Discovery: Device audioserver disappeared from network Mar 29 07:38:15 audioserver volumio[697]: info: Volumio called home Mar 29 07:38:15 audioserver volumio[697]: info: Spotify config file written Mar 29 07:38:15 audioserver sudo[914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Mar 29 07:38:15 audioserver sudo[914]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 07:38:15 audioserver volumio[697]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Mar 29 07:38:15 audioserver volumio[697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 07:38:15 audioserver volumio[697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 07:38:15 audioserver volumio[697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 07:38:15 audioserver volumio[697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 07:38:15 audioserver volumio[697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 07:38:16 audioserver volumio[697]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 07:38:16 audioserver volumio[697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 07:38:16 audioserver systemd[1]: Started go-librespot Daemon. Mar 29 07:38:16 audioserver go-librespot[923]: Librespot-go daemon starting... Mar 29 07:38:16 audioserver sudo[914]: pam_unix(sudo:session): session closed for user root Mar 29 07:38:16 audioserver volumio[697]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Mar 29 07:38:16 audioserver volumio[697]: SPOTIFY: BQC_0Bb73OTsCF0wNs35fsMFP77pHtfZxSTuv2v39azIIM7CAvSHknkaG5dNK8pAj8G0Z5F4TvnK8QpSSqR61H2Bv7YCvRTS9wO2h1yvZXQAcl6gsLsFETmUmdgk_2UEkhRYYq1fxNautA1Q1rRLJ80AftNipgrzwj-z-6h7ML4l3KWwbJ5ulRy62xMZV3AgSqfCAjuY7iXOhLlLPd7PxPiRLPijAHqAtq8EGfA6dzNjyD3XhkA Mar 29 07:38:16 audioserver volumio[697]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Mar 29 07:38:16 audioserver volumio[697]: info: New Spotify access token = BQC_0Bb73OTsCF0wNs35fsMFP77pHtfZxSTuv2v39azIIM7CAvSHknkaG5dNK8pAj8G0Z5F4TvnK8QpSSqR61H2Bv7YCvRTS9wO2h1yvZXQAcl6gsLsFETmUmdgk_2UEkhRYYq1fxNautA1Q1rRLJ80AftNipgrzwj-z-6h7ML4l3KWwbJ5ulRy62xMZV3AgSqfCAjuY7iXOhLlLPd7PxPiRLPijAHqAtq8EGfA6dzNjyD3XhkA Mar 29 07:38:16 audioserver volumio[697]: info: Spotify credentials grant success - running version from March 24, 2019 Mar 29 07:38:16 audioserver go-librespot[923]: time="2024-03-29T07:38:16+01:00" level=info msg="generated new device id: 3d32c640db022f8a1e5e82a20ec2794a89baf84e" Mar 29 07:38:16 audioserver go-librespot[923]: time="2024-03-29T07:38:16+01:00" level=debug msg="stored credentials found for 1233360321" Mar 29 07:38:16 audioserver volumio[697]: info: Discovery: adding b797d7d8-2e87-4917-bffc-3db707582012 Mar 29 07:38:16 audioserver volumio[697]: info: Discovery: Found device audioserver Mar 29 07:38:16 audioserver volumio[697]: info: CoreCommandRouter::volumioGetState Mar 29 07:38:16 audioserver volumio[697]: info: CorePlayQueue::getTrack 0 Mar 29 07:38:16 audioserver systemd[1]: apt-daily.service: Succeeded. Mar 29 07:38:16 audioserver systemd[1]: Started Daily apt download activities. Mar 29 07:38:16 audioserver volumio[697]: info: CoreCommandRouter::volumioGetState Mar 29 07:38:16 audioserver volumio[697]: info: CorePlayQueue::getTrack 0 Mar 29 07:38:16 audioserver systemd[1]: Starting Daily apt upgrade and clean activities... Mar 29 07:38:16 audioserver volumio[697]: SPOTIFY: User informations: {"display_name":"Matteo Mocellini","external_urls":{"spotify":"https://open.spotify.com/user/1233360321"},"href":"https://api.spotify.com/v1/users/1233360321","id":"1233360321","images":[{"url":"https://scontent-ams2-1.xx.fbcdn.net/v/t1.6435-1/107693713_10223986885282879_6450990579475624017_n.jpg?stp=cp0_dst-jpg_p50x50&_nc_cat=110&ccb=1-7&_nc_sid=5f2048&_nc_ohc=tU1DymIfsjgAX_1EMNb&_nc_oc=AdhJEKYWR2iPixEKC8PceT2oLAjyBKckZFmOWlFlxJMkun6SlhjuqtmGdNalPi5Uv9w&_nc_ht=scontent-ams2-1.xx&edm=AP4hL3IEAAAA&oh=00_AfC0nwhwPYjsGMv5bmwq86U5uruUcYfKDH6EcvgpwFjX3A&oe=662DC040","height":64,"width":64},{"url":"https://scontent-ams2-1.xx.fbcdn.net/v/t1.6435-1/107693713_10223986885282879_6450990579475624017_n.jpg?stp=dst-jpg_p320x320&_nc_cat=110&ccb=1-7&_nc_sid=5f2048&_nc_ohc=tU1DymIfsjgAX_1EMNb&_nc_oc=AdhJEKYWR2iPixEKC8PceT2oLAjyBKckZFmOWlFlxJMkun6SlhjuqtmGdNalPi5Uv9w&_nc_ht=scontent-ams2-1.xx&edm=AP4hL3IEAAAA&oh=00_AfA-Mwyxgvh6afW1v07mZow8XWxe6wUo0-MRNnsGvNrEsA&oe=662DC040","height":300,"width":300}],"type":"user","uri":"spotify:user:1233360321","followers":{"href":null,"total":70},"country":"IT","product":"premium","explicit_content":{"filter_enabled":false,"filter_locked":false},"email":"matteo_91_@hotmail.it"} Mar 29 07:38:16 audioserver volumio[697]: info: Spotify Successfully logged in Mar 29 07:38:16 audioserver volumio[697]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 29 07:38:16 audioserver volumio[697]: info: [1711694296927] CoreMusicLibrary::Adding element Spotify Mar 29 07:38:16 audioserver volumio[697]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 07:38:16 audioserver volumio[697]: Cannot find translation for source Spotify Mar 29 07:38:17 audioserver volumio[697]: info: New access token = BQAC8cdZR_sbxtRfpcgdDZgohxN9fTEtVOKTeIT8DPxzUZchk9rYNRiCml0G7YZ-C9H8LSFF8mOKJf-kvfH4Jn0-DYoaJ6uL0tmXdIzuiaUsOevvjAGGLHFl7utmzeztFHBzLUHCKkDleicBW9FKm2SInd-1p4QhB9t5gR0EYGSs_3VDoszypguTc_ehBaDd3A9oEN2Z_meONd8-m6nqWjLxOs2XB63B2oX6UjU_PGTnvdqyBr8 Mar 29 07:38:17 audioserver volumio[697]: info: New access token = BQDc8CgBDsDVlL_3FbfH5d0PxTU_jt82iykaU7_6G_S84dHrug4WxnQGPdpQVY099ZtOZb-EMwFfRSHYoql9pzqB71F0n4LLO-7eTnha3fh5Qy7fR5afnKZX9x8HKZwiBftdZfOZKu6z9oN8wihcAprP6yKQ2ZHYoV2WLycXadiTYwyR90i4cKAUiS_dscqxUxPq1ss5JtvpORgRhwneUSoGtZCyCHR80yTnJR39NDq4GX4HMmY Mar 29 07:38:17 audioserver volumio[697]: info: New access token = BQCRAVhTxH202DebliA38TPbLyrD4WEvToTlY2pNK6n9BkNzYumfGxSL885wskgzM4Yb9i7bypZ94q6iICwMvXmv911iPKOWJtVjXBNFgu2uRJpM-wOZwpv_wdnaK3kXqnssR93DIsmYbye0E929C6CWeU4CJhtwyiV7HEyVO5b-81gy7Ca5WpYruZIlUZHnp608ABIDfWuoylrTj4kzrVxlgL8BNxgJlqzWHZ3Na-ov8NfxI4k Mar 29 07:38:17 audioserver go-librespot[923]: time="2024-03-29T07:38:17+01:00" level=debug msg="obtained new client token: AACjiVQH/M1bvX8RYo/FoCauecnxeRCzmyPgc5AH/RixbgJsvyAT1F8NXi909ORUkCBCObefEfm1vFKHQKaCoo2Df2GxKD0hAmDNqT6H8avv3mjebajS/P169fNiOh4Ytqz2h4wsO6iXepe3y3Bs0Z3WFudwxqSgjIsmNsIPDtKYwaqG6CameWOzm2L/GFgNYEMnVFFbi2svCmRhy2jl55ugVhfbp4NVav04nV7Xg4k37lBOh/6R4ioCpXdcvA==" Mar 29 07:38:17 audioserver go-librespot[923]: time="2024-03-29T07:38:17+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Mar 29 07:38:17 audioserver mpd[898]: Mar 29 07:38 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 29 07:38:17 audioserver mpd[898]: Mar 29 07:38 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Mar 29 07:38:17 audioserver mpd[898]: Mar 29 07:38 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Mar 29 07:38:17 audioserver systemd[1]: Started Music Player Daemon. Mar 29 07:38:17 audioserver sudo[886]: pam_unix(sudo:session): session closed for user root Mar 29 07:38:17 audioserver volumio[697]: error: updateQueue error: null Mar 29 07:38:17 audioserver go-librespot[923]: time="2024-03-29T07:38:17+01:00" level=debug msg="completed keyexchange" Mar 29 07:38:17 audioserver systemd[1]: apt-daily-upgrade.service: Succeeded. Mar 29 07:38:17 audioserver systemd[1]: Started Daily apt upgrade and clean activities. Mar 29 07:38:17 audioserver go-librespot[923]: time="2024-03-29T07:38:17+01:00" level=debug msg="completed challenge" Mar 29 07:38:18 audioserver go-librespot[923]: time="2024-03-29T07:38:18+01:00" level=debug msg="authenticated as 1233360321" Mar 29 07:38:18 audioserver go-librespot[923]: time="2024-03-29T07:38:18+01:00" level=debug msg="authenticated as 1233360321" Mar 29 07:38:18 audioserver go-librespot[923]: time="2024-03-29T07:38:18+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Mar 29 07:38:18 audioserver go-librespot[923]: time="2024-03-29T07:38:18+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Mar 29 07:38:18 audioserver go-librespot[923]: time="2024-03-29T07:38:18+01:00" level=debug msg="dealer connection opened" Mar 29 07:38:18 audioserver go-librespot[923]: time="2024-03-29T07:38:18+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Mar 29 07:38:18 audioserver go-librespot[923]: time="2024-03-29T07:38:18+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Mar 29 07:38:18 audioserver go-librespot[923]: time="2024-03-29T07:38:18+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Mar 29 07:38:18 audioserver go-librespot[923]: time="2024-03-29T07:38:18+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Mar 29 07:38:18 audioserver go-librespot[923]: time="2024-03-29T07:38:18+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 513" Mar 29 07:38:18 audioserver go-librespot[923]: time="2024-03-29T07:38:18+01:00" level=debug msg="received connection id: NDMyYTMyOTUtOTBiMi00MTViLWFmYWMtY2JmMjYxMDZhZjFiK2RlYWxlcit0Y3A6Ly9nZXc0LWRlYWxlci1hLXQ0ODUuZ2V3NC5zcG90aWZ5Lm5ldDo1NzAwK0IwQjUyOTZGRjAxNkIwNkM3NDg2ODRFNzZEOEREQzVEMDhCQzgwRTc4MUUxQkNBMzVGMEY2MjA4RDBBRDBEODc=" Mar 29 07:38:18 audioserver go-librespot[923]: time="2024-03-29T07:38:18+01:00" level=debug msg="put connect state because NEW_DEVICE" Mar 29 07:38:19 audioserver sudo[1036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 29 07:38:19 audioserver sudo[1036]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 07:38:19 audioserver sudo[1036]: pam_unix(sudo:session): session closed for user root Mar 29 07:38:19 audioserver sudo[1038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 29 07:38:19 audioserver sudo[1038]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 07:38:19 audioserver sudo[1038]: pam_unix(sudo:session): session closed for user root Mar 29 07:38:19 audioserver sudo[1042]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 29 07:38:19 audioserver sudo[1042]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 07:38:19 audioserver systemd[1]: Started UPnP Renderer front-end to MPD. Mar 29 07:38:19 audioserver sudo[1042]: pam_unix(sudo:session): session closed for user root Mar 29 07:38:19 audioserver volumio[697]: info: Upmpdcli Daemon Started Mar 29 07:38:19 audioserver volumio[1044]: Generating RSA private key, 4096 bit long modulus (2 primes) Mar 29 07:38:19 audioserver volumio[697]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 29 07:38:19 audioserver volumio[697]: info: go-librespot daemon successfully initialized Mar 29 07:38:19 audioserver volumio[1044]: ..++++ Mar 29 07:38:22 audioserver volumio[697]: info: Initializing connection to go-librespot Websocket Mar 29 07:38:22 audioserver go-librespot[923]: time="2024-03-29T07:38:22+01:00" level=debug msg="new websocket client" Mar 29 07:38:22 audioserver volumio[697]: info: Connection to go-librespot Websocket established Mar 29 07:38:22 audioserver go-librespot[923]: time="2024-03-29T07:38:22+01:00" level=debug msg="handling transfer player command from 6cb635de61c1f4174ec141708e967873b216020c" Mar 29 07:38:22 audioserver go-librespot[923]: time="2024-03-29T07:38:22+01:00" level=trace msg="fetched new page 0 with 77 items (list: 77)" Mar 29 07:38:22 audioserver go-librespot[923]: time="2024-03-29T07:38:22+01:00" level=debug msg="shuffled context with seed 7783090970804646926 (len: 77, keep: 5)" Mar 29 07:38:22 audioserver go-librespot[923]: time="2024-03-29T07:38:22+01:00" level=debug msg="loading track spotify:track:7MIhUdNJtaOnDmC5nBC1fb (paused: false, position: 5812ms)" Mar 29 07:38:22 audioserver go-librespot[923]: time="2024-03-29T07:38:22+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 29 07:38:22 audioserver go-librespot[923]: time="2024-03-29T07:38:22+01:00" level=trace msg="emitting websocket event: will_play" Mar 29 07:38:22 audioserver volumio[697]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:7MIhUdNJtaOnDmC5nBC1fb","play_origin":"playlist"}} Mar 29 07:38:22 audioserver go-librespot[923]: time="2024-03-29T07:38:22+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 241" Mar 29 07:38:22 audioserver go-librespot[923]: time="2024-03-29T07:38:22+01:00" level=debug msg="selected format OGG_VORBIS_320 for spotify:track:7MIhUdNJtaOnDmC5nBC1fb" Mar 29 07:38:22 audioserver go-librespot[923]: time="2024-03-29T07:38:22+01:00" level=debug msg="requested aes key for file b80d8b82b08a997c63f1a33a0ea2b39712c09c3c, gid: 7MIhUdNJtaOnDmC5nBC1fb" Mar 29 07:38:23 audioserver go-librespot[923]: time="2024-03-29T07:38:23+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 3121" Mar 29 07:38:23 audioserver go-librespot[923]: time="2024-03-29T07:38:23+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 2113" Mar 29 07:38:23 audioserver go-librespot[923]: time="2024-03-29T07:38:23+01:00" level=debug msg="fetched first chunk of 13, total size is 6651292 bytes" Mar 29 07:38:23 audioserver go-librespot[923]: time="2024-03-29T07:38:23+01:00" level=trace msg="seek to 5812ms (diff: 93ms, samples: 256309, bytes: 204548)" Mar 29 07:38:23 audioserver go-librespot[923]: time="2024-03-29T07:38:23+01:00" level=info msg="loaded track \"Deep Down (feat. Never Dull)\" (uri: spotify:track:7MIhUdNJtaOnDmC5nBC1fb, paused: false, position: 5812ms, duration: 165752ms)" Mar 29 07:38:23 audioserver go-librespot[923]: time="2024-03-29T07:38:23+01:00" level=debug msg="fetched chunk 1/12, size: 524288" Mar 29 07:38:23 audioserver go-librespot[923]: time="2024-03-29T07:38:23+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 29 07:38:23 audioserver go-librespot[923]: time="2024-03-29T07:38:23+01:00" level=trace msg="emitting websocket event: metadata" Mar 29 07:38:23 audioserver volumio[697]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:7MIhUdNJtaOnDmC5nBC1fb","name":"Deep Down (feat. Never Dull)","artist_names":["Alok","Ella Eyre","Kenny Dope","Never Dull"],"album_name":"Deep Down (feat. Never Dull)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02ed443f0fff29eee63c9ede20","position":5812,"duration":165752,"release_date":"year:2022 month:6 day:17","track_number":1,"disc_number":1}} Mar 29 07:38:23 audioserver go-librespot[923]: time="2024-03-29T07:38:23+01:00" level=trace msg="emitting websocket event: active" Mar 29 07:38:23 audioserver volumio[697]: SPOTIFY: received: {"type":"active","data":null} Mar 29 07:38:23 audioserver volumio[697]: info: Aligning Spotify Volume to Volumio Volume Mar 29 07:38:23 audioserver volumio[697]: info: CoreCommandRouter::volumioGetState Mar 29 07:38:23 audioserver volumio[697]: info: CorePlayQueue::getTrack 0 Mar 29 07:38:23 audioserver volumio[697]: info: Setting Spotify Volume from Volumio: 33 Mar 29 07:38:23 audioserver go-librespot[923]: time="2024-03-29T07:38:23+01:00" level=debug msg="sending successful reply for delaer request" Mar 29 07:38:23 audioserver go-librespot[923]: time="2024-03-29T07:38:23+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Mar 29 07:38:23 audioserver go-librespot[923]: time="2024-03-29T07:38:23+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Mar 29 07:38:23 audioserver go-librespot[923]: time="2024-03-29T07:38:23+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Mar 29 07:38:23 audioserver go-librespot[923]: time="2024-03-29T07:38:23+01:00" level=debug msg="fetched chunk 3/12, size: 524288" Mar 29 07:38:23 audioserver go-librespot[923]: time="2024-03-29T07:38:23+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 29 07:38:23 audioserver go-librespot[923]: time="2024-03-29T07:38:23+01:00" level=trace msg="emitting websocket event: playing" Mar 29 07:38:23 audioserver volumio[697]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:7MIhUdNJtaOnDmC5nBC1fb","play_origin":"playlist"}} Mar 29 07:38:23 audioserver volumio[697]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 07:38:23 audioserver volumio[697]: TypeError: Cannot read property 'service' of undefined Mar 29 07:38:23 audioserver volumio[697]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:336:50) Mar 29 07:38:23 audioserver volumio[697]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:262:18) Mar 29 07:38:23 audioserver volumio[697]: at WebSocket.message (/data/plugins/music_service/spop/index.js:189:14) Mar 29 07:38:23 audioserver volumio[697]: at WebSocket.emit (events.js:315:20) Mar 29 07:38:23 audioserver volumio[697]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1203:20) Mar 29 07:38:23 audioserver volumio[697]: at Receiver.emit (events.js:315:20) Mar 29 07:38:23 audioserver volumio[697]: at /data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:608:16 Mar 29 07:38:23 audioserver volumio[697]: at internal/process/task_queues.js:149:7 Mar 29 07:38:23 audioserver volumio[697]: at AsyncResource.runInAsyncScope (async_hooks.js:197:9) Mar 29 07:38:23 audioserver volumio[697]: at AsyncResource.runMicrotask (internal/process/task_queues.js:146:8) Mar 29 07:38:23 audioserver volumio[697]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Mar 29 07:38:23 audioserver volumio[697]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 07:38:23 audioserver go-librespot[923]: time="2024-03-29T07:38:23+01:00" level=debug msg="fetched chunk 2/12, size: 524288" Mar 29 07:38:24 audioserver sudo[1072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-29 07:37 Mar 29 07:38:24 audioserver sudo[1072]: 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="893d2e91c55a7857b58762e70c2f65b9d163562b" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Oct 2023 03:38:28 PM CEST" VOLUMIO_VERSION="3.569" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4163d3756b55b3bf7c480d7285f68954"