-- Logs begin at Fri 2024-10-18 11:47:32 CEST, end at Fri 2024-10-18 11:54:23 CEST. -- Oct 18 11:53:00 volumio volumio[1089]: info: CALLMETHOD: music_service qobuz saveConfig [object Object] Oct 18 11:53:00 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: qobuz , saveConfig Oct 18 11:53:00 volumio volumio[1089]: info: Saving configuration Oct 18 11:53:00 volumio volumio[1089]: info: Done Oct 18 11:53:03 volumio nmbd[906]: [2024/10/18 11:53:03.414834, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 18 11:53:03 volumio nmbd[906]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.5 for name WORKGROUP<1d>. Oct 18 11:53:03 volumio nmbd[906]: This response was from IP 192.168.0.2, reporting an IP address of 192.168.0.2. Oct 18 11:53:06 volumio volumio[1089]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 18 11:53:06 volumio volumio[1089]: No protocol specified Oct 18 11:53:06 volumio volumio[1089]: xcb_connection_has_error() returned true Oct 18 11:53:06 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 18 11:53:06 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 18 11:53:06 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 18 11:53:06 volumio volumio[1089]: No protocol specified Oct 18 11:53:06 volumio volumio[1089]: xcb_connection_has_error() returned true Oct 18 11:53:06 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 18 11:53:06 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 18 11:53:06 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 18 11:53:06 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 18 11:53:06 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 18 11:53:06 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 18 11:53:06 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 18 11:53:06 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 18 11:53:06 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 18 11:53:24 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 18 11:53:24 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 18 11:53:24 volumio volumio[1089]: info: Discovery: Getting this device information Oct 18 11:53:24 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Oct 18 11:53:24 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Oct 18 11:53:24 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 18 11:53:29 volumio ntpd[1624]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 18 11:53:43 volumio volumio[1089]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Oct 18 11:53:43 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Oct 18 11:53:43 volumio sudo[3352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 18 11:53:43 volumio sudo[3352]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 11:53:43 volumio sudo[3352]: pam_unix(sudo:session): session closed for user root Oct 18 11:53:43 volumio volumio[1089]: info: MPD Permissions set Oct 18 11:53:43 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 18 11:53:43 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 18 11:53:43 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 18 11:53:43 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 18 11:53:43 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 18 11:53:43 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 18 11:53:43 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 18 11:53:43 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 18 11:53:43 volumio sudo[3356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 18 11:53:43 volumio sudo[3356]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 11:53:43 volumio systemd[1]: Stopping Music Player Daemon... Oct 18 11:53:43 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 18 11:53:43 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 18 11:53:43 volumio systemd[1]: mpd.service: Succeeded. Oct 18 11:53:43 volumio systemd[1]: Stopped Music Player Daemon. Oct 18 11:53:43 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 18 11:53:43 volumio volumio[1089]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 18 11:53:43 volumio volumio[1089]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 18 11:53:43 volumio systemd[1]: Starting Music Player Daemon... Oct 18 11:53:43 volumio volumio[1089]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 18 11:53:43 volumio sudo[3363]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 18 11:53:43 volumio sudo[3363]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 11:53:43 volumio sudo[3363]: pam_unix(sudo:session): session closed for user root Oct 18 11:53:43 volumio mpd[3366]: Oct 18 11:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 18 11:53:43 volumio systemd[1]: Started Music Player Daemon. Oct 18 11:53:43 volumio sudo[3356]: pam_unix(sudo:session): session closed for user root Oct 18 11:53:43 volumio volumio[1089]: error: updateQueue error: null Oct 18 11:53:54 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 18 11:53:54 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 18 11:53:54 volumio volumio[1089]: info: Discovery: Getting this device information Oct 18 11:53:54 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Oct 18 11:53:54 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Oct 18 11:53:54 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 18 11:54:10 volumio volumio[1089]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 18 11:54:10 volumio volumio[1089]: No protocol specified Oct 18 11:54:10 volumio volumio[1089]: xcb_connection_has_error() returned true Oct 18 11:54:10 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 18 11:54:10 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 18 11:54:10 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 18 11:54:10 volumio volumio[1089]: No protocol specified Oct 18 11:54:10 volumio volumio[1089]: xcb_connection_has_error() returned true Oct 18 11:54:10 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 18 11:54:10 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 18 11:54:10 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 18 11:54:10 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 18 11:54:10 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 18 11:54:10 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 18 11:54:10 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 18 11:54:10 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 18 11:54:10 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 18 11:54:14 volumio volumio[1089]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 18 11:54:14 volumio volumio[1089]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 18 11:54:14 volumio volumio[1089]: info: Retrieving Cloud Streaming UI Oct 18 11:54:14 volumio volumio[1089]: info: Getting Tidal Cloud Configuration Oct 18 11:54:14 volumio volumio[1089]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 18 11:54:14 volumio volumio[1089]: info: Getting Qobuz Cloud Configuration Oct 18 11:54:14 volumio volumio[1089]: info: Asking plugin for UI Config Oct 18 11:54:14 volumio volumio[1089]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 18 11:54:14 volumio volumio[1089]: info: Getting Spotify Cloud Configuration Oct 18 11:54:14 volumio volumio[1089]: info: Asking plugin for UI Config Oct 18 11:54:14 volumio volumio[1089]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 18 11:54:14 volumio volumio[1089]: info: Saving Spotify Acccount Oct 18 11:54:14 volumio volumio[1089]: info: Got it Oct 18 11:54:14 volumio volumio[1089]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 18 11:54:14 volumio volumio[1089]: info: Got Tidal Cloud Configuration Oct 18 11:54:14 volumio volumio[1089]: info: Got it Oct 18 11:54:14 volumio volumio[1089]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 18 11:54:14 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 18 11:54:14 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 18 11:54:14 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 18 11:54:14 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 18 11:54:14 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 18 11:54:14 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 18 11:54:14 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 18 11:54:14 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 18 11:54:14 volumio volumio[1089]: info: CoreCommandRouter::volumioGetBrowseSources Oct 18 11:54:14 volumio volumio[1089]: info: CoreCommandRouter::volumioGetBrowseSources Oct 18 11:54:14 volumio volumio[1089]: info: CoreCommandRouter::volumioGetBrowseSources Oct 18 11:54:15 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 18 11:54:15 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 18 11:54:18 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Oct 18 11:54:18 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Oct 18 11:54:19 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 18 11:54:23 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 18 11:54:23 volumio volumio[1089]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 18 11:54:23 volumio volumio[1089]: Error: dns service error: unknown Oct 18 11:54:23 volumio volumio[1089]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Oct 18 11:54:23 volumio volumio[1089]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Oct 18 11:54:23 volumio volumio[1089]: errorCode: -65537 Oct 18 11:54:23 volumio volumio[1089]: } Oct 18 11:54:23 volumio volumio[1089]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 18 11:54:23 volumio sudo[3392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-18 11:53 Oct 18 11:54:23 volumio sudo[3392]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"