-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Fri 2025-12-26 12:12:17 UTC. -- Dec 26 12:11:01 volumio volumio[778]: info: CoreCommandRouter::volumioGetQueue Dec 26 12:11:01 volumio volumio[778]: info: CoreStateMachine::getQueue Dec 26 12:11:01 volumio volumio[778]: info: CorePlayQueue::getQueue Dec 26 12:11:03 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 12:11:03 volumio volumio[778]: info: Received Get System Info Dec 26 12:11:03 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 12:11:03 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 12:11:03 volumio volumio[778]: info: Discovery: Getting this device information Dec 26 12:11:03 volumio volumio[778]: info: CoreCommandRouter::volumioGetState Dec 26 12:11:03 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 12:11:05 volumio volumio[778]: info: CoreCommandRouter::volumioGetState Dec 26 12:11:05 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 12:11:05 volumio volumio[778]: info: Received Get System Info Dec 26 12:11:05 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 12:11:05 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 12:11:05 volumio volumio[778]: info: Discovery: Getting this device information Dec 26 12:11:05 volumio volumio[778]: info: CoreCommandRouter::volumioGetState Dec 26 12:11:05 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 12:11:05 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 12:11:05 volumio volumio[778]: info: Received Get System Info Dec 26 12:11:05 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 12:11:05 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 12:11:05 volumio volumio[778]: info: Discovery: Getting this device information Dec 26 12:11:05 volumio volumio[778]: info: CoreCommandRouter::volumioGetState Dec 26 12:11:05 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 12:11:12 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 12:11:12 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 26 12:11:29 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 26 12:11:51 volumio volumio[778]: info: CoreCommandRouter::volumioGetState Dec 26 12:11:56 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 12:11:56 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 26 12:12:13 volumio volumio[778]: info: Enabling plugin spop Dec 26 12:12:13 volumio volumio[778]: info: Loading plugin "spop"... Dec 26 12:12:13 volumio volumio[778]: info: PLUGIN START: spop Dec 26 12:12:13 volumio volumio[778]: info: Checking for old spotify connect plugin installed Dec 26 12:12:13 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 26 12:12:13 volumio volumio[778]: [SpotifyConnect] Creating VLS config file Dec 26 12:12:13 volumio volumio[778]: error: Failed to read template file: Error: ENOENT: no such file or directory, open '/data/plugins/music_service/spop/volspotify.tmpl' Dec 26 12:12:13 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 12:12:13 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 12:12:13 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 12:12:13 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 12:12:13 volumio volumio[778]: [SpotifyConnect] Starting metadata listener Dec 26 12:12:13 volumio volumio[778]: (node:778) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'replace' of undefined Dec 26 12:12:13 volumio volumio[778]: at ControllerSpotify.createConfigFile (/data/plugins/music_service/spop/index.js:2578:27) Dec 26 12:12:13 volumio volumio[778]: at ControllerSpotify.init (/data/plugins/music_service/spop/index.js:2441:14) Dec 26 12:12:13 volumio volumio[778]: at Promise._successFn (/data/plugins/music_service/spop/index.js:133:14) Dec 26 12:12:13 volumio volumio[778]: at nextTickCallback (/data/plugins/music_service/spop/node_modules/kew/kew.js:47:28) Dec 26 12:12:13 volumio volumio[778]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Dec 26 12:12:13 volumio volumio[778]: (node:778) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 4) Dec 26 12:12:13 volumio sudo[8597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Dec 26 12:12:13 volumio sudo[8597]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 12:12:13 volumio volumio[778]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Dec 26 12:12:13 volumio systemd[1]: Started Volspotconnect2 Daemon. Dec 26 12:12:13 volumio sudo[8597]: pam_unix(sudo:session): session closed for user root Dec 26 12:12:13 volumio volumio[8599]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Dec 26 12:12:13 volumio systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Dec 26 12:12:13 volumio systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Dec 26 12:12:13 volumio volumio[778]: [SpotifyConnect] Vollibrespot Daemon service started! Dec 26 12:12:13 volumio volumio[778]: [Metrics] SpotifyConnect: 0s 116.47ms Dec 26 12:12:13 volumio volumio[778]: info: Done. Dec 26 12:12:14 volumio volumio[778]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Dec 26 12:12:14 volumio volumio[778]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 12:12:14 volumio volumio[778]: Cannot find translation for sourceMedia Servers Dec 26 12:12:14 volumio volumio[778]: [SpotifyConnect] Closing metadata listener Dec 26 12:12:14 volumio volumio[778]: info: Disabling plugin spop Dec 26 12:12:14 volumio volumio[778]: info: Done. Dec 26 12:12:14 volumio sudo[8602]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect.service Dec 26 12:12:14 volumio sudo[8602]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 26 12:12:14 volumio systemd[1]: Stopped Volspotconnect2 Daemon. Dec 26 12:12:14 volumio sudo[8602]: pam_unix(sudo:session): session closed for user root Dec 26 12:12:14 volumio volumio[778]: [SpotifyConnect] Vollibrespot Daemon service stoped! Dec 26 12:12:17 volumio volumio[778]: info: Checking Spotify Web API Dec 26 12:12:17 volumio volumio[778]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 12:12:17 volumio volumio[778]: Error [ERR_SOCKET_DGRAM_NOT_RUNNING]: Not running Dec 26 12:12:17 volumio volumio[778]: at healthCheck (dgram.js:897:11) Dec 26 12:12:17 volumio volumio[778]: at Socket.send (dgram.js:622:3) Dec 26 12:12:17 volumio volumio[778]: at SpotConnEvents.sendmsg (/data/plugins/music_service/spop/SpotConnController.js:106:21) Dec 26 12:12:17 volumio volumio[778]: at ControllerSpotify.checkWebApi (/data/plugins/music_service/spop/index.js:2354:23) Dec 26 12:12:17 volumio volumio[778]: at Timeout._onTimeout (/data/plugins/music_service/spop/index.js:2446:18) Dec 26 12:12:17 volumio volumio[778]: at listOnTimeout (internal/timers.js:554:17) Dec 26 12:12:17 volumio volumio[778]: at processTimers (internal/timers.js:497:7) { Dec 26 12:12:17 volumio volumio[778]: code: 'ERR_SOCKET_DGRAM_NOT_RUNNING' Dec 26 12:12:17 volumio volumio[778]: } Dec 26 12:12:17 volumio volumio[778]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 12:12:17 volumio sudo[8613]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-26 12:11 Dec 26 12:12:17 volumio sudo[8613]: 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="91e88ea6c5c4ec4f00aff63f7c3a2944b14ec939" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="8e6823482d6af342172ec9fdc1c15b0dd02653d2" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 04 Dec 2022 08:41:29 PM CET" VOLUMIO_VERSION="3.396" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d460c75d04818d0f55c67627fa362668"