Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::initPlayerControls Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 17:38:00 volumiosalon sudo[1637]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 26 17:38:00 volumiosalon sudo[1637]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:00 volumiosalon volumio[1368]: Express server listening on port 3000 Dec 26 17:38:00 volumiosalon volumio[1368]: [Metrics] WebUI: 3s 530.59ms Dec 26 17:38:00 volumiosalon sudo[1637]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:00 volumiosalon sudo[1641]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 17:38:00 volumiosalon sudo[1641]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreStateMachine::resetVolumioState Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreStateMachine::getcurrentVolume Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioRetrievevolume Dec 26 17:38:00 volumiosalon sudo[1641]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:00 volumiosalon wireless.js[982]: WIRELESS.JS - INFO: ... wlan0 IPv4 is 192.168.1.70, ipV6 is undefined Dec 26 17:38:00 volumiosalon wireless.js[982]: WIRELESS.JS - INFO: Connected to SSID: CHANUR3 Dec 26 17:38:00 volumiosalon wireless.js[982]: WIRELESS.JS - INFO: It's done! AP Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:00 volumiosalon wireless.js[982]: WIRELESS.JS - INFO: Restarting avahi-daemon... Dec 26 17:38:00 volumiosalon sudo[1651]: root : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart avahi-daemon Dec 26 17:38:00 volumiosalon sudo[1651]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 26 17:38:00 volumiosalon volumio[1368]: info: Volumio Network Manager: Network status updated: 0 Dec 26 17:38:00 volumiosalon volumio[1368]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '5'. Dec 26 17:38:00 volumiosalon volumio[1368]: info: Cannot mount NAS Youtube at system boot, trial number 1 ,retrying in 5 seconds Dec 26 17:38:00 volumiosalon volumio[1368]: info: Cannot mount NAS Lossy at system boot, trial number 1 ,retrying in 5 seconds Dec 26 17:38:00 volumiosalon systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 26 17:38:00 volumiosalon volumio[1368]: info: Cannot mount NAS Lossless at system boot, trial number 1 ,retrying in 5 seconds Dec 26 17:38:00 volumiosalon systemd[1]: shairport-sync.service: Deactivated successfully. Dec 26 17:38:00 volumiosalon systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 26 17:38:00 volumiosalon systemd[1]: shairport-sync.service: Consumed 1.610s CPU time. Dec 26 17:38:00 volumiosalon avahi-daemon[960]: Got SIGTERM, quitting. Dec 26 17:38:00 volumiosalon systemd[1]: Stopping avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Dec 26 17:38:00 volumiosalon avahi-daemon[960]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.70. Dec 26 17:38:00 volumiosalon avahi-daemon[960]: Leaving mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Dec 26 17:38:00 volumiosalon avahi-daemon[960]: avahi-daemon 0.8 exiting. Dec 26 17:38:00 volumiosalon systemd[1]: avahi-daemon.service: Deactivated successfully. Dec 26 17:38:00 volumiosalon systemd[1]: Stopped avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Dec 26 17:38:00 volumiosalon dbus-daemon[962]: [system] Activating via systemd: service name='org.freedesktop.Avahi' unit='dbus-org.freedesktop.Avahi.service' requested by ':1.12' (uid=0 pid=1607 comm="/usr/sbin/smbd --foreground --no-process-group") Dec 26 17:38:00 volumiosalon volumio-remote-updater[975]: [2025-12-26 17:38:00] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1766767077 101 Dec 26 17:38:00 volumiosalon volumio[1368]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 1 Dec 26 17:38:00 volumiosalon volumio[1368]: info: VolumeController:: Volume=undefined Mute =false Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreStateMachine::pushState Dec 26 17:38:00 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioPushState Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreStateMachine::updateTrackBlock Dec 26 17:38:00 volumiosalon volumio[1368]: info: CorePlayQueue::getTrackBlock Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioRetrievevolume Dec 26 17:38:00 volumiosalon systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Dec 26 17:38:00 volumiosalon avahi-daemon[1656]: Process 960 died: No such process; trying to remove PID file. (/run/avahi-daemon//pid) Dec 26 17:38:00 volumiosalon avahi-daemon[1656]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). Dec 26 17:38:00 volumiosalon avahi-daemon[1656]: Successfully dropped root privileges. Dec 26 17:38:00 volumiosalon avahi-daemon[1656]: avahi-daemon 0.8 starting up. Dec 26 17:38:00 volumiosalon dbus-daemon[962]: [system] Successfully activated service 'org.freedesktop.Avahi' Dec 26 17:38:00 volumiosalon systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Dec 26 17:38:00 volumiosalon avahi-daemon[1656]: Successfully called chroot(). Dec 26 17:38:00 volumiosalon avahi-daemon[1656]: Successfully dropped remaining capabilities. Dec 26 17:38:00 volumiosalon sudo[1651]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:00 volumiosalon avahi-daemon[1656]: Loading service file /services/volumio.service. Dec 26 17:38:00 volumiosalon systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 26 17:38:00 volumiosalon avahi-daemon[1656]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.70. Dec 26 17:38:00 volumiosalon avahi-daemon[1656]: New relevant interface wlan0.IPv4 for mDNS. Dec 26 17:38:00 volumiosalon avahi-daemon[1656]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Dec 26 17:38:00 volumiosalon avahi-daemon[1656]: New relevant interface lo.IPv4 for mDNS. Dec 26 17:38:00 volumiosalon avahi-daemon[1656]: Network interface enumeration completed. Dec 26 17:38:00 volumiosalon avahi-daemon[1656]: Registering new address record for 192.168.1.70 on wlan0.IPv4. Dec 26 17:38:00 volumiosalon avahi-daemon[1656]: Registering new address record for 127.0.0.1 on lo.IPv4. Dec 26 17:38:00 volumiosalon volumio[1368]: verbose: New Socket.io Connection to 192.168.1.70 from 192.168.1.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 2 Dec 26 17:38:00 volumiosalon wireless.js[982]: WIRELESS.JS - INFO: Notified systemd about wireless ready Dec 26 17:38:00 volumiosalon volumio[1368]: info: Reloading queue from file Dec 26 17:38:00 volumiosalon volumio[1368]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Dec 26 17:38:00 volumiosalon volumio[1368]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '5'. Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreStateMachine::setRepeat null single undefined Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreStateMachine::pushState Dec 26 17:38:00 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioPushState Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreStateMachine::setRandom null Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreStateMachine::pushState Dec 26 17:38:00 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioPushState Dec 26 17:38:00 volumiosalon volumio[1368]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 26 17:38:00 volumiosalon volumio[1368]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b04170 Dec 26 17:38:00 volumiosalon volumio[1368]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 26 17:38:00 volumiosalon volumio[1368]: info: VolumeController:: Volume=undefined Mute =false Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreStateMachine::pushState Dec 26 17:38:00 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioPushState Dec 26 17:38:00 volumiosalon volumio[1368]: info: Setting Device type: Raspberry PI Dec 26 17:38:00 volumiosalon volumio[1368]: info: Completed loading Core Plugins Dec 26 17:38:00 volumiosalon volumio[1368]: info: Preparing to generate the ALSA configuration file Dec 26 17:38:00 volumiosalon volumio[1368]: error: Discovery: Advertisement error: Error: dns service error: unknown Dec 26 17:38:00 volumiosalon volumio[1368]: error: Discovery: advertisement error: Error: dns service error: unknown Dec 26 17:38:00 volumiosalon volumio[1368]: info: Discovery: Advertisement raised the following error Error: dns service error: unknown Dec 26 17:38:00 volumiosalon volumio[1368]: info: Discovery: Stopping Advertising Immediately Dec 26 17:38:00 volumiosalon volumio[1368]: info: Discovery: Stopping existing advertisement Dec 26 17:38:00 volumiosalon volumio[1368]: info: Discovery: Browse raised the following error Error: dns service error: unknown Dec 26 17:38:00 volumiosalon volumio[1368]: info: Discovery: Restarting Browsing Dec 26 17:38:00 volumiosalon volumio[1368]: info: Asound.conf file unchanged, so no further update is needed Dec 26 17:38:00 volumiosalon volumio[1368]: info: Output device has changed, restarting MPD Dec 26 17:38:00 volumiosalon volumio[1368]: info: ___________ START PLUGINS ___________ Dec 26 17:38:00 volumiosalon sudo[1685]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 26 17:38:00 volumiosalon sudo[1685]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:00 volumiosalon volumio[1368]: info: ControllerMpd::onStart: Initializing MPD Dec 26 17:38:00 volumiosalon volumio[1368]: info: Creating MPD Configuration file Dec 26 17:38:00 volumiosalon sudo[1683]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 26 17:38:00 volumiosalon sudo[1683]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:00 volumiosalon sudo[1683]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 26 17:38:00 volumiosalon volumio[1368]: info: [1766767080175] CoreMusicLibrary::Adding element Serveurs Média Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 17:38:00 volumiosalon sudo[1689]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 26 17:38:00 volumiosalon sudo[1689]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:00 volumiosalon volumio[1368]: info: UPNP Browser: Client initialized successfully Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 26 17:38:00 volumiosalon volumio[1368]: info: [1766767080182] CoreMusicLibrary::Adding element Last_100 Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 26 17:38:00 volumiosalon volumio[1368]: info: [1766767080184] CoreMusicLibrary::Adding element Webradio Dec 26 17:38:00 volumiosalon sudo[1691]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 26 17:38:00 volumiosalon sudo[1691]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 17:38:00 volumiosalon sudo[1689]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 26 17:38:00 volumiosalon volumio[1368]: info: Initializing BBC Radios Dec 26 17:38:00 volumiosalon systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 26 17:38:00 volumiosalon systemd[1]: Starting mpd.service - Music Player Daemon... Dec 26 17:38:00 volumiosalon systemd[1]: mpd.service: Deactivated successfully. Dec 26 17:38:00 volumiosalon systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 26 17:38:00 volumiosalon systemd[1]: mpd.socket: Deactivated successfully. Dec 26 17:38:00 volumiosalon systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 26 17:38:00 volumiosalon systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 26 17:38:00 volumiosalon systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 26 17:38:00 volumiosalon systemd[1]: Starting mpd.service - Music Player Daemon... Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: [ytcr] Data store TTL expired - clearing it... Dec 26 17:38:00 volumiosalon sudo[1700]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 26 17:38:00 volumiosalon sudo[1700]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 26 17:38:00 volumiosalon sudo[1712]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 26 17:38:00 volumiosalon sudo[1700]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:00 volumiosalon volumio[1368]: info: Loading i18n strings for locale fr Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 26 17:38:00 volumiosalon volumio[1368]: info: Volumio Calling Home Dec 26 17:38:00 volumiosalon sudo[1716]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /data/volumiokioskextensions/IframeKeyboardBridge Dec 26 17:38:00 volumiosalon sudo[1716]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:00 volumiosalon sudo[1716]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:00 volumiosalon sudo[1722]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Dec 26 17:38:00 volumiosalon sudo[1722]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:00 volumiosalon sudo[1724]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Dec 26 17:38:00 volumiosalon sudo[1724]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:00 volumiosalon sudo[1727]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Dec 26 17:38:00 volumiosalon sudo[1727]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:00 volumiosalon systemd[1]: Reloading. Dec 26 17:38:00 volumiosalon volumio[1368]: info: touch_display: No backlight interface detected. Dec 26 17:38:00 volumiosalon volumio[1368]: verbose: New Socket.io Connection to 192.168.1.70 from 192.168.1.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 4 Dec 26 17:38:00 volumiosalon volumio[1368]: info: MPD Permissions set Dec 26 17:38:00 volumiosalon volumio[1368]: info: MPD Permissions set Dec 26 17:38:00 volumiosalon volumio[1368]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon sudo[1732]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/cp -r /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/content.js /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/manifest.json /data/volumiokioskextensions/IframeKeyboardBridge/ Dec 26 17:38:00 volumiosalon sudo[1732]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:00 volumiosalon sudo[1732]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:00 volumiosalon volumio[1368]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Dec 26 17:38:00 volumiosalon sudo[1767]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Dec 26 17:38:00 volumiosalon sudo[1767]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:00 volumiosalon sudo[1767]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:00 volumiosalon sudo[1765]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Dec 26 17:38:00 volumiosalon sudo[1765]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:00 volumiosalon volumio[1368]: verbose: New Socket.io Connection to 192.168.1.70 from 192.168.1.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 6 Dec 26 17:38:00 volumiosalon sudo[1765]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:00 volumiosalon volumio[1368]: info: Volumio called home Dec 26 17:38:00 volumiosalon volumio[1368]: info: touch_display: IframeKeyboardBridge extension installed successfully Dec 26 17:38:00 volumiosalon volumio[1368]: verbose: New Socket.io Connection to 192.168.1.70 from 192.168.1.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 7 Dec 26 17:38:00 volumiosalon volumio[1368]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Dec 26 17:38:00 volumiosalon volumio[1368]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Dec 26 17:38:00 volumiosalon volumio[1368]: verbose: New Socket.io Connection to 192.168.1.70 from 192.168.1.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 8 Dec 26 17:38:00 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:00 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:00 volumiosalon sudo[1428]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:00 volumiosalon systemd[1]: Reloading. Dec 26 17:38:00 volumiosalon sudo[1724]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:00 volumiosalon volumio[1368]: info: touch_display: systemctl disable getty@tty1.service succeeded. Dec 26 17:38:00 volumiosalon avahi-daemon[1656]: Server startup complete. Host name is volumiosalon.local. Local service cookie is 2489302778. Dec 26 17:38:01 volumiosalon sudo[1727]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:01 volumiosalon volumio[1368]: info: touch_display: systemctl daemon-reload succeeded. Dec 26 17:38:01 volumiosalon sudo[1722]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:01 volumiosalon sudo[1789]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Dec 26 17:38:01 volumiosalon sudo[1789]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:01 volumiosalon volumio[1368]: info: [yt-cast-receiver] DIAL server listening on port 8098 Dec 26 17:38:01 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioRetrievevolume Dec 26 17:38:01 volumiosalon volumio[1368]: info: touch_display: systemctl stop getty@tty1.service succeeded. Dec 26 17:38:01 volumiosalon volumio[1368]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number '5'. Dec 26 17:38:01 volumiosalon volumio[1368]: info: VolumeController:: Volume=undefined Mute =false Dec 26 17:38:01 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:01 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:01 volumiosalon volumio[1368]: info: CoreStateMachine::pushState Dec 26 17:38:01 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:01 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioPushState Dec 26 17:38:01 volumiosalon systemd[1]: Started volumio-kiosk.service - Volumio Kiosk. Dec 26 17:38:01 volumiosalon sudo[1789]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:01 volumiosalon volumio[1368]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Dec 26 17:38:01 volumiosalon volumio[1368]: info: touch_display: Volumio Kiosk started. Dec 26 17:38:01 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:01 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:01 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:01 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:01 volumiosalon volumio[1368]: info: touch_display: X display number found: Dec 26 17:38:01 volumiosalon volumio[1368]: info: touch_display: X display number found: 0 Dec 26 17:38:01 volumiosalon startx[1817]: X.Org X Server 1.21.1.7 Dec 26 17:38:01 volumiosalon startx[1817]: X Protocol Version 11, Revision 0 Dec 26 17:38:01 volumiosalon startx[1817]: Current Operating System: Linux volumiosalon 6.12.47-v8+ #1904 SMP PREEMPT Mon Sep 15 13:10:52 BST 2025 aarch64 Dec 26 17:38:01 volumiosalon startx[1817]: Kernel command line: reboot=w coherent_pool=1M 8250.nr_uarts=1 pci=pcie_bus_safe cgroup_disable=memory numa_policy=interleave nvme.max_host_mem_size_mb=0 numa=fake=4 system_heap.max_order=0 smsc95xx.macaddr=2C:CF:67:83:34:3E vc_mem.mem_base=0x3fc00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyAMA10,115200 console=tty1 imgpart=UUID=52aad46a-1f46-4dc6-9e34-84e57291c428 imgfile=/volumio_current.sqsh bootpart=UUID=C4F0-7FDF datapart=UUID=89f07350-0c15-4a4d-8ac1-e4c93520cb18 uuidconfig=cmdline.txt rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Dec 26 17:38:01 volumiosalon startx[1817]: xorg-server 2:21.1.7-3+rpt3+deb12u10 (https://www.debian.org/support) Dec 26 17:38:01 volumiosalon startx[1817]: Current version of pixman: 0.44.0 Dec 26 17:38:01 volumiosalon startx[1817]: Before reporting problems, check http://wiki.x.org Dec 26 17:38:01 volumiosalon startx[1817]: to make sure that you have the latest version. Dec 26 17:38:01 volumiosalon startx[1817]: Markers: (--) probed, (**) from config file, (==) default setting, Dec 26 17:38:01 volumiosalon startx[1817]: (++) from command line, (!!) notice, (II) informational, Dec 26 17:38:01 volumiosalon startx[1817]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Dec 26 17:38:01 volumiosalon startx[1817]: (==) Log file: "/var/log/Xorg.0.log", Time: Fri Dec 26 17:38:01 2025 Dec 26 17:38:01 volumiosalon startx[1817]: (==) Using config directory: "/etc/X11/xorg.conf.d" Dec 26 17:38:01 volumiosalon startx[1817]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Dec 26 17:38:01 volumiosalon volumio[1368]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Dec 26 17:38:01 volumiosalon volumio[1368]: info: touch_display: X display number found: 0 Dec 26 17:38:01 volumiosalon avahi-daemon[1656]: Service "VolumioSalon" (/services/volumio.service) successfully established. Dec 26 17:38:01 volumiosalon ntpd[1168]: IO: Listen normally on 3 wlan0 192.168.1.70:123 Dec 26 17:38:01 volumiosalon ntpd[1168]: IO: new interface(s) found: waking up resolver Dec 26 17:38:01 volumiosalon ntpd[1168]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 26 17:38:02 volumiosalon ntpd[1168]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Dec 26 17:38:02 volumiosalon ntpd[1168]: DNS: Pool taking: 193.42.63.23 Dec 26 17:38:02 volumiosalon ntpd[1168]: DNS: Pool taking: 38.143.19.16 Dec 26 17:38:02 volumiosalon ntpd[1168]: DNS: Pool taking: 82.64.247.11 Dec 26 17:38:02 volumiosalon ntpd[1168]: DNS: Pool taking: 172.234.184.36 Dec 26 17:38:02 volumiosalon ntpd[1168]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Dec 26 17:38:02 volumiosalon mpd[1713]: 2025-12-26T17:38:02 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 26 17:38:02 volumiosalon systemd[1]: Started mpd.service - Music Player Daemon. Dec 26 17:38:02 volumiosalon sudo[1691]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:02 volumiosalon sudo[1685]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:02 volumiosalon volumio[1368]: error: MPD error: The expression evaluated to a falsy value: Dec 26 17:38:02 volumiosalon volumio[1368]: assert.ok(self.idling) Dec 26 17:38:02 volumiosalon volumio[1368]: error: The expression evaluated to a falsy value: Dec 26 17:38:02 volumiosalon volumio[1368]: assert.ok(self.idling) Dec 26 17:38:02 volumiosalon volumio[1368]: info: MPD running with PID1713 Dec 26 17:38:02 volumiosalon volumio[1368]: ,establishing connection Dec 26 17:38:02 volumiosalon volumio[1368]: error: updateQueue error: null Dec 26 17:38:02 volumiosalon volumio[1368]: error: updateQueue error: null Dec 26 17:38:02 volumiosalon volumio[1368]: info: Completed starting Core Plugins Dec 26 17:38:02 volumiosalon volumio[1368]: info: ------------------------------------------- Dec 26 17:38:02 volumiosalon volumio[1368]: info: ----- MyVolumio plugins startup ---- Dec 26 17:38:02 volumiosalon volumio[1368]: info: ------------------------------------------- Dec 26 17:38:02 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 26 17:38:02 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:02 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:02 volumiosalon volumio[1368]: info: touch_display: Setting screensaver timeout to 0 seconds. Dec 26 17:38:02 volumiosalon ntpd[1168]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 26 17:38:03 volumiosalon ntpd[1168]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Dec 26 17:38:03 volumiosalon ntpd[1168]: DNS: Pool taking: 195.35.29.178 Dec 26 17:38:03 volumiosalon ntpd[1168]: DNS: Pool taking: 82.64.81.218 Dec 26 17:38:03 volumiosalon ntpd[1168]: DNS: Pool taking: 82.67.117.190 Dec 26 17:38:03 volumiosalon ntpd[1168]: DNS: Pool taking: 209.112.97.243 Dec 26 17:38:03 volumiosalon ntpd[1168]: DNS: Pool taking: 2a05:d012:54d:6c00::123 Dec 26 17:38:03 volumiosalon ntpd[1168]: DNS: Pool taking: 2001:41d0:305:2100::621 Dec 26 17:38:03 volumiosalon ntpd[1168]: DNS: Pool taking: 2001:678:8::123 Dec 26 17:38:03 volumiosalon ntpd[1168]: DNS: Pool taking: 2a06:e881:7000::d0a:29ac Dec 26 17:38:03 volumiosalon ntpd[1168]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Dec 26 17:38:03 volumiosalon volumio[1368]: verbose: New Socket.io Connection to 192.168.1.70 from 192.168.1.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 9 Dec 26 17:38:03 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 26 17:38:03 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetVisibleSources Dec 26 17:38:03 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 17:38:03 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:03 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:03 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:03 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:03 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 26 17:38:03 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 26 17:38:03 volumiosalon volumio[1368]: info: Received Get System Info Dec 26 17:38:03 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 17:38:03 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 17:38:03 volumiosalon volumio[1368]: info: Discovery: Getting this device information Dec 26 17:38:03 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:03 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:03 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 17:38:03 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:03 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:03 volumiosalon volumio[1368]: info: Listing playlists Dec 26 17:38:03 volumiosalon ntpd[1168]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 26 17:38:04 volumiosalon ntpd[1168]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Dec 26 17:38:04 volumiosalon ntpd[1168]: DNS: Pool taking: 162.159.200.123 Dec 26 17:38:04 volumiosalon ntpd[1168]: DNS: Pool taking: 141.95.171.142 Dec 26 17:38:04 volumiosalon ntpd[1168]: DNS: Pool taking: 82.67.41.119 Dec 26 17:38:04 volumiosalon ntpd[1168]: DNS: Pool taking: 54.38.114.34 Dec 26 17:38:04 volumiosalon ntpd[1168]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Dec 26 17:38:04 volumiosalon ntpd[1168]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 26 17:38:05 volumiosalon ntpd[1168]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Dec 26 17:38:05 volumiosalon ntpd[1168]: DNS: Pool taking: 194.177.34.116 Dec 26 17:38:05 volumiosalon ntpd[1168]: DNS: Pool taking: 176.137.36.37 Dec 26 17:38:05 volumiosalon ntpd[1168]: DNS: Pool taking: 51.255.141.76 Dec 26 17:38:05 volumiosalon ntpd[1168]: DNS: Pool taking: 37.59.63.125 Dec 26 17:38:05 volumiosalon ntpd[1168]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Dec 26 17:38:05 volumiosalon sudo[1905]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Antigone,password=Ishtar64,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.0 //192.168.1.101/Musique\\Youtube /mnt/NAS/Youtube Dec 26 17:38:05 volumiosalon sudo[1905]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:05 volumiosalon sudo[1907]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Antigone,password=Ishtar64,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.0 //192.168.1.101/Musique\\Lossy /mnt/NAS/Lossy Dec 26 17:38:05 volumiosalon kernel: CIFS: Attempting to mount //192.168.1.101/Musique/Youtube Dec 26 17:38:05 volumiosalon sudo[1907]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:05 volumiosalon sudo[1910]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Antigone,password=Ishtar64,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.0 //192.168.1.101/Musique\\Lossless /mnt/NAS/Lossless Dec 26 17:38:05 volumiosalon sudo[1910]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:05 volumiosalon volumio[1368]: info: Discovery: Browse raised the following error Error: dns service error: unknown Dec 26 17:38:05 volumiosalon volumio[1368]: info: Discovery: Restarting Browsing Dec 26 17:38:05 volumiosalon volumio[1368]: info: Discovery: Restart already pending, ignoring duplicate call Dec 26 17:38:05 volumiosalon volumio[1368]: info: Discovery: Browse raised the following error Error: dns service error: unknown Dec 26 17:38:05 volumiosalon volumio[1368]: info: Discovery: Restarting Browsing Dec 26 17:38:05 volumiosalon volumio[1368]: info: Discovery: Restart already pending, ignoring duplicate call Dec 26 17:38:05 volumiosalon volumio[1368]: info: Discovery: Restarting Advertising Dec 26 17:38:05 volumiosalon sudo[1905]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:05 volumiosalon kernel: CIFS: Attempting to mount //192.168.1.101/Musique/Lossy Dec 26 17:38:05 volumiosalon sudo[1907]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:05 volumiosalon kernel: CIFS: Attempting to mount //192.168.1.101/Musique/Lossless Dec 26 17:38:05 volumiosalon sudo[1910]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:05 volumiosalon volumio[1368]: info: Discovery: adding a70406a1-79a5-4293-b10d-1ba2397e7b76 Dec 26 17:38:05 volumiosalon volumio[1368]: info: Discovery: Found device VolumioTest Dec 26 17:38:05 volumiosalon volumio[1368]: info: Discovery: Connecting to remote: 192.168.1.77 Dec 26 17:38:05 volumiosalon volumio[1368]: info: Discovery: adding 3482849d-3710-4bca-8ec9-b7bf5e48a184 Dec 26 17:38:05 volumiosalon volumio[1368]: info: Discovery: Found device VolumioChambre Dec 26 17:38:05 volumiosalon volumio[1368]: info: Discovery: Connecting to remote: 192.168.1.73 Dec 26 17:38:05 volumiosalon volumio[1368]: info: Discovery: adding 9d9cd12e-0dcd-48a4-9db6-1837fd85195c Dec 26 17:38:05 volumiosalon volumio[1368]: info: Discovery: Found device VolumioBureau Dec 26 17:38:05 volumiosalon volumio[1368]: info: Discovery: Connecting to remote: 192.168.1.76 Dec 26 17:38:05 volumiosalon volumio[1368]: info: Discovery: Connected to remote: 192.168.1.77 Dec 26 17:38:05 volumiosalon volumio[1368]: info: Discovery: Connected to remote: 192.168.1.73 Dec 26 17:38:07 volumiosalon volumio[1368]: info: Volumio Network Manager: Network status updated: 2 Dec 26 17:38:07 volumiosalon volumio[1368]: info: Discovery: Connected to remote: 192.168.1.76 Dec 26 17:38:07 volumiosalon sudo[2035]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 26 17:38:07 volumiosalon sudo[2035]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:07 volumiosalon sudo[2037]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 17:38:07 volumiosalon sudo[2037]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:07 volumiosalon sudo[2035]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:07 volumiosalon sudo[2037]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:07 volumiosalon sudo[2042]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 26 17:38:07 volumiosalon sudo[2042]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:07 volumiosalon volumio[1368]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Dec 26 17:38:07 volumiosalon ntpd[1168]: CLOCK: time stepped by -0.436207 Dec 26 17:38:07 volumiosalon ntpd[1168]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Dec 26 17:38:07 volumiosalon systemd-journald[504]: Time jumped backwards, rotating. Dec 26 17:38:09 volumiosalon volumio[1368]: info: Discovery: Started advertising with name: VolumioSalon Dec 26 17:38:10 volumiosalon systemd[1]: systemd-fsckd.service: Deactivated successfully. Dec 26 17:38:11 volumiosalon dhcpcd[876]: timed out Dec 26 17:38:11 volumiosalon sh[860]: timed out Dec 26 17:38:11 volumiosalon sh[801]: ifup: failed to bring up eth0 Dec 26 17:38:11 volumiosalon systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Dec 26 17:38:11 volumiosalon systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Dec 26 17:38:11 volumiosalon volumio[1368]: verbose: New Socket.io Connection to 192.168.1.70:3000 from 192.168.1.77 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Dec 26 17:38:11 volumiosalon volumio[1368]: verbose: New Socket.io Connection to 192.168.1.70:3000 from 192.168.1.73 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Dec 26 17:38:12 volumiosalon volumio[1368]: Cannot compose Albumart path Dec 26 17:38:12 volumiosalon volumio[1368]: Cannot compose Albumart path Dec 26 17:38:12 volumiosalon volumio[1368]: Cannot compose Albumart path Dec 26 17:38:12 volumiosalon volumio[1368]: verbose: New Socket.io Connection to 192.168.1.70:3000 from 192.168.1.76 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Dec 26 17:38:12 volumiosalon volumio[1368]: info: Discovery: adding 97089748-58e0-40e4-94fb-f308482685b5 Dec 26 17:38:12 volumiosalon volumio[1368]: info: Discovery: Found device VolumioSalon Dec 26 17:38:12 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:12 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:12 volumiosalon volumio[1368]: info: Discovery: this is already registered, 97089748-58e0-40e4-94fb-f308482685b5 Dec 26 17:38:12 volumiosalon volumio[1368]: info: Discovery: Found device VolumioSalon Dec 26 17:38:12 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:12 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:12 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Dec 26 17:38:12 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:12 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:12 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Dec 26 17:38:12 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Dec 26 17:38:12 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:12 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:12 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:12 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Dec 26 17:38:13 volumiosalon volumio[1368]: info: Adding plugin bluetooth to MyMusic Plugins Dec 26 17:38:13 volumiosalon volumio[1368]: info: Adding plugin multiroom to MyMusic Plugins Dec 26 17:38:13 volumiosalon volumio[1368]: info: Adding plugin metavolumio to MyMusic Plugins Dec 26 17:38:13 volumiosalon volumio[1368]: info: Adding plugin cd_controller to MyMusic Plugins Dec 26 17:38:13 volumiosalon volumio[1368]: info: Adding plugin qobuzconnect to MyMusic Plugins Dec 26 17:38:13 volumiosalon volumio[1368]: info: Adding plugin smart_inputs to MyMusic Plugins Dec 26 17:38:13 volumiosalon volumio[1368]: info: Adding plugin tidalconnect to MyMusic Plugins Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Dec 26 17:38:13 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:13 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:13 volumiosalon volumio[1368]: info: Starting MyVolumio Remote Streaming Endpoints Dec 26 17:38:13 volumiosalon volumio[1368]: info: MyVolumio login type: Token Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Dec 26 17:38:13 volumiosalon volumio[1368]: info: Streaming services startup Dec 26 17:38:13 volumiosalon volumio[1368]: info: Starting Streaming Daemon Dec 26 17:38:13 volumiosalon sudo[2084]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 26 17:38:13 volumiosalon sudo[2084]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:13 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Dec 26 17:38:13 volumiosalon sudo[2084]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:13 volumiosalon volumio[1368]: error: Cannot start Volumio Streaming Daemon Dec 26 17:38:13 volumiosalon volumio[1368]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 26 17:38:13 volumiosalon volumio[1368]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 26 17:38:13 volumiosalon volumio[1368]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Dec 26 17:38:13 volumiosalon systemd[1]: systemd-hostnamed.service: Deactivated successfully. Dec 26 17:38:14 volumiosalon volumio[1368]: error: MyVolumio Custom Token format not valid, refreshing it Dec 26 17:38:14 volumiosalon volumio[1368]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Dec 26 17:38:14 volumiosalon systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Dec 26 17:38:14 volumiosalon systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 26 17:38:14 volumiosalon systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 26 17:38:14 volumiosalon sudo[2042]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:14 volumiosalon volumio[1368]: info: Upmpdcli Daemon Started Dec 26 17:38:14 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 26 17:38:14 volumiosalon volumio[1368]: info: MyVolumio login type: Token Dec 26 17:38:14 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetVisibleSources Dec 26 17:38:14 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 17:38:14 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:14 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:14 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 26 17:38:14 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 26 17:38:14 volumiosalon volumio[1368]: info: Received Get System Info Dec 26 17:38:14 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 17:38:14 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 17:38:14 volumiosalon volumio[1368]: info: Discovery: Getting this device information Dec 26 17:38:14 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:14 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:14 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 17:38:14 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:14 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:14 volumiosalon volumio[1368]: info: Listing playlists Dec 26 17:38:14 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 26 17:38:14 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 26 17:38:14 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 26 17:38:14 volumiosalon volumio[1368]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Dec 26 17:38:15 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:15 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:16 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 26 17:38:16 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 17:38:16 volumiosalon volumio[1368]: info: Received Get System Info Dec 26 17:38:16 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 17:38:16 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 17:38:16 volumiosalon volumio[1368]: info: Discovery: Getting this device information Dec 26 17:38:16 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:16 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:16 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 17:38:16 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 17:38:16 volumiosalon volumio[1368]: info: Received Get System Info Dec 26 17:38:16 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 17:38:16 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 17:38:16 volumiosalon volumio[1368]: info: Discovery: Getting this device information Dec 26 17:38:16 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:16 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:16 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 17:38:17 volumiosalon upmpdcli[2128]: writing RSA key Dec 26 17:38:17 volumiosalon volumio[1368]: info: MyVolumio token set successfully Dec 26 17:38:17 volumiosalon volumio[1368]: info: MYVOLUMIO: Adding device Dec 26 17:38:17 volumiosalon volumio[1368]: info: MYVOLUMIO: Evaluating Server Dec 26 17:38:18 volumiosalon volumio[1368]: info: MyVolumio Plan changed: superstar Dec 26 17:38:18 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Subscribed plan changed to superstar Dec 26 17:38:18 volumiosalon volumio[1368]: info: Adding audio output: Dec 26 17:38:18 volumiosalon volumio[1368]: info: MYVOLUMIO: Adding device Dec 26 17:38:18 volumiosalon volumio[1368]: info: MYVOLUMIO: Evaluating Server Dec 26 17:38:18 volumiosalon volumio[1368]: info: Remote config written successfully Dec 26 17:38:18 volumiosalon volumio[1368]: info: Starting Tunnel 1 Dec 26 17:38:18 volumiosalon volumio[1368]: info: Starting Tunnel Connection Checker Dec 26 17:38:18 volumiosalon volumio[1368]: info: Completed starting MyVolumio Plugin Dec 26 17:38:18 volumiosalon volumio[1368]: info: MYVolumio Device enabled Dec 26 17:38:18 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Dec 26 17:38:18 volumiosalon volumio[1368]: info: MyVolumio status changed Dec 26 17:38:18 volumiosalon volumio[1368]: info: Streaming services startup Dec 26 17:38:18 volumiosalon volumio[1368]: info: Starting Streaming Daemon Dec 26 17:38:18 volumiosalon sudo[2174]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 26 17:38:18 volumiosalon sudo[2174]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:18 volumiosalon sudo[2174]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:18 volumiosalon volumio[1368]: error: Cannot start Volumio Streaming Daemon Dec 26 17:38:18 volumiosalon volumio[1368]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 26 17:38:18 volumiosalon volumio[1368]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 26 17:38:18 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Dec 26 17:38:18 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Dec 26 17:38:18 volumiosalon volumio[1368]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Dec 26 17:38:18 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Dec 26 17:38:18 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Dec 26 17:38:18 volumiosalon sudo[2179]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Dec 26 17:38:18 volumiosalon sudo[2179]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:18 volumiosalon sudo[2179]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:18 volumiosalon volumio[1368]: info: MRS: MultiRoom plugin initialized Dec 26 17:38:18 volumiosalon volumio[1368]: info: MRS: STOPPING SNAPCLIENT Dec 26 17:38:18 volumiosalon volumio[1368]: info: MRS: Snap server stop Dec 26 17:38:18 volumiosalon volumio[1368]: info: MRS: STOPPING volumioStreaming Dec 26 17:38:18 volumiosalon sudo[2196]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Dec 26 17:38:18 volumiosalon sudo[2196]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:18 volumiosalon sudo[2199]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Dec 26 17:38:18 volumiosalon sudo[2199]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:18 volumiosalon sudo[2203]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Dec 26 17:38:18 volumiosalon sudo[2202]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Dec 26 17:38:18 volumiosalon sudo[2203]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:18 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Dec 26 17:38:18 volumiosalon sudo[2202]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:18 volumiosalon sudo[2203]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:18 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Dec 26 17:38:18 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Dec 26 17:38:18 volumiosalon sudo[2196]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:18 volumiosalon sudo[2199]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:18 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Dec 26 17:38:18 volumiosalon sudo[2202]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:18 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Dec 26 17:38:18 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Dec 26 17:38:18 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Dec 26 17:38:18 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Dec 26 17:38:18 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Dec 26 17:38:18 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Dec 26 17:38:18 volumiosalon volumio[1368]: info: Preparing to generate the ALSA configuration file Dec 26 17:38:18 volumiosalon volumio[1368]: info: Setting Geolocation for MyVolumio to eu11 Dec 26 17:38:18 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:18 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:18 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:18 volumiosalon volumio[1368]: info: MRS: Removed streaming files Dec 26 17:38:18 volumiosalon volumio[1368]: info: MRS: volumioStreaming STOPPED Dec 26 17:38:18 volumiosalon volumio[1368]: info: MRS: SNAPSERVER STOPPED Dec 26 17:38:18 volumiosalon volumio[1368]: info: MRS: SNAPCLIENT STOPPED Dec 26 17:38:18 volumiosalon volumio[1368]: info: Asound.conf file unchanged, so no further update is needed Dec 26 17:38:18 volumiosalon volumio[1368]: info: Output device has changed, restarting MPD Dec 26 17:38:19 volumiosalon volumio[1368]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 26 17:38:19 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:19 volumiosalon sudo[2208]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 26 17:38:19 volumiosalon sudo[2208]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:19 volumiosalon sudo[2208]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:19 volumiosalon sudo[2210]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 26 17:38:19 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Dec 26 17:38:19 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Plugin bluetooth disabled by user. Not starting Dec 26 17:38:19 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Dec 26 17:38:19 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Plugin multiroom disabled by user. Not starting Dec 26 17:38:19 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Dec 26 17:38:19 volumiosalon sudo[2210]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:19 volumiosalon volumio[1368]: info: Adding METAVOLUMIO REST API Endpoints Dec 26 17:38:19 volumiosalon volumio[1368]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Dec 26 17:38:19 volumiosalon volumio[1368]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Dec 26 17:38:19 volumiosalon volumio[1368]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Dec 26 17:38:19 volumiosalon volumio[1368]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Dec 26 17:38:19 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Dec 26 17:38:19 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Dec 26 17:38:19 volumiosalon volumio[1368]: info: Preparing CD Folders Dec 26 17:38:19 volumiosalon volumio[1368]: info: Adding CD REST API Endpoints Dec 26 17:38:19 volumiosalon volumio[1368]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Dec 26 17:38:19 volumiosalon volumio[1368]: info: Starting UDEV Watcher for CD Dec 26 17:38:19 volumiosalon volumio[1368]: info: Detecting CD presence with UDEV Dec 26 17:38:19 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Dec 26 17:38:19 volumiosalon systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 26 17:38:19 volumiosalon systemd[1]: mpd.service: Deactivated successfully. Dec 26 17:38:19 volumiosalon systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 26 17:38:19 volumiosalon systemd[1]: mpd.service: Consumed 1.739s CPU time. Dec 26 17:38:19 volumiosalon systemd[1]: mpd.socket: Deactivated successfully. Dec 26 17:38:19 volumiosalon systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 26 17:38:19 volumiosalon systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 26 17:38:19 volumiosalon systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 26 17:38:19 volumiosalon systemd[1]: Starting mpd.service - Music Player Daemon... Dec 26 17:38:19 volumiosalon sudo[2219]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 26 17:38:19 volumiosalon sudo[2219]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 26 17:38:19 volumiosalon sudo[2219]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:19 volumiosalon mpd[2221]: 2025-12-26T17:38:19 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 26 17:38:19 volumiosalon systemd[1]: Started mpd.service - Music Player Daemon. Dec 26 17:38:19 volumiosalon sudo[2210]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:24 volumiosalon volumio[1368]: warn: [cd-plugin] cdspeedctl: device or media not ready Dec 26 17:38:24 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Dec 26 17:38:24 volumiosalon volumio[1368]: info: Adding inputs REST Endpoints Dec 26 17:38:24 volumiosalon volumio[1368]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Dec 26 17:38:24 volumiosalon volumio[1368]: info: Scanning Audio Inputs Dec 26 17:38:24 volumiosalon volumio[1368]: info: Checking against Known Cards name Dec 26 17:38:24 volumiosalon volumio[1368]: info: Adding Server instance for streaming Dec 26 17:38:24 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Dec 26 17:38:24 volumiosalon volumio[1368]: error: Hi Res Audio Failed Login: Missing Login Data Dec 26 17:38:24 volumiosalon volumio[1368]: info: Adding HIGHRESAUDIO REST API Endpoints Dec 26 17:38:24 volumiosalon volumio[1368]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Dec 26 17:38:24 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Dec 26 17:38:24 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Dec 26 17:38:24 volumiosalon volumio[1368]: info: Refreshing QOBUZ token Dec 26 17:38:24 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Dec 26 17:38:24 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Plugin tidalconnect disabled by user. Not starting Dec 26 17:38:24 volumiosalon volumio[1368]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Dec 26 17:38:24 volumiosalon volumio[1368]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Dec 26 17:38:24 volumiosalon volumio[1368]: info: QobuzConnect: Starting Qobuz Connect socket and service Dec 26 17:38:24 volumiosalon volumio[1368]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Dec 26 17:38:24 volumiosalon volumio[1368]: info: Adding TIDAL REST API Endpoints Dec 26 17:38:24 volumiosalon volumio[1368]: info: Updating MyVolumio device info Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:24 volumiosalon sudo[2235]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 26 17:38:24 volumiosalon sudo[2235]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:24 volumiosalon sudo[2235]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:24 volumiosalon sudo[2237]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 26 17:38:24 volumiosalon sudo[2237]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:24 volumiosalon volumio[1368]: info: Successfully Added MyVolumio device Dec 26 17:38:24 volumiosalon volumio[1368]: info: Setting Geolocation for MyVolumio to eu6 Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:24 volumiosalon volumio[1368]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Dec 26 17:38:24 volumiosalon volumio[1368]: info: MPD Permissions set Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:24 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:24 volumiosalon systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 26 17:38:24 volumiosalon sudo[2237]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:24 volumiosalon volumio[1368]: error: updateQueue error: null Dec 26 17:38:24 volumiosalon volumio[1368]: info: Access Token successfully retrieved Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 26 17:38:24 volumiosalon volumio[1368]: info: [1766767104242] CoreMusicLibrary::Adding element QOBUZ Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 17:38:24 volumiosalon volumio[1368]: Cannot find translation for source QOBUZ Dec 26 17:38:24 volumiosalon volumio[1368]: info: Stopping AccessToken refresher cron for QOBUZ Dec 26 17:38:24 volumiosalon volumio[1368]: info: AccessToken refresher cron started for QOBUZ Dec 26 17:38:24 volumiosalon volumio[1368]: info: Adding QOBUZ REST API Endpoints Dec 26 17:38:24 volumiosalon volumio[1368]: [Metrics] CommandRouter: 28s 28.28ms Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::volumiosetStartupVolume Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::Close All Modals sent Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::Close All Modals sent Dec 26 17:38:24 volumiosalon volumio[1368]: info: Executing endpoint qc_getconfig Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 26 17:38:24 volumiosalon qobuz-connect[2239]: 20251226 17:38:24.344 [2239.2239] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 26 17:38:24 volumiosalon volumio[1368]: info: Successfully Updated MyVolumio device Dec 26 17:38:24 volumiosalon volumio[1368]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Dec 26 17:38:24 volumiosalon volumio[1368]: ALSA lib confmisc.c:165:(snd_config_get_card) Cannot get card index for x20 Dec 26 17:38:24 volumiosalon volumio[1368]: aplay: main:831: audio open error: No such device Dec 26 17:38:24 volumiosalon volumio[1368]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 26 17:38:24 volumiosalon volumio[1368]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 26 17:38:24 volumiosalon sudo[2257]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Dec 26 17:38:24 volumiosalon sudo[2257]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:38:24 volumiosalon systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 26 17:38:24 volumiosalon systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 26 17:38:24 volumiosalon qobuz-connect[2239]: 20251226 17:38:24.454 [2239.2239] INFO VolumeManager: [0x1c7d428]: Setting new playback volume: 75 Dec 26 17:38:24 volumiosalon qobuz-connect[2239]: 20251226 17:38:24.454 [2239.2239] INFO VolumeManager: [0x1c7d428]: Setting new mute state: 0 Dec 26 17:38:24 volumiosalon qobuz-connect[2239]: 20251226 17:38:24.454 [2239.2239] INFO QobuzConnect: [0x1c7ddf8]: Client initialized! Dec 26 17:38:24 volumiosalon qobuz-connect[2239]: 20251226 17:38:24.454 [2239.2239] INFO SampleApp: Starting Avahi advertising, name: VolumioSalon, service name: _qobuz-connect._tcp Dec 26 17:38:24 volumiosalon qobuz-connect[2239]: 20251226 17:38:24.458 [2239.2239] INFO LocalConfigManager: [0x1c7cd08]: Starting Local Configuration server Dec 26 17:38:24 volumiosalon qobuz-connect[2239]: 20251226 17:38:24.458 [2239.2239] INFO SampleApp: Starting Local configuration server Dec 26 17:38:24 volumiosalon qobuz-connect[2239]: 20251226 17:38:24.458 [2239.2239] INFO SampleApp: Connected to UNIX socket client 0x1c67818 Dec 26 17:38:24 volumiosalon systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Dec 26 17:38:24 volumiosalon sudo[2257]: pam_unix(sudo:session): session closed for user root Dec 26 17:38:24 volumiosalon volumio[1368]: info: Remote SSH Started Dec 26 17:38:24 volumiosalon autossh[2262]: port set to 0, monitoring disabled Dec 26 17:38:24 volumiosalon autossh[2262]: starting ssh (count 1) Dec 26 17:38:24 volumiosalon autossh[2262]: ssh child pid is 2265 Dec 26 17:38:24 volumiosalon qobuz-connect[2239]: 20251226 17:38:24.494 [2239.2239] INFO SampleApp: Playback volume changed: 75 Dec 26 17:38:24 volumiosalon volumio[1368]: info: Successfully Added MyVolumio device Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:24 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:24 volumiosalon volumio[1368]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Dec 26 17:38:24 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:24 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:24 volumiosalon volumiossh-tunnel[2265]: Warning: Permanently added '[eu11.myvolumio.org]:2222' (ED25519) to the list of known hosts. Dec 26 17:38:25 volumiosalon volumio[1368]: info: Updating MyVolumio device info Dec 26 17:38:25 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:25 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:25 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:25 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 26 17:38:25 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 26 17:38:25 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Dec 26 17:38:25 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 26 17:38:25 volumiosalon volumio[1368]: info: Successfully Updated MyVolumio device Dec 26 17:38:28 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 26 17:38:28 volumiosalon volumio[1368]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16 Dec 26 17:38:28 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:28 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:29 volumiosalon systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 26 17:38:29 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 26 17:38:29 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 17:38:29 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 26 17:38:29 volumiosalon volumio-remote-updater[975]: Test mode enabled Dec 26 17:38:29 volumiosalon volumio-remote-updater[975]: Alpha mode disabled Dec 26 17:38:29 volumiosalon volumio-remote-updater[975]: Alpha legacy test mode disabled Dec 26 17:38:29 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Dec 26 17:38:29 volumiosalon volumio[1368]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 26 17:38:29 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 26 17:38:30 volumiosalon systemd[1]: setdatetime-helper.service: Deactivated successfully. Dec 26 17:38:30 volumiosalon systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Dec 26 17:38:31 volumiosalon volumio[1368]: info: BOOT COMPLETED Dec 26 17:38:32 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 26 17:38:32 volumiosalon volumio[1368]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 26 17:38:32 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 26 17:38:32 volumiosalon volumio[1368]: info: Received Get System Version Dec 26 17:38:32 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 26 17:38:32 volumiosalon volumio[1368]: info: Received Get System Info Dec 26 17:38:32 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 17:38:32 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 17:38:32 volumiosalon volumio[1368]: info: Discovery: Getting this device information Dec 26 17:38:32 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:38:32 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:38:32 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 17:38:33 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:33 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 17:38:33 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Dec 26 17:38:33 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 26 17:38:33 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 26 17:38:33 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetBrowseSources Dec 26 17:38:33 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 26 17:38:54 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 17:38:54 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 26 17:38:59 volumiosalon volumio[1368]: info: Starting Uninstall of plugin user_interface - now_playing Dec 26 17:39:05 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:39:05 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:39:07 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 17:39:07 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 26 17:39:07 volumiosalon volumio[1368]: info: Executing endpoint metavolumio Dec 26 17:39:07 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 26 17:39:07 volumiosalon volumio[1368]: info: Executing endpoint metavolumio Dec 26 17:39:07 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 26 17:39:07 volumiosalon volumio[1368]: info: Executing endpoint metavolumio Dec 26 17:39:07 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Dec 26 17:39:11 volumiosalon volumio[1368]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/bookworm/armhf Dec 26 17:39:13 volumiosalon volumio[1368]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/bookworm/armhf Dec 26 17:39:13 volumiosalon volumio[1368]: info: Check plugin dependencies Dec 26 17:39:13 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 26 17:39:13 volumiosalon volumio[1368]: info: Rename folder Dec 26 17:39:13 volumiosalon volumio[1368]: info: Folder /tmp/downloaded_plugin.zip removed Dec 26 17:39:13 volumiosalon volumio[1368]: info: Move to category Dec 26 17:39:13 volumiosalon volumio[1368]: error: Error moving plugin folder: Error: Command failed: /bin/mv /data/plugins/now_playing /data/plugins/user_interface Dec 26 17:39:13 volumiosalon volumio[1368]: /bin/mv: cannot move '/data/plugins/now_playing' to '/data/plugins/user_interface/now_playing': Directory not empty Dec 26 17:39:14 volumiosalon volumio[1368]: info: An error occurred installing the plugin. Rolling back config Dec 26 17:39:14 volumiosalon volumio[1368]: info: Plugin folders cleanup Dec 26 17:39:14 volumiosalon volumio[1368]: info: Scanning into folder /volumio/app/plugins/ Dec 26 17:39:14 volumiosalon volumio[1368]: info: Scanning category audio_interface Dec 26 17:39:14 volumiosalon volumio[1368]: info: Scanning category miscellanea Dec 26 17:39:14 volumiosalon volumio[1368]: info: Scanning category music_service Dec 26 17:39:14 volumiosalon volumio[1368]: info: Scanning category plugins.json Dec 26 17:39:14 volumiosalon volumio[1368]: info: Scanning category system_controller Dec 26 17:39:14 volumiosalon volumio[1368]: info: Scanning category user_interface Dec 26 17:39:14 volumiosalon volumio[1368]: info: Scanning into folder /data/plugins/ Dec 26 17:39:14 volumiosalon volumio[1368]: info: Scanning category music_service Dec 26 17:39:14 volumiosalon volumio[1368]: info: Scanning category now_playing Dec 26 17:39:14 volumiosalon volumio[1368]: info: Removing /data/plugins//now_playing/README.md Dec 26 17:39:14 volumiosalon volumio[1368]: info: Removing /data/plugins//now_playing/config.json Dec 26 17:39:14 volumiosalon volumio[1368]: info: Removing /data/plugins//now_playing/eslint.config.mjs Dec 26 17:39:14 volumiosalon volumio[1368]: info: Removing /data/plugins//now_playing/fixup.sh Dec 26 17:39:14 volumiosalon volumio[1368]: info: Removing /data/plugins//now_playing/gitignore Dec 26 17:39:14 volumiosalon volumio[1368]: info: Removing /data/plugins//now_playing/install.sh Dec 26 17:39:14 volumiosalon volumio[1368]: info: Removing /data/plugins//now_playing/package-lock.json Dec 26 17:39:14 volumiosalon volumio[1368]: info: Removing /data/plugins//now_playing/package.json Dec 26 17:39:14 volumiosalon volumio[1368]: info: Removing /data/plugins//now_playing/tsconfig.json Dec 26 17:39:14 volumiosalon volumio[1368]: info: Removing /data/plugins//now_playing/uninstall.sh Dec 26 17:39:14 volumiosalon volumio[1368]: info: Scanning category system_controller Dec 26 17:39:14 volumiosalon volumio[1368]: info: Scanning category user_interface Dec 26 17:39:14 volumiosalon volumio[1368]: info: Plugin folders cleanup completed Dec 26 17:39:14 volumiosalon volumio[1368]: info: Error: Error Dec 26 17:39:14 volumiosalon volumio[1368]: info: Error: Error Dec 26 17:39:14 volumiosalon volumio[1368]: info: Folder /tmp/plugins removed Dec 26 17:39:14 volumiosalon volumio[1368]: info: Folder /tmp/downloaded_plugin.zip removed Dec 26 17:39:14 volumiosalon volumio[1368]: info: Folder /data/temp removed Dec 26 17:39:37 volumiosalon volumio[1368]: info: MRS: Pushing multiroomSync output for this device Dec 26 17:39:37 volumiosalon volumio[1368]: info: MRS: Pushing multiroomSync output Dec 26 17:39:37 volumiosalon volumio[1368]: info: Adding audio output: Dec 26 17:39:37 volumiosalon volumio[1368]: info: Adding audio output: Dec 26 17:39:37 volumiosalon volumio[1368]: info: MRS: Adding multiroomSync output Dec 26 17:39:37 volumiosalon volumio[1368]: info: Adding audio output: Dec 26 17:39:37 volumiosalon volumio[1368]: info: MRS: Pushing multiroomSync output Dec 26 17:39:37 volumiosalon volumio[1368]: info: MRS: Adding multiroomSync output Dec 26 17:39:37 volumiosalon volumio[1368]: info: Adding audio output: Dec 26 17:39:37 volumiosalon volumio[1368]: info: MRS: Pushing multiroomSync output Dec 26 17:39:37 volumiosalon volumio[1368]: info: MRS: Adding multiroomSync output Dec 26 17:39:37 volumiosalon volumio[1368]: info: Adding audio output: Dec 26 17:39:37 volumiosalon volumio[1368]: info: MRS: Pushing multiroomSync output Dec 26 17:39:38 volumiosalon volumio[1368]: info: MRS: Updating multiroomSync output Dec 26 17:39:38 volumiosalon volumio[1368]: info: MRS: Updating multiroomSync output Dec 26 17:39:40 volumiosalon sudo[2495]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 26 17:39:40 volumiosalon sudo[2495]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:39:40 volumiosalon sudo[2497]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 17:39:40 volumiosalon sudo[2497]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 17:39:40 volumiosalon sudo[2495]: pam_unix(sudo:session): session closed for user root Dec 26 17:39:40 volumiosalon sudo[2497]: pam_unix(sudo:session): session closed for user root Dec 26 17:39:40 volumiosalon volumio[1368]: verbose: New Socket.io Connection to 192.168.1.70 from 192.168.1.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:146.0) Gecko/20100101 Firefox/146.0 Engine version: 3 Transport: polling Total Clients: 11 Dec 26 17:39:40 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 26 17:39:40 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 26 17:39:40 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetVisibleSources Dec 26 17:39:40 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 26 17:39:40 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:39:40 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:39:40 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 26 17:39:40 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 26 17:39:40 volumiosalon volumio[1368]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Dec 26 17:39:40 volumiosalon volumio[1368]: info: Received Get System Info Dec 26 17:39:40 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 26 17:39:40 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 26 17:39:40 volumiosalon volumio[1368]: info: Discovery: Getting this device information Dec 26 17:39:40 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:39:40 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:39:40 volumiosalon volumio[1368]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 26 17:39:40 volumiosalon volumio[1368]: info: CoreCommandRouter::volumioGetState Dec 26 17:39:40 volumiosalon volumio[1368]: info: CorePlayQueue::getTrack 0 Dec 26 17:39:40 volumiosalon volumio[1368]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 17:39:40 volumiosalon volumio[1368]: TypeError: Cannot read properties of undefined (reading 'plugin_type') Dec 26 17:39:40 volumiosalon volumio[1368]: at PluginManager.getInstalledPlugins (/volumio/app/pluginmanager.js:1644:56) Dec 26 17:39:40 volumiosalon volumio[1368]: at CoreCommandRouter.getInstalledPlugins (/volumio/app/index.js:1540:29) Dec 26 17:39:40 volumiosalon volumio[1368]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1353:45) Dec 26 17:39:40 volumiosalon volumio[1368]: at Socket.emit (node:events:514:28) Dec 26 17:39:40 volumiosalon volumio[1368]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Dec 26 17:39:40 volumiosalon volumio[1368]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Dec 26 17:39:40 volumiosalon volumio[1368]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 17:39:41 volumiosalon sudo[2514]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-26 17:38' Dec 26 17:39:41 volumiosalon sudo[2514]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"