-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Thu 2024-10-03 05:21:43 UTC. -- Oct 03 05:21:40 volumio ntpd[671]: receive: Unexpected origin timestamp 0xea999dc7.1b83c92e does not match aorg 0000000000.00000000 from server@161.9.147.35 xmt 0xeaa8a864.d2b2d921 Oct 03 05:21:40 volumio ntpd[671]: receive: Unexpected origin timestamp 0xea999dc7.1b82e5fc does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xeaa8a864.d27939a8 Oct 03 05:21:40 volumio go-librespot[1642]: time="2024-10-03T05:21:40Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1316" Oct 03 05:21:40 volumio ntpd[671]: receive: Unexpected origin timestamp 0xea999dc7.1b7e7f5b does not match aorg 0000000000.00000000 from server@62.12.173.12 xmt 0xeaa8a864.d84e4637 Oct 03 05:21:40 volumio ntpd[671]: receive: Unexpected origin timestamp 0xea999dc7.1b81e373 does not match aorg 0000000000.00000000 from server@37.187.145.181 xmt 0xeaa8a864.d72020bb Oct 03 05:21:40 volumio ntpd[671]: receive: Unexpected origin timestamp 0xea999dc7.1b80a998 does not match aorg 0000000000.00000000 from server@85.199.214.98 xmt 0xeaa8a864.d7ff57bd Oct 03 05:21:40 volumio systemd[1]: Starting Daily apt download activities... Oct 03 05:21:41 volumio volumio[905]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 03 05:21:41 volumio volumio[905]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 03 05:21:41 volumio volumio[905]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 05:21:41 volumio volumio[905]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 05:21:41 volumio volumio[905]: info: Starting MyVolumio Remote Streaming Endpoints Oct 03 05:21:41 volumio volumio[905]: info: MyVolumio login type: Token Oct 03 05:21:41 volumio volumio[905]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 03 05:21:41 volumio volumio[905]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 03 05:21:42 volumio volumio[905]: info: Starting Streaming Service Transparent Proxy Oct 03 05:21:42 volumio volumio[905]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 03 05:21:42 volumio volumio[905]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 03 05:21:42 volumio volumio[905]: info: Streaming services startup Oct 03 05:21:42 volumio volumio[905]: info: Starting Streaming Daemon Oct 03 05:21:42 volumio sudo[1989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 03 05:21:42 volumio sudo[1989]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 05:21:42 volumio volumio[905]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 03 05:21:42 volumio sudo[1989]: pam_unix(sudo:session): session closed for user root Oct 03 05:21:43 volumio volumio[905]: info: CoreCommandRouter::volumioGetState Oct 03 05:21:43 volumio volumio[905]: info: CorePlayQueue::getTrack 0 Oct 03 05:21:43 volumio volumio[905]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:6eKrGinxWRfju1KH1RfXIq","play_origin":"playlist"}} Oct 03 05:21:43 volumio volumio[905]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:6eKrGinxWRfju1KH1RfXIq","name":"Ballo Ballo","artist_names":["Raffaella Carrà"],"album_name":"Fiesta","album_cover_url":"https://i.scdn.co/image/ab67616d00001e0266d619d0eb0780d5f2bcdbbe","position":-985630232,"duration":179813,"release_date":"year:1999 month:10 day:29","track_number":14,"disc_number":1}} Oct 03 05:21:43 volumio volumio[905]: SPOTIFY: received: {"type":"active","data":null} Oct 03 05:21:43 volumio volumio[905]: info: Aligning Spotify Volume to Volumio Volume Oct 03 05:21:43 volumio volumio[905]: info: CoreCommandRouter::volumioGetState Oct 03 05:21:43 volumio volumio[905]: info: CorePlayQueue::getTrack 0 Oct 03 05:21:43 volumio volumio[905]: info: Setting Spotify Volume from Volumio: 0 Oct 03 05:21:43 volumio volumio[905]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:6eKrGinxWRfju1KH1RfXIq","play_origin":"playlist"}} Oct 03 05:21:43 volumio volumio[905]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 03 05:21:43 volumio volumio[905]: TypeError: Cannot read property 'service' of undefined Oct 03 05:21:43 volumio volumio[905]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:336:50) Oct 03 05:21:43 volumio volumio[905]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:262:18) Oct 03 05:21:43 volumio volumio[905]: at WebSocket.message (/data/plugins/music_service/spop/index.js:189:14) Oct 03 05:21:43 volumio volumio[905]: at WebSocket.emit (events.js:315:20) Oct 03 05:21:43 volumio volumio[905]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1203:20) Oct 03 05:21:43 volumio volumio[905]: at Receiver.emit (events.js:315:20) Oct 03 05:21:43 volumio volumio[905]: at /data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:608:16 Oct 03 05:21:43 volumio volumio[905]: at internal/process/task_queues.js:149:7 Oct 03 05:21:43 volumio volumio[905]: at AsyncResource.runInAsyncScope (async_hooks.js:197:9) Oct 03 05:21:43 volumio volumio[905]: at AsyncResource.runMicrotask (internal/process/task_queues.js:146:8) Oct 03 05:21:43 volumio volumio[905]: at processTicksAndRejections (internal/process/task_queues.js:93:5) Oct 03 05:21:43 volumio volumio[905]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 03 05:21:43 volumio systemd[1]: apt-daily.service: Succeeded. Oct 03 05:21:43 volumio systemd[1]: Started Daily apt download activities. Oct 03 05:21:43 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Oct 03 05:21:43 volumio sudo[2044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-03 05:20 Oct 03 05:21:43 volumio sudo[2044]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"