-- Logs begin at Fri 2024-11-08 18:57:21 CET, end at Fri 2024-11-29 18:35:50 CET. -- Nov 29 18:34:00 volumio volumio[5886]: info: Successfully Updated MyVolumio device Nov 29 18:34:02 volumio ntpd[826]: Soliciting pool server 185.198.109.227 Nov 29 18:34:07 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 29 18:34:07 volumio volumio[5886]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Nov 29 18:34:07 volumio volumio[5886]: info: CoreCommandRouter::volumioGetState Nov 29 18:34:07 volumio volumio[5886]: info: CorePlayQueue::getTrack 0 Nov 29 18:34:10 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 29 18:34:10 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 18:34:10 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 29 18:34:12 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 18:34:12 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 18:34:12 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 29 18:34:12 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 29 18:34:12 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 29 18:34:12 volumio volumio[5886]: info: CoreCommandRouter::volumioGetBrowseSources Nov 29 18:34:12 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 29 18:34:13 volumio volumio[5886]: error: MyVolumio Plugin failed to authenticate in a timely fashion Nov 29 18:34:13 volumio volumio[5886]: info: Completed starting MyVolumio Plugin Nov 29 18:34:13 volumio volumio[5886]: [Metrics] CommandRouter: 38s 633.33ms Nov 29 18:34:13 volumio volumio[5886]: info: CoreCommandRouter::volumiosetStartupVolume Nov 29 18:34:13 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 18:34:13 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 18:34:13 volumio volumio[5886]: info: CoreCommandRouter::Close All Modals sent Nov 29 18:34:13 volumio volumio[5886]: info: CoreCommandRouter::Close All Modals sent Nov 29 18:34:14 volumio volumio-remote-updater[3236]: No test mode Nov 29 18:34:14 volumio volumio-remote-updater[3236]: No alpha test mode Nov 29 18:34:14 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Nov 29 18:34:14 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Nov 29 18:34:14 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 18:34:14 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Nov 29 18:34:14 volumio volumio[5886]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 29 18:34:14 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 29 18:34:15 volumio ntpd[826]: Soliciting pool server 5.250.191.170 Nov 29 18:34:20 volumio volumio[5886]: info: BOOT COMPLETED Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 18:34:41 volumio volumio[5886]: info: Retrieving Cloud Streaming UI Nov 29 18:34:41 volumio volumio[5886]: info: Getting Tidal Cloud Configuration Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 18:34:41 volumio volumio[5886]: info: Getting Qobuz Cloud Configuration Nov 29 18:34:41 volumio volumio[5886]: info: Asking plugin for UI Config Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 18:34:41 volumio volumio[5886]: info: Getting Spotify Cloud Configuration Nov 29 18:34:41 volumio volumio[5886]: info: Asking plugin for UI Config Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 18:34:41 volumio volumio[5886]: info: Saving Spotify Acccount Nov 29 18:34:41 volumio volumio[5886]: info: Got Tidal Cloud Configuration Nov 29 18:34:41 volumio volumio[5886]: info: Got it Nov 29 18:34:41 volumio volumio[5886]: info: Got it Nov 29 18:34:41 volumio volumio[5886]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 18:34:41 volumio volumio[5886]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::volumioGetBrowseSources Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::volumioGetBrowseSources Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::volumioGetBrowseSources Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 18:34:41 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 29 18:34:45 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 18:34:49 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 18:34:53 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 18:34:53 volumio volumio[5886]: info: Enabling MyMusic plugin bluetooth Nov 29 18:34:53 volumio volumio[5886]: info: [MyVolumio PluginManager] Enabling and starting plugin audio_interface bluetooth Nov 29 18:34:53 volumio volumio[5886]: info: [MyVolumio PluginManager] Plugin audio_interface bluetooth not in user plan, not enabling Nov 29 18:34:53 volumio volumio[5886]: info: Error: Plugin audio_interface bluetooth not in user plan, not enabling Nov 29 18:34:53 volumio volumio[5886]: error: Could not Enable MyMusic Plugin: Error Nov 29 18:34:55 volumio ntpd[826]: Soliciting pool server 2001:ba0:21f:4900::2 Nov 29 18:34:57 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 18:34:59 volumio volumio[5886]: info: Enabling MyMusic plugin multiroom Nov 29 18:34:59 volumio volumio[5886]: info: [MyVolumio PluginManager] Enabling and starting plugin audio_interface multiroom Nov 29 18:34:59 volumio volumio[5886]: info: [MyVolumio PluginManager] Plugin audio_interface multiroom not in user plan, not enabling Nov 29 18:34:59 volumio volumio[5886]: info: Error: Plugin audio_interface multiroom not in user plan, not enabling Nov 29 18:34:59 volumio volumio[5886]: error: Could not Enable MyMusic Plugin: Error Nov 29 18:35:01 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 18:35:02 volumio volumio[5886]: info: Enabling MyMusic plugin metavolumio Nov 29 18:35:02 volumio volumio[5886]: info: [MyVolumio PluginManager] Enabling and starting plugin miscellanea metavolumio Nov 29 18:35:02 volumio volumio[5886]: info: [MyVolumio PluginManager] Plugin miscellanea metavolumio not in user plan, not enabling Nov 29 18:35:02 volumio volumio[5886]: info: Error: Plugin miscellanea metavolumio not in user plan, not enabling Nov 29 18:35:02 volumio volumio[5886]: error: Could not Enable MyMusic Plugin: Error Nov 29 18:35:05 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 18:35:08 volumio volumio[5886]: info: Enabling MyMusic plugin smart_inputs Nov 29 18:35:08 volumio volumio[5886]: info: [MyVolumio PluginManager] Enabling and starting plugin music_service smart_inputs Nov 29 18:35:08 volumio volumio[5886]: info: [MyVolumio PluginManager] Plugin music_service smart_inputs not in user plan, not enabling Nov 29 18:35:08 volumio volumio[5886]: info: Error: Plugin music_service smart_inputs not in user plan, not enabling Nov 29 18:35:08 volumio volumio[5886]: error: Could not Enable MyMusic Plugin: Error Nov 29 18:35:09 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 18:35:13 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 18:35:16 volumio ntpd[826]: Soliciting pool server 195.20.235.143 Nov 29 18:35:17 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 18:35:23 volumio ntpd[826]: Soliciting pool server 195.95.153.43 Nov 29 18:35:24 volumio ntpd[826]: Soliciting pool server 212.227.232.46 Nov 29 18:35:27 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 18:35:27 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 18:35:29 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 18:35:30 volumio volumio[5886]: verbose: New Socket.io Connection to 192.168.1.33 from 192.168.1.129 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Nov 29 18:35:30 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 29 18:35:30 volumio volumio[5886]: info: CoreCommandRouter::volumioGetVisibleSources Nov 29 18:35:30 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 29 18:35:30 volumio volumio[5886]: info: CoreCommandRouter::volumioGetState Nov 29 18:35:30 volumio volumio[5886]: info: CorePlayQueue::getTrack 0 Nov 29 18:35:30 volumio volumio[5886]: info: CoreCommandRouter::volumioGetState Nov 29 18:35:30 volumio volumio[5886]: info: CorePlayQueue::getTrack 0 Nov 29 18:35:30 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 29 18:35:30 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 29 18:35:30 volumio volumio[5886]: info: Received Get System Info Nov 29 18:35:30 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 29 18:35:30 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 29 18:35:30 volumio volumio[5886]: info: Discovery: Getting this device information Nov 29 18:35:30 volumio volumio[5886]: info: CoreCommandRouter::volumioGetState Nov 29 18:35:30 volumio volumio[5886]: info: CorePlayQueue::getTrack 0 Nov 29 18:35:30 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 29 18:35:30 volumio volumio[5886]: info: CoreCommandRouter::volumioGetState Nov 29 18:35:30 volumio volumio[5886]: info: CorePlayQueue::getTrack 0 Nov 29 18:35:30 volumio volumio[5886]: info: Listing playlists Nov 29 18:35:30 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 29 18:35:33 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 18:35:37 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 18:35:41 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 18:35:44 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Nov 29 18:35:44 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Nov 29 18:35:45 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 18:35:49 volumio volumio[5886]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 29 18:35:49 volumio volumio[5886]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 29 18:35:49 volumio volumio[5886]: Error: dns service error: unknown Nov 29 18:35:49 volumio volumio[5886]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Nov 29 18:35:49 volumio volumio[5886]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Nov 29 18:35:49 volumio volumio[5886]: errorCode: -65537 Nov 29 18:35:49 volumio volumio[5886]: } Nov 29 18:35:49 volumio volumio[5886]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 29 18:35:50 volumio sudo[6475]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-29 18:34 Nov 29 18:35:50 volumio sudo[6475]: 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"