-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Tue 2025-09-16 19:22:40 CEST. -- Sep 16 19:21:00 volumio volumio-remote-updater[609]: No test mode Sep 16 19:21:00 volumio volumio-remote-updater[609]: No alpha test mode Sep 16 19:21:00 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:21:00 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:21:00 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Sep 16 19:21:00 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 16 19:21:00 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Sep 16 19:21:00 volumio volumio[933]: info: CoreCommandRouter::volumioGetBrowseSources Sep 16 19:21:00 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 19:21:00 volumio volumio[933]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 16 19:21:00 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 16 19:21:02 volumio volumio[933]: error: MyVolumio Plugin failed to authenticate in a timely fashion Sep 16 19:21:02 volumio volumio[933]: info: Completed starting MyVolumio Plugin Sep 16 19:21:02 volumio volumio[933]: [Metrics] CommandRouter: 45s 446.40ms Sep 16 19:21:02 volumio volumio[933]: info: CoreCommandRouter::volumiosetStartupVolume Sep 16 19:21:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:21:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:21:02 volumio volumio[933]: info: CoreCommandRouter::Close All Modals sent Sep 16 19:21:02 volumio volumio[933]: info: CoreCommandRouter::Close All Modals sent Sep 16 19:21:03 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Sep 16 19:21:03 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 16 19:21:03 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Sep 16 19:21:03 volumio volumio[933]: info: Version has changed, forcing UI Reload Sep 16 19:21:03 volumio volumio[933]: info: CoreCommandRouter::Reload Ui Sep 16 19:21:04 volumio sudo[1753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 16 19:21:04 volumio sudo[1753]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:04 volumio sudo[1753]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:04 volumio sudo[1755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 16 19:21:04 volumio sudo[1755]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:04 volumio sudo[1755]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:04 volumio volumio[933]: verbose: New Socket.io Connection to 192.168.1.119 from 192.168.1.117 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.0 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 4 Sep 16 19:21:04 volumio volumio[933]: info: CoreCommandRouter::volumioGetVisibleSources Sep 16 19:21:04 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 19:21:04 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Sep 16 19:21:04 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Sep 16 19:21:04 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Sep 16 19:21:04 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Sep 16 19:21:04 volumio volumio[933]: info: Received Get System Info Sep 16 19:21:04 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 16 19:21:04 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 16 19:21:04 volumio volumio[933]: info: Discovery: Getting this device information Sep 16 19:21:04 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Sep 16 19:21:04 volumio volumio[933]: info: CorePlayQueue::getTrack 0 Sep 16 19:21:04 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 16 19:21:04 volumio volumio-remote-updater[609]: No test mode Sep 16 19:21:04 volumio volumio-remote-updater[609]: No alpha test mode Sep 16 19:21:04 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 16 19:21:04 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 16 19:21:04 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:21:04 volumio volumio[933]: info: Retrieving Cloud Streaming UI Sep 16 19:21:04 volumio volumio[933]: info: Getting Tidal Cloud Configuration Sep 16 19:21:04 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:21:04 volumio volumio[933]: info: Getting Qobuz Cloud Configuration Sep 16 19:21:04 volumio volumio[933]: info: Asking plugin for UI Config Sep 16 19:21:04 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:21:04 volumio volumio[933]: info: Getting Spotify Cloud Configuration Sep 16 19:21:04 volumio volumio[933]: info: Asking plugin for UI Config Sep 16 19:21:04 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:21:04 volumio volumio[933]: info: Saving Spotify Acccount Sep 16 19:21:04 volumio volumio[933]: info: Got Tidal Cloud Configuration Sep 16 19:21:04 volumio volumio[933]: info: Got it Sep 16 19:21:04 volumio volumio[933]: info: Got it Sep 16 19:21:04 volumio volumio[933]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 16 19:21:04 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:21:04 volumio volumio[933]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 16 19:21:04 volumio volumio[933]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 16 19:21:04 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 16 19:21:05 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Sep 16 19:21:05 volumio volumio[933]: info: Loading i18n strings for locale it Sep 16 19:21:05 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Sep 16 19:21:05 volumio volumio[933]: info: Setting timezone to Europe/Rome Sep 16 19:21:05 volumio sudo[1763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Sep 16 19:21:05 volumio sudo[1763]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:05 volumio sudo[1763]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:05 volumio sudo[1766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Rome /etc/localtime Sep 16 19:21:05 volumio sudo[1766]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:05 volumio sudo[1766]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:05 volumio sudo[1769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Sep 16 19:21:05 volumio sudo[1769]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:05 volumio sudo[1769]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:05 volumio sudo[1772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Rome Sep 16 19:21:05 volumio sudo[1772]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:05 volumio dbus-daemon[607]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.19' (uid=0 pid=1773 comm="/usr/bin/timedatectl set-timezone Europe/Rome ") Sep 16 19:21:05 volumio systemd[1]: Starting Time & Date Service... Sep 16 19:21:05 volumio dbus-daemon[607]: [system] Successfully activated service 'org.freedesktop.timedate1' Sep 16 19:21:05 volumio systemd[1]: Started Time & Date Service. Sep 16 19:21:05 volumio sudo[1772]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:05 volumio volumio[933]: Updating browse sources language Sep 16 19:21:05 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 19:21:06 volumio volumio[933]: info: Fetching Streaming Services browse cache Sep 16 19:21:06 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 16 19:21:06 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Sep 16 19:21:06 volumio volumio[933]: info: MyVolumio login type: Token Sep 16 19:21:07 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 16 19:21:07 volumio volumio[933]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Sep 16 19:21:08 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Sep 16 19:21:08 volumio volumio[933]: info: MyVolumio login type: Token Sep 16 19:21:08 volumio volumio[933]: info: MyVolumio token set successfully Sep 16 19:21:08 volumio volumio[933]: info: MYVOLUMIO: Adding device Sep 16 19:21:08 volumio volumio[933]: info: MYVOLUMIO: Evaluating Server Sep 16 19:21:08 volumio volumio[933]: info: MyVolumio status changed Sep 16 19:21:08 volumio volumio[933]: info: Streaming services startup Sep 16 19:21:08 volumio volumio[933]: info: Starting Streaming Daemon Sep 16 19:21:08 volumio volumio[933]: info: Removing browser output: myVolumio user plan is not superstar Sep 16 19:21:08 volumio volumio[933]: info: Removing audio output: Sep 16 19:21:08 volumio volumio[933]: info: Stoppping Tunnel 1 Sep 16 19:21:08 volumio sudo[1793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 16 19:21:08 volumio sudo[1793]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:08 volumio sudo[1796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Sep 16 19:21:08 volumio sudo[1796]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:08 volumio sudo[1793]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:08 volumio volumio[933]: error: Cannot start Volumio Streaming Daemon Sep 16 19:21:08 volumio volumio[933]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 16 19:21:08 volumio volumio[933]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 16 19:21:08 volumio sudo[1796]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:08 volumio volumio[933]: info: Remote SSH Stopped Sep 16 19:21:09 volumio volumio[933]: info: Setting Geolocation for MyVolumio to eu2 Sep 16 19:21:09 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:21:09 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:21:09 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:21:09 volumio volumio[933]: info: BOOT COMPLETED Sep 16 19:21:09 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 16 19:21:09 volumio ntpd[741]: Soliciting pool server 195.32.70.195 Sep 16 19:21:09 volumio volumio[933]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Sep 16 19:21:10 volumio volumio[933]: info: Updating MyVolumio device info Sep 16 19:21:10 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:21:10 volumio ntpd[741]: Soliciting pool server 172.232.209.103 Sep 16 19:21:10 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 16 19:21:10 volumio volumio[933]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Sep 16 19:21:11 volumio ntpd[741]: Soliciting pool server 172.232.208.229 Sep 16 19:21:12 volumio ntpd[741]: Soliciting pool server 95.110.254.234 Sep 16 19:21:12 volumio ntpd[741]: Soliciting pool server 212.45.144.3 Sep 16 19:21:12 volumio volumio[933]: verbose: New Socket.io Connection to volumio.local from 192.168.1.117 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.0 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 5 Sep 16 19:21:12 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Sep 16 19:21:12 volumio volumio[933]: info: CorePlayQueue::getTrack 0 Sep 16 19:21:12 volumio volumio[933]: info: CoreCommandRouter::volumioGetQueue Sep 16 19:21:12 volumio volumio[933]: info: CoreStateMachine::getQueue Sep 16 19:21:12 volumio volumio[933]: info: CorePlayQueue::getQueue Sep 16 19:21:12 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Sep 16 19:21:12 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel Sep 16 19:21:12 volumio volumio[933]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Sep 16 19:21:12 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Sep 16 19:21:12 volumio volumio[933]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs Sep 16 19:21:12 volumio volumio[933]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Sep 16 19:21:12 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Sep 16 19:21:13 volumio ntpd[741]: Soliciting pool server 162.159.200.1 Sep 16 19:21:13 volumio ntpd[741]: Soliciting pool server 185.157.229.254 Sep 16 19:21:13 volumio volumio[933]: info: MYVOLUMIO: Adding device Sep 16 19:21:13 volumio volumio[933]: info: MYVOLUMIO: Evaluating Server Sep 16 19:21:13 volumio ntpd[741]: Soliciting pool server 212.45.144.206 Sep 16 19:21:13 volumio ntpd[741]: Soliciting pool server 185.19.184.35 Sep 16 19:21:14 volumio volumio[933]: info: Setting Geolocation for MyVolumio to eu4 Sep 16 19:21:14 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:21:14 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:21:14 volumio ntpd[741]: Soliciting pool server 89.46.74.148 Sep 16 19:21:14 volumio ntpd[741]: Soliciting pool server 93.94.88.51 Sep 16 19:21:14 volumio ntpd[741]: Soliciting pool server 151.22.209.90 Sep 16 19:21:14 volumio ntpd[741]: Soliciting pool server 81.56.230.156 Sep 16 19:21:15 volumio volumio[933]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Sep 16 19:21:15 volumio volumio[933]: info: Updating MyVolumio device info Sep 16 19:21:15 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:21:15 volumio ntpd[741]: Soliciting pool server 93.94.88.50 Sep 16 19:21:15 volumio ntpd[741]: Soliciting pool server 85.199.214.99 Sep 16 19:21:16 volumio volumio[933]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Sep 16 19:21:16 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , setUpdaterChannel Sep 16 19:21:16 volumio volumio[933]: info: Updater channel set to test Sep 16 19:21:16 volumio ntpd[741]: Soliciting pool server 37.247.53.178 Sep 16 19:21:17 volumio ntpd[741]: Soliciting pool server 2a00:6d41:10:1194::5 Sep 16 19:21:18 volumio volumio[933]: info: CALLMETHOD: system_controller system setTestPlugins true Sep 16 19:21:18 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Sep 16 19:21:18 volumio volumio[933]: info: Plugins store is now in test mode Sep 16 19:21:19 volumio ntpd[741]: receive: Unexpected origin timestamp 0xec741b0e.8b341e46 does not match aorg 0000000000.00000000 from server@212.45.144.3 xmt 0xec741b0f.14e6adca Sep 16 19:21:19 volumio ntpd[741]: receive: Unexpected origin timestamp 0xec741b0e.8b352faa does not match aorg 0000000000.00000000 from server@172.232.208.229 xmt 0xec741b0f.1439da00 Sep 16 19:21:19 volumio ntpd[741]: receive: Unexpected origin timestamp 0xec741b0e.8b32f4b8 does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xec741b0f.12ff1602 Sep 16 19:21:19 volumio ntpd[741]: receive: Unexpected origin timestamp 0xec741b0e.8b31d483 does not match aorg 0000000000.00000000 from server@89.46.74.148 xmt 0xec741b0f.15ec316b Sep 16 19:21:19 volumio ntpd[741]: receive: Unexpected origin timestamp 0xec741b0e.8b29ae60 does not match aorg 0000000000.00000000 from server@85.199.214.99 xmt 0xec741b0f.15b1f995 Sep 16 19:21:19 volumio ntpd[741]: receive: Unexpected origin timestamp 0xec741b0e.8b308b43 does not match aorg 0000000000.00000000 from server@93.94.88.51 xmt 0xec741b0f.17d64a87 Sep 16 19:21:19 volumio volumio[933]: info: CALLMETHOD: system_controller system setTestPlugins true Sep 16 19:21:19 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Sep 16 19:21:19 volumio volumio[933]: info: Plugins store is now in test mode Sep 16 19:21:19 volumio volumio[933]: info: CALLMETHOD: system_controller system setTestPlugins true Sep 16 19:21:19 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , setTestPlugins Sep 16 19:21:19 volumio volumio[933]: info: Plugins store is now in test mode Sep 16 19:21:33 volumio sudo[1865]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 16 19:21:33 volumio sudo[1865]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:33 volumio sudo[1865]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:33 volumio sudo[1867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 16 19:21:33 volumio sudo[1867]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:33 volumio sudo[1867]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:33 volumio volumio[933]: verbose: New Socket.io Connection to 192.168.1.119 from 192.168.1.117 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.0 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 5 Sep 16 19:21:33 volumio volumio[933]: info: CoreCommandRouter::volumioGetVisibleSources Sep 16 19:21:33 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 19:21:33 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Sep 16 19:21:33 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Sep 16 19:21:34 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Sep 16 19:21:34 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Sep 16 19:21:34 volumio volumio[933]: info: Received Get System Info Sep 16 19:21:34 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 16 19:21:34 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 16 19:21:34 volumio volumio[933]: info: Discovery: Getting this device information Sep 16 19:21:34 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Sep 16 19:21:34 volumio volumio[933]: info: CorePlayQueue::getTrack 0 Sep 16 19:21:34 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 16 19:21:34 volumio volumio-remote-updater[609]: Test mode enabled Sep 16 19:21:34 volumio volumio-remote-updater[609]: No alpha test mode Sep 16 19:21:34 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 16 19:21:34 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 16 19:21:34 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:21:34 volumio volumio[933]: info: Retrieving Cloud Streaming UI Sep 16 19:21:34 volumio volumio[933]: info: Getting Tidal Cloud Configuration Sep 16 19:21:34 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:21:34 volumio volumio[933]: info: Getting Qobuz Cloud Configuration Sep 16 19:21:34 volumio volumio[933]: info: Asking plugin for UI Config Sep 16 19:21:34 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:21:34 volumio volumio[933]: info: Getting Spotify Cloud Configuration Sep 16 19:21:34 volumio volumio[933]: info: Asking plugin for UI Config Sep 16 19:21:34 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:21:34 volumio volumio[933]: info: Saving Spotify Acccount Sep 16 19:21:34 volumio volumio[933]: info: Got Tidal Cloud Configuration Sep 16 19:21:34 volumio volumio[933]: info: Got it Sep 16 19:21:34 volumio volumio[933]: info: Got it Sep 16 19:21:34 volumio volumio[933]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 16 19:21:34 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:21:34 volumio volumio[933]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 16 19:21:34 volumio volumio[933]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 16 19:21:34 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 16 19:21:35 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Sep 16 19:21:35 volumio volumio[933]: info: Loading i18n strings for locale it Sep 16 19:21:35 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Sep 16 19:21:35 volumio volumio[933]: info: Setting timezone to Europe/Rome Sep 16 19:21:35 volumio sudo[1875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Sep 16 19:21:35 volumio sudo[1875]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:35 volumio sudo[1875]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:35 volumio sudo[1878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Rome /etc/localtime Sep 16 19:21:35 volumio sudo[1878]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:35 volumio sudo[1878]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:35 volumio sudo[1881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Sep 16 19:21:35 volumio sudo[1881]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:35 volumio sudo[1881]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:35 volumio sudo[1884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Rome Sep 16 19:21:35 volumio sudo[1884]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:35 volumio sudo[1884]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:35 volumio volumio[933]: Updating browse sources language Sep 16 19:21:35 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 19:21:35 volumio volumio[933]: info: Fetching Streaming Services browse cache Sep 16 19:21:35 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 16 19:21:36 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Sep 16 19:21:36 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 16 19:21:36 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 16 19:21:36 volumio volumio-remote-updater[609]: Test mode enabled Sep 16 19:21:36 volumio volumio-remote-updater[609]: No alpha test mode Sep 16 19:21:36 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Sep 16 19:21:36 volumio volumio[933]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 16 19:21:36 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 16 19:21:39 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Sep 16 19:21:39 volumio volumio[933]: info: Loading i18n strings for locale it Sep 16 19:21:39 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Sep 16 19:21:39 volumio volumio[933]: info: Setting timezone to Europe/Rome Sep 16 19:21:39 volumio sudo[1888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Sep 16 19:21:39 volumio sudo[1888]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:39 volumio sudo[1888]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:39 volumio sudo[1891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Rome /etc/localtime Sep 16 19:21:39 volumio sudo[1891]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:39 volumio sudo[1891]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:39 volumio sudo[1894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Sep 16 19:21:39 volumio sudo[1894]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:39 volumio sudo[1894]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:39 volumio sudo[1897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Rome Sep 16 19:21:39 volumio sudo[1897]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:39 volumio sudo[1897]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:39 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Sep 16 19:21:39 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Sep 16 19:21:39 volumio sudo[1900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 16 19:21:39 volumio sudo[1900]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:21:39 volumio volumio[933]: Updating browse sources language Sep 16 19:21:39 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 19:21:40 volumio volumio[933]: info: Fetching Streaming Services browse cache Sep 16 19:21:43 volumio sudo[1900]: pam_unix(sudo:session): session closed for user root Sep 16 19:21:44 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Sep 16 19:21:44 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Sep 16 19:21:44 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 16 19:21:44 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:21:44 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 16 19:21:52 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 16 19:21:52 volumio volumio[933]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Sep 16 19:21:52 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Sep 16 19:21:52 volumio volumio[933]: info: Received Get System Version Sep 16 19:21:52 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 19:21:52 volumio volumio[933]: info: Received Get System Info Sep 16 19:21:52 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 16 19:21:52 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 16 19:21:52 volumio volumio[933]: info: Discovery: Getting this device information Sep 16 19:21:52 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Sep 16 19:21:52 volumio volumio[933]: info: CorePlayQueue::getTrack 0 Sep 16 19:21:52 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 16 19:22:00 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Sep 16 19:22:00 volumio volumio[933]: info: Preparing to save Alsa Options, stopping services first Sep 16 19:22:00 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Sep 16 19:22:00 volumio volumio[933]: info: CorePlayQueue::getTrack 0 Sep 16 19:22:00 volumio volumio[933]: info: CoreCommandRouter::volumioPause Sep 16 19:22:00 volumio volumio[933]: info: CoreStateMachine::pause Sep 16 19:22:00 volumio volumio[933]: info: Saving Audio Output to: {"i2s":true,"i2sid":{"value":"hifiberry-dac2hd","label":"HiFiBerry DAC2 HD"},"output_device":{"value":1,"label":"HiFiBerry DAC2 HD"},"disallowPush":true} Sep 16 19:22:00 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 16 19:22:00 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Sep 16 19:22:00 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:22:00 volumio volumio[933]: info: Enabling I2S DAC: HiFiBerry DAC2 HD Sep 16 19:22:00 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Sep 16 19:22:00 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:22:01 volumio sudo[1936]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Sep 16 19:22:01 volumio sudo[1936]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:22:01 volumio sudo[1936]: pam_unix(sudo:session): session closed for user root Sep 16 19:22:01 volumio volumio[933]: info: No Overlays Loaded Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:22:01 volumio sudo[1939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay hifiberry-dacplushd Sep 16 19:22:01 volumio sudo[1939]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:22:01 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2s@7e203000/status Sep 16 19:22:01 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2c@7e804000/status Sep 16 19:22:01 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2c@7e804000/pcm1792a@4c/compatible Sep 16 19:22:01 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2c@7e804000/pcm1792a@4c/#sound-dai-cells Sep 16 19:22:01 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2c@7e804000/pcm1792a@4c/#clock-cells Sep 16 19:22:01 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2c@7e804000/pcm1792a@4c/reg Sep 16 19:22:01 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2c@7e804000/pcm1792a@4c/status Sep 16 19:22:01 volumio sudo[1939]: pam_unix(sudo:session): session closed for user root Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:22:01 volumio volumio[933]: info: Found match in i2s Card Database: setting mixer DAC for card HiFiBerry DAC2 HD Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::volumioUpdateVolumeSettings Sep 16 19:22:01 volumio volumio[933]: info: Updating Volume Controller Parameters: Device: 2 Name: HiFiBerry DAC2 HD Mixer: DAC Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Sep 16 19:22:01 volumio volumio[933]: info: Disabling external Volume Control Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Sep 16 19:22:01 volumio volumio[933]: info: Preparing to generate the ALSA configuration file Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Sep 16 19:22:01 volumio sudo[1955]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 16 19:22:01 volumio sudo[1955]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:22:01 volumio sudo[1957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 16 19:22:01 volumio sudo[1957]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:22:01 volumio sudo[1957]: pam_unix(sudo:session): session closed for user root Sep 16 19:22:01 volumio volumio[933]: error: Cannot enable I2S Param: Error: Command failed: /usr/bin/sudo /usr/bin/dtoverlay hifiberry-dacplushd Sep 16 19:22:01 volumio volumio[933]: * Failed to apply overlay '0_hifiberry-dacplushd' (kernel) Sep 16 19:22:01 volumio volumio[933]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Sep 16 19:22:01 volumio volumio[933]: wlan0 Interface doesn't support scanning : Device or resource busy Sep 16 19:22:01 volumio volumio[933]: info: Cannot use regular scanning, forcing with ap-force Sep 16 19:22:01 volumio sudo[1962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Sep 16 19:22:01 volumio sudo[1962]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:22:01 volumio sudo[1962]: pam_unix(sudo:session): session closed for user root Sep 16 19:22:01 volumio volumio[933]: command failed: Device or resource busy (-16) Sep 16 19:22:01 volumio volumio[933]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Sep 16 19:22:01 volumio volumio[933]: command failed: Device or resource busy (-16) Sep 16 19:22:01 volumio volumio[933]: info: VolumeController:: Volume=46 Mute =false Sep 16 19:22:01 volumio volumio[933]: info: CoreStateMachine::pushState Sep 16 19:22:01 volumio volumio[933]: info: CorePlayQueue::getTrack 0 Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 16 19:22:01 volumio volumio[933]: info: Getting Alsa Cards List without I2S DAC Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 16 19:22:01 volumio volumio[933]: info: Asound.conf file written Sep 16 19:22:01 volumio sudo[1973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Sep 16 19:22:01 volumio sudo[1973]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:22:01 volumio sudo[1973]: pam_unix(sudo:session): session closed for user root Sep 16 19:22:01 volumio volumio[933]: No state is present for card b1 Sep 16 19:22:01 volumio volumio[933]: /usr/share/alsa/init/bcm2835:14: control element not found Sep 16 19:22:01 volumio volumio[933]: No state is present for card b1 Sep 16 19:22:01 volumio volumio[933]: No state is present for card Headphones Sep 16 19:22:01 volumio volumio[933]: /usr/share/alsa/init/bcm2835:20: control element not found Sep 16 19:22:01 volumio volumio[933]: No state is present for card Headphones Sep 16 19:22:01 volumio volumio[933]: No state is present for card sndrpihifiberry Sep 16 19:22:01 volumio volumio[933]: Found hardware: "HifiberryDacplu" "" "" "" "" Sep 16 19:22:01 volumio volumio[933]: Hardware is initialized using a generic method Sep 16 19:22:01 volumio volumio[933]: No state is present for card sndrpihifiberry Sep 16 19:22:01 volumio volumio[933]: info: Output device has changed, restarting MPD Sep 16 19:22:01 volumio volumio[933]: info: Output device has changed, restarting Shairport Sync Sep 16 19:22:01 volumio sudo[1978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 16 19:22:01 volumio sudo[1978]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:22:01 volumio sudo[1978]: pam_unix(sudo:session): session closed for user root Sep 16 19:22:01 volumio sudo[1980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 16 19:22:01 volumio sudo[1980]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:22:01 volumio systemd[1]: Stopping Music Player Daemon... Sep 16 19:22:01 volumio volumio[933]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 19:22:01 volumio volumio[933]: info: Output device has changed, restarting MPD Sep 16 19:22:01 volumio systemd[1]: mpd.service: Succeeded. Sep 16 19:22:01 volumio systemd[1]: Stopped Music Player Daemon. Sep 16 19:22:01 volumio volumio[933]: info: Output device has changed, restarting Shairport Sync Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:01 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:22:01 volumio systemd[1]: Starting Music Player Daemon... Sep 16 19:22:01 volumio sudo[1987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 16 19:22:01 volumio sudo[1987]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:22:01 volumio sudo[1987]: pam_unix(sudo:session): session closed for user root Sep 16 19:22:01 volumio sudo[1990]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 16 19:22:01 volumio sudo[1990]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:22:01 volumio volumio[933]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 16 19:22:02 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Sep 16 19:22:02 volumio systemd[1]: mpd.service: Succeeded. Sep 16 19:22:02 volumio systemd[1]: Stopped Music Player Daemon. Sep 16 19:22:02 volumio volumio[933]: info: MPD Permissions set Sep 16 19:22:02 volumio volumio[933]: info: MPD Permissions set Sep 16 19:22:02 volumio systemd[1]: Starting Music Player Daemon... Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:02 volumio volumio[933]: info: Starting Shairport Sync Sep 16 19:22:02 volumio volumio[933]: info: Starting Shairport Sync Sep 16 19:22:02 volumio sudo[2006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 19:22:02 volumio sudo[2006]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:22:02 volumio sudo[1996]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 16 19:22:02 volumio sudo[1996]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:22:02 volumio sudo[2009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 16 19:22:02 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 16 19:22:02 volumio sudo[1996]: pam_unix(sudo:session): session closed for user root Sep 16 19:22:02 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 16 19:22:02 volumio sudo[2009]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:22:02 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 16 19:22:02 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 16 19:22:02 volumio sudo[2006]: pam_unix(sudo:session): session closed for user root Sep 16 19:22:02 volumio volumio[933]: info: Shairport-Sync Started Sep 16 19:22:02 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 16 19:22:02 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Sep 16 19:22:02 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 16 19:22:02 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 16 19:22:02 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 16 19:22:02 volumio sudo[2009]: pam_unix(sudo:session): session closed for user root Sep 16 19:22:02 volumio volumio[933]: info: Shairport-Sync Started Sep 16 19:22:03 volumio mpd[2012]: Sep 16 19:22 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 16 19:22:03 volumio systemd[1]: Started Music Player Daemon. Sep 16 19:22:03 volumio sudo[1990]: pam_unix(sudo:session): session closed for user root Sep 16 19:22:03 volumio sudo[1980]: pam_unix(sudo:session): session closed for user root Sep 16 19:22:03 volumio volumio[933]: error: MPD error: The expression evaluated to a falsy value: Sep 16 19:22:03 volumio volumio[933]: assert.ok(self.idling) Sep 16 19:22:03 volumio volumio[933]: error: The expression evaluated to a falsy value: Sep 16 19:22:03 volumio volumio[933]: assert.ok(self.idling) Sep 16 19:22:03 volumio volumio[933]: error: updateQueue error: null Sep 16 19:22:04 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:22:04 volumio volumio[933]: info: Retrieving Cloud Streaming UI Sep 16 19:22:04 volumio volumio[933]: info: Getting Tidal Cloud Configuration Sep 16 19:22:04 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:22:04 volumio volumio[933]: info: Getting Qobuz Cloud Configuration Sep 16 19:22:04 volumio volumio[933]: info: Asking plugin for UI Config Sep 16 19:22:04 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:22:04 volumio volumio[933]: info: Getting Spotify Cloud Configuration Sep 16 19:22:04 volumio volumio[933]: info: Asking plugin for UI Config Sep 16 19:22:04 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:22:04 volumio volumio[933]: info: Saving Spotify Acccount Sep 16 19:22:04 volumio volumio[933]: info: Got Tidal Cloud Configuration Sep 16 19:22:04 volumio volumio[933]: info: Got it Sep 16 19:22:04 volumio volumio[933]: info: Got it Sep 16 19:22:04 volumio volumio[933]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 16 19:22:04 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:22:04 volumio volumio[933]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 16 19:22:05 volumio sudo[1955]: pam_unix(sudo:session): session closed for user root Sep 16 19:22:05 volumio volumio[933]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Sep 16 19:22:05 volumio volumio[933]: info: CoreStateMachine::getcurrentVolume Sep 16 19:22:05 volumio volumio[933]: info: CoreCommandRouter::volumioRetrievevolume Sep 16 19:22:05 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Sep 16 19:22:05 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 16 19:22:05 volumio volumio[933]: info: VolumeController:: Volume=46 Mute =false Sep 16 19:22:05 volumio volumio[933]: info: CoreStateMachine::pushState Sep 16 19:22:05 volumio volumio[933]: info: CorePlayQueue::getTrack 0 Sep 16 19:22:05 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Sep 16 19:22:05 volumio volumio[933]: info: CoreStateMachine::updateTrackBlock Sep 16 19:22:05 volumio volumio[933]: info: CorePlayQueue::getTrackBlock Sep 16 19:22:05 volumio volumio[933]: info: CoreCommandRouter::volumioRetrievevolume Sep 16 19:22:05 volumio volumio[933]: info: VolumeController:: Volume=46 Mute =false Sep 16 19:22:05 volumio volumio[933]: info: CoreStateMachine::pushState Sep 16 19:22:05 volumio volumio[933]: info: CorePlayQueue::getTrack 0 Sep 16 19:22:05 volumio volumio[933]: info: CoreCommandRouter::volumioPushState Sep 16 19:22:05 volumio volumio-remote-updater[609]: Test mode enabled Sep 16 19:22:05 volumio volumio-remote-updater[609]: No alpha test mode Sep 16 19:22:05 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Sep 16 19:22:05 volumio volumio[933]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 16 19:22:05 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 16 19:22:07 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Sep 16 19:22:07 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Sep 16 19:22:07 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Sep 16 19:22:07 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Sep 16 19:22:07 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Sep 16 19:22:09 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Sep 16 19:22:09 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 16 19:22:09 volumio systemd[1]: systemd-timedated.service: Succeeded. Sep 16 19:22:09 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Sep 16 19:22:09 volumio volumio[933]: info: CoreCommandRouter::Reload Ui Sep 16 19:22:09 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Sep 16 19:22:09 volumio volumio[933]: info: Wizard terminated Successfully Sep 16 19:22:09 volumio volumio[933]: info: CoreCommandRouter::volumiosetStartupVolume Sep 16 19:22:09 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 16 19:22:09 volumio volumio[933]: info: Player Reboot required after I2S DAC has been enabled in wizard Sep 16 19:22:10 volumio volumio-remote-updater[609]: Test mode enabled Sep 16 19:22:10 volumio volumio-remote-updater[609]: No alpha test mode Sep 16 19:22:10 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Sep 16 19:22:10 volumio volumio[933]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 16 19:22:10 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 16 19:22:10 volumio sudo[2089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 16 19:22:10 volumio sudo[2089]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:22:10 volumio sudo[2089]: pam_unix(sudo:session): session closed for user root Sep 16 19:22:10 volumio sudo[2091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 16 19:22:10 volumio sudo[2091]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:22:10 volumio sudo[2091]: pam_unix(sudo:session): session closed for user root Sep 16 19:22:10 volumio volumio[933]: verbose: New Socket.io Connection to 192.168.1.119 from 192.168.1.117 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.0 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 4 Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::volumioGetVisibleSources Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Sep 16 19:22:11 volumio volumio[933]: info: CorePlayQueue::getTrack 0 Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 16 19:22:11 volumio volumio[933]: info: Received Get System Info Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 16 19:22:11 volumio volumio[933]: info: Discovery: Getting this device information Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Sep 16 19:22:11 volumio volumio[933]: info: CorePlayQueue::getTrack 0 Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Sep 16 19:22:11 volumio volumio[933]: info: CorePlayQueue::getTrack 0 Sep 16 19:22:11 volumio volumio[933]: info: Listing playlists Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 16 19:22:11 volumio sudo[2098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 16 19:22:11 volumio sudo[2098]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:22:11 volumio sudo[2098]: pam_unix(sudo:session): session closed for user root Sep 16 19:22:11 volumio sudo[2100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 16 19:22:11 volumio sudo[2100]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 16 19:22:11 volumio sudo[2100]: pam_unix(sudo:session): session closed for user root Sep 16 19:22:11 volumio volumio[933]: verbose: New Socket.io Connection to 192.168.1.119 from 192.168.1.117 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.0 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 5 Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::volumioGetVisibleSources Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Sep 16 19:22:11 volumio volumio[933]: info: CorePlayQueue::getTrack 0 Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 16 19:22:11 volumio volumio[933]: info: Received Get System Info Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 16 19:22:11 volumio volumio[933]: info: Discovery: Getting this device information Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Sep 16 19:22:11 volumio volumio[933]: info: CorePlayQueue::getTrack 0 Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Sep 16 19:22:11 volumio volumio[933]: info: CorePlayQueue::getTrack 0 Sep 16 19:22:11 volumio volumio[933]: info: Listing playlists Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 16 19:22:11 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 16 19:22:12 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Sep 16 19:22:12 volumio volumio[933]: info: CorePlayQueue::getTrack 0 Sep 16 19:22:13 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Sep 16 19:22:13 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 16 19:22:13 volumio volumio[933]: info: Received Get System Info Sep 16 19:22:13 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 16 19:22:13 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 16 19:22:13 volumio volumio[933]: info: Discovery: Getting this device information Sep 16 19:22:13 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Sep 16 19:22:13 volumio volumio[933]: info: CorePlayQueue::getTrack 0 Sep 16 19:22:13 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 16 19:22:15 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 16 19:22:15 volumio volumio[933]: info: Received Get System Info Sep 16 19:22:15 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 16 19:22:15 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 16 19:22:15 volumio volumio[933]: info: Discovery: Getting this device information Sep 16 19:22:15 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Sep 16 19:22:15 volumio volumio[933]: info: CorePlayQueue::getTrack 0 Sep 16 19:22:15 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 16 19:22:20 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Sep 16 19:22:21 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 16 19:22:25 volumio volumio[933]: info: CoreCommandRouter::Close All Modals sent Sep 16 19:22:25 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted Sep 16 19:22:29 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 16 19:22:29 volumio volumio[933]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Sep 16 19:22:29 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Sep 16 19:22:29 volumio volumio[933]: info: Received Get System Version Sep 16 19:22:29 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 16 19:22:29 volumio volumio[933]: info: Received Get System Info Sep 16 19:22:29 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 16 19:22:29 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 16 19:22:29 volumio volumio[933]: info: Discovery: Getting this device information Sep 16 19:22:29 volumio volumio[933]: info: CoreCommandRouter::volumioGetState Sep 16 19:22:29 volumio volumio[933]: info: CorePlayQueue::getTrack 0 Sep 16 19:22:29 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:22:36 volumio volumio[933]: info: Retrieving Cloud Streaming UI Sep 16 19:22:36 volumio volumio[933]: info: Getting Tidal Cloud Configuration Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:22:36 volumio volumio[933]: info: Getting Qobuz Cloud Configuration Sep 16 19:22:36 volumio volumio[933]: info: Asking plugin for UI Config Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:22:36 volumio volumio[933]: info: Getting Spotify Cloud Configuration Sep 16 19:22:36 volumio volumio[933]: info: Asking plugin for UI Config Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:22:36 volumio volumio[933]: info: Saving Spotify Acccount Sep 16 19:22:36 volumio volumio[933]: info: Got Tidal Cloud Configuration Sep 16 19:22:36 volumio volumio[933]: info: Got it Sep 16 19:22:36 volumio volumio[933]: info: Got it Sep 16 19:22:36 volumio volumio[933]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 16 19:22:36 volumio volumio[933]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::volumioGetBrowseSources Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::volumioGetBrowseSources Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::volumioGetBrowseSources Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 16 19:22:36 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 16 19:22:39 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Sep 16 19:22:39 volumio volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Sep 16 19:22:39 volumio volumio[933]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 16 19:22:39 volumio volumio[933]: Error: getaddrinfo -3007 Sep 16 19:22:39 volumio volumio[933]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Sep 16 19:22:39 volumio volumio[933]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Sep 16 19:22:39 volumio volumio[933]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Sep 16 19:22:39 volumio volumio[933]: code: -3007, Sep 16 19:22:39 volumio volumio[933]: errno: -3007, Sep 16 19:22:39 volumio volumio[933]: syscall: 'getaddrinfo' Sep 16 19:22:39 volumio volumio[933]: } Sep 16 19:22:39 volumio volumio[933]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 16 19:22:40 volumio sudo[2163]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-16 19:21 Sep 16 19:22:40 volumio sudo[2163]: 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="95d9088e5dcb3a55aabfe7f209b9ae00946f3ec5" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9a3927796ae9ab3a5a247866bf574288cd09ee64" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 04 Sep 2025 04:11:35 PM CEST" VOLUMIO_VERSION="3.845" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d8c10ad904a299b47c7499a1cf239286"