-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Mon 2025-05-12 07:09:17 CEST. --
May 12 07:09:07 volumio ntpd[826]: receive: Unexpected origin timestamp 0xea09dfe6.b309c23c does not match aorg 0000000000.00000000 from server@5.250.184.159 xmt 0xebcc00f3.5c6c8330
May 12 07:09:07 volumio ntpd[826]: receive: Unexpected origin timestamp 0xea09dfe6.b3151d09 does not match aorg 0000000000.00000000 from server@94.143.139.219 xmt 0xebcc00f3.5cab0a0e
May 12 07:09:07 volumio ntpd[826]: receive: Unexpected origin timestamp 0xea09dfe6.b31acf73 does not match aorg 0000000000.00000000 from server@213.165.71.32 xmt 0xebcc00f3.5c20136b
May 12 07:09:07 volumio ntpd[826]: receive: Unexpected origin timestamp 0xea09dfe6.b31eb116 does not match aorg 0000000000.00000000 from server@212.227.232.46 xmt 0xebcc00f3.5cc24d00
May 12 07:09:07 volumio ntpd[826]: receive: Unexpected origin timestamp 0xea09dfe6.b321ad8d does not match aorg 0000000000.00000000 from server@5.250.191.170 xmt 0xebcc00f3.5bf095d4
May 12 07:09:07 volumio ntpd[826]: receive: Unexpected origin timestamp 0xea09dfe6.b311f52e does not match aorg 0000000000.00000000 from server@90.68.206.60 xmt 0xebcc00f3.5bd51475
May 12 07:09:07 volumio ntpd[826]: receive: Unexpected origin timestamp 0xea09dfe6.b317f887 does not match aorg 0000000000.00000000 from server@84.77.195.114 xmt 0xebcc00f3.6006617c
May 12 07:09:07 volumio systemd[1]: Starting Daily apt download activities...
May 12 07:09:08 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart.
May 12 07:09:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11.
May 12 07:09:08 volumio systemd[1]: Stopped go-librespot Daemon.
May 12 07:09:08 volumio systemd[1]: Started go-librespot Daemon.
May 12 07:09:08 volumio go-librespot[1414]: Librespot-go daemon starting...
May 12 07:09:08 volumio go-librespot[1414]: time="2025-05-12T07:09:08+02:00" level=info msg="generated new device id: d32e2f7883976c5a4f392d0f6435809c3b66b5af"
May 12 07:09:08 volumio volumio[1055]: info: Initializing connection to go-librespot Websocket
May 12 07:09:08 volumio go-librespot[1414]: time="2025-05-12T07:09:08+02:00" level=debug msg="new websocket client"
May 12 07:09:08 volumio volumio[1055]: info: Connection to go-librespot Websocket established
May 12 07:09:08 volumio volumio[1055]: info: Discovery: A device disappeared from network
May 12 07:09:08 volumio volumio[1055]: info: Discovery: Device volumio disappeared from network
May 12 07:09:08 volumio volumio[1055]: info: Discovery: A device disappeared from network
May 12 07:09:08 volumio go-librespot[1414]: time="2025-05-12T07:09:08+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]"
May 12 07:09:08 volumio go-librespot[1414]: time="2025-05-12T07:09:08+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
May 12 07:09:08 volumio go-librespot[1414]: time="2025-05-12T07:09:08+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
May 12 07:09:08 volumio go-librespot[1414]: time="2025-05-12T07:09:08+02:00" level=debug msg="zeroconf server listening on port 37323"
May 12 07:09:09 volumio volumio[1055]: info: Discovery: adding d11f6002-ab22-4007-9745-13341cbf1155
May 12 07:09:09 volumio volumio[1055]: info: Discovery: Found device Volumio
May 12 07:09:09 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState
May 12 07:09:09 volumio volumio[1055]: info: CorePlayQueue::getTrack 0
May 12 07:09:09 volumio volumio[1055]: info: Discovery: this is already registered, d11f6002-ab22-4007-9745-13341cbf1155
May 12 07:09:09 volumio volumio[1055]: info: Discovery: Found device Volumio
May 12 07:09:09 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState
May 12 07:09:09 volumio volumio[1055]: info: CorePlayQueue::getTrack 0
May 12 07:09:09 volumio systemd[1]: apt-daily.service: Succeeded.
May 12 07:09:09 volumio systemd[1]: Started Daily apt download activities.
May 12 07:09:09 volumio systemd[1]: Starting Daily apt upgrade and clean activities...
May 12 07:09:10 volumio systemd[1]: apt-daily-upgrade.service: Succeeded.
May 12 07:09:10 volumio systemd[1]: Started Daily apt upgrade and clean activities.
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
May 12 07:09:10 volumio volumio[1055]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
May 12 07:09:10 volumio volumio[1055]: info: Adding plugin bluetooth to MyMusic Plugins
May 12 07:09:10 volumio volumio[1055]: info: Adding plugin multiroom to MyMusic Plugins
May 12 07:09:10 volumio volumio[1055]: info: Adding plugin metavolumio to MyMusic Plugins
May 12 07:09:10 volumio volumio[1055]: info: Adding plugin cd_controller to MyMusic Plugins
May 12 07:09:10 volumio volumio[1055]: info: Adding plugin smart_inputs to MyMusic Plugins
May 12 07:09:10 volumio volumio[1055]: info: Adding plugin tidalconnect to MyMusic Plugins
May 12 07:09:11 volumio volumio[1055]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
May 12 07:09:12 volumio go-librespot[1414]: time="2025-05-12T07:09:12+02:00" level=debug msg="obtained new client token: AAB9wFeLaOQov9scD47n/XyNpzvfn0K9BdSeQ0NAZlPSvQqj5zEl5eAsG08HUj92xZZBQB4wZiBHTxRcWcPup+r84z1J1/WhH3J9d0mG9IR2sLzRErPQH40o1Zmop29jNl9XmdHZNGH26eRkfisWrPsjauX3QSlgJseN1EyQiukcROGWMOo++pThuCSIjhLOkuEKe7wbVxC9QIuftR54nlmlzNQ9DKrOl+NKQI1wgmn+T5tleKKVSCb9iP246A=="
May 12 07:09:12 volumio go-librespot[1414]: time="2025-05-12T07:09:12+02:00" level=info msg="connected to ap-gew1.spotify.com:4070"
May 12 07:09:12 volumio go-librespot[1414]: time="2025-05-12T07:09:12+02:00" level=debug msg="completed keyexchange"
May 12 07:09:13 volumio go-librespot[1414]: time="2025-05-12T07:09:13+02:00" level=debug msg="completed challenge"
May 12 07:09:13 volumio go-librespot[1414]: time="2025-05-12T07:09:13+02:00" level=debug msg="authenticated as crepeer51"
May 12 07:09:13 volumio volumio[1055]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
May 12 07:09:13 volumio volumio[1055]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
May 12 07:09:13 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 12 07:09:13 volumio volumio[1055]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 12 07:09:13 volumio volumio[1055]: info: Starting MyVolumio Remote Streaming Endpoints
May 12 07:09:13 volumio volumio[1055]: info: MyVolumio login type: Token
May 12 07:09:13 volumio go-librespot[1414]: time="2025-05-12T07:09:13+02:00" level=debug msg="authenticated as crepeer51"
May 12 07:09:13 volumio volumio[1055]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
May 12 07:09:13 volumio volumio[1055]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
May 12 07:09:13 volumio go-librespot[1414]: time="2025-05-12T07:09:13+02:00" level=debug msg="dealer connection opened"
May 12 07:09:13 volumio go-librespot[1414]: time="2025-05-12T07:09:13+02:00" level=info msg="accepted zeroconf user crepeer51 from Redmi Note 14 Pro+ 5G"
May 12 07:09:13 volumio go-librespot[1414]: time="2025-05-12T07:09:13+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336"
May 12 07:09:13 volumio go-librespot[1414]: time="2025-05-12T07:09:13+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2"
May 12 07:09:13 volumio go-librespot[1414]: time="2025-05-12T07:09:13+02:00" level=debug msg="received connection id: OGY5YjQzMGEtNjRlMC00YzFhLTk5ZGItYTNkZjRhN2UyOWVjK2RlYWxlcit0Y3A6Ly8wYWNhNDEyNi5pcC5nZXcxLnNwb3RpZnkubmV0OjU3MDArNzg2Rjg2RjBDODQ2RTFBRDcwQzBDNjVGQzA1NjVGODE0Mzg2OUQ2NDMxM0VCMzBEMkUwQzU2QTVENjY5NjAxQg=="
May 12 07:09:14 volumio go-librespot[1414]: time="2025-05-12T07:09:14+02:00" level=debug msg="put connect state because NEW_DEVICE"
May 12 07:09:14 volumio go-librespot[1414]: time="2025-05-12T07:09:14+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17"
May 12 07:09:14 volumio go-librespot[1414]: time="2025-05-12T07:09:14+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0"
May 12 07:09:14 volumio go-librespot[1414]: time="2025-05-12T07:09:14+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481"
May 12 07:09:14 volumio go-librespot[1414]: time="2025-05-12T07:09:14+02:00" level=debug msg="autoplay enabled: false"
May 12 07:09:14 volumio go-librespot[1414]: time="2025-05-12T07:09:14+02:00" level=debug msg="handling transfer player command from e6dca45a608ab0b39cdc036ab7ab0d533a44f13f"
May 12 07:09:14 volumio go-librespot[1414]: time="2025-05-12T07:09:14+02:00" level=debug msg="resolved context of track" uri="spotify:album:79NGtx30Jubzmphir2G4IA"
May 12 07:09:14 volumio go-librespot[1414]: time="2025-05-12T07:09:14+02:00" level=trace msg="fetched new page 0 with 10 items (list: 10)" uri="spotify:album:79NGtx30Jubzmphir2G4IA"
May 12 07:09:14 volumio go-librespot[1414]: time="2025-05-12T07:09:14+02:00" level=debug msg="shuffled context with seed 15161371119603877281 (len: 10, keep: 3)"
May 12 07:09:14 volumio go-librespot[1414]: time="2025-05-12T07:09:14+02:00" level=debug msg="loading track (paused: true, position: 138688ms)" uri="spotify:track:4umtx1HPKuHwrpE8d451mN"
May 12 07:09:14 volumio go-librespot[1414]: time="2025-05-12T07:09:14+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
May 12 07:09:14 volumio go-librespot[1414]: time="2025-05-12T07:09:14+02:00" level=trace msg="emitting websocket event: will_play"
May 12 07:09:14 volumio go-librespot[1414]: time="2025-05-12T07:09:14+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 345"
May 12 07:09:14 volumio go-librespot[1414]: time="2025-05-12T07:09:14+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1666"
May 12 07:09:14 volumio go-librespot[1414]: time="2025-05-12T07:09:14+02:00" level=debug msg="selected format OGG_VORBIS_320 (2c5c27db75ba359f20b273017aa2f890d27eadfd)" uri="spotify:track:4umtx1HPKuHwrpE8d451mN"
May 12 07:09:14 volumio go-librespot[1414]: time="2025-05-12T07:09:14+02:00" level=debug msg="requested aes key for file 2c5c27db75ba359f20b273017aa2f890d27eadfd, gid: 4umtx1HPKuHwrpE8d451mN"
May 12 07:09:14 volumio go-librespot[1414]: time="2025-05-12T07:09:14+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1277"
May 12 07:09:14 volumio volumio[1254]: ....................................................................................................................++++
May 12 07:09:14 volumio volumio[1254]: e is 65537 (0x010001)
May 12 07:09:14 volumio volumio[1254]: writing RSA key
May 12 07:09:15 volumio go-librespot[1414]: time="2025-05-12T07:09:15+02:00" level=debug msg="fetched first chunk of 29, total size is 14764896 bytes" uri="spotify:track:4umtx1HPKuHwrpE8d451mN"
May 12 07:09:15 volumio go-librespot[1414]: time="2025-05-12T07:09:15+02:00" level=debug msg="fetched chunk 1/28, size: 524288" uri="spotify:track:4umtx1HPKuHwrpE8d451mN"
May 12 07:09:15 volumio go-librespot[1414]: time="2025-05-12T07:09:15+02:00" level=debug msg="fetched chunk 3/28, size: 524288" uri="spotify:track:4umtx1HPKuHwrpE8d451mN"
May 12 07:09:15 volumio go-librespot[1414]: time="2025-05-12T07:09:15+02:00" level=debug msg="fetched chunk 2/28, size: 524288" uri="spotify:track:4umtx1HPKuHwrpE8d451mN"
May 12 07:09:16 volumio go-librespot[1414]: time="2025-05-12T07:09:16+02:00" level=debug msg="fetched chunk 13/28, size: 524288" uri="spotify:track:4umtx1HPKuHwrpE8d451mN"
May 12 07:09:16 volumio go-librespot[1414]: time="2025-05-12T07:09:16+02:00" level=debug msg="fetched chunk 12/28, size: 524288" uri="spotify:track:4umtx1HPKuHwrpE8d451mN"
May 12 07:09:16 volumio go-librespot[1414]: time="2025-05-12T07:09:16+02:00" level=debug msg="fetched chunk 14/28, size: 524288" uri="spotify:track:4umtx1HPKuHwrpE8d451mN"
May 12 07:09:16 volumio go-librespot[1414]: time="2025-05-12T07:09:16+02:00" level=debug msg="fetched chunk 11/28, size: 524288" uri="spotify:track:4umtx1HPKuHwrpE8d451mN"
May 12 07:09:16 volumio go-librespot[1414]: time="2025-05-12T07:09:16+02:00" level=trace msg="seek to 138688ms (diff: 116ms, samples: 6116140, bytes: 6127083)" uri="spotify:track:4umtx1HPKuHwrpE8d451mN"
May 12 07:09:16 volumio go-librespot[1414]: time="2025-05-12T07:09:16+02:00" level=debug msg="alsa driver configured, rate = 44100 bps, period time = 10068 us, period size = 444 frames, buffer time = 500000 us, buffer size = 22050 frames, periods per buffer = 49 frames"
May 12 07:09:16 volumio go-librespot[1414]: time="2025-05-12T07:09:16+02:00" level=debug msg="created new output device"
May 12 07:09:16 volumio go-librespot[1414]: time="2025-05-12T07:09:16+02:00" level=info msg="loaded track \"Surrender - Remastered 2005\" (paused: true, position: 138688ms, duration: 341893ms, prefetched: false)" uri="spotify:track:4umtx1HPKuHwrpE8d451mN"
May 12 07:09:16 volumio go-librespot[1414]: time="2025-05-12T07:09:16+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
May 12 07:09:16 volumio go-librespot[1414]: time="2025-05-12T07:09:16+02:00" level=trace msg="emitting websocket event: metadata"
May 12 07:09:16 volumio go-librespot[1414]: time="2025-05-12T07:09:16+02:00" level=trace msg="emitting websocket event: active"
May 12 07:09:16 volumio go-librespot[1414]: time="2025-05-12T07:09:16+02:00" level=debug msg="sending successful reply for dealer request"
May 12 07:09:16 volumio go-librespot[1414]: time="2025-05-12T07:09:16+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update
May 12 07:09:16 volumio go-librespot[1414]: time="2025-05-12T07:09:16+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update
May 12 07:09:16 volumio go-librespot[1414]: time="2025-05-12T07:09:16+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update
May 12 07:09:16 volumio go-librespot[1414]: time="2025-05-12T07:09:16+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
May 12 07:09:16 volumio go-librespot[1414]: time="2025-05-12T07:09:16+02:00" level=trace msg="emitting websocket event: paused"
May 12 07:09:16 volumio volumio[1055]: info: Starting Streaming Service Transparent Proxy
May 12 07:09:16 volumio volumio[1055]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
May 12 07:09:16 volumio volumio[1055]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
May 12 07:09:16 volumio volumio[1055]: info: Streaming services startup
May 12 07:09:16 volumio volumio[1055]: info: Starting Streaming Daemon
May 12 07:09:16 volumio sudo[1536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
May 12 07:09:16 volumio sudo[1536]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 12 07:09:16 volumio volumio[1055]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
May 12 07:09:16 volumio sudo[1536]: pam_unix(sudo:session): session closed for user root
May 12 07:09:16 volumio volumio[1055]: info: Getting Spotify volume
May 12 07:09:16 volumio volumio[1055]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:4umtx1HPKuHwrpE8d451mN","play_origin":"playlist"}}
May 12 07:09:16 volumio volumio[1055]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:4umtx1HPKuHwrpE8d451mN","name":"Surrender - Remastered 2005","artist_names":["Eloy"],"album_name":"Performance (Remastered 2005)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02c9d200da204c9ed9a98c70a9","position":138688,"duration":341893,"release_date":"year:1983 month:1 day:1","track_number":4,"disc_number":1}}
May 12 07:09:16 volumio volumio[1055]: SPOTIFY: received: {"type":"active","data":null}
May 12 07:09:16 volumio volumio[1055]: info: Aligning Spotify Volume to Volumio Volume
May 12 07:09:16 volumio volumio[1055]: info: CoreCommandRouter::volumioGetState
May 12 07:09:16 volumio volumio[1055]: info: CorePlayQueue::getTrack 0
May 12 07:09:16 volumio volumio[1055]: info: Setting Spotify Volume from Volumio: 91
May 12 07:09:16 volumio volumio[1055]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:4umtx1HPKuHwrpE8d451mN","play_origin":"playlist"}}
May 12 07:09:16 volumio volumio[1055]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 12 07:09:16 volumio volumio[1055]: TypeError: Cannot read property 'service' of undefined
May 12 07:09:16 volumio volumio[1055]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:337:50)
May 12 07:09:16 volumio volumio[1055]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:271:18)
May 12 07:09:16 volumio volumio[1055]: at WebSocket.message (/data/plugins/music_service/spop/index.js:190:14)
May 12 07:09:16 volumio volumio[1055]: at WebSocket.emit (events.js:315:20)
May 12 07:09:16 volumio volumio[1055]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1220:20)
May 12 07:09:16 volumio volumio[1055]: at Receiver.emit (events.js:315:20)
May 12 07:09:16 volumio volumio[1055]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:596:14)
May 12 07:09:16 volumio volumio[1055]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:496:10)
May 12 07:09:16 volumio volumio[1055]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:16)
May 12 07:09:16 volumio volumio[1055]: at Receiver._write (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:94:10)
May 12 07:09:16 volumio volumio[1055]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 12 07:09:17 volumio go-librespot[1414]: time="2025-05-12T07:09:17+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 160"
May 12 07:09:17 volumio go-librespot[1414]: time="2025-05-12T07:09:17+02:00" level=debug msg="skipping dealer message" uri=playback-settings/content-settings-update
May 12 07:09:17 volumio sudo[1552]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-12 07:08
May 12 07:09:17 volumio sudo[1552]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"