-- Logs begin at Sun 2024-11-24 12:30:38 CET, end at Sun 2024-11-24 12:54:13 CET. -- Nov 24 12:53:03 huiskamer volumio[713]: info: CoreCommandRouter::volumioGetState Nov 24 12:53:03 huiskamer volumio[713]: info: CorePlayQueue::getTrack 0 Nov 24 12:53:03 huiskamer volumio[713]: info: Listing playlists Nov 24 12:53:13 huiskamer volumio[713]: info: CoreCommandRouter::volumioGetState Nov 24 12:53:13 huiskamer volumio[713]: info: CorePlayQueue::getTrack 0 Nov 24 12:53:14 huiskamer ntpd[584]: 95.211.123.72 local addr 192.168.178.47 -> Nov 24 12:53:23 huiskamer volumio[713]: info: CoreCommandRouter::volumioGetState Nov 24 12:53:23 huiskamer volumio[713]: info: CorePlayQueue::getTrack 0 Nov 24 12:53:23 huiskamer volumio[713]: info: Listing playlists Nov 24 12:53:23 huiskamer volumio[713]: info: Listing playlists Nov 24 12:53:33 huiskamer volumio[713]: info: CoreCommandRouter::volumioGetState Nov 24 12:53:33 huiskamer volumio[713]: info: CorePlayQueue::getTrack 0 Nov 24 12:53:43 huiskamer volumio[713]: info: CoreCommandRouter::volumioGetState Nov 24 12:53:43 huiskamer volumio[713]: info: CorePlayQueue::getTrack 0 Nov 24 12:53:43 huiskamer volumio[713]: info: Listing playlists Nov 24 12:53:53 huiskamer volumio[713]: info: CoreCommandRouter::volumioGetState Nov 24 12:53:53 huiskamer volumio[713]: info: CorePlayQueue::getTrack 0 Nov 24 12:53:53 huiskamer volumio[713]: verbose: New Socket.io Connection to 192.168.178.47 from 192.168.178.84 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.1 Mobile/15E148 Safari/604.1 Ddg/18.1 Engine version: 3 Transport: polling Total Clients: 6 Nov 24 12:53:53 huiskamer volumio[713]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 24 12:53:53 huiskamer volumio[713]: info: CoreCommandRouter::volumioGetVisibleSources Nov 24 12:53:54 huiskamer volumio[713]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 24 12:53:54 huiskamer volumio[713]: info: CoreCommandRouter::volumioGetState Nov 24 12:53:54 huiskamer volumio[713]: info: CorePlayQueue::getTrack 0 Nov 24 12:53:54 huiskamer volumio[713]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 24 12:53:54 huiskamer volumio[713]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 24 12:53:54 huiskamer volumio[713]: info: Received Get System Info Nov 24 12:53:54 huiskamer volumio[713]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 12:53:54 huiskamer volumio[713]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 12:53:54 huiskamer volumio[713]: info: Discovery: Getting this device information Nov 24 12:53:54 huiskamer volumio[713]: info: CoreCommandRouter::volumioGetState Nov 24 12:53:54 huiskamer volumio[713]: info: CorePlayQueue::getTrack 0 Nov 24 12:53:54 huiskamer volumio[713]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 12:53:54 huiskamer volumio[713]: info: CoreCommandRouter::volumioGetState Nov 24 12:53:54 huiskamer volumio[713]: info: CorePlayQueue::getTrack 0 Nov 24 12:53:54 huiskamer volumio[713]: info: Listing playlists Nov 24 12:53:54 huiskamer volumio[713]: info: CoreCommandRouter::volumioGetQueue Nov 24 12:53:54 huiskamer volumio[713]: info: CoreStateMachine::getQueue Nov 24 12:53:54 huiskamer volumio[713]: info: CorePlayQueue::getQueue Nov 24 12:53:54 huiskamer volumio[713]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 24 12:54:00 huiskamer volumio[713]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 24 12:54:00 huiskamer volumio[713]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 24 12:54:03 huiskamer volumio[713]: info: CoreCommandRouter::volumioGetState Nov 24 12:54:03 huiskamer volumio[713]: info: CorePlayQueue::getTrack 0 Nov 24 12:54:03 huiskamer volumio[713]: info: Listing playlists Nov 24 12:54:03 huiskamer volumio[713]: info: Listing playlists Nov 24 12:54:04 huiskamer volumio[713]: info: Enabling plugin spop Nov 24 12:54:04 huiskamer volumio[713]: info: Loading plugin "spop"... Nov 24 12:54:04 huiskamer volumio[713]: info: PLUGIN START: spop Nov 24 12:54:04 huiskamer volumio[713]: info: Checking for old spotify connect plugin installed Nov 24 12:54:04 huiskamer volumio[713]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 24 12:54:04 huiskamer volumio[713]: [SpotifyConnect] Creating VLS config file Nov 24 12:54:04 huiskamer volumio[713]: error: Failed to read template file: Error: ENOENT: no such file or directory, open '/data/plugins/music_service/spop/volspotify.tmpl' Nov 24 12:54:04 huiskamer volumio[713]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 12:54:04 huiskamer volumio[713]: [SpotifyConnect] Starting metadata listener Nov 24 12:54:04 huiskamer volumio[713]: (node:713) UnhandledPromiseRejectionWarning: TypeError: Cannot read property 'replace' of undefined Nov 24 12:54:04 huiskamer volumio[713]: at ControllerSpotify.createConfigFile (/data/plugins/music_service/spop/index.js:2607:27) Nov 24 12:54:04 huiskamer volumio[713]: at ControllerSpotify.init (/data/plugins/music_service/spop/index.js:2470:14) Nov 24 12:54:04 huiskamer volumio[713]: at Promise._successFn (/data/plugins/music_service/spop/index.js:134:14) Nov 24 12:54:04 huiskamer volumio[713]: at nextTickCallback (/data/plugins/music_service/spop/node_modules/kew/kew.js:47:28) Nov 24 12:54:04 huiskamer volumio[713]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Nov 24 12:54:04 huiskamer volumio[713]: (node:713) 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: 5) Nov 24 12:54:05 huiskamer sudo[3971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Nov 24 12:54:05 huiskamer sudo[3971]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 12:54:05 huiskamer volumio[713]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Nov 24 12:54:05 huiskamer systemd[1]: Started Volspotconnect2 Daemon. Nov 24 12:54:05 huiskamer sudo[3971]: pam_unix(sudo:session): session closed for user root Nov 24 12:54:05 huiskamer volumio[3973]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Nov 24 12:54:05 huiskamer systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Nov 24 12:54:05 huiskamer systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Nov 24 12:54:05 huiskamer volumio[713]: [SpotifyConnect] Vollibrespot Daemon service started! Nov 24 12:54:05 huiskamer volumio[713]: [Metrics] SpotifyConnect: 0s 771.84ms Nov 24 12:54:05 huiskamer volumio[713]: info: Done. Nov 24 12:54:07 huiskamer systemd[1]: volspotconnect.service: Service RestartSec=2s expired, scheduling restart. Nov 24 12:54:07 huiskamer systemd[1]: volspotconnect.service: Scheduled restart job, restart counter is at 1. Nov 24 12:54:07 huiskamer systemd[1]: Stopped Volspotconnect2 Daemon. Nov 24 12:54:07 huiskamer systemd[1]: Started Volspotconnect2 Daemon. Nov 24 12:54:07 huiskamer volumio[713]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Nov 24 12:54:07 huiskamer volumio[713]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 24 12:54:07 huiskamer volumio[3989]: /usr/lib/startconnect.sh: line 2: ./usr/bin/vollibrespot: No such file or directory Nov 24 12:54:07 huiskamer systemd[1]: volspotconnect.service: Main process exited, code=exited, status=127/n/a Nov 24 12:54:07 huiskamer systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Nov 24 12:54:07 huiskamer volumio[713]: [SpotifyConnect] Closing metadata listener Nov 24 12:54:07 huiskamer volumio[713]: info: Disabling plugin spop Nov 24 12:54:07 huiskamer volumio[713]: info: Done. Nov 24 12:54:08 huiskamer sudo[3992]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect.service Nov 24 12:54:08 huiskamer sudo[3992]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 12:54:08 huiskamer systemd[1]: Stopped Volspotconnect2 Daemon. Nov 24 12:54:08 huiskamer sudo[3992]: pam_unix(sudo:session): session closed for user root Nov 24 12:54:08 huiskamer volumio[713]: [SpotifyConnect] Vollibrespot Daemon service stoped! Nov 24 12:54:09 huiskamer volumio[713]: info: Checking Spotify Web API Nov 24 12:54:09 huiskamer volumio[713]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 24 12:54:09 huiskamer volumio[713]: Error [ERR_SOCKET_DGRAM_NOT_RUNNING]: Not running Nov 24 12:54:09 huiskamer volumio[713]: at healthCheck (dgram.js:897:11) Nov 24 12:54:09 huiskamer volumio[713]: at Socket.send (dgram.js:622:3) Nov 24 12:54:09 huiskamer volumio[713]: at SpotConnEvents.sendmsg (/data/plugins/music_service/spop/SpotConnController.js:121:21) Nov 24 12:54:09 huiskamer volumio[713]: at ControllerSpotify.checkWebApi (/data/plugins/music_service/spop/index.js:2383:23) Nov 24 12:54:09 huiskamer volumio[713]: at Timeout._onTimeout (/data/plugins/music_service/spop/index.js:2475:18) Nov 24 12:54:09 huiskamer volumio[713]: at listOnTimeout (internal/timers.js:554:17) Nov 24 12:54:09 huiskamer volumio[713]: at processTimers (internal/timers.js:497:7) { Nov 24 12:54:09 huiskamer volumio[713]: code: 'ERR_SOCKET_DGRAM_NOT_RUNNING' Nov 24 12:54:09 huiskamer volumio[713]: } Nov 24 12:54:09 huiskamer volumio[713]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 24 12:54:13 huiskamer sudo[4006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-24 12:53 Nov 24 12:54:13 huiskamer sudo[4006]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"