-- Logs begin at Thu 2019-02-14 10:11:59 GMT, end at Sun 2025-07-06 17:23:39 BST. -- Jul 06 17:23:07 ensuite systemd-timedated[874]: Changed local time to Sun Jul 6 17:23:07 2025 Jul 06 17:23:07 ensuite sudo[871]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:07 ensuite volumio-time-update[595]: volumio-time-update-util: System time updated successfully. Jul 06 17:23:07 ensuite systemd[1]: Starting Daily apt download activities... Jul 06 17:23:07 ensuite systemd[1]: Started Volumio Time Update Utility. Jul 06 17:23:07 ensuite bthelper[681]: [CHG] Controller B8:27:EB:C9:13:E8 Class: 0x0000041c Jul 06 17:23:07 ensuite bthelper[681]: Changing power on succeeded Jul 06 17:23:07 ensuite sudo[813]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:07 ensuite wireless.js[601]: SETTING APPROPRIATE REG DOMAIN: GB Jul 06 17:23:07 ensuite sudo[898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jul 06 17:23:07 ensuite sudo[898]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:07 ensuite sudo[898]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:07 ensuite sudo[902]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set GB Jul 06 17:23:07 ensuite sudo[902]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:07 ensuite sudo[902]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:07 ensuite wireless.js[601]: SUCCESSFULLY SET NEW REGDOMAIN: GB Jul 06 17:23:07 ensuite sudo[910]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jul 06 17:23:07 ensuite sudo[910]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:07 ensuite sudo[910]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:07 ensuite sudo[914]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jul 06 17:23:07 ensuite sudo[914]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:07 ensuite systemd[1]: apt-daily.service: Succeeded. Jul 06 17:23:07 ensuite systemd[1]: Started Daily apt download activities. Jul 06 17:23:07 ensuite systemd[1]: Starting Daily apt upgrade and clean activities... Jul 06 17:23:08 ensuite sudo[914]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:08 ensuite avahi-daemon[599]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Jul 06 17:23:08 ensuite avahi-daemon[599]: New relevant interface wlan0.IPv4 for mDNS. Jul 06 17:23:08 ensuite avahi-daemon[599]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Jul 06 17:23:08 ensuite kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jul 06 17:23:08 ensuite systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 06 17:23:08 ensuite systemd[1]: Starting dnsmasq - A lightweight DHCP and caching DNS server... Jul 06 17:23:08 ensuite dnsmasq[960]: dnsmasq: syntax check OK. Jul 06 17:23:08 ensuite hostapd[959]: Configuration file: /etc/hostapd/hostapd.conf Jul 06 17:23:08 ensuite hostapd[959]: wlan0: Could not connect to kernel driver Jul 06 17:23:08 ensuite hostapd[959]: Using interface wlan0 with hwaddr b8:27:eb:36:ec:17 and ssid "Volumio-106AC" Jul 06 17:23:08 ensuite dnsmasq[976]: started, version 2.80 cachesize 150 Jul 06 17:23:08 ensuite dnsmasq[976]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect inotify dumpfile Jul 06 17:23:08 ensuite dnsmasq-dhcp[976]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Jul 06 17:23:08 ensuite dnsmasq[976]: reading /etc/resolv.conf Jul 06 17:23:08 ensuite dnsmasq[976]: using nameserver 8.8.8.8#53 Jul 06 17:23:08 ensuite dnsmasq[976]: using nameserver 8.8.4.4#53 Jul 06 17:23:08 ensuite dnsmasq[976]: using nameserver 208.67.222.222#53 Jul 06 17:23:08 ensuite dnsmasq[976]: using nameserver 208.67.220.220#53 Jul 06 17:23:08 ensuite dnsmasq[976]: read /etc/hosts - 1 addresses Jul 06 17:23:08 ensuite hostapd[959]: wlan0: interface state UNINITIALIZED->ENABLED Jul 06 17:23:08 ensuite hostapd[959]: wlan0: AP-ENABLED Jul 06 17:23:08 ensuite systemd[1]: Started Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 06 17:23:08 ensuite systemd[1]: Started dnsmasq - A lightweight DHCP and caching DNS server. Jul 06 17:23:08 ensuite iwconfig[990]: Error for wireless request "Set Power Management" (8B2C) : Jul 06 17:23:08 ensuite iwconfig[990]: SET failed on device wlan0 ; Invalid argument. Jul 06 17:23:08 ensuite systemd[1]: wireless.service: Succeeded. Jul 06 17:23:08 ensuite systemd[1]: Started Wireless Services. Jul 06 17:23:08 ensuite systemd[1]: Started Volumio Backend Module. Jul 06 17:23:08 ensuite systemd[1]: Started Volumio Cpu Tweaker. Jul 06 17:23:08 ensuite systemd[1]: Reached target Host and Network Name Lookups. Jul 06 17:23:08 ensuite nmbd[720]: [2025/07/06 17:23:08.463928, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jul 06 17:23:08 ensuite nmbd[720]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jul 06 17:23:08 ensuite systemd[1]: Started Samba NMB Daemon. Jul 06 17:23:08 ensuite systemd[1]: Starting Samba Winbind Daemon... Jul 06 17:23:08 ensuite volumio-cpu-tweak[994]: Setting RT Priority for mpd Jul 06 17:23:08 ensuite volumio-cpu-tweak[994]: Setting MPD Affinity Jul 06 17:23:08 ensuite volumio-cpu-tweak[994]: pid 782's current affinity mask: f Jul 06 17:23:08 ensuite volumio-cpu-tweak[994]: pid 782's new affinity mask: 3 Jul 06 17:23:08 ensuite volumio-cpu-tweak[994]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Jul 06 17:23:08 ensuite volumio-cpu-tweak[994]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Jul 06 17:23:08 ensuite systemd[1]: volumio_cpu_tweak.service: Succeeded. Jul 06 17:23:08 ensuite systemd[1]: apt-daily-upgrade.service: Succeeded. Jul 06 17:23:08 ensuite systemd[1]: Started Daily apt upgrade and clean activities. Jul 06 17:23:08 ensuite winbindd[1008]: [2025/07/06 17:23:08.805428, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Jul 06 17:23:08 ensuite winbindd[1008]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jul 06 17:23:08 ensuite winbindd[1008]: [2025/07/06 17:23:08.826878, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jul 06 17:23:08 ensuite systemd[1]: Started Samba Winbind Daemon. Jul 06 17:23:08 ensuite winbindd[1008]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jul 06 17:23:08 ensuite systemd[1]: Starting Samba SMB Daemon... Jul 06 17:23:09 ensuite smbd[1033]: [2025/07/06 17:23:09.416794, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jul 06 17:23:09 ensuite systemd[1]: Started Samba SMB Daemon. Jul 06 17:23:09 ensuite smbd[1033]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jul 06 17:23:09 ensuite systemd[1]: Reached target Multi-User System. Jul 06 17:23:09 ensuite systemd[1]: Reached target Graphical Interface. Jul 06 17:23:09 ensuite systemd[1]: Starting Update UTMP about System Runlevel Changes... Jul 06 17:23:09 ensuite systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jul 06 17:23:09 ensuite systemd[1]: Started Update UTMP about System Runlevel Changes. Jul 06 17:23:09 ensuite systemd[1]: Startup finished in 13.240s (kernel) + 13.343s (userspace) = 26.584s. Jul 06 17:23:10 ensuite ntpd[767]: Listen normally on 3 eth0 192.168.1.218:123 Jul 06 17:23:10 ensuite ntpd[767]: Listen normally on 4 wlan0 192.168.211.1:123 Jul 06 17:23:10 ensuite ntpd[767]: new interface(s) found: waking up resolver Jul 06 17:23:11 ensuite volumio[992]: info: ------------------------------------------- Jul 06 17:23:11 ensuite volumio[992]: info: ----- Volumio3 ---- Jul 06 17:23:11 ensuite volumio[992]: info: ------------------------------------------- Jul 06 17:23:11 ensuite volumio[992]: info: ----- System startup ---- Jul 06 17:23:11 ensuite volumio[992]: info: ------------------------------------------- Jul 06 17:23:12 ensuite volumio[992]: info: MYVOLUMIO Environment detected Jul 06 17:23:12 ensuite volumio[992]: info: Plugin folders cleanup Jul 06 17:23:12 ensuite volumio[992]: info: Scanning into folder /volumio/app/plugins/ Jul 06 17:23:12 ensuite volumio[992]: info: Scanning category audio_interface Jul 06 17:23:12 ensuite volumio[992]: info: Scanning category miscellanea Jul 06 17:23:12 ensuite volumio[992]: info: Scanning category music_service Jul 06 17:23:12 ensuite volumio[992]: info: Scanning category plugins.json Jul 06 17:23:12 ensuite volumio[992]: info: Scanning category system_controller Jul 06 17:23:12 ensuite volumio[992]: info: Scanning category user_interface Jul 06 17:23:12 ensuite volumio[992]: info: Scanning into folder /data/plugins/ Jul 06 17:23:12 ensuite volumio[992]: info: Plugin folders cleanup completed Jul 06 17:23:12 ensuite volumio[992]: info: ------------------------------------------- Jul 06 17:23:12 ensuite volumio[992]: info: ----- Core plugins startup ---- Jul 06 17:23:12 ensuite volumio[992]: info: ------------------------------------------- Jul 06 17:23:12 ensuite volumio[992]: info: Loading plugins from folder /volumio/app/plugins/ Jul 06 17:23:12 ensuite volumio[992]: info: Adding plugin upnp to MyMusic Plugins Jul 06 17:23:12 ensuite volumio[992]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 06 17:23:12 ensuite volumio[992]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 06 17:23:12 ensuite volumio[992]: info: Loading plugins from folder /data/plugins/ Jul 06 17:23:12 ensuite volumio[992]: info: Loading plugin "system"... Jul 06 17:23:12 ensuite volumio[992]: info: Loading plugin "appearance"... Jul 06 17:23:13 ensuite volumio[992]: info: Loading plugin "network"... Jul 06 17:23:13 ensuite volumio[992]: info: Refreshing Cached IP Addresses Jul 06 17:23:13 ensuite sudo[1056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 06 17:23:13 ensuite sudo[1056]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:13 ensuite sudo[1058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 06 17:23:13 ensuite sudo[1058]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:13 ensuite sudo[1056]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:13 ensuite volumio[992]: info: Loading plugin "services"... Jul 06 17:23:13 ensuite sudo[1058]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:13 ensuite volumio[992]: info: Loading plugin "alsa_controller"... Jul 06 17:23:13 ensuite sudo[1067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 06 17:23:13 ensuite sudo[1067]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:13 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 06 17:23:13 ensuite volumio[992]: info: Loading plugin "wizard"... Jul 06 17:23:13 ensuite volumio[992]: info: Loading plugin "networkfs"... Jul 06 17:23:13 ensuite volumio[992]: info: Starting Udev Watcher for removable devices Jul 06 17:23:14 ensuite volumio-remote-updater[565]: [2025-07-06 17:23:14] [connect] Successful connection Jul 06 17:23:14 ensuite sudo[1084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Administrator,password=Sph3r!cal,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.166/Music /mnt/NAS/Media Jul 06 17:23:14 ensuite sudo[1084]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:14 ensuite volumio[992]: info: Ignoring mount for partition: boot Jul 06 17:23:14 ensuite volumio[992]: info: Ignoring mount for partition: volumio Jul 06 17:23:14 ensuite volumio[992]: info: Ignoring mount for partition: volumio_data Jul 06 17:23:14 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 06 17:23:14 ensuite volumio[992]: info: Loading plugin "volumio_command_line_client"... Jul 06 17:23:14 ensuite volumio[992]: info: Loading plugin "upnp"... Jul 06 17:23:14 ensuite volumio[992]: info: [1751818994051] Starting Upmpd Daemon Jul 06 17:23:14 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 06 17:23:14 ensuite volumio[992]: info: Loading plugin "my_music"... Jul 06 17:23:14 ensuite volumio[992]: info: Loading plugin "mpd"... Jul 06 17:23:14 ensuite kernel: Key type cifs.spnego registered Jul 06 17:23:14 ensuite kernel: Key type cifs.idmap registered Jul 06 17:23:14 ensuite kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Jul 06 17:23:14 ensuite kernel: CIFS: Attempting to mount //192.168.1.166/Music Jul 06 17:23:14 ensuite sudo[1084]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:14 ensuite volumio[992]: info: Loading plugin "upnp_browser"... Jul 06 17:23:14 ensuite volumio[992]: info: Loading plugin "alarm-clock"... Jul 06 17:23:15 ensuite volumio[992]: info: Loading plugin "airplay_emulation"... Jul 06 17:23:15 ensuite volumio[992]: info: Starting Shairport Sync Jul 06 17:23:15 ensuite volumio[992]: info: Loading plugin "last_100"... Jul 06 17:23:15 ensuite volumio[992]: info: Loading plugin "webradio"... Jul 06 17:23:15 ensuite volumio[992]: info: Loading plugin "i2s_dacs"... Jul 06 17:23:15 ensuite volumio[992]: info: Loading plugin "volumiodiscovery"... Jul 06 17:23:15 ensuite volumio[992]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 06 17:23:15 ensuite volumio[992]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 06 17:23:15 ensuite node[992]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 06 17:23:15 ensuite volumio[992]: *** WARNING *** For more information see Jul 06 17:23:15 ensuite volumio[992]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 06 17:23:15 ensuite volumio[992]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 06 17:23:15 ensuite volumio[992]: *** WARNING *** For more information see Jul 06 17:23:15 ensuite node[992]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 06 17:23:15 ensuite node[992]: *** WARNING *** For more information see Jul 06 17:23:15 ensuite node[992]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 06 17:23:15 ensuite node[992]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 06 17:23:15 ensuite node[992]: *** WARNING *** For more information see Jul 06 17:23:15 ensuite volumio[992]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 06 17:23:15 ensuite volumio[992]: info: Discovery: Started advertising with name: Ensuite Jul 06 17:23:15 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 06 17:23:15 ensuite volumio[992]: info: Loading plugin "outputs"... Jul 06 17:23:15 ensuite volumio[992]: info: Loading plugin "albumart"... Jul 06 17:23:15 ensuite volumio[992]: info: Plugin example_plugin is not enabled Jul 06 17:23:15 ensuite volumio[992]: info: Loading plugin "inputs"... Jul 06 17:23:15 ensuite volumio[992]: info: Loading plugin "updater_comm"... Jul 06 17:23:15 ensuite volumio[992]: info: Plugin mpdemulation is not enabled Jul 06 17:23:15 ensuite volumio[992]: info: Loading plugin "rest_api"... Jul 06 17:23:15 ensuite volumio[992]: info: Loading plugin "websocket"... Jul 06 17:23:15 ensuite volumio[992]: info: Starting Socket.io Server version 2.3.0 Jul 06 17:23:15 ensuite volumio[992]: info: Loading i18n strings for locale en Jul 06 17:23:15 ensuite volumio[992]: Forking 3 albumart workers Jul 06 17:23:15 ensuite volumio[992]: Updating browse sources language Jul 06 17:23:15 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 06 17:23:16 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 06 17:23:16 ensuite volumio[992]: info: CoreCommandRouter::initPlayerControls Jul 06 17:23:16 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:16 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:16 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 06 17:23:16 ensuite volumio[992]: Express server listening on port 3000 Jul 06 17:23:16 ensuite volumio[992]: [Metrics] WebUI: 6s 91.55ms Jul 06 17:23:16 ensuite volumio[992]: info: CoreStateMachine::resetVolumioState Jul 06 17:23:16 ensuite volumio[992]: info: CoreStateMachine::getcurrentVolume Jul 06 17:23:16 ensuite volumio[992]: info: CoreCommandRouter::volumioRetrievevolume Jul 06 17:23:16 ensuite volumio[992]: info: Volumio Network Manager: Network status updated: 1 Jul 06 17:23:16 ensuite volumio-remote-updater[565]: [2025-07-06 17:23:16] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751818994 101 Jul 06 17:23:16 ensuite volumio[992]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Jul 06 17:23:16 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 06 17:23:16 ensuite volumio[992]: info: Executing start script for DAC IQaudIO Pi-DigiAMP+ Jul 06 17:23:16 ensuite volumio[992]: info: Reloading queue from file Jul 06 17:23:16 ensuite volumio[992]: info: Setting Device type: Raspberry PI Jul 06 17:23:16 ensuite volumio[992]: info: CoreStateMachine::setRepeat null single undefined Jul 06 17:23:16 ensuite volumio[992]: info: CoreStateMachine::pushState Jul 06 17:23:16 ensuite volumio[992]: info: CorePlayQueue::getTrack 0 Jul 06 17:23:16 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 17:23:16 ensuite volumio[992]: info: CoreCommandRouter::volumioPushState Jul 06 17:23:16 ensuite volumio[992]: info: CoreStateMachine::setRandom null Jul 06 17:23:16 ensuite volumio[992]: info: CoreStateMachine::pushState Jul 06 17:23:16 ensuite volumio[992]: info: CorePlayQueue::getTrack 0 Jul 06 17:23:16 ensuite volumio[992]: info: CoreCommandRouter::volumioPushState Jul 06 17:23:16 ensuite volumio[992]: info: VolumeController:: Volume=100 Mute =false Jul 06 17:23:16 ensuite volumio[992]: info: CoreStateMachine::pushState Jul 06 17:23:16 ensuite volumio[992]: info: CorePlayQueue::getTrack 0 Jul 06 17:23:16 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 17:23:16 ensuite volumio[992]: info: CoreCommandRouter::volumioPushState Jul 06 17:23:16 ensuite volumio[992]: info: CoreStateMachine::updateTrackBlock Jul 06 17:23:16 ensuite volumio[992]: info: CorePlayQueue::getTrackBlock Jul 06 17:23:16 ensuite volumio[992]: info: CoreCommandRouter::volumioRetrievevolume Jul 06 17:23:16 ensuite volumio[992]: info: DAC script executed Jul 06 17:23:16 ensuite volumio[992]: info: Completed loading Core Plugins Jul 06 17:23:16 ensuite volumio[992]: info: Preparing to generate the ALSA configuration file Jul 06 17:23:16 ensuite volumio[992]: Starting albumart workers Jul 06 17:23:16 ensuite volumio[992]: info: Discovery: adding f0f68dbd-77ce-43a5-8443-a97e6c1ae853 Jul 06 17:23:16 ensuite volumio[992]: info: Discovery: Found device Ensuite Jul 06 17:23:16 ensuite volumio[992]: info: CoreCommandRouter::volumioGetState Jul 06 17:23:16 ensuite volumio[992]: info: CorePlayQueue::getTrack 0 Jul 06 17:23:16 ensuite volumio[992]: info: Asound.conf file unchanged, so no further update is needed Jul 06 17:23:16 ensuite volumio[992]: info: Output device has changed, restarting MPD Jul 06 17:23:16 ensuite volumio[992]: Starting albumart workers Jul 06 17:23:16 ensuite volumio[992]: info: Output device has changed, restarting Shairport Sync Jul 06 17:23:16 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:16 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 06 17:23:16 ensuite sudo[1161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 06 17:23:16 ensuite sudo[1161]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:16 ensuite sudo[1161]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:16 ensuite volumio[992]: Starting albumart workers Jul 06 17:23:16 ensuite sudo[1163]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 06 17:23:16 ensuite sudo[1163]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:17 ensuite volumio[992]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 06 17:23:17 ensuite volumio[992]: info: ___________ START PLUGINS ___________ Jul 06 17:23:17 ensuite systemd[1]: Stopping Music Player Daemon... Jul 06 17:23:17 ensuite volumio[992]: info: ControllerMpd::onStart: Initializing MPD Jul 06 17:23:17 ensuite volumio[992]: info: Creating MPD Configuration file Jul 06 17:23:17 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 06 17:23:17 ensuite volumio[992]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 06 17:23:17 ensuite sudo[1170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 06 17:23:17 ensuite sudo[1170]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:17 ensuite volumio[992]: info: [1751818997129] CoreMusicLibrary::Adding element Media Servers Jul 06 17:23:17 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 06 17:23:17 ensuite sudo[1172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 06 17:23:17 ensuite sudo[1172]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:17 ensuite sudo[1170]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:17 ensuite systemd[1]: mpd.service: Succeeded. Jul 06 17:23:17 ensuite systemd[1]: Stopped Music Player Daemon. Jul 06 17:23:17 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:17 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 06 17:23:17 ensuite systemd[1]: Starting Music Player Daemon... Jul 06 17:23:17 ensuite systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jul 06 17:23:17 ensuite systemd[1]: mpd.service: Succeeded. Jul 06 17:23:17 ensuite systemd[1]: Stopped Music Player Daemon. Jul 06 17:23:17 ensuite systemd[1]: Starting Music Player Daemon... Jul 06 17:23:17 ensuite volumio[992]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 06 17:23:17 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:17 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 06 17:23:17 ensuite sudo[1176]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 06 17:23:17 ensuite sudo[1176]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:17 ensuite sudo[1176]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:17 ensuite volumio[992]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 06 17:23:17 ensuite volumio[992]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 06 17:23:17 ensuite volumio[992]: info: [1751818997441] CoreMusicLibrary::Adding element Last_100 Jul 06 17:23:17 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 06 17:23:17 ensuite volumio[992]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 06 17:23:17 ensuite volumio[992]: info: [1751818997446] CoreMusicLibrary::Adding element Webradio Jul 06 17:23:17 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 06 17:23:17 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 06 17:23:17 ensuite volumio[992]: info: Initializing BBC Radios Jul 06 17:23:17 ensuite sudo[1067]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:17 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 06 17:23:17 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 06 17:23:17 ensuite volumio[992]: info: Volumio Calling Home Jul 06 17:23:17 ensuite volumio[992]: info: Discovery: this is already registered, f0f68dbd-77ce-43a5-8443-a97e6c1ae853 Jul 06 17:23:18 ensuite volumio[992]: info: Discovery: Found device Ensuite Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::volumioGetState Jul 06 17:23:18 ensuite volumio[992]: info: CorePlayQueue::getTrack 0 Jul 06 17:23:18 ensuite volumio[992]: info: Discovery: adding f3015b1e-3b99-4c9e-a2fe-6887082c38ba Jul 06 17:23:18 ensuite volumio[992]: info: Discovery: Found device Bathroom Jul 06 17:23:18 ensuite volumio[992]: info: Discovery: Connecting to remote: 192.168.1.172 Jul 06 17:23:18 ensuite volumio[992]: info: MPD Permissions set Jul 06 17:23:18 ensuite volumio[992]: info: MPD Permissions set Jul 06 17:23:18 ensuite volumio[992]: info: VolumeController:: Volume=100 Mute =false Jul 06 17:23:18 ensuite volumio[992]: info: CoreStateMachine::pushState Jul 06 17:23:18 ensuite volumio[992]: info: CorePlayQueue::getTrack 0 Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::volumioPushState Jul 06 17:23:18 ensuite volumio[992]: info: Discovery: adding 934a93b3-6530-4c52-9391-f55af6030b17 Jul 06 17:23:18 ensuite volumio[992]: info: Discovery: Found device Master-Bedroom Jul 06 17:23:18 ensuite volumio[992]: info: Discovery: Connecting to remote: 192.168.1.217 Jul 06 17:23:18 ensuite volumio[992]: verbose: New Socket.io Connection to 192.168.1.218:3000 from 192.168.1.217 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jul 06 17:23:18 ensuite volumio[992]: info: Volumio called home Jul 06 17:23:18 ensuite volumio[992]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 06 17:23:18 ensuite volumio[992]: info: Discovery: adding 2b04395b-6da0-45ee-8ca9-3dc2714ed0ee Jul 06 17:23:18 ensuite volumio[992]: info: Discovery: Found device Dressing-room Jul 06 17:23:18 ensuite volumio[992]: info: Discovery: Connecting to remote: 192.168.1.223 Jul 06 17:23:18 ensuite volumio[992]: verbose: New Socket.io Connection to 192.168.1.218:3000 from 192.168.1.172 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jul 06 17:23:18 ensuite volumio[992]: info: Discovery: Connected to remote: 192.168.1.172 Jul 06 17:23:18 ensuite volumio[992]: info: Discovery: Connected to remote: 192.168.1.217 Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jul 06 17:23:18 ensuite volumio[992]: info: Starting Shairport Sync Jul 06 17:23:18 ensuite volumio[992]: info: Starting Shairport Sync Jul 06 17:23:18 ensuite volumio[992]: info: Starting Shairport Sync Jul 06 17:23:18 ensuite sudo[1231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 06 17:23:18 ensuite sudo[1231]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:18 ensuite sudo[1233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 06 17:23:18 ensuite sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::volumioGetState Jul 06 17:23:18 ensuite volumio[992]: info: CorePlayQueue::getTrack 0 Jul 06 17:23:18 ensuite sudo[1236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 06 17:23:18 ensuite sudo[1236]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:18 ensuite systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 06 17:23:18 ensuite systemd[1]: shairport-sync.service: Succeeded. Jul 06 17:23:18 ensuite systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jul 06 17:23:18 ensuite systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 06 17:23:18 ensuite sudo[1233]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:18 ensuite sudo[1231]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:18 ensuite sudo[1236]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:18 ensuite volumio[992]: info: Shairport-Sync Started Jul 06 17:23:18 ensuite volumio[992]: Error adding Membership: Error: addMembership EINVAL Jul 06 17:23:18 ensuite volumio[992]: info: Shairport-Sync Started Jul 06 17:23:18 ensuite volumio[992]: info: Shairport-Sync Started Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::volumioGetState Jul 06 17:23:18 ensuite volumio[992]: info: CorePlayQueue::getTrack 0 Jul 06 17:23:18 ensuite volumio[992]: info: CoreCommandRouter::volumioGetState Jul 06 17:23:18 ensuite volumio[992]: info: CorePlayQueue::getTrack 0 Jul 06 17:23:18 ensuite volumio[992]: verbose: New Socket.io Connection to 192.168.1.218:3000 from 192.168.1.223 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jul 06 17:23:18 ensuite volumio[992]: info: Discovery: Connected to remote: 192.168.1.223 Jul 06 17:23:19 ensuite mpd[1184]: Jul 06 17:23 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 06 17:23:19 ensuite systemd[1]: Started Music Player Daemon. Jul 06 17:23:19 ensuite sudo[1163]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:19 ensuite sudo[1172]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:19 ensuite volumio[992]: info: Completed starting Core Plugins Jul 06 17:23:19 ensuite volumio[992]: info: ------------------------------------------- Jul 06 17:23:19 ensuite volumio[992]: info: ----- MyVolumio plugins startup ---- Jul 06 17:23:19 ensuite volumio[992]: info: ------------------------------------------- Jul 06 17:23:19 ensuite volumio[992]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 06 17:23:19 ensuite volumio[992]: info: MPD running with PID1184 Jul 06 17:23:19 ensuite volumio[992]: ,establishing connection Jul 06 17:23:19 ensuite volumio[992]: error: MPD error: The expression evaluated to a falsy value: Jul 06 17:23:19 ensuite volumio[992]: assert.ok(self.idling) Jul 06 17:23:19 ensuite volumio[992]: error: The expression evaluated to a falsy value: Jul 06 17:23:19 ensuite volumio[992]: assert.ok(self.idling) Jul 06 17:23:19 ensuite volumio[992]: error: MPD error: The expression evaluated to a falsy value: Jul 06 17:23:19 ensuite volumio[992]: assert.ok(self.idling) Jul 06 17:23:19 ensuite volumio[992]: error: The expression evaluated to a falsy value: Jul 06 17:23:19 ensuite volumio[992]: assert.ok(self.idling) Jul 06 17:23:19 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jul 06 17:23:19 ensuite volumio[992]: error: updateQueue error: null Jul 06 17:23:19 ensuite volumio[992]: info: CoreCommandRouter::volumioGetState Jul 06 17:23:19 ensuite volumio[992]: info: CorePlayQueue::getTrack 0 Jul 06 17:23:24 ensuite sudo[1262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 06 17:23:24 ensuite sudo[1262]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:24 ensuite sudo[1262]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:24 ensuite sudo[1264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 06 17:23:24 ensuite sudo[1264]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:24 ensuite sudo[1264]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:24 ensuite sudo[1268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 06 17:23:24 ensuite sudo[1268]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:24 ensuite systemd[1]: Started UPnP Renderer front-end to MPD. Jul 06 17:23:24 ensuite sudo[1268]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:24 ensuite volumio[992]: info: Upmpdcli Daemon Started Jul 06 17:23:24 ensuite volumio[992]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jul 06 17:23:24 ensuite volumio[1270]: Generating RSA private key, 4096 bit long modulus (2 primes) Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jul 06 17:23:27 ensuite volumio[992]: info: Adding plugin bluetooth to MyMusic Plugins Jul 06 17:23:27 ensuite volumio[992]: info: Adding plugin multiroom to MyMusic Plugins Jul 06 17:23:27 ensuite volumio[992]: info: Adding plugin metavolumio to MyMusic Plugins Jul 06 17:23:27 ensuite volumio[992]: info: Adding plugin cd_controller to MyMusic Plugins Jul 06 17:23:27 ensuite volumio[992]: info: Adding plugin qobuzconnect to MyMusic Plugins Jul 06 17:23:27 ensuite volumio[992]: info: Adding plugin smart_inputs to MyMusic Plugins Jul 06 17:23:27 ensuite volumio[992]: info: Adding plugin tidalconnect to MyMusic Plugins Jul 06 17:23:27 ensuite volumio[992]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jul 06 17:23:28 ensuite volumio[992]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jul 06 17:23:28 ensuite volumio[992]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jul 06 17:23:28 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 06 17:23:28 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 06 17:23:28 ensuite volumio[992]: info: Starting MyVolumio Remote Streaming Endpoints Jul 06 17:23:28 ensuite volumio[992]: info: MyVolumio login type: Token Jul 06 17:23:28 ensuite volumio[992]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jul 06 17:23:28 ensuite volumio[992]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jul 06 17:23:29 ensuite systemd[1]: systemd-fsckd.service: Succeeded. Jul 06 17:23:30 ensuite volumio[992]: info: Starting Streaming Service Transparent Proxy Jul 06 17:23:30 ensuite volumio[992]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jul 06 17:23:30 ensuite volumio[992]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jul 06 17:23:30 ensuite volumio[992]: info: Streaming services startup Jul 06 17:23:30 ensuite volumio[992]: info: Starting Streaming Daemon Jul 06 17:23:30 ensuite sudo[1296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 06 17:23:30 ensuite sudo[1296]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:30 ensuite sudo[1296]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:30 ensuite volumio[992]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jul 06 17:23:30 ensuite volumio[992]: error: Cannot start Volumio Streaming Daemon Jul 06 17:23:30 ensuite volumio[992]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 06 17:23:30 ensuite volumio[992]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 06 17:23:31 ensuite volumio[992]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jul 06 17:23:31 ensuite volumio[992]: STREAMING PROXY: Starting server on port 3245 Jul 06 17:23:31 ensuite volumio[992]: Node JS runtime: 14 Jul 06 17:23:31 ensuite volumio[992]: info: MyVolumio token set successfully Jul 06 17:23:31 ensuite volumio[992]: info: MYVOLUMIO: Adding device Jul 06 17:23:31 ensuite volumio[992]: info: MYVOLUMIO: Evaluating Server Jul 06 17:23:31 ensuite volumio[992]: info: MyVolumio status changed Jul 06 17:23:31 ensuite volumio[992]: info: Streaming services startup Jul 06 17:23:31 ensuite volumio[992]: info: Starting Streaming Daemon Jul 06 17:23:32 ensuite volumio[992]: info: Removing browser output: myVolumio user plan is not superstar Jul 06 17:23:32 ensuite volumio[992]: info: Removing audio output: Jul 06 17:23:32 ensuite volumio[992]: info: Stoppping Tunnel 1 Jul 06 17:23:32 ensuite sudo[1321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 06 17:23:32 ensuite sudo[1321]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:32 ensuite sudo[1323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Jul 06 17:23:32 ensuite sudo[1321]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:32 ensuite sudo[1323]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 17:23:32 ensuite sudo[1323]: pam_unix(sudo:session): session closed for user root Jul 06 17:23:32 ensuite volumio[992]: info: Remote SSH Stopped Jul 06 17:23:32 ensuite volumio[992]: error: Cannot start Volumio Streaming Daemon Jul 06 17:23:32 ensuite volumio[992]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 06 17:23:32 ensuite volumio[992]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 06 17:23:32 ensuite volumio[992]: info: Discovery: Disconnected from remote: 192.168.1.217 Jul 06 17:23:32 ensuite systemd[1]: systemd-hostnamed.service: Succeeded. Jul 06 17:23:33 ensuite volumio[992]: info: Discovery: Connecting to remote: 192.168.1.217 Jul 06 17:23:33 ensuite volumio[992]: info: Discovery: Disconnected from remote: 192.168.1.223 Jul 06 17:23:33 ensuite volumio[992]: info: Setting Geolocation for MyVolumio to eu5 Jul 06 17:23:33 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 06 17:23:33 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 06 17:23:33 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 06 17:23:33 ensuite volumio[992]: info: Discovery: A device disappeared from network Jul 06 17:23:33 ensuite volumio[992]: info: Discovery: Device master-bedroom disappeared from network Jul 06 17:23:34 ensuite volumio[992]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jul 06 17:23:34 ensuite volumio[992]: info: Discovery: Connecting to remote: 192.168.1.223 Jul 06 17:23:34 ensuite volumio[992]: info: Discovery: A device disappeared from network Jul 06 17:23:34 ensuite volumio[992]: info: Discovery: Device dressing-room disappeared from network Jul 06 17:23:34 ensuite volumio[992]: info: Updating MyVolumio device info Jul 06 17:23:34 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 06 17:23:34 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 06 17:23:34 ensuite volumio[992]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 06 17:23:35 ensuite volumio[992]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jul 06 17:23:37 ensuite systemd[1]: systemd-timedated.service: Succeeded. Jul 06 17:23:38 ensuite volumio[992]: info: MYVOLUMIO: Adding device Jul 06 17:23:38 ensuite volumio[992]: info: MYVOLUMIO: Evaluating Server Jul 06 17:23:38 ensuite volumio[992]: error: Failed to ping endpoint us1.myvolumio.org : unknown error Jul 06 17:23:38 ensuite volumio[992]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 06 17:23:38 ensuite volumio[992]: Error: Unable to resolve or reject the same promise twice Jul 06 17:23:38 ensuite volumio[992]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jul 06 17:23:38 ensuite volumio[992]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32086) Jul 06 17:23:38 ensuite volumio[992]: at Socket.emit (events.js:327:22) Jul 06 17:23:38 ensuite volumio[992]: at endReadableNT (internal/streams/readable.js:1327:12) Jul 06 17:23:38 ensuite volumio[992]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jul 06 17:23:38 ensuite volumio[992]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 06 17:23:39 ensuite sudo[1373]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-06 17:22 Jul 06 17:23:39 ensuite sudo[1373]: 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="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST" VOLUMIO_VERSION="3.819" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"