-- 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"