-- Logs begin at Sun 2024-10-06 10:15:51 CEST, end at Sun 2024-10-06 10:17:00 CEST. -- Oct 06 10:16:00 volumio systemd[1]: Started Getty on tty1. Oct 06 10:16:00 volumio systemd[1]: Reached target Login Prompts. Oct 06 10:16:00 volumio volumio-remote-updater[647]: Error: No active session Oct 06 10:16:00 volumio volumio-remote-updater[647]: [2024-10-06 10:16:00] [info] asio async_connect error: system:111 (Connection refused) Oct 06 10:16:00 volumio volumio-remote-updater[647]: [2024-10-06 10:16:00] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 06 10:16:00 volumio volumio-remote-updater[647]: [2024-10-06 10:16:00] [error] handle_connect error: Underlying Transport Error Oct 06 10:16:00 volumio ntpd[739]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 06 10:16:00 volumio ntpd[739]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Oct 06 10:16:00 volumio volumio[662]: Could not open config: /tmp/upmpdcli.conf Oct 06 10:16:00 volumio systemd[1]: Started Network Time Service. Oct 06 10:16:00 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 06 10:16:00 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 06 10:16:00 volumio systemd[1]: iptables.service: Succeeded. Oct 06 10:16:00 volumio ntpd[777]: proto: precision = 1.354 usec (-19) Oct 06 10:16:00 volumio ifplugd(eth0)[789]: ifplugd 0.28 initializing. Oct 06 10:16:00 volumio ifplugd(eth0)[789]: Using interface eth0/B8:27:EB:9F:D7:27 with driver (version: 6.1.69-v7+) Oct 06 10:16:00 volumio ifplugd(eth0)[789]: Using detection mode: SIOCETHTOOL Oct 06 10:16:00 volumio ifplugd(eth0)[789]: Initialization complete, link beat detected. Oct 06 10:16:00 volumio ntpd[777]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 06 10:16:00 volumio ntpd[777]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 06 10:16:00 volumio ntpd[777]: Listen and drop on 0 v6wildcard [::]:123 Oct 06 10:16:00 volumio ntpd[777]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 06 10:16:00 volumio ntpd[777]: Listen normally on 2 lo 127.0.0.1:123 Oct 06 10:16:00 volumio ntpd[777]: Listening on routing socket on fd #19 for interface updates Oct 06 10:16:00 volumio ntpd[777]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 06 10:16:00 volumio ntpd[777]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 06 10:16:00 volumio ifplugd(eth0)[789]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Oct 06 10:16:00 volumio bluetoothd[770]: Bluetooth daemon 5.50 Oct 06 10:16:01 volumio ifplugd(eth0)[789]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Oct 06 10:16:01 volumio bluetoothd[770]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Oct 06 10:16:01 volumio systemd[1]: Started Bluetooth service. Oct 06 10:16:01 volumio systemd[1]: Reached target Bluetooth. Oct 06 10:16:01 volumio bluetoothd[770]: Starting SDP server Oct 06 10:16:01 volumio bluetoothd[770]: Excluding (cli) sap Oct 06 10:16:01 volumio loadcpufreq[744]: Loading cpufreq kernel modules...done (none). Oct 06 10:16:01 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Oct 06 10:16:01 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Oct 06 10:16:01 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Oct 06 10:16:01 volumio kernel: Bluetooth: BNEP filters: protocol multicast Oct 06 10:16:01 volumio kernel: Bluetooth: BNEP socket layer initialized Oct 06 10:16:01 volumio bluetoothd[770]: Bluetooth management interface 1.22 initialized Oct 06 10:16:01 volumio kernel: Bluetooth: MGMT ver 1.22 Oct 06 10:16:01 volumio dbus-daemon[667]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=770 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Oct 06 10:16:01 volumio bluetoothd[770]: Failed to set privacy: Rejected (0x0b) Oct 06 10:16:01 volumio ntpd[777]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Oct 06 10:16:01 volumio systemd[1]: systemd-rfkill.service: Succeeded. Oct 06 10:16:01 volumio systemd[1]: Starting Hostname Service... Oct 06 10:16:01 volumio cpufrequtils[821]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Oct 06 10:16:01 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Oct 06 10:16:02 volumio dbus-daemon[667]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 06 10:16:02 volumio systemd[1]: Started Hostname Service. Oct 06 10:16:02 volumio ntpd[777]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Oct 06 10:16:02 volumio nmbd[749]: [2024/10/06 10:16:02.613745, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Oct 06 10:16:02 volumio nmbd[749]: started asyncdns process 842 Oct 06 10:16:02 volumio nmbd[749]: [2024/10/06 10:16:02.620824, 0] ../lib/util/become_daemon.c:149(daemon_status) Oct 06 10:16:02 volumio nmbd[749]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Oct 06 10:16:02 volumio nmbd[749]: [2024/10/06 10:16:02.622179, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Oct 06 10:16:02 volumio nmbd[749]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Oct 06 10:16:03 volumio ntpd[777]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Oct 06 10:16:03 volumio wireless.js[656]: Cleaning previous... Oct 06 10:16:03 volumio sudo[850]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Oct 06 10:16:03 volumio sudo[850]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:03 volumio sudo[850]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:03 volumio sudo[852]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Oct 06 10:16:03 volumio sudo[852]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:04 volumio sh[550]: eth0: leased 192.168.1.239 for 86400 seconds Oct 06 10:16:04 volumio dhcpcd[602]: eth0: leased 192.168.1.239 for 86400 seconds Oct 06 10:16:04 volumio ntpd[777]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Oct 06 10:16:04 volumio avahi-daemon[657]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.239. Oct 06 10:16:04 volumio sh[550]: eth0: adding route to 192.168.1.0/24 Oct 06 10:16:04 volumio sh[550]: eth0: adding default route via 192.168.1.1 Oct 06 10:16:04 volumio avahi-daemon[657]: New relevant interface eth0.IPv4 for mDNS. Oct 06 10:16:04 volumio avahi-daemon[657]: Registering new address record for 192.168.1.239 on eth0.IPv4. Oct 06 10:16:04 volumio dhcpcd[602]: eth0: adding route to 192.168.1.0/24 Oct 06 10:16:04 volumio dhcpcd[602]: eth0: adding default route via 192.168.1.1 Oct 06 10:16:04 volumio sudo[852]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:04 volumio sh[550]: forked to background, child pid 879 Oct 06 10:16:04 volumio dhcpcd[602]: forked to background, child pid 879 Oct 06 10:16:04 volumio wireless.js[656]: Stopped aP Oct 06 10:16:04 volumio sudo[887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Oct 06 10:16:04 volumio sudo[887]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:04 volumio sudo[887]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:04 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Oct 06 10:16:04 volumio sudo[901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Oct 06 10:16:04 volumio sudo[901]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:04 volumio sudo[901]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:04 volumio ifplugd(eth0)[789]: client: ifup: interface eth0 already configured Oct 06 10:16:04 volumio sudo[911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Oct 06 10:16:04 volumio sudo[911]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:04 volumio sh[550]: eth0=eth0 Oct 06 10:16:04 volumio sudo[911]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:04 volumio sudo[917]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Oct 06 10:16:04 volumio sudo[917]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:04 volumio ifplugd(eth0)[789]: Program executed successfully. Oct 06 10:16:04 volumio ifplugd[747]: Network Interface Plugging Daemon...start eth0...done. Oct 06 10:16:04 volumio systemd[1]: Started LSB: Brings up/down network automatically. Oct 06 10:16:04 volumio bthelper[743]: Changing power off succeeded Oct 06 10:16:05 volumio bthelper[743]: [CHG] Controller B8:27:EB:35:7D:8D Class: 0x0000041c Oct 06 10:16:05 volumio bthelper[743]: Changing power on succeeded Oct 06 10:16:05 volumio volumio-remote-updater[647]: [2024-10-06 10:16:05] [info] asio async_connect error: system:111 (Connection refused) Oct 06 10:16:05 volumio volumio-remote-updater[647]: [2024-10-06 10:16:05] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 06 10:16:05 volumio volumio-remote-updater[647]: [2024-10-06 10:16:05] [error] handle_connect error: Underlying Transport Error Oct 06 10:16:05 volumio sudo[917]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:05 volumio wireless.js[656]: SETTING APPROPRIATE REG DOMAIN: IT Oct 06 10:16:05 volumio sudo[928]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Oct 06 10:16:05 volumio sudo[928]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:05 volumio sudo[928]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:05 volumio sudo[930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set IT Oct 06 10:16:05 volumio sudo[930]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:05 volumio sudo[930]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:05 volumio wireless.js[656]: SUCCESSFULLY SET NEW REGDOMAIN: IT Oct 06 10:16:05 volumio sudo[937]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Oct 06 10:16:05 volumio sudo[937]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:05 volumio sudo[937]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:05 volumio sudo[939]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Oct 06 10:16:05 volumio sudo[939]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:06 volumio sudo[939]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:06 volumio avahi-daemon[657]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Oct 06 10:16:06 volumio avahi-daemon[657]: New relevant interface wlan0.IPv4 for mDNS. Oct 06 10:16:06 volumio avahi-daemon[657]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Oct 06 10:16:06 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Oct 06 10:16:06 volumio systemd[1]: Starting dnsmasq - A lightweight DHCP and caching DNS server... Oct 06 10:16:06 volumio systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Oct 06 10:16:06 volumio dnsmasq[945]: dnsmasq: syntax check OK. Oct 06 10:16:06 volumio hostapd[946]: Configuration file: /etc/hostapd/hostapd.conf Oct 06 10:16:06 volumio hostapd[946]: wlan0: Could not connect to kernel driver Oct 06 10:16:06 volumio hostapd[946]: Using interface wlan0 with hwaddr b8:27:eb:ca:82:72 and ssid "Volumio-5D626" Oct 06 10:16:06 volumio dnsmasq[952]: started, version 2.80 cachesize 150 Oct 06 10:16:06 volumio dnsmasq[952]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect inotify dumpfile Oct 06 10:16:06 volumio dnsmasq-dhcp[952]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Oct 06 10:16:06 volumio dnsmasq[952]: reading /etc/resolv.conf Oct 06 10:16:06 volumio dnsmasq[952]: using nameserver 192.168.1.1#53 Oct 06 10:16:06 volumio dnsmasq[952]: using nameserver 208.67.222.222#53 Oct 06 10:16:06 volumio dnsmasq[952]: using nameserver 208.67.220.220#53 Oct 06 10:16:06 volumio dnsmasq[952]: read /etc/hosts - 5 addresses Oct 06 10:16:06 volumio hostapd[946]: wlan0: interface state UNINITIALIZED->ENABLED Oct 06 10:16:06 volumio hostapd[946]: wlan0: AP-ENABLED Oct 06 10:16:06 volumio systemd[1]: Started Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Oct 06 10:16:06 volumio systemd[1]: Started dnsmasq - A lightweight DHCP and caching DNS server. Oct 06 10:16:06 volumio iwconfig[960]: Error for wireless request "Set Power Management" (8B2C) : Oct 06 10:16:06 volumio iwconfig[960]: SET failed on device wlan0 ; Invalid argument. Oct 06 10:16:06 volumio systemd[1]: wireless.service: Succeeded. Oct 06 10:16:06 volumio systemd[1]: Started Wireless Services. Oct 06 10:16:06 volumio systemd[1]: Started Volumio Backend Module. Oct 06 10:16:06 volumio systemd[1]: Started Volumio Cpu Tweaker. Oct 06 10:16:06 volumio systemd[1]: Reached target Host and Network Name Lookups. Oct 06 10:16:07 volumio volumio-cpu-tweak[962]: Setting RT Priority for mpd Oct 06 10:16:07 volumio volumio-cpu-tweak[962]: pid 35's current scheduling policy: SCHED_OTHER Oct 06 10:16:07 volumio volumio-cpu-tweak[962]: pid 35's current scheduling priority: 0 Oct 06 10:16:07 volumio volumio-cpu-tweak[962]: Setting MPD Affinity Oct 06 10:16:07 volumio volumio-cpu-tweak[962]: pid 3's current affinity mask: f Oct 06 10:16:07 volumio volumio-cpu-tweak[962]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Oct 06 10:16:07 volumio volumio-cpu-tweak[962]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Oct 06 10:16:07 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Oct 06 10:16:07 volumio nmbd[749]: [2024/10/06 10:16:07.632815, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 06 10:16:07 volumio nmbd[749]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Oct 06 10:16:07 volumio systemd[1]: Started Samba NMB Daemon. Oct 06 10:16:07 volumio systemd[1]: Starting Samba Winbind Daemon... Oct 06 10:16:08 volumio ntpd[777]: Listen normally on 3 eth0 192.168.1.239:123 Oct 06 10:16:08 volumio ntpd[777]: Listen normally on 4 wlan0 192.168.211.1:123 Oct 06 10:16:08 volumio ntpd[777]: new interface(s) found: waking up resolver Oct 06 10:16:08 volumio winbindd[978]: [2024/10/06 10:16:08.432265, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Oct 06 10:16:08 volumio winbindd[978]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Oct 06 10:16:08 volumio winbindd[978]: [2024/10/06 10:16:08.527567, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 06 10:16:08 volumio winbindd[978]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Oct 06 10:16:08 volumio systemd[1]: Started Samba Winbind Daemon. Oct 06 10:16:08 volumio systemd[1]: Starting Samba SMB Daemon... Oct 06 10:16:09 volumio systemd[1]: Started Samba SMB Daemon. Oct 06 10:16:09 volumio systemd[1]: Reached target Multi-User System. Oct 06 10:16:09 volumio smbd[983]: [2024/10/06 10:16:09.725096, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 06 10:16:09 volumio systemd[1]: Reached target Graphical Interface. Oct 06 10:16:09 volumio smbd[983]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Oct 06 10:16:09 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 06 10:16:09 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Oct 06 10:16:09 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 06 10:16:09 volumio systemd[1]: Startup finished in 17.519s (kernel) + 21.219s (userspace) = 38.738s. Oct 06 10:16:12 volumio volumio-remote-updater[647]: [2024-10-06 10:16:12] [connect] Successful connection Oct 06 10:16:12 volumio volumio[961]: info: ------------------------------------------- Oct 06 10:16:12 volumio volumio[961]: info: ----- Volumio3 ---- Oct 06 10:16:12 volumio volumio[961]: info: ------------------------------------------- Oct 06 10:16:12 volumio volumio[961]: info: ----- System startup ---- Oct 06 10:16:12 volumio volumio[961]: info: ------------------------------------------- Oct 06 10:16:15 volumio volumio[961]: info: MYVOLUMIO Environment detected Oct 06 10:16:15 volumio volumio[961]: info: Plugin folders cleanup Oct 06 10:16:15 volumio volumio[961]: info: Scanning into folder /volumio/app/plugins/ Oct 06 10:16:15 volumio volumio[961]: info: Scanning category audio_interface Oct 06 10:16:15 volumio volumio[961]: info: Scanning category miscellanea Oct 06 10:16:15 volumio volumio[961]: info: Scanning category music_service Oct 06 10:16:15 volumio volumio[961]: info: Scanning category plugins.json Oct 06 10:16:15 volumio volumio[961]: info: Scanning category system_controller Oct 06 10:16:15 volumio volumio[961]: info: Scanning category user_interface Oct 06 10:16:15 volumio volumio[961]: info: Scanning into folder /data/plugins/ Oct 06 10:16:15 volumio volumio[961]: info: Plugin folders cleanup completed Oct 06 10:16:15 volumio volumio[961]: info: ------------------------------------------- Oct 06 10:16:15 volumio volumio[961]: info: ----- Core plugins startup ---- Oct 06 10:16:15 volumio volumio[961]: info: ------------------------------------------- Oct 06 10:16:15 volumio volumio[961]: info: Loading plugins from folder /volumio/app/plugins/ Oct 06 10:16:15 volumio volumio[961]: info: Adding plugin upnp to MyMusic Plugins Oct 06 10:16:15 volumio volumio[961]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 06 10:16:15 volumio volumio[961]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 06 10:16:15 volumio volumio[961]: info: Loading plugins from folder /data/plugins/ Oct 06 10:16:15 volumio volumio[961]: info: Loading plugin "system"... Oct 06 10:16:15 volumio volumio[961]: info: Loading plugin "appearance"... Oct 06 10:16:18 volumio volumio[961]: info: Loading plugin "network"... Oct 06 10:16:18 volumio volumio[961]: info: Refreshing Cached IP Addresses Oct 06 10:16:18 volumio sudo[1006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 06 10:16:18 volumio sudo[1006]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:18 volumio volumio[961]: info: Loading plugin "services"... Oct 06 10:16:18 volumio sudo[1006]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:18 volumio sudo[1008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 06 10:16:18 volumio sudo[1008]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:18 volumio volumio[961]: info: Loading plugin "alsa_controller"... Oct 06 10:16:18 volumio sudo[1008]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:18 volumio sudo[1011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 06 10:16:18 volumio sudo[1011]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:18 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 06 10:16:18 volumio volumio[961]: info: Loading plugin "wizard"... Oct 06 10:16:18 volumio volumio[961]: info: Loading plugin "networkfs"... Oct 06 10:16:18 volumio volumio[961]: info: Starting Udev Watcher for removable devices Oct 06 10:16:18 volumio volumio[961]: info: Ignoring mount for partition: boot Oct 06 10:16:18 volumio volumio[961]: info: Ignoring mount for partition: volumio Oct 06 10:16:18 volumio volumio[961]: info: Ignoring mount for partition: volumio_data Oct 06 10:16:18 volumio volumio[961]: info: Mounting Device PENNA_USB Oct 06 10:16:18 volumio sudo[1022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/PENNA_USB -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 06 10:16:18 volumio sudo[1022]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:19 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Oct 06 10:16:19 volumio kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Oct 06 10:16:19 volumio sudo[1022]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:19 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 06 10:16:19 volumio volumio[961]: info: Loading plugin "volumio_command_line_client"... Oct 06 10:16:19 volumio volumio[961]: info: Loading plugin "upnp"... Oct 06 10:16:19 volumio volumio[961]: info: [1728202579200] Starting Upmpd Daemon Oct 06 10:16:19 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 06 10:16:19 volumio volumio[961]: info: Loading plugin "my_music"... Oct 06 10:16:19 volumio volumio[961]: info: Loading plugin "mpd"... Oct 06 10:16:19 volumio sudo[1011]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:20 volumio volumio[961]: info: Loading plugin "upnp_browser"... Oct 06 10:16:20 volumio volumio[961]: info: Loading plugin "alarm-clock"... Oct 06 10:16:21 volumio volumio[961]: info: Loading plugin "airplay_emulation"... Oct 06 10:16:21 volumio volumio[961]: info: Starting Shairport Sync Oct 06 10:16:21 volumio volumio[961]: info: Loading plugin "last_100"... Oct 06 10:16:21 volumio volumio[961]: info: Loading plugin "webradio"... Oct 06 10:16:21 volumio volumio[961]: info: Loading plugin "i2s_dacs"... Oct 06 10:16:21 volumio volumio[961]: info: Loading plugin "volumiodiscovery"... Oct 06 10:16:21 volumio volumio[961]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 06 10:16:21 volumio volumio[961]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 06 10:16:21 volumio volumio[961]: *** WARNING *** For more information see Oct 06 10:16:21 volumio volumio[961]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 06 10:16:21 volumio node[961]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 06 10:16:21 volumio volumio[961]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 06 10:16:21 volumio volumio[961]: *** WARNING *** For more information see Oct 06 10:16:21 volumio node[961]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 06 10:16:21 volumio node[961]: *** WARNING *** For more information see Oct 06 10:16:21 volumio node[961]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 06 10:16:21 volumio node[961]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 06 10:16:21 volumio node[961]: *** WARNING *** For more information see Oct 06 10:16:21 volumio volumio[961]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 06 10:16:21 volumio volumio[961]: info: Discovery: Started advertising with name: Volumio Oct 06 10:16:21 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 06 10:16:21 volumio volumio[961]: info: Loading plugin "outputs"... Oct 06 10:16:21 volumio volumio[961]: info: Loading plugin "albumart"... Oct 06 10:16:22 volumio volumio[961]: info: Plugin example_plugin is not enabled Oct 06 10:16:22 volumio volumio[961]: info: Loading plugin "inputs"... Oct 06 10:16:22 volumio volumio[961]: info: Loading plugin "updater_comm"... Oct 06 10:16:22 volumio volumio[961]: info: Plugin mpdemulation is not enabled Oct 06 10:16:22 volumio volumio[961]: info: Loading plugin "rest_api"... Oct 06 10:16:22 volumio volumio[961]: info: Loading plugin "websocket"... Oct 06 10:16:22 volumio volumio[961]: info: Starting Socket.io Server version 2.3.0 Oct 06 10:16:22 volumio volumio[961]: info: Loading i18n strings for locale it Oct 06 10:16:22 volumio volumio[961]: Updating browse sources language Oct 06 10:16:22 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 10:16:22 volumio volumio[961]: Forking 3 albumart workers Oct 06 10:16:23 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 10:16:23 volumio volumio[961]: info: CoreCommandRouter::initPlayerControls Oct 06 10:16:23 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:23 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:23 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:23 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:23 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:23 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:23 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:23 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:23 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 10:16:23 volumio volumio[961]: Express server listening on port 3000 Oct 06 10:16:23 volumio volumio[961]: [Metrics] WebUI: 12s 362.29ms Oct 06 10:16:23 volumio volumio[961]: info: CoreStateMachine::resetVolumioState Oct 06 10:16:23 volumio volumio[961]: info: CoreStateMachine::getcurrentVolume Oct 06 10:16:23 volumio volumio[961]: info: CoreCommandRouter::volumioRetrievevolume Oct 06 10:16:24 volumio volumio[961]: info: Reloading queue from file Oct 06 10:16:24 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 10:16:24 volumio volumio[961]: info: CoreStateMachine::setRepeat null single undefined Oct 06 10:16:24 volumio volumio[961]: info: CoreStateMachine::pushState Oct 06 10:16:24 volumio volumio[961]: info: CorePlayQueue::getTrack 0 Oct 06 10:16:24 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 10:16:24 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Oct 06 10:16:24 volumio volumio[961]: info: CoreStateMachine::setRandom null Oct 06 10:16:24 volumio volumio[961]: info: CoreStateMachine::pushState Oct 06 10:16:24 volumio volumio[961]: info: CorePlayQueue::getTrack 0 Oct 06 10:16:24 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Oct 06 10:16:24 volumio volumio[961]: info: Setting Device type: Raspberry PI Oct 06 10:16:24 volumio volumio[961]: info: VolumeController:: Volume=86 Mute =false Oct 06 10:16:24 volumio volumio[961]: info: CoreStateMachine::pushState Oct 06 10:16:24 volumio volumio[961]: info: CorePlayQueue::getTrack 0 Oct 06 10:16:24 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 10:16:24 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Oct 06 10:16:24 volumio volumio[961]: info: CoreStateMachine::updateTrackBlock Oct 06 10:16:24 volumio volumio[961]: info: CorePlayQueue::getTrackBlock Oct 06 10:16:24 volumio volumio[961]: info: CoreCommandRouter::volumioRetrievevolume Oct 06 10:16:24 volumio volumio[961]: info: Completed loading Core Plugins Oct 06 10:16:24 volumio volumio[961]: info: Preparing to generate the ALSA configuration file Oct 06 10:16:24 volumio volumio[961]: info: Asound.conf file unchanged, so no further update is needed Oct 06 10:16:24 volumio volumio[961]: info: Output device has changed, restarting MPD Oct 06 10:16:24 volumio volumio[961]: info: Output device has changed, restarting Shairport Sync Oct 06 10:16:24 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:24 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 10:16:24 volumio sudo[1070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 06 10:16:24 volumio sudo[1070]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:24 volumio systemd[1]: systemd-fsckd.service: Succeeded. Oct 06 10:16:24 volumio sudo[1070]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:24 volumio sudo[1072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 06 10:16:24 volumio sudo[1072]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:24 volumio volumio[961]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 06 10:16:24 volumio volumio[961]: info: ___________ START PLUGINS ___________ Oct 06 10:16:24 volumio volumio[961]: info: ControllerMpd::onStart: Initializing MPD Oct 06 10:16:24 volumio volumio[961]: Starting albumart workers Oct 06 10:16:24 volumio volumio[961]: info: Creating MPD Configuration file Oct 06 10:16:24 volumio volumio[961]: Starting albumart workers Oct 06 10:16:24 volumio systemd[1]: Listening on mpd.socket. Oct 06 10:16:24 volumio systemd[1]: Starting Music Player Daemon... Oct 06 10:16:24 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 10:16:24 volumio volumio[961]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 06 10:16:24 volumio volumio[961]: info: [1728202584820] CoreMusicLibrary::Adding element Server multimediali Oct 06 10:16:24 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 10:16:24 volumio volumio[961]: Starting albumart workers Oct 06 10:16:24 volumio sudo[1080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 06 10:16:24 volumio sudo[1080]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:24 volumio sudo[1080]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:24 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:24 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 10:16:24 volumio sudo[1083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 06 10:16:24 volumio sudo[1083]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:24 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 06 10:16:24 volumio systemd[1]: mpd.service: Succeeded. Oct 06 10:16:24 volumio systemd[1]: Stopped Music Player Daemon. Oct 06 10:16:25 volumio systemd[1]: Starting Music Player Daemon... Oct 06 10:16:25 volumio volumio[961]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 06 10:16:25 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:25 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 10:16:25 volumio volumio[961]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 06 10:16:25 volumio volumio[961]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 06 10:16:25 volumio volumio[961]: info: [1728202585185] CoreMusicLibrary::Adding element Last_100 Oct 06 10:16:25 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 10:16:25 volumio volumio[961]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 06 10:16:25 volumio volumio[961]: info: [1728202585192] CoreMusicLibrary::Adding element Webradio Oct 06 10:16:25 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 10:16:25 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 06 10:16:25 volumio volumio[961]: info: Initializing BBC Radios Oct 06 10:16:25 volumio sudo[1089]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 06 10:16:25 volumio sudo[1089]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:25 volumio sudo[1089]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 06 10:16:25 volumio sudo[1089]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:25 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 06 10:16:25 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 10:16:25 volumio volumio[961]: info: Volumio Calling Home Oct 06 10:16:25 volumio volumio[961]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Oct 06 10:16:25 volumio volumio[961]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Oct 06 10:16:26 volumio volumio[961]: info: MPD Permissions set Oct 06 10:16:26 volumio volumio[961]: info: MPD Permissions set Oct 06 10:16:26 volumio volumio[961]: info: VolumeController:: Volume=86 Mute =false Oct 06 10:16:26 volumio volumio[961]: info: CoreStateMachine::pushState Oct 06 10:16:26 volumio volumio[961]: info: CorePlayQueue::getTrack 0 Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::volumioPushState Oct 06 10:16:26 volumio volumio[961]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 10:16:26 volumio volumio[961]: info: Volumio called home Oct 06 10:16:26 volumio volumio[961]: info: Starting Shairport Sync Oct 06 10:16:26 volumio volumio[961]: info: Starting Shairport Sync Oct 06 10:16:26 volumio volumio[961]: info: Starting Shairport Sync Oct 06 10:16:26 volumio sudo[1125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 06 10:16:26 volumio sudo[1125]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:26 volumio sudo[1132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 06 10:16:26 volumio sudo[1132]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:26 volumio sudo[1134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 06 10:16:26 volumio sudo[1134]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:26 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 06 10:16:26 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 06 10:16:26 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 06 10:16:26 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 06 10:16:26 volumio sudo[1125]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:26 volumio volumio[961]: info: CoreCommandRouter::volumioGetState Oct 06 10:16:26 volumio volumio[961]: info: CorePlayQueue::getTrack 0 Oct 06 10:16:26 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 06 10:16:26 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Oct 06 10:16:26 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 06 10:16:26 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 06 10:16:26 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 06 10:16:26 volumio sudo[1132]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:27 volumio sudo[1134]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:27 volumio volumio[961]: info: Shairport-Sync Started Oct 06 10:16:27 volumio volumio[961]: Error adding Membership: Error: addMembership EINVAL Oct 06 10:16:27 volumio volumio[961]: info: Shairport-Sync Started Oct 06 10:16:27 volumio volumio[961]: info: Shairport-Sync Started Oct 06 10:16:27 volumio volumio-remote-updater[647]: [2024-10-06 10:16:27] [connect] Successful connection Oct 06 10:16:27 volumio volumio-remote-updater[647]: [2024-10-06 10:16:27] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1728202587 101 Oct 06 10:16:27 volumio volumio[961]: 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: 2 Oct 06 10:16:29 volumio sudo[1158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 06 10:16:29 volumio sudo[1158]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:29 volumio sudo[1158]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:29 volumio sudo[1160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 06 10:16:29 volumio sudo[1160]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:29 volumio sudo[1160]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:29 volumio sudo[1164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 06 10:16:29 volumio sudo[1164]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:29 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Oct 06 10:16:29 volumio sudo[1164]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:29 volumio volumio[961]: info: Upmpdcli Daemon Started Oct 06 10:16:31 volumio sudo[1168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 06 10:16:31 volumio sudo[1168]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:31 volumio sudo[1168]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:31 volumio sudo[1170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 06 10:16:31 volumio sudo[1170]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:31 volumio sudo[1170]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:31 volumio volumio[961]: verbose: New Socket.io Connection to 192.168.1.239 from 192.168.1.222 UA: Mozilla/5.0 (X11; Linux x86_64; rv:109.0) Gecko/20100101 Firefox/113.0 Engine version: 3 Transport: polling Total Clients: 3 Oct 06 10:16:32 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Oct 06 10:16:32 volumio mpd[1100]: Oct 06 10:16 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 06 10:16:32 volumio systemd[1]: Started Music Player Daemon. Oct 06 10:16:32 volumio volumio[961]: Upnp client error: Error: This socket has been ended by the other party Oct 06 10:16:32 volumio sudo[1083]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:32 volumio sudo[1072]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:32 volumio volumio[961]: info: Completed starting Core Plugins Oct 06 10:16:32 volumio volumio[961]: info: ------------------------------------------- Oct 06 10:16:32 volumio volumio[961]: info: ----- MyVolumio plugins startup ---- Oct 06 10:16:32 volumio volumio[961]: info: ------------------------------------------- Oct 06 10:16:32 volumio volumio[961]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 06 10:16:32 volumio volumio[961]: info: MPD running with PID1100 Oct 06 10:16:32 volumio volumio[961]: ,establishing connection Oct 06 10:16:32 volumio volumio[961]: error: MPD error: The expression evaluated to a falsy value: Oct 06 10:16:32 volumio volumio[961]: assert.ok(self.idling) Oct 06 10:16:32 volumio volumio[961]: error: The expression evaluated to a falsy value: Oct 06 10:16:32 volumio volumio[961]: assert.ok(self.idling) Oct 06 10:16:32 volumio volumio[961]: error: MPD error: The expression evaluated to a falsy value: Oct 06 10:16:32 volumio volumio[961]: assert.ok(self.idling) Oct 06 10:16:32 volumio volumio[961]: error: The expression evaluated to a falsy value: Oct 06 10:16:32 volumio volumio[961]: assert.ok(self.idling) Oct 06 10:16:32 volumio sudo[1180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 06 10:16:32 volumio sudo[1180]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:32 volumio volumio[961]: error: updateQueue error: null Oct 06 10:16:32 volumio sudo[1180]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:32 volumio sudo[1182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 06 10:16:32 volumio sudo[1182]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:32 volumio sudo[1182]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:32 volumio volumio[961]: verbose: New Socket.io Connection to 192.168.1.239 from 192.168.1.222 UA: Mozilla/5.0 (X11; Linux x86_64; rv:109.0) Gecko/20100101 Firefox/113.0 Engine version: 3 Transport: polling Total Clients: 4 Oct 06 10:16:32 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 06 10:16:32 volumio volumio[961]: info: CoreCommandRouter::volumioGetVisibleSources Oct 06 10:16:32 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 10:16:32 volumio volumio[961]: info: CoreCommandRouter::volumioGetState Oct 06 10:16:32 volumio volumio[961]: info: CorePlayQueue::getTrack 0 Oct 06 10:16:32 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 06 10:16:32 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 06 10:16:32 volumio volumio[961]: info: Received Get System Info Oct 06 10:16:32 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 06 10:16:32 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 06 10:16:32 volumio volumio[961]: info: Discovery: Getting this device information Oct 06 10:16:32 volumio volumio[961]: info: CoreCommandRouter::volumioGetState Oct 06 10:16:32 volumio volumio[961]: info: CorePlayQueue::getTrack 0 Oct 06 10:16:32 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 06 10:16:32 volumio volumio[961]: info: CoreCommandRouter::volumioGetState Oct 06 10:16:32 volumio volumio[961]: info: CorePlayQueue::getTrack 0 Oct 06 10:16:32 volumio volumio[961]: info: Listing playlists Oct 06 10:16:32 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 06 10:16:32 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 06 10:16:33 volumio volumio[961]: info: CoreCommandRouter::volumioGetState Oct 06 10:16:33 volumio volumio[961]: info: CorePlayQueue::getTrack 0 Oct 06 10:16:33 volumio volumio[1166]: Generating RSA private key, 4096 bit long modulus (2 primes) Oct 06 10:16:34 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 06 10:16:34 volumio volumio[961]: info: Received Get System Info Oct 06 10:16:34 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 06 10:16:34 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 06 10:16:34 volumio volumio[961]: info: Discovery: Getting this device information Oct 06 10:16:34 volumio volumio[961]: info: CoreCommandRouter::volumioGetState Oct 06 10:16:34 volumio volumio[961]: info: CorePlayQueue::getTrack 0 Oct 06 10:16:34 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 06 10:16:34 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 06 10:16:37 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 06 10:16:37 volumio volumio[961]: info: Received Get System Info Oct 06 10:16:37 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 06 10:16:37 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 06 10:16:37 volumio volumio[961]: info: Discovery: Getting this device information Oct 06 10:16:37 volumio volumio[961]: info: CoreCommandRouter::volumioGetState Oct 06 10:16:37 volumio volumio[961]: info: CorePlayQueue::getTrack 0 Oct 06 10:16:37 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 06 10:16:37 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 06 10:16:40 volumio volumio[961]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 06 10:16:40 volumio volumio[961]: info: Adding plugin bluetooth to MyMusic Plugins Oct 06 10:16:40 volumio volumio[961]: info: Adding plugin multiroom to MyMusic Plugins Oct 06 10:16:40 volumio volumio[961]: info: Adding plugin metavolumio to MyMusic Plugins Oct 06 10:16:41 volumio volumio[961]: info: Adding plugin cd_controller to MyMusic Plugins Oct 06 10:16:41 volumio volumio[961]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 06 10:16:41 volumio volumio[961]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 06 10:16:41 volumio volumio[961]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 06 10:16:43 volumio volumio[961]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 06 10:16:43 volumio volumio[961]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 06 10:16:43 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 10:16:43 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 10:16:43 volumio volumio[961]: info: Starting MyVolumio Remote Streaming Endpoints Oct 06 10:16:43 volumio volumio[961]: info: MyVolumio login type: Token Oct 06 10:16:43 volumio volumio[961]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 06 10:16:43 volumio volumio[961]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 06 10:16:46 volumio volumio[961]: info: Starting Streaming Service Transparent Proxy Oct 06 10:16:46 volumio volumio[961]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 06 10:16:46 volumio volumio[961]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 06 10:16:46 volumio volumio[961]: info: Streaming services startup Oct 06 10:16:46 volumio volumio[961]: info: Starting Streaming Daemon Oct 06 10:16:46 volumio sudo[1207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 06 10:16:46 volumio sudo[1207]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:46 volumio volumio[961]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 06 10:16:46 volumio sudo[1207]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:46 volumio volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 06 10:16:46 volumio volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 06 10:16:46 volumio volumio[961]: info: Retrieving Cloud Streaming UI Oct 06 10:16:46 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 06 10:16:46 volumio volumio[961]: error: Cannot start Volumio Streaming Daemon Oct 06 10:16:46 volumio volumio[961]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 06 10:16:46 volumio volumio[961]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 06 10:16:46 volumio volumio[961]: info: Getting Tidal Cloud Configuration Oct 06 10:16:46 volumio volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 06 10:16:46 volumio volumio[961]: info: Getting Qobuz Cloud Configuration Oct 06 10:16:46 volumio volumio[961]: info: Asking plugin for UI Config Oct 06 10:16:46 volumio volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 06 10:16:46 volumio volumio[961]: info: Getting Spotify Cloud Configuration Oct 06 10:16:46 volumio volumio[961]: info: Asking plugin for UI Config Oct 06 10:16:46 volumio volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 06 10:16:46 volumio volumio[961]: info: Saving Spotify Acccount Oct 06 10:16:46 volumio volumio[961]: info: Got Tidal Cloud Configuration Oct 06 10:16:46 volumio volumio[961]: info: Got it Oct 06 10:16:46 volumio volumio[961]: info: Got it Oct 06 10:16:46 volumio volumio[961]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 06 10:16:46 volumio volumio[961]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 06 10:16:46 volumio volumio[961]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Oct 06 10:16:46 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 06 10:16:46 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 06 10:16:46 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 06 10:16:46 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 06 10:16:46 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 10:16:46 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 10:16:46 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 10:16:46 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 10:16:46 volumio volumio[961]: info: CoreCommandRouter::volumioGetBrowseSources Oct 06 10:16:46 volumio volumio[961]: info: CoreCommandRouter::volumioGetBrowseSources Oct 06 10:16:46 volumio volumio[961]: info: CoreCommandRouter::volumioGetBrowseSources Oct 06 10:16:47 volumio volumio[961]: error: MyVolumio Custom Token format not valid, refreshing it Oct 06 10:16:47 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 10:16:47 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 06 10:16:47 volumio volumio[961]: info: MyVolumio login type: Token Oct 06 10:16:48 volumio volumio[961]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 06 10:16:48 volumio volumio[961]: STREAMING PROXY: Starting server on port 3245 Oct 06 10:16:48 volumio volumio[961]: Node JS runtime: 14 Oct 06 10:16:49 volumio volumio[961]: info: MyVolumio token set successfully Oct 06 10:16:49 volumio volumio[961]: info: MYVOLUMIO: Adding device Oct 06 10:16:49 volumio volumio[961]: info: MYVOLUMIO: Evaluating Server Oct 06 10:16:49 volumio volumio[961]: info: MyVolumio status changed Oct 06 10:16:49 volumio volumio[961]: info: Streaming services startup Oct 06 10:16:49 volumio volumio[961]: info: Starting Streaming Daemon Oct 06 10:16:50 volumio volumio[961]: info: Removing browser output: myVolumio user plan is not superstar Oct 06 10:16:50 volumio volumio[961]: info: Removing audio output: Oct 06 10:16:50 volumio volumio[961]: info: Stoppping Tunnel 1 Oct 06 10:16:50 volumio sudo[1232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 06 10:16:50 volumio sudo[1232]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:50 volumio sudo[1234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Oct 06 10:16:50 volumio sudo[1234]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 10:16:50 volumio sudo[1232]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:50 volumio volumio[961]: error: Cannot start Volumio Streaming Daemon Oct 06 10:16:50 volumio volumio[961]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 06 10:16:50 volumio volumio[961]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 06 10:16:50 volumio sudo[1234]: pam_unix(sudo:session): session closed for user root Oct 06 10:16:50 volumio volumio[961]: info: Remote SSH Stopped Oct 06 10:16:50 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 06 10:16:50 volumio volumio[961]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 06 10:16:50 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 06 10:16:50 volumio volumio[961]: info: Received Get System Version Oct 06 10:16:50 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 06 10:16:50 volumio volumio[961]: info: Received Get System Info Oct 06 10:16:50 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 06 10:16:50 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 06 10:16:50 volumio volumio[961]: info: Discovery: Getting this device information Oct 06 10:16:50 volumio volumio[961]: info: CoreCommandRouter::volumioGetState Oct 06 10:16:50 volumio volumio[961]: info: CorePlayQueue::getTrack 0 Oct 06 10:16:50 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 06 10:16:51 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 10:16:52 volumio volumio[961]: info: Setting Geolocation for MyVolumio to eu4 Oct 06 10:16:52 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 10:16:52 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 10:16:52 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 10:16:53 volumio volumio[961]: info: Updating MyVolumio device info Oct 06 10:16:53 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 10:16:53 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 10:16:53 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 10:16:53 volumio volumio[961]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 06 10:16:53 volumio volumio[961]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 06 10:16:55 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 10:16:55 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 06 10:16:55 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 10:16:55 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 06 10:16:55 volumio volumio-remote-updater[647]: No test mode Oct 06 10:16:55 volumio volumio-remote-updater[647]: No alpha test mode Oct 06 10:16:55 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 06 10:16:55 volumio volumio[1166]: ................................................................................++++ Oct 06 10:16:55 volumio volumio[961]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 06 10:16:55 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 06 10:16:57 volumio volumio[961]: info: MYVOLUMIO: Adding device Oct 06 10:16:57 volumio volumio[961]: info: MYVOLUMIO: Evaluating Server Oct 06 10:16:58 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 06 10:16:58 volumio volumio[961]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 06 10:16:58 volumio volumio[961]: info: CoreCommandRouter::volumioGetState Oct 06 10:16:58 volumio volumio[961]: info: CorePlayQueue::getTrack 0 Oct 06 10:16:59 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Oct 06 10:16:59 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Oct 06 10:16:59 volumio volumio[961]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 06 10:16:59 volumio volumio[961]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 06 10:16:59 volumio volumio[961]: Error: getaddrinfo -3007 Oct 06 10:16:59 volumio volumio[961]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Oct 06 10:16:59 volumio volumio[961]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Oct 06 10:16:59 volumio volumio[961]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Oct 06 10:16:59 volumio volumio[961]: code: -3007, Oct 06 10:16:59 volumio volumio[961]: errno: -3007, Oct 06 10:16:59 volumio volumio[961]: syscall: 'getaddrinfo' Oct 06 10:16:59 volumio volumio[961]: } Oct 06 10:16:59 volumio volumio[961]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 06 10:17:00 volumio sudo[1305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-06 10:16 Oct 06 10:17:00 volumio sudo[1305]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"