-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Fri 2025-06-13 00:39:02 CEST. -- Jun 13 00:38:06 volumio-k systemd-timedated[899]: Changed local time to Fri Jun 13 00:38:06 2025 Jun 13 00:38:06 volumio-k sudo[888]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:06 volumio-k volumio-time-update[638]: volumio-time-update-util: System time updated successfully. Jun 13 00:38:06 volumio-k systemd[1]: Started Volumio Time Update Utility. Jun 13 00:38:06 volumio-k sudo[912]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:06 volumio-k ntpd[781]: Soliciting pool server 185.194.239.35 Jun 13 00:38:06 volumio-k sudo[919]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 13 00:38:06 volumio-k sudo[919]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:06 volumio-k sudo[919]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:06 volumio-k sudo[921]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 13 00:38:06 volumio-k sudo[921]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:07 volumio-k sudo[921]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:07 volumio-k avahi-daemon[623]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Jun 13 00:38:07 volumio-k avahi-daemon[623]: New relevant interface wlan0.IPv4 for mDNS. Jun 13 00:38:07 volumio-k avahi-daemon[623]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Jun 13 00:38:07 volumio-k kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jun 13 00:38:07 volumio-k systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jun 13 00:38:07 volumio-k systemd[1]: Starting dnsmasq - A lightweight DHCP and caching DNS server... Jun 13 00:38:07 volumio-k dnsmasq[928]: dnsmasq: syntax check OK. Jun 13 00:38:07 volumio-k ntpd[781]: Soliciting pool server 49.12.35.6 Jun 13 00:38:07 volumio-k hostapd[927]: Configuration file: /etc/hostapd/hostapd.conf Jun 13 00:38:07 volumio-k hostapd[927]: wlan0: Could not connect to kernel driver Jun 13 00:38:07 volumio-k hostapd[927]: Using interface wlan0 with hwaddr b8:27:eb:ae:8e:77 and ssid "Volumio-0FFF8" Jun 13 00:38:07 volumio-k hostapd[927]: wlan0: interface state UNINITIALIZED->ENABLED Jun 13 00:38:07 volumio-k hostapd[927]: wlan0: AP-ENABLED Jun 13 00:38:07 volumio-k systemd[1]: Started Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jun 13 00:38:07 volumio-k dnsmasq[935]: started, version 2.80 cachesize 150 Jun 13 00:38:07 volumio-k dnsmasq[935]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect inotify dumpfile Jun 13 00:38:07 volumio-k dnsmasq-dhcp[935]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Jun 13 00:38:07 volumio-k dnsmasq[935]: reading /etc/resolv.conf Jun 13 00:38:07 volumio-k dnsmasq[935]: using nameserver 192.168.0.1#53 Jun 13 00:38:07 volumio-k dnsmasq[935]: using nameserver 208.67.222.222#53 Jun 13 00:38:07 volumio-k dnsmasq[935]: using nameserver 208.67.220.220#53 Jun 13 00:38:07 volumio-k dnsmasq[935]: read /etc/hosts - 1 addresses Jun 13 00:38:07 volumio-k nmbd[758]: [2025/06/13 00:38:07.771318, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 13 00:38:07 volumio-k nmbd[758]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jun 13 00:38:07 volumio-k systemd[1]: Started Samba NMB Daemon. Jun 13 00:38:07 volumio-k systemd[1]: Starting Samba Winbind Daemon... Jun 13 00:38:07 volumio-k iwconfig[942]: Error for wireless request "Set Power Management" (8B2C) : Jun 13 00:38:07 volumio-k iwconfig[942]: SET failed on device wlan0 ; Invalid argument. Jun 13 00:38:07 volumio-k systemd[1]: wireless.service: Succeeded. Jun 13 00:38:07 volumio-k systemd[1]: Started Wireless Services. Jun 13 00:38:07 volumio-k systemd[1]: Started Volumio Backend Module. Jun 13 00:38:07 volumio-k systemd[1]: Started Volumio Cpu Tweaker. Jun 13 00:38:07 volumio-k systemd[1]: Started dnsmasq - A lightweight DHCP and caching DNS server. Jun 13 00:38:08 volumio-k systemd[1]: Reached target Host and Network Name Lookups. Jun 13 00:38:08 volumio-k volumio-cpu-tweak[944]: Setting RT Priority for mpd Jun 13 00:38:08 volumio-k volumio-cpu-tweak[944]: Setting MPD Affinity Jun 13 00:38:08 volumio-k volumio-cpu-tweak[944]: pid 822's current affinity mask: f Jun 13 00:38:08 volumio-k volumio-cpu-tweak[944]: pid 822's new affinity mask: 3 Jun 13 00:38:08 volumio-k volumio-cpu-tweak[944]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Jun 13 00:38:08 volumio-k volumio-cpu-tweak[944]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Jun 13 00:38:08 volumio-k systemd[1]: volumio_cpu_tweak.service: Succeeded. Jun 13 00:38:08 volumio-k winbindd[941]: [2025/06/13 00:38:08.631984, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Jun 13 00:38:08 volumio-k winbindd[941]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jun 13 00:38:09 volumio-k ntpd[781]: Listen normally on 4 wlan0 192.168.211.1:123 Jun 13 00:38:09 volumio-k ntpd[781]: new interface(s) found: waking up resolver Jun 13 00:38:12 volumio-k volumio-remote-updater[613]: [2025-06-13 00:38:12] [info] asio async_connect error: system:111 (Connection refused) Jun 13 00:38:12 volumio-k volumio-remote-updater[613]: [2025-06-13 00:38:12] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 13 00:38:12 volumio-k volumio-remote-updater[613]: [2025-06-13 00:38:12] [error] handle_connect error: Underlying Transport Error Jun 13 00:38:15 volumio-k winbindd[941]: [2025/06/13 00:38:15.992332, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 13 00:38:15 volumio-k systemd[1]: Started Samba Winbind Daemon. Jun 13 00:38:15 volumio-k winbindd[941]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jun 13 00:38:16 volumio-k systemd[1]: Starting Samba SMB Daemon... Jun 13 00:38:17 volumio-k mpd[822]: Jun 13 00:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 13 00:38:17 volumio-k systemd[1]: Started Music Player Daemon. Jun 13 00:38:17 volumio-k mpd_monitor.sh[645]: MPD Monitor Service: MPD restarted due to no mpc output. Jun 13 00:38:17 volumio-k smbd[965]: [2025/06/13 00:38:17.952416, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 13 00:38:17 volumio-k smbd[965]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jun 13 00:38:17 volumio-k systemd[1]: Started Samba SMB Daemon. Jun 13 00:38:17 volumio-k systemd[1]: Reached target Multi-User System. Jun 13 00:38:17 volumio-k systemd[1]: Reached target Graphical Interface. Jun 13 00:38:18 volumio-k systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 13 00:38:18 volumio-k systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jun 13 00:38:18 volumio-k systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 13 00:38:18 volumio-k systemd[1]: Startup finished in 21.027s (kernel) + 29.413s (userspace) = 50.440s. Jun 13 00:38:21 volumio-k volumio[943]: info: ------------------------------------------- Jun 13 00:38:21 volumio-k volumio[943]: info: ----- Volumio3 ---- Jun 13 00:38:21 volumio-k volumio[943]: info: ------------------------------------------- Jun 13 00:38:21 volumio-k volumio[943]: info: ----- System startup ---- Jun 13 00:38:21 volumio-k volumio[943]: info: ------------------------------------------- Jun 13 00:38:23 volumio-k volumio[943]: info: MYVOLUMIO Environment detected Jun 13 00:38:23 volumio-k volumio[943]: info: Plugin folders cleanup Jun 13 00:38:23 volumio-k volumio[943]: info: Scanning into folder /volumio/app/plugins/ Jun 13 00:38:23 volumio-k volumio[943]: info: Scanning category audio_interface Jun 13 00:38:23 volumio-k volumio[943]: info: Scanning category miscellanea Jun 13 00:38:23 volumio-k volumio[943]: info: Scanning category music_service Jun 13 00:38:23 volumio-k volumio[943]: info: Scanning category plugins.json Jun 13 00:38:23 volumio-k volumio[943]: info: Scanning category system_controller Jun 13 00:38:23 volumio-k volumio[943]: info: Scanning category user_interface Jun 13 00:38:23 volumio-k volumio[943]: info: Scanning into folder /data/plugins/ Jun 13 00:38:23 volumio-k volumio[943]: info: Scanning category audio_interface Jun 13 00:38:23 volumio-k volumio[943]: info: Plugin folders cleanup completed Jun 13 00:38:23 volumio-k volumio[943]: info: ------------------------------------------- Jun 13 00:38:23 volumio-k volumio[943]: info: ----- Core plugins startup ---- Jun 13 00:38:23 volumio-k volumio[943]: info: ------------------------------------------- Jun 13 00:38:23 volumio-k volumio[943]: info: Loading plugins from folder /volumio/app/plugins/ Jun 13 00:38:23 volumio-k volumio[943]: info: Adding plugin upnp to MyMusic Plugins Jun 13 00:38:23 volumio-k volumio[943]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 13 00:38:23 volumio-k volumio[943]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 13 00:38:23 volumio-k volumio[943]: info: Loading plugins from folder /data/plugins/ Jun 13 00:38:23 volumio-k volumio[943]: info: Loading plugin "system"... Jun 13 00:38:23 volumio-k volumio-remote-updater[613]: [2025-06-13 00:38:23] [connect] Successful connection Jun 13 00:38:23 volumio-k volumio[943]: info: No id defined. Creating one Jun 13 00:38:23 volumio-k volumio[943]: info: Loading plugin "appearance"... Jun 13 00:38:26 volumio-k systemd[1]: systemd-fsckd.service: Succeeded. Jun 13 00:38:26 volumio-k volumio[943]: info: Loading plugin "network"... Jun 13 00:38:26 volumio-k volumio[943]: info: Refreshing Cached IP Addresses Jun 13 00:38:26 volumio-k sudo[991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 13 00:38:26 volumio-k sudo[991]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:26 volumio-k sudo[991]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:26 volumio-k sudo[993]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 13 00:38:26 volumio-k sudo[993]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:26 volumio-k sudo[993]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:26 volumio-k volumio[943]: info: Loading plugin "services"... Jun 13 00:38:26 volumio-k volumio[943]: info: Loading plugin "alsa_controller"... Jun 13 00:38:26 volumio-k sudo[1002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 13 00:38:26 volumio-k sudo[1002]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:27 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 13 00:38:27 volumio-k volumio[943]: info: Loading plugin "wizard"... Jun 13 00:38:27 volumio-k volumio[943]: info: Loading plugin "networkfs"... Jun 13 00:38:27 volumio-k volumio[943]: info: Starting Udev Watcher for removable devices Jun 13 00:38:27 volumio-k volumio[943]: info: Ignoring mount for partition: boot Jun 13 00:38:27 volumio-k volumio[943]: info: Ignoring mount for partition: volumio Jun 13 00:38:27 volumio-k volumio[943]: info: Ignoring mount for partition: volumio_data Jun 13 00:38:27 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 13 00:38:27 volumio-k volumio[943]: info: Loading plugin "volumio_command_line_client"... Jun 13 00:38:27 volumio-k volumio[943]: info: Loading plugin "upnp"... Jun 13 00:38:27 volumio-k volumio[943]: info: [1749767907230] Starting Upmpd Daemon Jun 13 00:38:27 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 13 00:38:27 volumio-k volumio[943]: info: Loading plugin "my_music"... Jun 13 00:38:27 volumio-k volumio[943]: info: Loading plugin "mpd"... Jun 13 00:38:27 volumio-k sudo[1002]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:28 volumio-k volumio[943]: info: Loading plugin "upnp_browser"... Jun 13 00:38:28 volumio-k volumio[943]: info: Loading plugin "alarm-clock"... Jun 13 00:38:29 volumio-k volumio[943]: info: Loading plugin "airplay_emulation"... Jun 13 00:38:29 volumio-k volumio[943]: info: Starting Shairport Sync Jun 13 00:38:29 volumio-k volumio[943]: info: Loading plugin "last_100"... Jun 13 00:38:29 volumio-k volumio[943]: info: Loading plugin "webradio"... Jun 13 00:38:29 volumio-k volumio[943]: info: Loading plugin "i2s_dacs"... Jun 13 00:38:29 volumio-k volumio[943]: info: Loading plugin "volumiodiscovery"... Jun 13 00:38:29 volumio-k volumio[943]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 13 00:38:29 volumio-k volumio[943]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 13 00:38:29 volumio-k volumio[943]: *** WARNING *** For more information see Jun 13 00:38:29 volumio-k node[943]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 13 00:38:29 volumio-k volumio[943]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 13 00:38:29 volumio-k volumio[943]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 13 00:38:29 volumio-k volumio[943]: *** WARNING *** For more information see Jun 13 00:38:29 volumio-k node[943]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 13 00:38:29 volumio-k node[943]: *** WARNING *** For more information see Jun 13 00:38:29 volumio-k node[943]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 13 00:38:29 volumio-k node[943]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 13 00:38:29 volumio-k node[943]: *** WARNING *** For more information see Jun 13 00:38:29 volumio-k volumio[943]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 13 00:38:29 volumio-k volumio[943]: info: Discovery: Started advertising with name: Volumio Jun 13 00:38:29 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 13 00:38:29 volumio-k volumio[943]: info: Loading plugin "outputs"... Jun 13 00:38:29 volumio-k volumio[943]: info: Loading plugin "albumart"... Jun 13 00:38:30 volumio-k volumio[943]: info: Plugin example_plugin is not enabled Jun 13 00:38:30 volumio-k volumio[943]: info: Loading plugin "inputs"... Jun 13 00:38:30 volumio-k volumio[943]: info: Loading plugin "updater_comm"... Jun 13 00:38:30 volumio-k volumio[943]: info: Plugin mpdemulation is not enabled Jun 13 00:38:30 volumio-k volumio[943]: info: Loading plugin "rest_api"... Jun 13 00:38:30 volumio-k volumio[943]: info: Loading plugin "websocket"... Jun 13 00:38:30 volumio-k volumio[943]: info: Starting Socket.io Server version 2.3.0 Jun 13 00:38:30 volumio-k volumio[943]: info: Loading plugin "fusiondsp"... Jun 13 00:38:30 volumio-k volumio[943]: Forking 3 albumart workers Jun 13 00:38:31 volumio-k volumio[943]: info: Applying required configuration parameters for plugin fusiondsp Jun 13 00:38:32 volumio-k volumio[943]: info: Loading i18n strings for locale en Jun 13 00:38:32 volumio-k volumio[943]: Updating browse sources language Jun 13 00:38:32 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 13 00:38:32 volumio-k volumio[943]: Starting albumart workers Jun 13 00:38:32 volumio-k volumio[943]: Starting albumart workers Jun 13 00:38:32 volumio-k volumio[943]: Starting albumart workers Jun 13 00:38:33 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 13 00:38:33 volumio-k volumio[943]: info: CoreCommandRouter::initPlayerControls Jun 13 00:38:33 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:33 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:33 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:33 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:33 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:33 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:33 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:33 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:33 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 13 00:38:33 volumio-k volumio[943]: Express server listening on port 3000 Jun 13 00:38:33 volumio-k volumio[943]: [Metrics] WebUI: 13s 691.80ms Jun 13 00:38:33 volumio-k volumio[943]: info: CoreStateMachine::resetVolumioState Jun 13 00:38:33 volumio-k volumio[943]: info: CoreStateMachine::getcurrentVolume Jun 13 00:38:33 volumio-k volumio[943]: info: CoreCommandRouter::volumioRetrievevolume Jun 13 00:38:33 volumio-k volumio[943]: info: Volumio Network Manager: Network status updated: 1 Jun 13 00:38:33 volumio-k systemd[1]: systemd-hostnamed.service: Succeeded. Jun 13 00:38:33 volumio-k volumio[943]: verbose: New Socket.io Connection to 192.168.0.16:3000 from 192.168.0.68 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jun 13 00:38:33 volumio-k volumio[943]: verbose: New Socket.io Connection to 192.168.0.16:3000 from 192.168.0.68 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jun 13 00:38:34 volumio-k volumio[943]: verbose: New Socket.io Connection to 192.168.0.16:3000 from 192.168.0.68 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 13 00:38:34 volumio-k volumio[943]: info: Reloading queue from file Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jun 13 00:38:34 volumio-k volumio[943]: info: CoreStateMachine::setRepeat null single undefined Jun 13 00:38:34 volumio-k volumio[943]: info: CoreStateMachine::pushState Jun 13 00:38:34 volumio-k volumio[943]: info: CorePlayQueue::getTrack 0 Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::volumioPushState Jun 13 00:38:34 volumio-k volumio[943]: info: CoreStateMachine::setRandom null Jun 13 00:38:34 volumio-k volumio[943]: info: CoreStateMachine::pushState Jun 13 00:38:34 volumio-k volumio[943]: info: CorePlayQueue::getTrack 0 Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::volumioPushState Jun 13 00:38:34 volumio-k volumio[943]: info: Setting Device type: Raspberry PI Jun 13 00:38:34 volumio-k volumio[943]: info: Completed loading Core Plugins Jun 13 00:38:34 volumio-k volumio[943]: info: Preparing to generate the ALSA configuration file Jun 13 00:38:34 volumio-k volumio[943]: info: VolumeController:: Volume=0 Mute =false Jun 13 00:38:34 volumio-k volumio[943]: info: CoreStateMachine::pushState Jun 13 00:38:34 volumio-k volumio[943]: info: CorePlayQueue::getTrack 0 Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::volumioPushState Jun 13 00:38:34 volumio-k volumio[943]: info: CoreStateMachine::updateTrackBlock Jun 13 00:38:34 volumio-k volumio[943]: info: CorePlayQueue::getTrackBlock Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::volumioRetrievevolume Jun 13 00:38:34 volumio-k volumio[943]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 13 00:38:34 volumio-k volumio[943]: info: Reading ALSA contributions from plugins. Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::volumioGetState Jun 13 00:38:34 volumio-k volumio[943]: info: CorePlayQueue::getTrack 0 Jun 13 00:38:34 volumio-k volumio[943]: info: Discovery: adding b9096ee4-16da-4392-a4ca-7b9638af41e3 Jun 13 00:38:34 volumio-k volumio[943]: info: Discovery: Found device Volumio Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::volumioGetState Jun 13 00:38:34 volumio-k volumio[943]: info: CorePlayQueue::getTrack 0 Jun 13 00:38:34 volumio-k volumio[943]: info: Discovery: this is already registered, b9096ee4-16da-4392-a4ca-7b9638af41e3 Jun 13 00:38:34 volumio-k volumio[943]: info: Discovery: Found device Volumio Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::volumioGetState Jun 13 00:38:34 volumio-k volumio[943]: info: CorePlayQueue::getTrack 0 Jun 13 00:38:34 volumio-k volumio[943]: info: Asound.conf file unchanged, so no further update is needed Jun 13 00:38:34 volumio-k volumio[943]: info: Output device has changed, restarting MPD Jun 13 00:38:34 volumio-k volumio[943]: info: Output device has changed, restarting Shairport Sync Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 13 00:38:34 volumio-k sudo[1091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 13 00:38:34 volumio-k sudo[1091]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:34 volumio-k sudo[1091]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:34 volumio-k sudo[1093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 13 00:38:34 volumio-k sudo[1093]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:34 volumio-k systemd[1]: Stopping Music Player Daemon... Jun 13 00:38:34 volumio-k volumio[943]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 13 00:38:34 volumio-k volumio[943]: info: ___________ START PLUGINS ___________ Jun 13 00:38:34 volumio-k volumio[943]: info: Setting Hotspot Unique name on first start: Volumio-0FFF8 Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getConfigParam Jun 13 00:38:34 volumio-k volumio[943]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getConfigParam] in plugin network Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , saveHotspotSettings Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::Reload Ui Jun 13 00:38:34 volumio-k volumio[943]: info: ControllerMpd::onStart: Initializing MPD Jun 13 00:38:34 volumio-k volumio[943]: info: Creating MPD Configuration file Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 13 00:38:34 volumio-k volumio[943]: info: [1749767914887] CoreMusicLibrary::Adding element Media Servers Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 13 00:38:34 volumio-k sudo[1100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 13 00:38:34 volumio-k sudo[1100]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:34 volumio-k sudo[1102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 13 00:38:34 volumio-k sudo[1102]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:34 volumio-k sudo[1100]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:34 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 13 00:38:35 volumio-k volumio[943]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 13 00:38:35 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:35 volumio-k systemd[1]: mpd.service: Succeeded. Jun 13 00:38:35 volumio-k systemd[1]: Stopped Music Player Daemon. Jun 13 00:38:35 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 13 00:38:35 volumio-k systemd[1]: Starting Music Player Daemon... Jun 13 00:38:35 volumio-k volumio[943]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 13 00:38:35 volumio-k volumio[943]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 13 00:38:35 volumio-k volumio[943]: info: [1749767915169] CoreMusicLibrary::Adding element Last_100 Jun 13 00:38:35 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 13 00:38:35 volumio-k volumio[943]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 13 00:38:35 volumio-k volumio[943]: info: [1749767915176] CoreMusicLibrary::Adding element Webradio Jun 13 00:38:35 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 13 00:38:35 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 13 00:38:35 volumio-k volumio[943]: info: Initializing BBC Radios Jun 13 00:38:35 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 13 00:38:35 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 13 00:38:35 volumio-k volumio[943]: info: Loading i18n strings for locale en Jun 13 00:38:35 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 13 00:38:35 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:35 volumio-k volumio[943]: info: FusionDsp - mixtype--------------------- Hardware Jun 13 00:38:35 volumio-k volumio[943]: info: Volumio Calling Home Jun 13 00:38:35 volumio-k sudo[1109]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 13 00:38:35 volumio-k sudo[1109]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:35 volumio-k sudo[1109]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:35 volumio-k volumio[943]: info: Preparing to generate the ALSA configuration file Jun 13 00:38:35 volumio-k volumio[943]: info: Discovery: adding 8f03e8f0-1fee-4713-aa71-6141656ce1d0 Jun 13 00:38:35 volumio-k volumio[943]: info: Discovery: Found device Volumio5 Jun 13 00:38:35 volumio-k volumio[943]: info: Discovery: Connecting to remote: 192.168.0.70 Jun 13 00:38:35 volumio-k volumio[943]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 13 00:38:35 volumio-k volumio[943]: info: Reading ALSA contributions from plugins. Jun 13 00:38:35 volumio-k volumio[943]: info: MPD Permissions set Jun 13 00:38:35 volumio-k volumio[943]: info: MPD Permissions set Jun 13 00:38:35 volumio-k volumio[943]: info: VolumeController:: Volume=0 Mute =false Jun 13 00:38:35 volumio-k volumio[943]: info: CoreStateMachine::pushState Jun 13 00:38:35 volumio-k volumio[943]: info: CorePlayQueue::getTrack 0 Jun 13 00:38:35 volumio-k volumio[943]: info: CoreCommandRouter::volumioPushState Jun 13 00:38:35 volumio-k volumio[943]: info: Volumio called home Jun 13 00:38:35 volumio-k sudo[1128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf Jun 13 00:38:35 volumio-k sudo[1128]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:35 volumio-k sudo[1128]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:35 volumio-k volumio[943]: info: Discovery: Connected to remote: 192.168.0.70 Jun 13 00:38:36 volumio-k volumio[943]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k volumio[943]: info: Permissions for /etc/hostapd/hostapd.conf Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Jun 13 00:38:36 volumio-k volumio[943]: info: Discovery: Restarting Advertising due to device name change Jun 13 00:38:36 volumio-k sudo[1139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Jun 13 00:38:36 volumio-k sudo[1139]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:36 volumio-k volumio[943]: info: Starting Shairport Sync Jun 13 00:38:36 volumio-k volumio[943]: info: Starting Shairport Sync Jun 13 00:38:36 volumio-k systemd[1]: Starting Wireless Services... Jun 13 00:38:36 volumio-k volumio[943]: info: Starting Shairport Sync Jun 13 00:38:36 volumio-k sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 13 00:38:36 volumio-k sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:36 volumio-k sudo[1148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 13 00:38:36 volumio-k sudo[1148]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:36 volumio-k sudo[1145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 13 00:38:36 volumio-k sudo[1145]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::volumioGetState Jun 13 00:38:36 volumio-k volumio[943]: info: CorePlayQueue::getTrack 0 Jun 13 00:38:36 volumio-k systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 13 00:38:36 volumio-k systemd[1]: shairport-sync.service: Succeeded. Jun 13 00:38:36 volumio-k systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 13 00:38:36 volumio-k volumio[943]: info: Asound.conf file unchanged, so no further update is needed Jun 13 00:38:36 volumio-k volumio[943]: info: Output device has changed, restarting MPD Jun 13 00:38:36 volumio-k systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 13 00:38:36 volumio-k sudo[1148]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:36 volumio-k sudo[1145]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:36 volumio-k volumio[943]: info: Output device has changed, restarting Shairport Sync Jun 13 00:38:36 volumio-k sudo[1143]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:36 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:36 volumio-k sudo[1160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 13 00:38:36 volumio-k sudo[1160]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:36 volumio-k sudo[1166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 13 00:38:36 volumio-k sudo[1166]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:37 volumio-k sudo[1160]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:37 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 13 00:38:37 volumio-k systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 13 00:38:37 volumio-k systemd[1]: mpd.service: Succeeded. Jun 13 00:38:37 volumio-k systemd[1]: Stopped Music Player Daemon. Jun 13 00:38:37 volumio-k systemd[1]: Starting Music Player Daemon... Jun 13 00:38:37 volumio-k volumio[943]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 13 00:38:37 volumio-k volumio[943]: info: MPD Permissions set Jun 13 00:38:37 volumio-k volumio[943]: info: Shairport-Sync Started Jun 13 00:38:37 volumio-k volumio[943]: Error adding Membership: Error: addMembership EINVAL Jun 13 00:38:37 volumio-k volumio[943]: info: Shairport-Sync Started Jun 13 00:38:37 volumio-k volumio[943]: info: Shairport-Sync Started Jun 13 00:38:37 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:37 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:37 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:37 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:37 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:37 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:37 volumio-k sudo[1188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 13 00:38:37 volumio-k sudo[1188]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:37 volumio-k sudo[1190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 13 00:38:37 volumio-k sudo[1190]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:37 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 13 00:38:37 volumio-k sudo[1188]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:37 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:37 volumio-k sudo[1190]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:37 volumio-k sudo[1184]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 13 00:38:37 volumio-k sudo[1184]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:37 volumio-k sudo[1184]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:37 volumio-k volumio[943]: info: camilladsp service started and running in background, instance 1 Jun 13 00:38:37 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:37 volumio-k volumio[943]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 13 00:38:37 volumio-k volumio[943]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jun 13 00:38:37 volumio-k volumio[943]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 13 00:38:37 volumio-k volumio[943]: info: FusionDsp loaded Jun 13 00:38:37 volumio-k volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 13 00:38:37 volumio-k sudo[1209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 13 00:38:37 volumio-k sudo[1209]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:37 volumio-k systemd[1]: systemd-timedated.service: Succeeded. Jun 13 00:38:37 volumio-k volumio[943]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 13 00:38:37 volumio-k volumio[943]: info: Adding Signal Path Element [object Object] Jun 13 00:38:37 volumio-k volumio[943]: info: Adding fusiondspeq DSP Signal Path Element Jun 13 00:38:37 volumio-k volumio[943]: info: FusionDsp - ---- installed callbackRead Jun 13 00:38:37 volumio-k volumio[943]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 13 00:38:37 volumio-k volumio[943]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 13 00:38:37 volumio-k volumio[943]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jun 13 00:38:37 volumio-k volumio[943]: at onErrorNT (internal/child_process.js:465:16) Jun 13 00:38:37 volumio-k volumio[943]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jun 13 00:38:37 volumio-k volumio[943]: at runNextTicks (internal/process/task_queues.js:62:3) Jun 13 00:38:37 volumio-k volumio[943]: at listOnTimeout (internal/timers.js:523:9) Jun 13 00:38:37 volumio-k volumio[943]: at processTimers (internal/timers.js:497:7) { Jun 13 00:38:37 volumio-k volumio[943]: errno: -2, Jun 13 00:38:37 volumio-k volumio[943]: code: 'ENOENT', Jun 13 00:38:37 volumio-k volumio[943]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 13 00:38:37 volumio-k volumio[943]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 13 00:38:37 volumio-k volumio[943]: spawnargs: [ Jun 13 00:38:37 volumio-k volumio[943]: '-p', Jun 13 00:38:37 volumio-k volumio[943]: 9876, Jun 13 00:38:37 volumio-k volumio[943]: '-o', Jun 13 00:38:37 volumio-k volumio[943]: '/tmp/camilladsp.log', Jun 13 00:38:37 volumio-k volumio[943]: '-l', Jun 13 00:38:37 volumio-k volumio[943]: 'warn', Jun 13 00:38:37 volumio-k volumio[943]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 13 00:38:37 volumio-k volumio[943]: ] Jun 13 00:38:37 volumio-k volumio[943]: } Jun 13 00:38:37 volumio-k volumio[943]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 13 00:38:37 volumio-k sudo[1209]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:37 volumio-k wireless.js[1141]: Cleaning previous... Jun 13 00:38:38 volumio-k systemd[1]: Stopping Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jun 13 00:38:38 volumio-k systemd[1]: hostapd.service: Succeeded. Jun 13 00:38:38 volumio-k systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jun 13 00:38:38 volumio-k sudo[1228]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 13 00:38:38 volumio-k sudo[1228]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:38 volumio-k avahi-daemon[623]: Withdrawing address record for 192.168.211.1 on wlan0. Jun 13 00:38:38 volumio-k avahi-daemon[623]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Jun 13 00:38:38 volumio-k sudo[1228]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:38 volumio-k avahi-daemon[623]: Interface wlan0.IPv4 no longer relevant for mDNS. Jun 13 00:38:38 volumio-k sudo[1230]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 13 00:38:38 volumio-k sudo[1230]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:39 volumio-k volumio-remote-updater[613]: [2025-06-13 00:38:39] [connect] Successful connection Jun 13 00:38:39 volumio-k sudo[1230]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:39 volumio-k sudo[1233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-13 00:37 Jun 13 00:38:39 volumio-k sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:39 volumio-k sudo[1233]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:39 volumio-k sudo[1166]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:39 volumio-k sudo[1102]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:39 volumio-k sudo[1093]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:39 volumio-k wireless.js[1141]: Stopped aP Jun 13 00:38:39 volumio-k volumio[943]: Terminated Jun 13 00:38:39 volumio-k volumio[943]: child_process.js:655 Jun 13 00:38:39 volumio-k volumio[943]: throw err; Jun 13 00:38:39 volumio-k volumio[943]: ^ Jun 13 00:38:39 volumio-k volumio[943]: Error: Command failed: /usr/bin/sudo /bin/journalctl --since="2025-06-13 00:37" > /tmp/crashdump Jun 13 00:38:39 volumio-k volumio[943]: Terminated Jun 13 00:38:39 volumio-k volumio[943]: at checkExecSyncError (child_process.js:616:11) Jun 13 00:38:39 volumio-k volumio[943]: at execSync (child_process.js:652:15) Jun 13 00:38:39 volumio-k volumio[943]: at Object. (/volumio/crashreport.js:14:18) Jun 13 00:38:39 volumio-k volumio[943]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Jun 13 00:38:39 volumio-k volumio[943]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Jun 13 00:38:39 volumio-k volumio[943]: at Module.load (internal/modules/cjs/loader.js:928:32) Jun 13 00:38:39 volumio-k volumio[943]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Jun 13 00:38:39 volumio-k volumio[943]: at Function.executeUserEntryPoint [as runMain] (internal/modules/run_main.js:72:12) Jun 13 00:38:39 volumio-k volumio[943]: at internal/main/run_main_module.js:17:47 { Jun 13 00:38:39 volumio-k volumio[943]: status: 143, Jun 13 00:38:39 volumio-k volumio[943]: signal: null, Jun 13 00:38:39 volumio-k volumio[943]: output: [ Jun 13 00:38:39 volumio-k volumio[943]: null, Jun 13 00:38:39 volumio-k volumio[943]: Buffer(0) [Uint8Array] [], Jun 13 00:38:39 volumio-k volumio[943]: Buffer(11) [Uint8Array] [ Jun 13 00:38:39 volumio-k volumio[943]: 84, 101, 114, 109, Jun 13 00:38:39 volumio-k volumio[943]: 105, 110, 97, 116, Jun 13 00:38:39 volumio-k volumio[943]: 101, 100, 10 Jun 13 00:38:39 volumio-k volumio[943]: ] Jun 13 00:38:39 volumio-k volumio[943]: ], Jun 13 00:38:39 volumio-k volumio[943]: pid: 1232, Jun 13 00:38:39 volumio-k volumio[943]: stdout: Buffer(0) [Uint8Array] [], Jun 13 00:38:39 volumio-k volumio[943]: stderr: Buffer(11) [Uint8Array] [ Jun 13 00:38:39 volumio-k volumio[943]: 84, 101, 114, 109, Jun 13 00:38:39 volumio-k volumio[943]: 105, 110, 97, 116, Jun 13 00:38:39 volumio-k volumio[943]: 101, 100, 10 Jun 13 00:38:39 volumio-k volumio[943]: ] Jun 13 00:38:39 volumio-k volumio[943]: } Jun 13 00:38:39 volumio-k volumio[943]: child_process.js:655 Jun 13 00:38:39 volumio-k volumio[943]: throw err; Jun 13 00:38:39 volumio-k volumio[943]: ^ Jun 13 00:38:39 volumio-k volumio[943]: Error: Command failed: /usr/bin/node /volumio/crashreport.js "spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT" Jun 13 00:38:39 volumio-k volumio[943]: Terminated Jun 13 00:38:39 volumio-k volumio[943]: child_process.js:655 Jun 13 00:38:39 volumio-k volumio[943]: throw err; Jun 13 00:38:39 volumio-k volumio[943]: ^ Jun 13 00:38:39 volumio-k volumio[943]: Error: Command failed: /usr/bin/sudo /bin/journalctl --since="2025-06-13 00:37" > /tmp/crashdump Jun 13 00:38:39 volumio-k volumio[943]: Terminated Jun 13 00:38:39 volumio-k volumio[943]: at checkExecSyncError (child_process.js:616:11) Jun 13 00:38:39 volumio-k volumio[943]: at execSync (child_process.js:652:15) Jun 13 00:38:39 volumio-k volumio[943]: at Object. (/volumio/crashreport.js:14:18) Jun 13 00:38:39 volumio-k volumio[943]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Jun 13 00:38:39 volumio-k volumio[943]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Jun 13 00:38:39 volumio-k volumio[943]: at Module.load (internal/modules/cjs/loader.js:928:32) Jun 13 00:38:39 volumio-k volumio[943]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Jun 13 00:38:39 volumio-k volumio[943]: at Function.executeUserEntryPoint [as runMain] (internal/modules/run_main.js:72:12) Jun 13 00:38:39 volumio-k volumio[943]: at internal/main/run_main_module.js:17:47 { Jun 13 00:38:39 volumio-k volumio[943]: status: 143, Jun 13 00:38:39 volumio-k volumio[943]: signal: null, Jun 13 00:38:39 volumio-k volumio[943]: output: [ Jun 13 00:38:39 volumio-k volumio[943]: null, Jun 13 00:38:39 volumio-k volumio[943]: Buffer(0) [Uint8Array] [], Jun 13 00:38:39 volumio-k volumio[943]: Buffer(11) [Uint8Array] [ Jun 13 00:38:39 volumio-k volumio[943]: 84, 101, 114, 109, Jun 13 00:38:39 volumio-k volumio[943]: 105, 110, 97, 116, Jun 13 00:38:39 volumio-k volumio[943]: 101, 100, 10 Jun 13 00:38:39 volumio-k volumio[943]: ] Jun 13 00:38:39 volumio-k volumio[943]: ], Jun 13 00:38:39 volumio-k volumio[943]: pid: 1232, Jun 13 00:38:39 volumio-k volumio[943]: stdout: Buffer(0) [Uint8Array] [], Jun 13 00:38:39 volumio-k volumio[943]: stderr: Buffer(11) [Uint8Array] [ Jun 13 00:38:39 volumio-k volumio[943]: 84, 101, 114, 109, Jun 13 00:38:39 volumio-k volumio[943]: 105, 110, 97, 116, Jun 13 00:38:39 volumio-k volumio[943]: 101, 100, 10 Jun 13 00:38:39 volumio-k volumio[943]: ] Jun 13 00:38:39 volumio-k volumio[943]: } Jun 13 00:38:39 volumio-k volumio[943]: at checkExecSyncError (child_process.js:616:11) Jun 13 00:38:39 volumio-k volumio[943]: at execSync (child_process.js:652:15) Jun 13 00:38:39 volumio-k volumio[943]: at process. (/volumio/index.js:78:3) Jun 13 00:38:39 volumio-k volumio[943]: at process.emit (events.js:315:20) Jun 13 00:38:39 volumio-k volumio[943]: at process._fatalException (internal/process/execution.js:163:25) { Jun 13 00:38:39 volumio-k volumio[943]: status: 1, Jun 13 00:38:39 volumio-k volumio[943]: signal: null, Jun 13 00:38:39 volumio-k volumio[943]: output: [ Jun 13 00:38:39 volumio-k volumio[943]: null, Jun 13 00:38:39 volumio-k volumio[943]: Buffer(0) [Uint8Array] [], Jun 13 00:38:39 volumio-k volumio[943]: Buffer(1076) [Uint8Array] [ Jun 13 00:38:39 volumio-k volumio[943]: 84, 101, 114, 109, 105, 110, 97, 116, 101, 100, 10, 99, Jun 13 00:38:39 volumio-k volumio[943]: 104, 105, 108, 100, 95, 112, 114, 111, 99, 101, 115, 115, Jun 13 00:38:39 volumio-k volumio[943]: 46, 106, 115, 58, 54, 53, 53, 10, 32, 32, 32, 32, Jun 13 00:38:39 volumio-k volumio[943]: 116, 104, 114, 111, 119, 32, 101, 114, 114, 59, 10, 32, Jun 13 00:38:39 volumio-k volumio[943]: 32, 32, 32, 94, 10, 10, 69, 114, 114, 111, 114, 58, Jun 13 00:38:39 volumio-k volumio[943]: 32, 67, 111, 109, 109, 97, 110, 100, 32, 102, 97, 105, Jun 13 00:38:39 volumio-k volumio[943]: 108, 101, 100, 58, 32, 47, 117, 115, 114, 47, 98, 105, Jun 13 00:38:39 volumio-k volumio[943]: 110, 47, 115, 117, 100, 111, 32, 47, 98, 105, 110, 47, Jun 13 00:38:39 volumio-k volumio[943]: 106, 111, 117, 114, Jun 13 00:38:39 volumio-k volumio[943]: ... 976 more items Jun 13 00:38:39 volumio-k volumio[943]: ] Jun 13 00:38:39 volumio-k volumio[943]: ], Jun 13 00:38:39 volumio-k volumio[943]: pid: 1213, Jun 13 00:38:39 volumio-k volumio[943]: stdout: Buffer(0) [Uint8Array] [], Jun 13 00:38:39 volumio-k volumio[943]: stderr: Buffer(1076) [Uint8Array] [ Jun 13 00:38:39 volumio-k volumio[943]: 84, 101, 114, 109, 105, 110, 97, 116, 101, 100, 10, 99, Jun 13 00:38:39 volumio-k volumio[943]: 104, 105, 108, 100, 95, 112, 114, 111, 99, 101, 115, 115, Jun 13 00:38:39 volumio-k volumio[943]: 46, 106, 115, 58, 54, 53, 53, 10, 32, 32, 32, 32, Jun 13 00:38:39 volumio-k volumio[943]: 116, 104, 114, 111, 119, 32, 101, 114, 114, 59, 10, 32, Jun 13 00:38:39 volumio-k volumio[943]: 32, 32, 32, 94, 10, 10, 69, 114, 114, 111, 114, 58, Jun 13 00:38:39 volumio-k volumio[943]: 32, 67, 111, 109, 109, 97, 110, 100, 32, 102, 97, 105, Jun 13 00:38:39 volumio-k volumio[943]: 108, 101, 100, 58, 32, 47, 117, 115, 114, 47, 98, 105, Jun 13 00:38:39 volumio-k volumio[943]: 110, 47, 115, 117, 100, 111, 32, 47, 98, 105, 110, 47, Jun 13 00:38:39 volumio-k volumio[943]: 106, 111, 117, 114, Jun 13 00:38:39 volumio-k volumio[943]: ... 976 more items Jun 13 00:38:39 volumio-k volumio[943]: ] Jun 13 00:38:39 volumio-k volumio[943]: } Jun 13 00:38:39 volumio-k sudo[1240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 13 00:38:39 volumio-k sudo[1240]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:39 volumio-k sudo[1240]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:39 volumio-k kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jun 13 00:38:39 volumio-k volumio-remote-updater[613]: [2025-06-13 00:38:39] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Jun 13 00:38:39 volumio-k volumio-remote-updater[613]: [2025-06-13 00:38:39] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error) Jun 13 00:38:39 volumio-k volumio-remote-updater[613]: [2025-06-13 00:38:39] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 13 00:38:39 volumio-k systemd[1]: volumio.service: Main process exited, code=exited, status=7/NOTRUNNING Jun 13 00:38:39 volumio-k sudo[1139]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:39 volumio-k sudo[1242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jun 13 00:38:39 volumio-k sudo[1242]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:39 volumio-k systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 13 00:38:39 volumio-k sudo[1242]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:39 volumio-k systemd[1]: Started dynamicswap service. Jun 13 00:38:39 volumio-k sudo[1250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 13 00:38:39 volumio-k systemd[1]: dynamicswap.service: Succeeded. Jun 13 00:38:39 volumio-k sudo[1250]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:39 volumio-k systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 13 00:38:39 volumio-k systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Jun 13 00:38:39 volumio-k sudo[1250]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:39 volumio-k systemd[1]: Started dynamicswap service. Jun 13 00:38:39 volumio-k systemd[1]: Stopped Volumio Backend Module. Jun 13 00:38:39 volumio-k sudo[1258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jun 13 00:38:39 volumio-k sudo[1258]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:39 volumio-k systemd[1]: dynamicswap.service: Succeeded. Jun 13 00:38:40 volumio-k sudo[1258]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:40 volumio-k sudo[1270]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 13 00:38:40 volumio-k sudo[1270]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:40 volumio-k sudo[1270]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:40 volumio-k sudo[1272]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 13 00:38:40 volumio-k sudo[1272]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:40 volumio-k mpd[1204]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 13 00:38:40 volumio-k mpd[1204]: output: No 'audio_output' defined in config file Jun 13 00:38:40 volumio-k mpd[1204]: output: Successfully detected a sndio audio device Jun 13 00:38:40 volumio-k mpd[1204]: zeroconf: No global port, disabling zeroconf Jun 13 00:38:40 volumio-k systemd[1]: Started Music Player Daemon. Jun 13 00:38:40 volumio-k sudo[1272]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:41 volumio-k avahi-daemon[623]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Jun 13 00:38:41 volumio-k avahi-daemon[623]: New relevant interface wlan0.IPv4 for mDNS. Jun 13 00:38:41 volumio-k avahi-daemon[623]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Jun 13 00:38:41 volumio-k kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jun 13 00:38:41 volumio-k systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jun 13 00:38:41 volumio-k hostapd[1281]: Configuration file: /etc/hostapd/hostapd.conf Jun 13 00:38:41 volumio-k hostapd[1281]: wlan0: Could not connect to kernel driver Jun 13 00:38:41 volumio-k hostapd[1281]: Using interface wlan0 with hwaddr b8:27:eb:ae:8e:77 and ssid "Volumio-0FFF8" Jun 13 00:38:41 volumio-k hostapd[1281]: wlan0: interface state UNINITIALIZED->ENABLED Jun 13 00:38:41 volumio-k hostapd[1281]: wlan0: AP-ENABLED Jun 13 00:38:41 volumio-k systemd[1]: Started Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jun 13 00:38:41 volumio-k iwconfig[1284]: Error for wireless request "Set Power Management" (8B2C) : Jun 13 00:38:41 volumio-k iwconfig[1284]: SET failed on device wlan0 ; Invalid argument. Jun 13 00:38:41 volumio-k systemd[1]: wireless.service: Succeeded. Jun 13 00:38:41 volumio-k systemd[1]: Started Wireless Services. Jun 13 00:38:41 volumio-k systemd[1]: Started Volumio Backend Module. Jun 13 00:38:44 volumio-k volumio[1285]: info: ------------------------------------------- Jun 13 00:38:44 volumio-k volumio[1285]: info: ----- Volumio3 ---- Jun 13 00:38:44 volumio-k volumio[1285]: info: ------------------------------------------- Jun 13 00:38:44 volumio-k volumio[1285]: info: ----- System startup ---- Jun 13 00:38:44 volumio-k volumio[1285]: info: ------------------------------------------- Jun 13 00:38:45 volumio-k volumio[1285]: info: MYVOLUMIO Environment detected Jun 13 00:38:46 volumio-k volumio[1285]: info: Plugin folders cleanup Jun 13 00:38:46 volumio-k volumio[1285]: info: Scanning into folder /volumio/app/plugins/ Jun 13 00:38:46 volumio-k volumio[1285]: info: Scanning category audio_interface Jun 13 00:38:46 volumio-k volumio[1285]: info: Scanning category miscellanea Jun 13 00:38:46 volumio-k volumio[1285]: info: Scanning category music_service Jun 13 00:38:46 volumio-k volumio[1285]: info: Scanning category plugins.json Jun 13 00:38:46 volumio-k volumio[1285]: info: Scanning category system_controller Jun 13 00:38:46 volumio-k volumio[1285]: info: Scanning category user_interface Jun 13 00:38:46 volumio-k volumio[1285]: info: Scanning into folder /data/plugins/ Jun 13 00:38:46 volumio-k volumio[1285]: info: Scanning category audio_interface Jun 13 00:38:46 volumio-k volumio[1285]: info: Plugin folders cleanup completed Jun 13 00:38:46 volumio-k volumio[1285]: info: ------------------------------------------- Jun 13 00:38:46 volumio-k volumio[1285]: info: ----- Core plugins startup ---- Jun 13 00:38:46 volumio-k volumio[1285]: info: ------------------------------------------- Jun 13 00:38:46 volumio-k volumio[1285]: info: Loading plugins from folder /volumio/app/plugins/ Jun 13 00:38:46 volumio-k volumio[1285]: info: Adding plugin upnp to MyMusic Plugins Jun 13 00:38:46 volumio-k volumio[1285]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 13 00:38:46 volumio-k volumio[1285]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 13 00:38:46 volumio-k volumio[1285]: info: Loading plugins from folder /data/plugins/ Jun 13 00:38:46 volumio-k volumio[1285]: info: Loading plugin "system"... Jun 13 00:38:46 volumio-k volumio[1285]: info: Loading plugin "appearance"... Jun 13 00:38:47 volumio-k volumio[1285]: info: Loading plugin "network"... Jun 13 00:38:47 volumio-k volumio[1285]: info: Refreshing Cached IP Addresses Jun 13 00:38:48 volumio-k sudo[1306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 13 00:38:48 volumio-k sudo[1306]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:48 volumio-k sudo[1308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 13 00:38:48 volumio-k sudo[1308]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:48 volumio-k sudo[1306]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:48 volumio-k sudo[1308]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:48 volumio-k volumio[1285]: info: Loading plugin "services"... Jun 13 00:38:48 volumio-k volumio[1285]: info: Loading plugin "alsa_controller"... Jun 13 00:38:48 volumio-k sudo[1317]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 13 00:38:48 volumio-k sudo[1317]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:48 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 13 00:38:48 volumio-k volumio[1285]: info: Loading plugin "wizard"... Jun 13 00:38:48 volumio-k volumio[1285]: info: Loading plugin "networkfs"... Jun 13 00:38:48 volumio-k volumio[1285]: info: Starting Udev Watcher for removable devices Jun 13 00:38:48 volumio-k volumio[1285]: info: Ignoring mount for partition: boot Jun 13 00:38:48 volumio-k volumio[1285]: info: Ignoring mount for partition: volumio Jun 13 00:38:48 volumio-k volumio[1285]: info: Ignoring mount for partition: volumio_data Jun 13 00:38:48 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 13 00:38:48 volumio-k volumio[1285]: info: Loading plugin "volumio_command_line_client"... Jun 13 00:38:48 volumio-k volumio[1285]: info: Loading plugin "upnp"... Jun 13 00:38:48 volumio-k volumio[1285]: info: [1749767928465] Starting Upmpd Daemon Jun 13 00:38:48 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 13 00:38:48 volumio-k volumio[1285]: info: Loading plugin "my_music"... Jun 13 00:38:48 volumio-k volumio[1285]: info: Loading plugin "mpd"... Jun 13 00:38:49 volumio-k sudo[1317]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:49 volumio-k volumio[1285]: info: Loading plugin "upnp_browser"... Jun 13 00:38:49 volumio-k volumio-remote-updater[613]: [2025-06-13 00:38:49] [connect] Successful connection Jun 13 00:38:49 volumio-k volumio[1285]: info: Loading plugin "alarm-clock"... Jun 13 00:38:49 volumio-k volumio[1285]: info: Loading plugin "airplay_emulation"... Jun 13 00:38:49 volumio-k volumio[1285]: info: Starting Shairport Sync Jun 13 00:38:49 volumio-k volumio[1285]: info: Loading plugin "last_100"... Jun 13 00:38:50 volumio-k volumio[1285]: info: Loading plugin "webradio"... Jun 13 00:38:50 volumio-k volumio[1285]: info: Loading plugin "i2s_dacs"... Jun 13 00:38:50 volumio-k volumio[1285]: info: Loading plugin "volumiodiscovery"... Jun 13 00:38:50 volumio-k volumio[1285]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 13 00:38:50 volumio-k volumio[1285]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 13 00:38:50 volumio-k volumio[1285]: *** WARNING *** For more information see Jun 13 00:38:50 volumio-k node[1285]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 13 00:38:50 volumio-k volumio[1285]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 13 00:38:50 volumio-k volumio[1285]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 13 00:38:50 volumio-k volumio[1285]: *** WARNING *** For more information see Jun 13 00:38:50 volumio-k node[1285]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 13 00:38:50 volumio-k node[1285]: *** WARNING *** For more information see Jun 13 00:38:50 volumio-k node[1285]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 13 00:38:50 volumio-k node[1285]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 13 00:38:50 volumio-k node[1285]: *** WARNING *** For more information see Jun 13 00:38:50 volumio-k volumio[1285]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 13 00:38:54 volumio-k volumio[1285]: info: Discovery: Started advertising with name: Volumio Jun 13 00:38:54 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 13 00:38:54 volumio-k volumio[1285]: info: Loading plugin "outputs"... Jun 13 00:38:54 volumio-k volumio[1285]: info: Loading plugin "albumart"... Jun 13 00:38:54 volumio-k volumio[1285]: info: Plugin example_plugin is not enabled Jun 13 00:38:54 volumio-k volumio[1285]: info: Loading plugin "inputs"... Jun 13 00:38:54 volumio-k volumio[1285]: info: Loading plugin "updater_comm"... Jun 13 00:38:54 volumio-k volumio[1285]: info: Plugin mpdemulation is not enabled Jun 13 00:38:54 volumio-k volumio[1285]: info: Loading plugin "rest_api"... Jun 13 00:38:54 volumio-k volumio[1285]: info: Loading plugin "websocket"... Jun 13 00:38:54 volumio-k volumio[1285]: info: Starting Socket.io Server version 2.3.0 Jun 13 00:38:54 volumio-k volumio[1285]: info: Loading plugin "fusiondsp"... Jun 13 00:38:55 volumio-k volumio[1285]: Forking 3 albumart workers Jun 13 00:38:55 volumio-k volumio[1285]: info: Applying required configuration parameters for plugin fusiondsp Jun 13 00:38:55 volumio-k volumio[1285]: info: Loading i18n strings for locale en Jun 13 00:38:55 volumio-k volumio[1285]: Updating browse sources language Jun 13 00:38:55 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 13 00:38:56 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 13 00:38:56 volumio-k volumio[1285]: info: CoreCommandRouter::initPlayerControls Jun 13 00:38:56 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:56 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:56 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:56 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:56 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:56 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:56 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:56 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:56 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 13 00:38:56 volumio-k volumio[1285]: Express server listening on port 3000 Jun 13 00:38:56 volumio-k volumio[1285]: [Metrics] WebUI: 12s 827.82ms Jun 13 00:38:56 volumio-k volumio[1285]: info: CoreStateMachine::resetVolumioState Jun 13 00:38:56 volumio-k volumio[1285]: info: CoreStateMachine::getcurrentVolume Jun 13 00:38:56 volumio-k volumio[1285]: info: CoreCommandRouter::volumioRetrievevolume Jun 13 00:38:56 volumio-k volumio[1285]: info: Volumio Network Manager: Network status updated: 1 Jun 13 00:38:56 volumio-k volumio[1285]: verbose: New Socket.io Connection to 192.168.0.16:3000 from 192.168.0.68 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jun 13 00:38:56 volumio-k volumio[1285]: verbose: New Socket.io Connection to 192.168.0.16:3000 from 192.168.0.68 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jun 13 00:38:56 volumio-k volumio[1285]: verbose: New Socket.io Connection to 192.168.0.16:3000 from 192.168.0.68 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jun 13 00:38:57 volumio-k volumio[1285]: Starting albumart workers Jun 13 00:38:57 volumio-k volumio[1285]: Starting albumart workers Jun 13 00:38:57 volumio-k volumio[1285]: Starting albumart workers Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 13 00:38:57 volumio-k volumio[1285]: info: Reloading queue from file Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jun 13 00:38:57 volumio-k volumio[1285]: verbose: New Socket.io Connection to 192.168.0.16:3000 from 192.168.0.68 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jun 13 00:38:57 volumio-k volumio[1285]: info: VolumeController:: Volume=0 Mute =false Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreStateMachine::pushState Jun 13 00:38:57 volumio-k volumio[1285]: info: CorePlayQueue::getTrack 0 Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreCommandRouter::volumioPushState Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreStateMachine::updateTrackBlock Jun 13 00:38:57 volumio-k volumio[1285]: info: CorePlayQueue::getTrackBlock Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreCommandRouter::volumioRetrievevolume Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreStateMachine::setRepeat null single undefined Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreStateMachine::pushState Jun 13 00:38:57 volumio-k volumio[1285]: info: CorePlayQueue::getTrack 0 Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreCommandRouter::volumioPushState Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreStateMachine::setRandom null Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreStateMachine::pushState Jun 13 00:38:57 volumio-k volumio[1285]: info: CorePlayQueue::getTrack 0 Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreCommandRouter::volumioPushState Jun 13 00:38:57 volumio-k volumio[1285]: info: Setting Device type: Raspberry PI Jun 13 00:38:57 volumio-k volumio[1285]: info: Completed loading Core Plugins Jun 13 00:38:57 volumio-k volumio[1285]: info: Preparing to generate the ALSA configuration file Jun 13 00:38:57 volumio-k volumio[1285]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 13 00:38:57 volumio-k volumio[1285]: info: Reading ALSA contributions from plugins. Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreCommandRouter::volumioGetState Jun 13 00:38:57 volumio-k volumio[1285]: info: CorePlayQueue::getTrack 0 Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jun 13 00:38:57 volumio-k volumio[1285]: info: Discovery: adding 8f03e8f0-1fee-4713-aa71-6141656ce1d0 Jun 13 00:38:57 volumio-k volumio[1285]: info: Discovery: Found device Volumio5 Jun 13 00:38:57 volumio-k volumio[1285]: info: Discovery: Connecting to remote: 192.168.0.70 Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreCommandRouter::volumioGetState Jun 13 00:38:57 volumio-k volumio[1285]: info: CorePlayQueue::getTrack 0 Jun 13 00:38:57 volumio-k volumio[1285]: info: VolumeController:: Volume=0 Mute =false Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreStateMachine::pushState Jun 13 00:38:57 volumio-k volumio[1285]: info: CorePlayQueue::getTrack 0 Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreCommandRouter::volumioPushState Jun 13 00:38:57 volumio-k volumio[1285]: info: Discovery: adding b9096ee4-16da-4392-a4ca-7b9638af41e3 Jun 13 00:38:57 volumio-k volumio[1285]: info: Discovery: Found device Volumio Jun 13 00:38:57 volumio-k volumio[1285]: info: CoreCommandRouter::volumioGetState Jun 13 00:38:57 volumio-k volumio[1285]: info: CorePlayQueue::getTrack 0 Jun 13 00:38:58 volumio-k volumio[1285]: info: Discovery: Connected to remote: 192.168.0.70 Jun 13 00:38:58 volumio-k volumio[1285]: info: Discovery: this is already registered, b9096ee4-16da-4392-a4ca-7b9638af41e3 Jun 13 00:38:58 volumio-k volumio[1285]: info: Discovery: Found device Volumio Jun 13 00:38:58 volumio-k volumio[1285]: info: CoreCommandRouter::volumioGetState Jun 13 00:38:58 volumio-k volumio[1285]: info: CorePlayQueue::getTrack 0 Jun 13 00:38:58 volumio-k volumio[1285]: info: Asound.conf file unchanged, so no further update is needed Jun 13 00:38:58 volumio-k volumio[1285]: info: Output device has changed, restarting MPD Jun 13 00:38:58 volumio-k sudo[1408]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 13 00:38:58 volumio-k sudo[1408]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:58 volumio-k sudo[1408]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:58 volumio-k volumio[1285]: info: Output device has changed, restarting Shairport Sync Jun 13 00:38:58 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:58 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 13 00:38:58 volumio-k sudo[1411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 13 00:38:58 volumio-k sudo[1411]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:58 volumio-k systemd[1]: Stopping Music Player Daemon... Jun 13 00:38:58 volumio-k volumio[1285]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 13 00:38:58 volumio-k volumio[1285]: info: ___________ START PLUGINS ___________ Jun 13 00:38:58 volumio-k volumio[1285]: info: ControllerMpd::onStart: Initializing MPD Jun 13 00:38:58 volumio-k volumio[1285]: info: Creating MPD Configuration file Jun 13 00:38:58 volumio-k systemd[1]: mpd.service: Succeeded. Jun 13 00:38:58 volumio-k systemd[1]: Stopped Music Player Daemon. Jun 13 00:38:58 volumio-k systemd[1]: Starting Music Player Daemon... Jun 13 00:38:58 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 13 00:38:58 volumio-k volumio[1285]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 13 00:38:58 volumio-k volumio[1285]: info: [1749767938675] CoreMusicLibrary::Adding element Media Servers Jun 13 00:38:58 volumio-k sudo[1426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 13 00:38:58 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 13 00:38:58 volumio-k sudo[1426]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:58 volumio-k sudo[1428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 13 00:38:58 volumio-k sudo[1428]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:58 volumio-k sudo[1426]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:58 volumio-k systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 13 00:38:58 volumio-k systemd[1]: mpd.service: Succeeded. Jun 13 00:38:58 volumio-k systemd[1]: Stopped Music Player Daemon. Jun 13 00:38:58 volumio-k systemd[1]: Starting Music Player Daemon... Jun 13 00:38:58 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:58 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 13 00:38:58 volumio-k volumio[1285]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 13 00:38:58 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:58 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 13 00:38:58 volumio-k volumio[1285]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 13 00:38:58 volumio-k volumio[1285]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 13 00:38:58 volumio-k volumio[1285]: info: [1749767938958] CoreMusicLibrary::Adding element Last_100 Jun 13 00:38:58 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 13 00:38:58 volumio-k volumio[1285]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 13 00:38:58 volumio-k volumio[1285]: info: [1749767938965] CoreMusicLibrary::Adding element Webradio Jun 13 00:38:58 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 13 00:38:58 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 13 00:38:58 volumio-k volumio[1285]: info: Initializing BBC Radios Jun 13 00:38:59 volumio-k sudo[1431]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 13 00:38:59 volumio-k sudo[1431]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:59 volumio-k sudo[1431]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: Loading i18n strings for locale en Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: FusionDsp - mixtype--------------------- Hardware Jun 13 00:38:59 volumio-k volumio[1285]: info: Volumio Calling Home Jun 13 00:38:59 volumio-k volumio[1285]: info: Preparing to generate the ALSA configuration file Jun 13 00:38:59 volumio-k volumio[1285]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 13 00:38:59 volumio-k volumio[1285]: info: Reading ALSA contributions from plugins. Jun 13 00:38:59 volumio-k sudo[1454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 13 00:38:59 volumio-k sudo[1454]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:59 volumio-k sudo[1454]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:59 volumio-k volumio[1285]: info: MPD Permissions set Jun 13 00:38:59 volumio-k volumio[1285]: info: MPD Permissions set Jun 13 00:38:59 volumio-k sudo[1456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 13 00:38:59 volumio-k sudo[1456]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:38:59 volumio-k sudo[1456]: pam_unix(sudo:session): session closed for user root Jun 13 00:38:59 volumio-k volumio[1285]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jun 13 00:38:59 volumio-k volumio[1285]: info: Volumio called home Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:38:59 volumio-k volumio[1285]: info: Starting Shairport Sync Jun 13 00:39:00 volumio-k volumio[1285]: info: Starting Shairport Sync Jun 13 00:39:00 volumio-k volumio[1285]: info: Starting Shairport Sync Jun 13 00:39:00 volumio-k sudo[1468]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 13 00:39:00 volumio-k sudo[1468]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:39:00 volumio-k sudo[1470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 13 00:39:00 volumio-k sudo[1470]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:39:00 volumio-k volumio[1285]: info: CoreCommandRouter::volumioGetState Jun 13 00:39:00 volumio-k volumio[1285]: info: CorePlayQueue::getTrack 0 Jun 13 00:39:00 volumio-k systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 13 00:39:00 volumio-k systemd[1]: shairport-sync.service: Succeeded. Jun 13 00:39:00 volumio-k systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 13 00:39:00 volumio-k sudo[1473]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 13 00:39:00 volumio-k sudo[1473]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:39:00 volumio-k sudo[1477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 13 00:39:00 volumio-k sudo[1477]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:39:00 volumio-k volumio[1285]: info: Asound.conf file unchanged, so no further update is needed Jun 13 00:39:00 volumio-k volumio[1285]: info: Output device has changed, restarting MPD Jun 13 00:39:00 volumio-k systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 13 00:39:00 volumio-k sudo[1468]: pam_unix(sudo:session): session closed for user root Jun 13 00:39:00 volumio-k volumio[1285]: info: Output device has changed, restarting Shairport Sync Jun 13 00:39:00 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:39:00 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 13 00:39:00 volumio-k systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 13 00:39:00 volumio-k sudo[1481]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 13 00:39:00 volumio-k systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jun 13 00:39:00 volumio-k systemd[1]: shairport-sync.service: Succeeded. Jun 13 00:39:00 volumio-k systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 13 00:39:00 volumio-k sudo[1481]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:39:00 volumio-k sudo[1481]: pam_unix(sudo:session): session closed for user root Jun 13 00:39:00 volumio-k sudo[1484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 13 00:39:00 volumio-k sudo[1484]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:39:00 volumio-k systemd[1]: Started UPnP Renderer front-end to MPD. Jun 13 00:39:00 volumio-k volumio[1285]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 13 00:39:00 volumio-k systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 13 00:39:00 volumio-k sudo[1470]: pam_unix(sudo:session): session closed for user root Jun 13 00:39:00 volumio-k sudo[1473]: pam_unix(sudo:session): session closed for user root Jun 13 00:39:00 volumio-k volumiologrotate[625]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jun 13 00:39:00 volumio-k volumiologrotate[625]: ls: cannot access 'K': No such file or directory Jun 13 00:39:00 volumio-k volumio[1285]: info: MPD Permissions set Jun 13 00:39:00 volumio-k volumio[1285]: info: Shairport-Sync Started Jun 13 00:39:00 volumio-k sudo[1477]: pam_unix(sudo:session): session closed for user root Jun 13 00:39:00 volumio-k volumio[1285]: Error adding Membership: Error: addMembership EINVAL Jun 13 00:39:00 volumio-k volumio[1285]: info: Shairport-Sync Started Jun 13 00:39:00 volumio-k volumio[1285]: info: Shairport-Sync Started Jun 13 00:39:00 volumio-k volumio[1285]: info: Upmpdcli Daemon Started Jun 13 00:39:00 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:39:00 volumio-k systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 13 00:39:00 volumio-k systemd[1]: mpd.service: Succeeded. Jun 13 00:39:00 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:39:00 volumio-k systemd[1]: Stopped Music Player Daemon. Jun 13 00:39:00 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:39:00 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:39:00 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:39:00 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:39:00 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 13 00:39:00 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:39:00 volumio-k volumio[1285]: info: Starting Shairport Sync Jun 13 00:39:00 volumio-k systemd[1]: Starting Music Player Daemon... Jun 13 00:39:00 volumio-k sudo[1543]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 13 00:39:00 volumio-k sudo[1543]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:39:00 volumio-k systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 13 00:39:00 volumio-k systemd[1]: shairport-sync.service: Succeeded. Jun 13 00:39:00 volumio-k systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 13 00:39:00 volumio-k systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 13 00:39:00 volumio-k sudo[1543]: pam_unix(sudo:session): session closed for user root Jun 13 00:39:00 volumio-k volumio[1285]: info: Shairport-Sync Started Jun 13 00:39:01 volumio-k sudo[1527]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 13 00:39:01 volumio-k sudo[1527]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:39:01 volumio-k sudo[1527]: pam_unix(sudo:session): session closed for user root Jun 13 00:39:01 volumio-k volumio[1285]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 13 00:39:01 volumio-k volumio[1285]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Jun 13 00:39:01 volumio-k volumio[1285]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 13 00:39:01 volumio-k volumio[1285]: info: camilladsp service started and running in background, instance 1 Jun 13 00:39:01 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 13 00:39:01 volumio-k volumio[1285]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 13 00:39:01 volumio-k volumio[1285]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jun 13 00:39:01 volumio-k volumio[1285]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 13 00:39:01 volumio-k volumio[1285]: info: FusionDsp loaded Jun 13 00:39:01 volumio-k volumio[1285]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 13 00:39:01 volumio-k sudo[1560]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 13 00:39:01 volumio-k sudo[1560]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 13 00:39:01 volumio-k volumio[1285]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 13 00:39:01 volumio-k volumio[1285]: info: Adding Signal Path Element [object Object] Jun 13 00:39:01 volumio-k volumio[1285]: info: Adding fusiondspeq DSP Signal Path Element Jun 13 00:39:01 volumio-k sudo[1560]: pam_unix(sudo:session): session closed for user root Jun 13 00:39:01 volumio-k volumio[1285]: info: FusionDsp - ---- installed callbackRead Jun 13 00:39:01 volumio-k volumio[1285]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 13 00:39:01 volumio-k volumio[1285]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 13 00:39:01 volumio-k volumio[1285]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jun 13 00:39:01 volumio-k volumio[1285]: at onErrorNT (internal/child_process.js:465:16) Jun 13 00:39:01 volumio-k volumio[1285]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Jun 13 00:39:01 volumio-k volumio[1285]: errno: -2, Jun 13 00:39:01 volumio-k volumio[1285]: code: 'ENOENT', Jun 13 00:39:01 volumio-k volumio[1285]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 13 00:39:01 volumio-k volumio[1285]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 13 00:39:01 volumio-k volumio[1285]: spawnargs: [ Jun 13 00:39:01 volumio-k volumio[1285]: '-p', Jun 13 00:39:01 volumio-k volumio[1285]: 9876, Jun 13 00:39:01 volumio-k volumio[1285]: '-o', Jun 13 00:39:01 volumio-k volumio[1285]: '/tmp/camilladsp.log', Jun 13 00:39:01 volumio-k volumio[1285]: '-l', Jun 13 00:39:01 volumio-k volumio[1285]: 'warn', Jun 13 00:39:01 volumio-k volumio[1285]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 13 00:39:01 volumio-k volumio[1285]: ] Jun 13 00:39:01 volumio-k volumio[1285]: } Jun 13 00:39:01 volumio-k volumio[1285]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 13 00:39:02 volumio-k sudo[1571]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-13 00:38 Jun 13 00:39:02 volumio-k sudo[1571]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"