-- Logs begin at Wed 2024-10-09 00:08:53 CEST, end at Wed 2024-10-09 00:10:34 CEST. -- Oct 09 00:09:00 volumio systemd[1]: nfs-config.service: Succeeded. Oct 09 00:09:00 volumio systemd[1]: Started Preprocess NFS configuration. Oct 09 00:09:00 volumio systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Oct 09 00:09:00 volumio systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Oct 09 00:09:00 volumio systemd[1]: Reached target NFS client services. Oct 09 00:09:00 volumio systemd[1]: Started Create Volatile Files and Directories. Oct 09 00:09:00 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown... Oct 09 00:09:00 volumio systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Oct 09 00:09:00 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Oct 09 00:09:00 volumio systemd[1]: Starting RPC bind portmap service... Oct 09 00:09:00 volumio systemd[1]: plymouth-read-write.service: Succeeded. Oct 09 00:09:00 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Oct 09 00:09:00 volumio systemd[1]: Received SIGRTMIN+20 from PID 264 (plymouthd). Oct 09 00:09:00 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown. Oct 09 00:09:00 volumio systemd[1]: Reached target System Initialization. Oct 09 00:09:00 volumio systemd[1]: Started Daily man-db regeneration. Oct 09 00:09:00 volumio systemd[1]: Listening on triggerhappy.socket. Oct 09 00:09:00 volumio systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 09 00:09:00 volumio systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 09 00:09:00 volumio systemd[1]: Started Volumio Splash. Oct 09 00:09:00 volumio systemd[1]: Started Daily apt download activities. Oct 09 00:09:00 volumio systemd[1]: Started Daily apt upgrade and clean activities. Oct 09 00:09:00 volumio systemd[1]: Reached target Timers. Oct 09 00:09:00 volumio systemd[589]: volumiosplash.service: Failed to execute command: No such file or directory Oct 09 00:09:00 volumio systemd[589]: volumiosplash.service: Failed at step EXEC spawning /bin/volumiosplash.sh: No such file or directory Oct 09 00:09:00 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Oct 09 00:09:00 volumio systemd[1]: Reached target Sockets. Oct 09 00:09:00 volumio systemd[1]: Reached target Basic System. Oct 09 00:09:00 volumio systemd[1]: Started volumio-remote-updater.service. Oct 09 00:09:00 volumio systemd[1]: Starting triggerhappy global hotkey daemon... Oct 09 00:09:00 volumio systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Oct 09 00:09:00 volumio systemd[1]: Started Volumio Iptables Module. Oct 09 00:09:00 volumio systemd[1]: Started Manage Sound Card State (restore and store). Oct 09 00:09:00 volumio systemd[1]: Condition check resulted in Configure Bluetooth Modems connected by UART being skipped. Oct 09 00:09:00 volumio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Oct 09 00:09:00 volumio systemd[1]: Starting Save/Restore Sound Card State... Oct 09 00:09:00 volumio alsactl[596]: alsactl 1.1.8 daemon started Oct 09 00:09:00 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Oct 09 00:09:00 volumio systemd[1]: Starting Raspberry Pi bluetooth helper... Oct 09 00:09:00 volumio systemd[1]: Starting Wireless Services... Oct 09 00:09:00 volumio systemd[1]: Started Volumio Log Rotation Service. Oct 09 00:09:00 volumio systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Oct 09 00:09:00 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Oct 09 00:09:00 volumio systemd[1]: Starting dhcpcd on all interfaces... Oct 09 00:09:00 volumio systemd[1]: Started D-Bus System Message Bus. Oct 09 00:09:00 volumio systemd[1]: Starting WPA supplicant... Oct 09 00:09:00 volumio systemd[1]: Starting Login Service... Oct 09 00:09:00 volumio systemd[1]: volumiosplash.service: Main process exited, code=exited, status=203/EXEC Oct 09 00:09:00 volumio systemd[1]: volumiosplash.service: Failed with result 'exit-code'. Oct 09 00:09:00 volumio dhcpcd[603]: Not running dhcpcd because /etc/network/interfaces Oct 09 00:09:00 volumio dhcpcd[603]: defines some interfaces that will use a Oct 09 00:09:00 volumio dhcpcd[603]: DHCP client or static address Oct 09 00:09:00 volumio thd[594]: Unable to parse trigger line: Oct 09 00:09:00 volumio thd[594]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Oct 09 00:09:00 volumio thd[594]: Unable to parse trigger line: Oct 09 00:09:00 volumio thd[594]: Found socket passed from systemd Oct 09 00:09:01 volumio bthelper[599]: Raspberry Pi BDADDR already set Oct 09 00:09:01 volumio systemd-logind[609]: New seat seat0. Oct 09 00:09:01 volumio systemd-logind[609]: Watching system buttons on /dev/input/event0 (HID 046a:0023) Oct 09 00:09:01 volumio systemd-logind[609]: Watching system buttons on /dev/input/event1 (HID 046a:0023) Oct 09 00:09:01 volumio systemd-logind[609]: Watching system buttons on /dev/input/event4 (pwr_button) Oct 09 00:09:01 volumio systemd-logind[609]: Watching system buttons on /dev/input/event3 (vc4-hdmi-0) Oct 09 00:09:01 volumio systemd-logind[609]: Watching system buttons on /dev/input/event5 (vc4-hdmi-1) Oct 09 00:09:01 volumio avahi-daemon[602]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Oct 09 00:09:01 volumio avahi-daemon[602]: Successfully dropped root privileges. Oct 09 00:09:01 volumio avahi-daemon[602]: avahi-daemon 0.7 starting up. Oct 09 00:09:02 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Oct 09 00:09:02 volumio kernel: 8021q: 802.1Q VLAN Support v1.8 Oct 09 00:09:03 volumio avahi-daemon[602]: Successfully called chroot(). Oct 09 00:09:03 volumio avahi-daemon[602]: Successfully dropped remaining capabilities. Oct 09 00:09:03 volumio systemd[1]: Started Login Service. Oct 09 00:09:03 volumio wpa_supplicant[608]: Successfully initialized wpa_supplicant Oct 09 00:09:03 volumio systemd[1]: Started triggerhappy global hotkey daemon. Oct 09 00:09:03 volumio systemd[1]: Started RPC bind portmap service. Oct 09 00:09:03 volumio systemd[1]: haveged.service: Main process exited, code=killed, status=11/SEGV Oct 09 00:09:03 volumio systemd[1]: haveged.service: Failed with result 'signal'. Oct 09 00:09:03 volumio systemd[1]: Started Save/Restore Sound Card State. Oct 09 00:09:03 volumio systemd[1]: Started Raspberry Pi bluetooth helper. Oct 09 00:09:03 volumio systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Oct 09 00:09:03 volumio systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Oct 09 00:09:03 volumio systemd[1]: Failed to start dhcpcd on all interfaces. Oct 09 00:09:03 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Oct 09 00:09:03 volumio systemd[1]: Started WPA supplicant. Oct 09 00:09:03 volumio systemd[1]: Starting Bluetooth service... Oct 09 00:09:03 volumio systemd[1]: Reached target Sound Card. Oct 09 00:09:03 volumio systemd[1]: Reached target RPC Port Mapper. Oct 09 00:09:03 volumio systemd[1]: Reached target Remote File Systems (Pre). Oct 09 00:09:03 volumio systemd[1]: Reached target Remote File Systems. Oct 09 00:09:03 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Oct 09 00:09:03 volumio ifup[561]: ifup: waiting for lock on /run/network/ifstate.wlan0 Oct 09 00:09:03 volumio sh[560]: wlan0=wlan0 Oct 09 00:09:03 volumio systemd[1]: Started Raise network interfaces. Oct 09 00:09:03 volumio systemd[1]: Reached target Network. Oct 09 00:09:03 volumio avahi-daemon[602]: No service file found in /etc/avahi/services. Oct 09 00:09:03 volumio systemd[1]: Starting Permit User Sessions... Oct 09 00:09:03 volumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Oct 09 00:09:03 volumio avahi-daemon[602]: Network interface enumeration completed. Oct 09 00:09:03 volumio systemd[1]: Starting Network Time Service... Oct 09 00:09:03 volumio avahi-daemon[602]: Server startup complete. Host name is volumio.local. Local service cookie is 1628693568. Oct 09 00:09:03 volumio systemd[1]: Starting OpenBSD Secure Shell server... Oct 09 00:09:03 volumio systemd[1]: Reached target Network is Online. Oct 09 00:09:03 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 09 00:09:03 volumio systemd[1]: Starting Samba NMB Daemon... Oct 09 00:09:03 volumio systemd[1]: Starting /etc/rc.local Compatibility... Oct 09 00:09:03 volumio systemd[1]: Starting LSB: Brings up/down network automatically... Oct 09 00:09:03 volumio systemd[1]: Started Permit User Sessions. Oct 09 00:09:04 volumio volumio-remote-updater[593]: Error: No active session Oct 09 00:09:04 volumio volumio-remote-updater[593]: [2024-10-09 00:09:04] [info] asio async_connect error: system:111 (Connection refused) Oct 09 00:09:04 volumio volumio-remote-updater[593]: [2024-10-09 00:09:04] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 09 00:09:04 volumio volumio-remote-updater[593]: [2024-10-09 00:09:04] [error] handle_connect error: Underlying Transport Error Oct 09 00:09:04 volumio kernel: macb 1f00100000.ethernet eth0: PHY [1f00100000.ethernet-ffffffff:01] driver [Broadcom BCM54213PE] (irq=POLL) Oct 09 00:09:04 volumio kernel: macb 1f00100000.ethernet eth0: configuring for phy/rgmii-id link mode Oct 09 00:09:04 volumio kernel: pps pps0: new PPS source ptp0 Oct 09 00:09:04 volumio kernel: macb 1f00100000.ethernet: gem-ptp-timer ptp clock registered. Oct 09 00:09:04 volumio dhcpcd[654]: eth0: waiting for carrier Oct 09 00:09:04 volumio sh[565]: eth0: waiting for carrier Oct 09 00:09:04 volumio systemd[1]: Started /etc/rc.local Compatibility. Oct 09 00:09:04 volumio volumio[598]: Could not open config: /tmp/upmpdcli.conf Oct 09 00:09:04 volumio bluetoothd[707]: Bluetooth daemon 5.50 Oct 09 00:09:04 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 09 00:09:04 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 09 00:09:04 volumio systemd[1]: Starting Hold until boot process finishes up... Oct 09 00:09:04 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... Oct 09 00:09:04 volumio systemd[1]: iptables.service: Succeeded. Oct 09 00:09:04 volumio systemd[1]: Received SIGRTMIN+21 from PID 264 (plymouthd). Oct 09 00:09:04 volumio systemd[1]: Received SIGRTMIN+21 from PID 264 (plymouthd). Oct 09 00:09:04 volumio systemd[1]: plymouth-quit.service: Succeeded. Oct 09 00:09:04 volumio systemd[1]: Started Terminate Plymouth Boot Screen. Oct 09 00:09:04 volumio systemd[1]: plymouth-quit-wait.service: Succeeded. Oct 09 00:09:04 volumio systemd[1]: Started Hold until boot process finishes up. Oct 09 00:09:04 volumio bluetoothd[707]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Oct 09 00:09:04 volumio systemd[1]: Started Serial Getty on ttyAMA10. Oct 09 00:09:04 volumio systemd[1]: Reached target Login Prompts. Oct 09 00:09:04 volumio systemd[1]: plymouth-start.service: Succeeded. Oct 09 00:09:04 volumio systemd[1]: Started Bluetooth service. Oct 09 00:09:04 volumio systemd[1]: Reached target Bluetooth. Oct 09 00:09:04 volumio ifplugd(eth0)[792]: ifplugd 0.28 initializing. Oct 09 00:09:04 volumio ifplugd(eth0)[792]: Using interface eth0/D8:3A:DD:BB:95:CA with driver (version: 6.1.69-v8+) Oct 09 00:09:04 volumio ifplugd(eth0)[792]: Using detection mode: SIOCETHTOOL Oct 09 00:09:04 volumio ifplugd(eth0)[792]: Initialization complete, link beat not detected. Oct 09 00:09:04 volumio bluetoothd[707]: Starting SDP server Oct 09 00:09:04 volumio bluetoothd[707]: Excluding (cli) sap Oct 09 00:09:04 volumio systemd[1]: systemd-rfkill.service: Succeeded. Oct 09 00:09:04 volumio ifplugd[758]: Network Interface Plugging Daemon...start eth0...done. Oct 09 00:09:04 volumio systemd[1]: Started LSB: Brings up/down network automatically. Oct 09 00:09:04 volumio ntpd[744]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 09 00:09:04 volumio ntpd[744]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Oct 09 00:09:04 volumio systemd[1]: Started Network Time Service. Oct 09 00:09:04 volumio loadcpufreq[715]: Loading cpufreq kernel modules...done (none). Oct 09 00:09:04 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Oct 09 00:09:04 volumio ntpd[796]: proto: precision = 1.259 usec (-20) Oct 09 00:09:04 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Oct 09 00:09:04 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Oct 09 00:09:04 volumio kernel: Bluetooth: BNEP filters: protocol multicast Oct 09 00:09:04 volumio kernel: Bluetooth: BNEP socket layer initialized Oct 09 00:09:04 volumio bluetoothd[707]: Bluetooth management interface 1.22 initialized Oct 09 00:09:04 volumio dbus-daemon[604]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=707 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Oct 09 00:09:04 volumio kernel: Bluetooth: MGMT ver 1.22 Oct 09 00:09:04 volumio ntpd[796]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 09 00:09:04 volumio ntpd[796]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 09 00:09:04 volumio ntpd[796]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 103 days ago Oct 09 00:09:04 volumio ntpd[796]: Listen and drop on 0 v6wildcard [::]:123 Oct 09 00:09:04 volumio ntpd[796]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 09 00:09:04 volumio ntpd[796]: Listen normally on 2 lo 127.0.0.1:123 Oct 09 00:09:04 volumio ntpd[796]: Listening on routing socket on fd #19 for interface updates Oct 09 00:09:04 volumio ntpd[796]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 09 00:09:04 volumio ntpd[796]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 09 00:09:05 volumio sshd[819]: Server listening on 0.0.0.0 port 22. Oct 09 00:09:05 volumio sshd[819]: Server listening on :: port 22. Oct 09 00:09:05 volumio bluetoothd[707]: Failed to set privacy: Rejected (0x0b) Oct 09 00:09:05 volumio cpufrequtils[812]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Oct 09 00:09:05 volumio systemd[1]: Started OpenBSD Secure Shell server. Oct 09 00:09:05 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Oct 09 00:09:05 volumio systemd[1]: Starting Hostname Service... Oct 09 00:09:05 volumio dbus-daemon[604]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 09 00:09:05 volumio systemd[1]: Started Hostname Service. Oct 09 00:09:05 volumio ntpd[796]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Oct 09 00:09:06 volumio bthelper[599]: Changing power off succeeded Oct 09 00:09:06 volumio bthelper[599]: [CHG] Controller D8:3A:DD:BB:95:CC Class: 0x0000041c Oct 09 00:09:06 volumio bthelper[599]: Changing power on succeeded Oct 09 00:09:06 volumio nmbd[761]: [2024/10/09 00:09:06.567093, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Oct 09 00:09:06 volumio nmbd[761]: started asyncdns process 836 Oct 09 00:09:06 volumio nmbd[761]: [2024/10/09 00:09:06.568077, 0] ../lib/util/become_daemon.c:149(daemon_status) Oct 09 00:09:06 volumio nmbd[761]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Oct 09 00:09:06 volumio nmbd[761]: [2024/10/09 00:09:06.568137, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Oct 09 00:09:06 volumio nmbd[761]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Oct 09 00:09:06 volumio ntpd[796]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Oct 09 00:09:06 volumio wireless.js[600]: Cleaning previous... Oct 09 00:09:07 volumio sudo[844]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Oct 09 00:09:07 volumio sudo[844]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:09:07 volumio sudo[844]: pam_unix(sudo:session): session closed for user root Oct 09 00:09:07 volumio sudo[846]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Oct 09 00:09:07 volumio sudo[846]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:09:07 volumio sudo[846]: pam_unix(sudo:session): session closed for user root Oct 09 00:09:07 volumio wireless.js[600]: Stopped aP Oct 09 00:09:07 volumio wireless.js[600]: Wireless Networking DISABLED, not starting wireless flow Oct 09 00:09:07 volumio systemd[1]: wireless.service: Succeeded. Oct 09 00:09:07 volumio systemd[1]: Started Wireless Services. Oct 09 00:09:07 volumio systemd[1]: Started Volumio Backend Module. Oct 09 00:09:07 volumio systemd[1]: Started Volumio Cpu Tweaker. Oct 09 00:09:07 volumio volumio-cpu-tweak[855]: Setting RT Priority for mpd Oct 09 00:09:07 volumio volumio-cpu-tweak[855]: pid 35's current scheduling policy: SCHED_OTHER Oct 09 00:09:07 volumio volumio-cpu-tweak[855]: pid 35's current scheduling priority: 0 Oct 09 00:09:07 volumio volumio-cpu-tweak[855]: Setting MPD Affinity Oct 09 00:09:07 volumio volumio-cpu-tweak[855]: pid 3's current affinity mask: f Oct 09 00:09:07 volumio volumio-cpu-tweak[855]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Oct 09 00:09:07 volumio volumio-cpu-tweak[855]: VOLUMIO CPU TWEAK: Setting CPU Governor: conservative Oct 09 00:09:07 volumio ntpd[796]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Oct 09 00:09:07 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Oct 09 00:09:08 volumio sh[565]: eth0: carrier acquired Oct 09 00:09:08 volumio dhcpcd[654]: eth0: carrier acquired Oct 09 00:09:08 volumio kernel: macb 1f00100000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off Oct 09 00:09:08 volumio sh[565]: DUID 00:01:00:01:2d:67:e1:04:d8:3a:dd:bb:95:ca Oct 09 00:09:08 volumio sh[565]: eth0: IAID dd:bb:95:ca Oct 09 00:09:08 volumio sh[565]: eth0: adding address fe80::da3a:ddff:febb:95ca Oct 09 00:09:08 volumio sh[565]: ipv6_addaddr1: Permission denied Oct 09 00:09:08 volumio dhcpcd[654]: DUID 00:01:00:01:2d:67:e1:04:d8:3a:dd:bb:95:ca Oct 09 00:09:08 volumio dhcpcd[654]: eth0: IAID dd:bb:95:ca Oct 09 00:09:08 volumio dhcpcd[654]: eth0: adding address fe80::da3a:ddff:febb:95ca Oct 09 00:09:08 volumio dhcpcd[654]: ipv6_addaddr1: Permission denied Oct 09 00:09:08 volumio ifplugd(eth0)[792]: Link beat detected. Oct 09 00:09:08 volumio ifplugd(eth0)[792]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Oct 09 00:09:08 volumio sh[565]: eth0: soliciting an IPv6 router Oct 09 00:09:08 volumio dhcpcd[654]: eth0: soliciting an IPv6 router Oct 09 00:09:08 volumio ifplugd(eth0)[792]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Oct 09 00:09:08 volumio ntpd[796]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Oct 09 00:09:09 volumio volumio-remote-updater[593]: [2024-10-09 00:09:09] [connect] Successful connection Oct 09 00:09:09 volumio sh[565]: eth0: soliciting a DHCP lease Oct 09 00:09:09 volumio dhcpcd[654]: eth0: soliciting a DHCP lease Oct 09 00:09:09 volumio sh[565]: eth0: offered 192.168.178.7 from 192.168.178.1 Oct 09 00:09:09 volumio dhcpcd[654]: eth0: offered 192.168.178.7 from 192.168.178.1 Oct 09 00:09:09 volumio sh[565]: eth0: probing address 192.168.178.7/24 Oct 09 00:09:09 volumio dhcpcd[654]: eth0: probing address 192.168.178.7/24 Oct 09 00:09:09 volumio volumio[854]: info: ------------------------------------------- Oct 09 00:09:09 volumio volumio[854]: info: ----- Volumio3 ---- Oct 09 00:09:09 volumio volumio[854]: info: ------------------------------------------- Oct 09 00:09:09 volumio volumio[854]: info: ----- System startup ---- Oct 09 00:09:09 volumio volumio[854]: info: ------------------------------------------- Oct 09 00:09:10 volumio volumio[854]: info: MYVOLUMIO Environment detected Oct 09 00:09:10 volumio volumio[854]: info: Plugin folders cleanup Oct 09 00:09:10 volumio volumio[854]: info: Scanning into folder /volumio/app/plugins/ Oct 09 00:09:10 volumio volumio[854]: info: Scanning category audio_interface Oct 09 00:09:10 volumio volumio[854]: info: Scanning category miscellanea Oct 09 00:09:10 volumio volumio[854]: info: Scanning category music_service Oct 09 00:09:10 volumio volumio[854]: info: Scanning category plugins.json Oct 09 00:09:10 volumio volumio[854]: info: Scanning category system_controller Oct 09 00:09:10 volumio volumio[854]: info: Scanning category user_interface Oct 09 00:09:10 volumio volumio[854]: info: Scanning into folder /data/plugins/ Oct 09 00:09:10 volumio volumio[854]: info: Scanning category audio_interface Oct 09 00:09:10 volumio volumio[854]: info: Scanning category music_service Oct 09 00:09:10 volumio volumio[854]: info: Scanning category system_hardware Oct 09 00:09:10 volumio volumio[854]: info: Scanning category user_interface Oct 09 00:09:10 volumio volumio[854]: info: Plugin folders cleanup completed Oct 09 00:09:10 volumio volumio[854]: info: ------------------------------------------- Oct 09 00:09:10 volumio volumio[854]: info: ----- Core plugins startup ---- Oct 09 00:09:10 volumio volumio[854]: info: ------------------------------------------- Oct 09 00:09:10 volumio volumio[854]: info: Loading plugins from folder /volumio/app/plugins/ Oct 09 00:09:10 volumio volumio[854]: info: Adding plugin upnp to MyMusic Plugins Oct 09 00:09:10 volumio volumio[854]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 09 00:09:10 volumio volumio[854]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 09 00:09:10 volumio volumio[854]: info: Loading plugins from folder /data/plugins/ Oct 09 00:09:10 volumio volumio[854]: info: Loading plugin "system"... Oct 09 00:09:10 volumio volumio[854]: info: Loading plugin "appearance"... Oct 09 00:09:11 volumio volumio[854]: info: Loading plugin "network"... Oct 09 00:09:11 volumio volumio[854]: info: Refreshing Cached IP Addresses Oct 09 00:09:11 volumio volumio[854]: info: Loading plugin "services"... Oct 09 00:09:11 volumio sudo[891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 09 00:09:11 volumio sudo[891]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:09:11 volumio volumio[854]: info: Loading plugin "alsa_controller"... Oct 09 00:09:11 volumio sudo[891]: pam_unix(sudo:session): session closed for user root Oct 09 00:09:11 volumio sudo[893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 09 00:09:11 volumio sudo[893]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:09:11 volumio sudo[893]: pam_unix(sudo:session): session closed for user root Oct 09 00:09:11 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 09 00:09:11 volumio volumio[854]: info: Loading plugin "wizard"... Oct 09 00:09:11 volumio volumio[854]: info: Loading plugin "networkfs"... Oct 09 00:09:11 volumio volumio[854]: info: Starting Udev Watcher for removable devices Oct 09 00:09:11 volumio volumio[854]: info: Ignoring mount for partition: boot Oct 09 00:09:11 volumio volumio[854]: info: Ignoring mount for partition: volumio Oct 09 00:09:11 volumio volumio[854]: info: Ignoring mount for partition: volumio_data Oct 09 00:09:11 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 09 00:09:11 volumio volumio[854]: info: Loading plugin "volumio_command_line_client"... Oct 09 00:09:11 volumio volumio[854]: info: Loading plugin "upnp"... Oct 09 00:09:11 volumio volumio[854]: info: [1728425351597] Starting Upmpd Daemon Oct 09 00:09:11 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 09 00:09:11 volumio volumio[854]: info: Loading plugin "my_music"... Oct 09 00:09:11 volumio volumio[854]: info: Loading plugin "mpd"... Oct 09 00:09:11 volumio volumio[854]: info: Loading plugin "upnp_browser"... Oct 09 00:09:12 volumio volumio[854]: info: Loading plugin "alarm-clock"... Oct 09 00:09:12 volumio volumio[854]: info: Loading plugin "airplay_emulation"... Oct 09 00:09:12 volumio volumio[854]: info: Starting Shairport Sync Oct 09 00:09:12 volumio volumio[854]: info: Loading plugin "last_100"... Oct 09 00:09:12 volumio volumio[854]: info: Loading plugin "webradio"... Oct 09 00:09:12 volumio volumio[854]: info: Loading plugin "i2s_dacs"... Oct 09 00:09:12 volumio volumio[854]: info: I2S DAC not set, start Auto-detection Oct 09 00:09:12 volumio volumio[854]: info: Loading plugin "volumiodiscovery"... Oct 09 00:09:12 volumio volumio[854]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 09 00:09:12 volumio node[854]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 09 00:09:12 volumio volumio[854]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:09:12 volumio node[854]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:09:12 volumio volumio[854]: *** WARNING *** For more information see Oct 09 00:09:12 volumio node[854]: *** WARNING *** For more information see Oct 09 00:09:12 volumio volumio[854]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 09 00:09:12 volumio node[854]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 09 00:09:12 volumio volumio[854]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:09:12 volumio node[854]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:09:12 volumio volumio[854]: *** WARNING *** For more information see Oct 09 00:09:12 volumio node[854]: *** WARNING *** For more information see Oct 09 00:09:12 volumio volumio[854]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 09 00:09:12 volumio volumio[854]: info: Discovery: Started advertising with name: Volumio Oct 09 00:09:12 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 09 00:09:12 volumio volumio[854]: info: Plugin spop is not enabled Oct 09 00:09:12 volumio volumio[854]: info: Loading plugin "gpio-buttons"... Oct 09 00:09:12 volumio volumio[854]: info: GPIO-Buttons initialized Oct 09 00:09:12 volumio volumio[854]: info: Loading plugin "peppy_screensaver"... Oct 09 00:09:13 volumio volumio[854]: info: Applying required configuration parameters for plugin peppy_screensaver Oct 09 00:09:13 volumio volumio[854]: info: Loading plugin "outputs"... Oct 09 00:09:13 volumio volumio[854]: info: Loading plugin "albumart"... Oct 09 00:09:13 volumio volumio[854]: info: Plugin example_plugin is not enabled Oct 09 00:09:13 volumio volumio[854]: info: Loading plugin "inputs"... Oct 09 00:09:13 volumio volumio[854]: info: Loading plugin "updater_comm"... Oct 09 00:09:13 volumio volumio[854]: info: Plugin mpdemulation is not enabled Oct 09 00:09:13 volumio volumio[854]: info: Loading plugin "rest_api"... Oct 09 00:09:13 volumio volumio[854]: info: Loading plugin "websocket"... Oct 09 00:09:13 volumio volumio[854]: info: Plugin fusiondsp is not enabled Oct 09 00:09:13 volumio volumio[854]: info: Plugin radio_paradise is not enabled Oct 09 00:09:13 volumio volumio[854]: info: Loading plugin "gpio_control"... Oct 09 00:09:13 volumio volumio[854]: Forking 3 albumart workers Oct 09 00:09:13 volumio volumio[854]: Starting albumart workers Oct 09 00:09:13 volumio volumio[854]: Starting albumart workers Oct 09 00:09:13 volumio volumio[854]: Starting albumart workers Oct 09 00:09:13 volumio volumio[854]: info: Applying required configuration parameters for plugin gpio_control Oct 09 00:09:13 volumio volumio[854]: info: [GPIO_Control] Detected Raspberry Pi 5 Model B Rev 1.0 Oct 09 00:09:13 volumio volumio[854]: info: [GPIO_Control] 40 GPIOs: true Oct 09 00:09:13 volumio volumio[854]: info: [GPIO_Control] Initialized Oct 09 00:09:13 volumio volumio[854]: info: Loading plugin "rotaryencoder2"... Oct 09 00:09:13 volumio volumio[854]: info: Plugin Systeminfo is not enabled Oct 09 00:09:13 volumio volumio[854]: info: Loading plugin "touch_display"... Oct 09 00:09:14 volumio volumio[854]: info: Applying required configuration parameters for plugin touch_display Oct 09 00:09:14 volumio volumio[854]: info: Loading i18n strings for locale en Oct 09 00:09:14 volumio volumio[854]: Updating browse sources language Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::initPlayerControls Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 00:09:14 volumio volumio[854]: Express server listening on port 3000 Oct 09 00:09:14 volumio volumio[854]: [Metrics] WebUI: 5s 520.80ms Oct 09 00:09:14 volumio volumio[854]: info: CoreStateMachine::resetVolumioState Oct 09 00:09:14 volumio volumio[854]: info: CoreStateMachine::getcurrentVolume Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::volumioRetrievevolume Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 09 00:09:14 volumio sh[565]: eth0: leased 192.168.178.7 for 86400 seconds Oct 09 00:09:14 volumio sh[565]: eth0: adding route to 192.168.178.0/24 Oct 09 00:09:14 volumio sh[565]: eth0: adding default route via 192.168.178.1 Oct 09 00:09:14 volumio dhcpcd[654]: eth0: leased 192.168.178.7 for 86400 seconds Oct 09 00:09:14 volumio avahi-daemon[602]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.178.7. Oct 09 00:09:14 volumio avahi-daemon[602]: New relevant interface eth0.IPv4 for mDNS. Oct 09 00:09:14 volumio dhcpcd[654]: eth0: adding route to 192.168.178.0/24 Oct 09 00:09:14 volumio dhcpcd[654]: eth0: adding default route via 192.168.178.1 Oct 09 00:09:14 volumio avahi-daemon[602]: Registering new address record for 192.168.178.7 on eth0.IPv4. Oct 09 00:09:14 volumio volumio[854]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1 Oct 09 00:09:14 volumio volumio[854]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Oct 09 00:09:14 volumio volumio[854]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 Oct 09 00:09:14 volumio volumio[854]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4 Oct 09 00:09:14 volumio volumio[854]: info: CoreStateMachine::pushState Oct 09 00:09:14 volumio volumio[854]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::volumioPushState Oct 09 00:09:14 volumio volumio[854]: info: CoreStateMachine::updateTrackBlock Oct 09 00:09:14 volumio volumio[854]: info: CorePlayQueue::getTrackBlock Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::volumioRetrievevolume Oct 09 00:09:14 volumio volumio[854]: info: Reloading queue from file Oct 09 00:09:14 volumio ntpd[796]: ntpd exiting on signal 15 (Terminated) Oct 09 00:09:14 volumio systemd[1]: Stopping Network Time Service... Oct 09 00:09:14 volumio systemd[1]: ntp.service: Succeeded. Oct 09 00:09:14 volumio systemd[1]: Stopped Network Time Service. Oct 09 00:09:14 volumio systemd[1]: Starting Network Time Service... Oct 09 00:09:14 volumio volumio[854]: info: Setting Device type: Raspberry PI Oct 09 00:09:14 volumio volumio[854]: info: CoreStateMachine::setRepeat null single undefined Oct 09 00:09:14 volumio volumio[854]: info: CoreStateMachine::pushState Oct 09 00:09:14 volumio volumio[854]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::volumioPushState Oct 09 00:09:14 volumio volumio[854]: info: CoreStateMachine::setRandom null Oct 09 00:09:14 volumio volumio[854]: info: CoreStateMachine::pushState Oct 09 00:09:14 volumio volumio[854]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::volumioPushState Oct 09 00:09:14 volumio volumio[854]: info: CoreStateMachine::pushState Oct 09 00:09:14 volumio volumio[854]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:14 volumio volumio[854]: info: CoreCommandRouter::volumioPushState Oct 09 00:09:14 volumio ntpd[1011]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 09 00:09:14 volumio ntpd[1011]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /run/ntp.conf.dhcp -u 103:103 Oct 09 00:09:14 volumio systemd[1]: Started Network Time Service. Oct 09 00:09:14 volumio ntpd[1017]: proto: precision = 0.796 usec (-20) Oct 09 00:09:14 volumio sh[565]: forked to background, child pid 1018 Oct 09 00:09:14 volumio dhcpcd[654]: forked to background, child pid 1018 Oct 09 00:09:14 volumio ntpd[1017]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 09 00:09:14 volumio ntpd[1017]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 09 00:09:14 volumio ntpd[1017]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 103 days ago Oct 09 00:09:14 volumio ntpd[1017]: Listen and drop on 0 v6wildcard [::]:123 Oct 09 00:09:14 volumio ntpd[1017]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 09 00:09:14 volumio ntpd[1017]: Listen normally on 2 lo 127.0.0.1:123 Oct 09 00:09:14 volumio ntpd[1017]: Listen normally on 3 eth0 192.168.178.7:123 Oct 09 00:09:14 volumio ntpd[1017]: Listening on routing socket on fd #20 for interface updates Oct 09 00:09:14 volumio ntpd[1017]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 09 00:09:14 volumio ntpd[1017]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 09 00:09:14 volumio ifplugd(eth0)[792]: client: ifup: interface eth0 already configured Oct 09 00:09:14 volumio sh[565]: eth0=eth0 Oct 09 00:09:14 volumio ifplugd(eth0)[792]: Program executed successfully. Oct 09 00:09:15 volumio volumio[854]: info: Discovery: adding 035af7b2-7f1f-4ffe-8f43-ece295115eb4 Oct 09 00:09:15 volumio volumio[854]: info: Discovery: Found device Volumio Oct 09 00:09:15 volumio volumio[854]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:15 volumio volumio[854]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:15 volumio ntpd[1017]: Soliciting pool server 185.183.159.238 Oct 09 00:09:16 volumio ntpd[1017]: Soliciting pool server 168.119.239.121 Oct 09 00:09:16 volumio ntpd[1017]: Soliciting pool server 185.233.107.180 Oct 09 00:09:16 volumio nmbd[761]: [2024/10/09 00:09:16.570725, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 09 00:09:16 volumio systemd[1]: Started Samba NMB Daemon. Oct 09 00:09:16 volumio nmbd[761]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Oct 09 00:09:16 volumio systemd[1]: Starting Samba Winbind Daemon... Oct 09 00:09:16 volumio winbindd[1046]: [2024/10/09 00:09:16.867088, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Oct 09 00:09:16 volumio winbindd[1046]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Oct 09 00:09:16 volumio winbindd[1046]: [2024/10/09 00:09:16.876131, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 09 00:09:16 volumio winbindd[1046]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Oct 09 00:09:16 volumio systemd[1]: Started Samba Winbind Daemon. Oct 09 00:09:16 volumio systemd[1]: Starting Samba SMB Daemon... Oct 09 00:09:17 volumio smbd[1051]: [2024/10/09 00:09:17.312730, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 09 00:09:17 volumio systemd[1]: Started Samba SMB Daemon. Oct 09 00:09:17 volumio systemd[1]: Reached target Multi-User System. Oct 09 00:09:17 volumio smbd[1051]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Oct 09 00:09:17 volumio systemd[1]: Reached target Graphical Interface. Oct 09 00:09:17 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 09 00:09:17 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Oct 09 00:09:17 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 09 00:09:17 volumio systemd[1]: Startup finished in 9.785s (kernel) + 25.480s (userspace) = 35.266s. Oct 09 00:09:17 volumio ntpd[1017]: Soliciting pool server 78.47.249.55 Oct 09 00:09:17 volumio ntpd[1017]: Soliciting pool server 78.31.67.99 Oct 09 00:09:17 volumio ntpd[1017]: Soliciting pool server 195.201.19.162 Oct 09 00:09:18 volumio ntpd[1017]: Soliciting pool server 136.243.7.20 Oct 09 00:09:18 volumio ntpd[1017]: Soliciting pool server 46.4.54.78 Oct 09 00:09:18 volumio ntpd[1017]: Soliciting pool server 85.215.229.230 Oct 09 00:09:18 volumio ntpd[1017]: Soliciting pool server 144.76.76.107 Oct 09 00:09:19 volumio ntpd[1017]: Soliciting pool server 159.69.64.189 Oct 09 00:09:19 volumio ntpd[1017]: Soliciting pool server 185.252.140.125 Oct 09 00:09:19 volumio ntpd[1017]: Soliciting pool server 80.153.195.191 Oct 09 00:09:20 volumio ntpd[1017]: Soliciting pool server 78.46.53.2 Oct 09 00:09:20 volumio ntpd[1017]: Soliciting pool server 78.47.56.71 Oct 09 00:09:21 volumio ntpd[1017]: Soliciting pool server 88.99.86.9 Oct 09 00:09:21 volumio ntpd[1017]: Soliciting pool server 2001:41d0:700:49bc::1 Oct 09 00:09:21 volumio volumio-remote-updater[593]: [2024-10-09 00:09:21] [connect] Successful connection Oct 09 00:09:21 volumio volumio-remote-updater[593]: [2024-10-09 00:09:21] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1728425361 101 Oct 09 00:09:21 volumio volumio[854]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 5 Oct 09 00:09:21 volumio sudo[1061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 09 00:09:21 volumio sudo[1061]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:09:21 volumio sudo[1061]: pam_unix(sudo:session): session closed for user root Oct 09 00:09:21 volumio sudo[1063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 09 00:09:21 volumio sudo[1063]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:09:21 volumio sudo[1063]: pam_unix(sudo:session): session closed for user root Oct 09 00:09:21 volumio sudo[1067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 09 00:09:21 volumio sudo[1067]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:09:21 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Oct 09 00:09:21 volumio sudo[1067]: pam_unix(sudo:session): session closed for user root Oct 09 00:09:21 volumio volumio[854]: info: Upmpdcli Daemon Started Oct 09 00:09:21 volumio volumio[854]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Oct 09 00:09:23 volumio ntpd[1017]: receive: Unexpected origin timestamp 0xeab02c13.82de4ecf does not match aorg 0000000000.00000000 from server@195.201.19.162 xmt 0xeab02c13.ba950c95 Oct 09 00:09:23 volumio ntpd[1017]: receive: Unexpected origin timestamp 0xeab02c13.82dff9d3 does not match aorg 0000000000.00000000 from server@168.119.239.121 xmt 0xeab02c13.ba6e7800 Oct 09 00:09:23 volumio ntpd[1017]: receive: Unexpected origin timestamp 0xeab02c13.82d83e07 does not match aorg 0000000000.00000000 from server@78.46.53.2 xmt 0xeab02c13.ba8e8ff1 Oct 09 00:09:23 volumio ntpd[1017]: receive: Unexpected origin timestamp 0xeab02c13.82dd6e4b does not match aorg 0000000000.00000000 from server@85.215.229.230 xmt 0xeab02c13.bb5b8c0e Oct 09 00:09:23 volumio ntpd[1017]: receive: Unexpected origin timestamp 0xeab02c13.82dc8142 does not match aorg 0000000000.00000000 from server@80.153.195.191 xmt 0xeab02c13.bb7aca1e Oct 09 00:09:25 volumio volumio[854]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Oct 09 00:09:30 volumio systemd[1]: systemd-fsckd.service: Succeeded. Oct 09 00:09:31 volumio volumio[854]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Oct 09 00:09:33 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 00:09:33 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 00:09:33 volumio volumio[854]: info: Discovery: Getting this device information Oct 09 00:09:33 volumio volumio[854]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:33 volumio volumio[854]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:33 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 00:09:33 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 00:09:33 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 00:09:33 volumio volumio[854]: info: Discovery: Getting this device information Oct 09 00:09:33 volumio volumio[854]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:33 volumio volumio[854]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:33 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 00:09:33 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 00:09:33 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 00:09:33 volumio volumio[854]: info: Discovery: Getting this device information Oct 09 00:09:33 volumio volumio[854]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:33 volumio volumio[854]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:33 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 00:09:34 volumio volumio[854]: verbose: New Socket.io Connection to 192.168.178.7:3000 from 192.168.178.191 UA: Dart/3.4 (dart:io) Total Clients: 6 Oct 09 00:09:35 volumio volumio[854]: verbose: New Socket.io Connection to 192.168.178.7 from 192.168.178.191 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 7 Oct 09 00:09:35 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 09 00:09:35 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 09 00:09:35 volumio volumio[854]: info: CoreCommandRouter::volumioGetVisibleSources Oct 09 00:09:35 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 00:09:35 volumio volumio[854]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:35 volumio volumio[854]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:35 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 09 00:09:35 volumio volumio[854]: info: CoreCommandRouter::volumioGetQueue Oct 09 00:09:35 volumio volumio[854]: info: CoreStateMachine::getQueue Oct 09 00:09:35 volumio volumio[854]: info: CorePlayQueue::getQueue Oct 09 00:09:35 volumio volumio[854]: info: Listing playlists Oct 09 00:09:35 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 09 00:09:35 volumio volumio[854]: info: Received Get System Info Oct 09 00:09:35 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 00:09:35 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 00:09:35 volumio volumio[854]: info: Discovery: Getting this device information Oct 09 00:09:35 volumio volumio[854]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:35 volumio volumio[854]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:35 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 00:09:35 volumio volumio[854]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:35 volumio volumio[854]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:36 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Oct 09 00:09:37 volumio volumio[854]: verbose: New Socket.io Connection to 192.168.178.7 from 192.168.178.8 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/17.6 Safari/605.1.15 Total Clients: 8 Oct 09 00:09:37 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 09 00:09:37 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 09 00:09:37 volumio volumio[854]: info: CoreCommandRouter::volumioGetVisibleSources Oct 09 00:09:37 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 00:09:37 volumio volumio[854]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:37 volumio volumio[854]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:37 volumio volumio[854]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:37 volumio volumio[854]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:37 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 09 00:09:37 volumio volumio[854]: info: CoreCommandRouter::volumioGetQueue Oct 09 00:09:37 volumio volumio[854]: info: CoreStateMachine::getQueue Oct 09 00:09:37 volumio volumio[854]: info: CorePlayQueue::getQueue Oct 09 00:09:37 volumio volumio[854]: info: Listing playlists Oct 09 00:09:37 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 09 00:09:37 volumio volumio[854]: info: Received Get System Info Oct 09 00:09:37 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 00:09:37 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 00:09:37 volumio volumio[854]: info: Discovery: Getting this device information Oct 09 00:09:37 volumio volumio[854]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:37 volumio volumio[854]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:37 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 00:09:37 volumio volumio[854]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:37 volumio volumio[854]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:41 volumio volumio[854]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Oct 09 00:09:42 volumio volumio[854]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 09 00:09:42 volumio volumio[854]: info: CURURI: albums:// Oct 09 00:09:42 volumio volumio[854]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 09 00:09:42 volumio volumio[854]: TypeError: Cannot read property 'sendCommand' of undefined Oct 09 00:09:42 volumio volumio[854]: at /volumio/app/plugins/music_service/mpd/index.js:2986:22 Oct 09 00:09:42 volumio volumio[854]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Oct 09 00:09:42 volumio volumio[854]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 09 00:09:42 volumio sudo[1081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-09 00:08 Oct 09 00:09:42 volumio sudo[1081]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:09:42 volumio sudo[1081]: pam_unix(sudo:session): session closed for user root Oct 09 00:09:42 volumio volumio-remote-updater[593]: [2024-10-09 00:09:42] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 09 00:09:42 volumio volumio-remote-updater[593]: [2024-10-09 00:09:42] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 09 00:09:42 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 09 00:09:42 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 09 00:09:42 volumio systemd[1]: Started dynamicswap service. Oct 09 00:09:42 volumio systemd[1]: dynamicswap.service: Succeeded. Oct 09 00:09:43 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Oct 09 00:09:43 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Oct 09 00:09:43 volumio systemd[1]: Stopped Volumio Backend Module. Oct 09 00:09:43 volumio systemd[1]: Started Volumio Backend Module. Oct 09 00:09:43 volumio systemd[1]: Started dynamicswap service. Oct 09 00:09:43 volumio systemd[1]: dynamicswap.service: Succeeded. Oct 09 00:09:43 volumio volumio[1095]: info: ------------------------------------------- Oct 09 00:09:43 volumio volumio[1095]: info: ----- Volumio3 ---- Oct 09 00:09:43 volumio volumio[1095]: info: ------------------------------------------- Oct 09 00:09:43 volumio volumio[1095]: info: ----- System startup ---- Oct 09 00:09:43 volumio volumio[1095]: info: ------------------------------------------- Oct 09 00:09:43 volumio volumio[1095]: info: MYVOLUMIO Environment detected Oct 09 00:09:43 volumio volumio[1095]: info: Plugin folders cleanup Oct 09 00:09:43 volumio volumio[1095]: info: Scanning into folder /volumio/app/plugins/ Oct 09 00:09:43 volumio volumio[1095]: info: Scanning category audio_interface Oct 09 00:09:43 volumio volumio[1095]: info: Scanning category miscellanea Oct 09 00:09:43 volumio volumio[1095]: info: Scanning category music_service Oct 09 00:09:43 volumio volumio[1095]: info: Scanning category plugins.json Oct 09 00:09:43 volumio volumio[1095]: info: Scanning category system_controller Oct 09 00:09:43 volumio volumio[1095]: info: Scanning category user_interface Oct 09 00:09:43 volumio volumio[1095]: info: Scanning into folder /data/plugins/ Oct 09 00:09:43 volumio volumio[1095]: info: Scanning category audio_interface Oct 09 00:09:43 volumio volumio[1095]: info: Scanning category music_service Oct 09 00:09:43 volumio volumio[1095]: info: Scanning category system_hardware Oct 09 00:09:43 volumio volumio[1095]: info: Scanning category user_interface Oct 09 00:09:43 volumio volumio[1095]: info: Plugin folders cleanup completed Oct 09 00:09:43 volumio volumio[1095]: info: ------------------------------------------- Oct 09 00:09:43 volumio volumio[1095]: info: ----- Core plugins startup ---- Oct 09 00:09:43 volumio volumio[1095]: info: ------------------------------------------- Oct 09 00:09:43 volumio volumio[1095]: info: Loading plugins from folder /volumio/app/plugins/ Oct 09 00:09:43 volumio volumio[1095]: info: Adding plugin upnp to MyMusic Plugins Oct 09 00:09:43 volumio volumio[1095]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 09 00:09:43 volumio volumio[1095]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 09 00:09:43 volumio volumio[1095]: info: Loading plugins from folder /data/plugins/ Oct 09 00:09:43 volumio volumio[1095]: info: Loading plugin "system"... Oct 09 00:09:43 volumio volumio[1095]: info: Loading plugin "appearance"... Oct 09 00:09:43 volumio volumio[1095]: info: Loading plugin "network"... Oct 09 00:09:43 volumio volumio[1095]: info: Refreshing Cached IP Addresses Oct 09 00:09:43 volumio volumio[1095]: info: Loading plugin "services"... Oct 09 00:09:43 volumio sudo[1122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 09 00:09:43 volumio sudo[1122]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:09:43 volumio sudo[1122]: pam_unix(sudo:session): session closed for user root Oct 09 00:09:43 volumio volumio[1095]: info: Loading plugin "alsa_controller"... Oct 09 00:09:43 volumio sudo[1124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 09 00:09:43 volumio sudo[1124]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:09:43 volumio sudo[1124]: pam_unix(sudo:session): session closed for user root Oct 09 00:09:44 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "wizard"... Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "networkfs"... Oct 09 00:09:44 volumio volumio[1095]: info: Starting Udev Watcher for removable devices Oct 09 00:09:44 volumio volumio[1095]: info: Ignoring mount for partition: boot Oct 09 00:09:44 volumio volumio[1095]: info: Ignoring mount for partition: volumio Oct 09 00:09:44 volumio volumio[1095]: info: Ignoring mount for partition: volumio_data Oct 09 00:09:44 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "volumio_command_line_client"... Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "upnp"... Oct 09 00:09:44 volumio volumio[1095]: info: [1728425384030] Starting Upmpd Daemon Oct 09 00:09:44 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "my_music"... Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "mpd"... Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "upnp_browser"... Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "alarm-clock"... Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "airplay_emulation"... Oct 09 00:09:44 volumio volumio[1095]: info: Starting Shairport Sync Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "last_100"... Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "webradio"... Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "i2s_dacs"... Oct 09 00:09:44 volumio volumio[1095]: info: I2S DAC not set, start Auto-detection Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "volumiodiscovery"... Oct 09 00:09:44 volumio volumio[1095]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 09 00:09:44 volumio node[1095]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 09 00:09:44 volumio volumio[1095]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:09:44 volumio node[1095]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:09:44 volumio volumio[1095]: *** WARNING *** For more information see Oct 09 00:09:44 volumio node[1095]: *** WARNING *** For more information see Oct 09 00:09:44 volumio volumio[1095]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 09 00:09:44 volumio node[1095]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 09 00:09:44 volumio volumio[1095]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:09:44 volumio node[1095]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:09:44 volumio volumio[1095]: *** WARNING *** For more information see Oct 09 00:09:44 volumio node[1095]: *** WARNING *** For more information see Oct 09 00:09:44 volumio volumio[1095]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 09 00:09:44 volumio volumio[1095]: info: Discovery: Started advertising with name: Volumio Oct 09 00:09:44 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 09 00:09:44 volumio volumio[1095]: info: Plugin spop is not enabled Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "gpio-buttons"... Oct 09 00:09:44 volumio volumio[1095]: info: GPIO-Buttons initialized Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "peppy_screensaver"... Oct 09 00:09:44 volumio volumio[1095]: info: Applying required configuration parameters for plugin peppy_screensaver Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "outputs"... Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "albumart"... Oct 09 00:09:44 volumio volumio[1095]: info: Plugin example_plugin is not enabled Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "inputs"... Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "updater_comm"... Oct 09 00:09:44 volumio volumio[1095]: info: Plugin mpdemulation is not enabled Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "rest_api"... Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "websocket"... Oct 09 00:09:44 volumio volumio[1095]: info: Plugin fusiondsp is not enabled Oct 09 00:09:44 volumio volumio[1095]: info: Plugin radio_paradise is not enabled Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "gpio_control"... Oct 09 00:09:44 volumio volumio[1095]: Forking 3 albumart workers Oct 09 00:09:44 volumio volumio[1095]: info: Applying required configuration parameters for plugin gpio_control Oct 09 00:09:44 volumio volumio[1095]: info: [GPIO_Control] Detected Raspberry Pi 5 Model B Rev 1.0 Oct 09 00:09:44 volumio volumio[1095]: info: [GPIO_Control] 40 GPIOs: true Oct 09 00:09:44 volumio volumio[1095]: info: [GPIO_Control] Initialized Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "rotaryencoder2"... Oct 09 00:09:44 volumio volumio[1095]: info: Plugin Systeminfo is not enabled Oct 09 00:09:44 volumio volumio[1095]: info: Loading plugin "touch_display"... Oct 09 00:09:44 volumio volumio[1095]: Starting albumart workers Oct 09 00:09:44 volumio volumio[1095]: Starting albumart workers Oct 09 00:09:44 volumio volumio[1095]: info: Applying required configuration parameters for plugin touch_display Oct 09 00:09:44 volumio volumio[1095]: info: Loading i18n strings for locale en Oct 09 00:09:44 volumio volumio[1095]: Updating browse sources language Oct 09 00:09:44 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 00:09:44 volumio volumio[1095]: Starting albumart workers Oct 09 00:09:44 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 00:09:44 volumio volumio[1095]: info: CoreCommandRouter::initPlayerControls Oct 09 00:09:44 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:44 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:44 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:44 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:44 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:44 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:44 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:44 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:44 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 00:09:44 volumio volumio[1095]: Express server listening on port 3000 Oct 09 00:09:44 volumio volumio[1095]: [Metrics] WebUI: 1s 351.43ms Oct 09 00:09:44 volumio volumio[1095]: info: CoreStateMachine::resetVolumioState Oct 09 00:09:44 volumio volumio[1095]: info: CoreStateMachine::getcurrentVolume Oct 09 00:09:44 volumio volumio[1095]: info: CoreCommandRouter::volumioRetrievevolume Oct 09 00:09:44 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 09 00:09:44 volumio volumio[1095]: verbose: New Socket.io Connection to 192.168.178.7:3000 from 192.168.178.191 UA: Dart/3.4 (dart:io) Total Clients: 1 Oct 09 00:09:44 volumio systemd[1]: mnt-NAS-music_cd-alben.automount: Got automount request for /mnt/NAS/music_cd/alben, triggered by 1095 (node) Oct 09 00:09:44 volumio systemd[1]: Mounting /mnt/NAS/music_cd/alben... Oct 09 00:09:45 volumio kernel: Key type cifs.spnego registered Oct 09 00:09:45 volumio kernel: Key type cifs.idmap registered Oct 09 00:09:45 volumio kernel: CIFS: Attempting to mount \\192.168.178.6\music_cd Oct 09 00:09:46 volumio systemd[1]: Mounted /mnt/NAS/music_cd/alben. Oct 09 00:09:46 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 00:09:46 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 00:09:46 volumio volumio[1095]: info: Discovery: Getting this device information Oct 09 00:09:46 volumio volumio[1095]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:46 volumio volumio[1095]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:46 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 00:09:46 volumio volumio[1095]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Oct 09 00:09:46 volumio volumio[1095]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 Oct 09 00:09:46 volumio volumio[1095]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4 Oct 09 00:09:46 volumio volumio[1095]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5 Oct 09 00:09:46 volumio volumio[1095]: info: CoreStateMachine::pushState Oct 09 00:09:46 volumio volumio[1095]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:46 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 00:09:46 volumio volumio[1095]: info: CoreCommandRouter::volumioPushState Oct 09 00:09:46 volumio volumio[1095]: info: CoreStateMachine::updateTrackBlock Oct 09 00:09:46 volumio volumio[1095]: info: CorePlayQueue::getTrackBlock Oct 09 00:09:46 volumio volumio[1095]: info: CoreCommandRouter::volumioRetrievevolume Oct 09 00:09:46 volumio volumio[1095]: info: Reloading queue from file Oct 09 00:09:46 volumio volumio[1095]: info: CoreStateMachine::setRepeat null single undefined Oct 09 00:09:46 volumio volumio[1095]: info: CoreStateMachine::pushState Oct 09 00:09:46 volumio volumio[1095]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:46 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 00:09:46 volumio volumio[1095]: info: CoreCommandRouter::volumioPushState Oct 09 00:09:46 volumio volumio[1095]: info: CoreStateMachine::setRandom null Oct 09 00:09:46 volumio volumio[1095]: info: CoreStateMachine::pushState Oct 09 00:09:46 volumio volumio[1095]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:46 volumio volumio[1095]: info: CoreCommandRouter::volumioPushState Oct 09 00:09:46 volumio volumio[1095]: info: Setting Device type: Raspberry PI Oct 09 00:09:46 volumio volumio[1095]: info: CoreStateMachine::pushState Oct 09 00:09:46 volumio volumio[1095]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:46 volumio volumio[1095]: info: CoreCommandRouter::volumioPushState Oct 09 00:09:46 volumio volumio[1095]: info: Discovery: adding 035af7b2-7f1f-4ffe-8f43-ece295115eb4 Oct 09 00:09:46 volumio volumio[1095]: info: Discovery: Found device Volumio Oct 09 00:09:46 volumio volumio[1095]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:46 volumio volumio[1095]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:46 volumio volumio[1095]: verbose: New Socket.io Connection to 192.168.178.7 from 192.168.178.191 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 6 Oct 09 00:09:46 volumio volumio[1095]: verbose: New Socket.io Connection to 192.168.178.7 from 192.168.178.191 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 7 Oct 09 00:09:47 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 09 00:09:47 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 09 00:09:47 volumio volumio[1095]: info: CoreCommandRouter::volumioGetVisibleSources Oct 09 00:09:47 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 00:09:47 volumio volumio[1095]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:47 volumio volumio[1095]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:47 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 09 00:09:47 volumio volumio[1095]: info: CoreCommandRouter::volumioGetQueue Oct 09 00:09:47 volumio volumio[1095]: info: CoreStateMachine::getQueue Oct 09 00:09:47 volumio volumio[1095]: info: CorePlayQueue::getQueue Oct 09 00:09:47 volumio volumio[1095]: info: Listing playlists Oct 09 00:09:47 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 09 00:09:47 volumio volumio[1095]: info: Received Get System Info Oct 09 00:09:47 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 00:09:47 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 00:09:47 volumio volumio[1095]: info: Discovery: Getting this device information Oct 09 00:09:47 volumio volumio[1095]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:47 volumio volumio[1095]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:47 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 00:09:47 volumio volumio[1095]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:47 volumio volumio[1095]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:47 volumio volumio-remote-updater[593]: [2024-10-09 00:09:47] [connect] Successful connection Oct 09 00:09:47 volumio volumio-remote-updater[593]: [2024-10-09 00:09:47] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1728425387 101 Oct 09 00:09:47 volumio volumio[1095]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 8 Oct 09 00:09:48 volumio systemd[1]: mnt-NAS-music_cd-chillout.automount: Got automount request for /mnt/NAS/music_cd/chillout, triggered by 1095 (node) Oct 09 00:09:48 volumio systemd[1]: Mounting /mnt/NAS/music_cd/chillout... Oct 09 00:09:48 volumio kernel: CIFS: Attempting to mount \\192.168.178.6\music_cd Oct 09 00:09:48 volumio systemd[1]: Mounted /mnt/NAS/music_cd/chillout. Oct 09 00:09:48 volumio systemd[1]: mnt-NAS-music_cd-classic.automount: Got automount request for /mnt/NAS/music_cd/classic, triggered by 1095 (node) Oct 09 00:09:48 volumio systemd[1]: Mounting /mnt/NAS/music_cd/classic... Oct 09 00:09:48 volumio kernel: CIFS: Attempting to mount \\192.168.178.6\music_cd Oct 09 00:09:48 volumio systemd[1]: Mounted /mnt/NAS/music_cd/classic. Oct 09 00:09:49 volumio systemd[1]: mnt-NAS-music_cd-electronic.automount: Got automount request for /mnt/NAS/music_cd/electronic, triggered by 1095 (node) Oct 09 00:09:49 volumio systemd[1]: Mounting /mnt/NAS/music_cd/electronic... Oct 09 00:09:49 volumio kernel: CIFS: Attempting to mount \\192.168.178.6\music_cd Oct 09 00:09:49 volumio systemd[1]: Mounted /mnt/NAS/music_cd/electronic. Oct 09 00:09:49 volumio systemd[1]: mnt-NAS-music_cd-jazz.automount: Got automount request for /mnt/NAS/music_cd/jazz, triggered by 1095 (node) Oct 09 00:09:49 volumio systemd[1]: Mounting /mnt/NAS/music_cd/jazz... Oct 09 00:09:49 volumio kernel: CIFS: Attempting to mount \\192.168.178.6\music_cd Oct 09 00:09:49 volumio systemd[1]: Mounted /mnt/NAS/music_cd/jazz. Oct 09 00:09:49 volumio systemd[1]: mnt-NAS-music_cd-sampler.automount: Got automount request for /mnt/NAS/music_cd/sampler, triggered by 1095 (node) Oct 09 00:09:49 volumio systemd[1]: Mounting /mnt/NAS/music_cd/sampler... Oct 09 00:09:49 volumio kernel: CIFS: Attempting to mount \\192.168.178.6\music_cd Oct 09 00:09:49 volumio systemd[1]: Mounted /mnt/NAS/music_cd/sampler. Oct 09 00:09:53 volumio systemd[1]: mnt-NAS-music_cd-soundtrack.automount: Got automount request for /mnt/NAS/music_cd/soundtrack, triggered by 1095 (node) Oct 09 00:09:53 volumio systemd[1]: Mounting /mnt/NAS/music_cd/soundtrack... Oct 09 00:09:53 volumio kernel: CIFS: Attempting to mount \\192.168.178.6\music_cd Oct 09 00:09:53 volumio systemd[1]: Mounted /mnt/NAS/music_cd/soundtrack. Oct 09 00:09:54 volumio sudo[1257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 09 00:09:54 volumio sudo[1257]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:09:54 volumio sudo[1257]: pam_unix(sudo:session): session closed for user root Oct 09 00:09:54 volumio sudo[1260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 09 00:09:54 volumio sudo[1260]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:09:54 volumio sudo[1260]: pam_unix(sudo:session): session closed for user root Oct 09 00:09:54 volumio sudo[1263]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 09 00:09:54 volumio sudo[1263]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:09:54 volumio sudo[1263]: pam_unix(sudo:session): session closed for user root Oct 09 00:09:54 volumio volumio[1095]: info: Upmpdcli Daemon Started Oct 09 00:09:54 volumio systemd[1]: mnt-NAS-music_cd-xmas.automount: Got automount request for /mnt/NAS/music_cd/xmas, triggered by 1095 (node) Oct 09 00:09:54 volumio systemd[1]: Mounting /mnt/NAS/music_cd/xmas... Oct 09 00:09:54 volumio kernel: CIFS: Attempting to mount \\192.168.178.6\music_cd Oct 09 00:09:54 volumio systemd[1]: Mounted /mnt/NAS/music_cd/xmas. Oct 09 00:09:54 volumio systemd[1]: mnt-NAS-music_hd-alben.automount: Got automount request for /mnt/NAS/music_hd/alben, triggered by 1095 (node) Oct 09 00:09:54 volumio systemd[1]: Mounting /mnt/NAS/music_hd/alben... Oct 09 00:09:54 volumio kernel: CIFS: Attempting to mount \\192.168.178.6\music_hd Oct 09 00:09:54 volumio systemd[1]: Mounted /mnt/NAS/music_hd/alben. Oct 09 00:09:55 volumio volumio[1095]: verbose: New Socket.io Connection to 192.168.178.7 from 192.168.178.8 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/17.6 Safari/605.1.15 Total Clients: 9 Oct 09 00:09:55 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 09 00:09:56 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 09 00:09:56 volumio volumio[1095]: info: CoreCommandRouter::volumioGetVisibleSources Oct 09 00:09:56 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 00:09:56 volumio volumio[1095]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:56 volumio volumio[1095]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:56 volumio volumio[1095]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:56 volumio volumio[1095]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:56 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 09 00:09:56 volumio volumio[1095]: info: CoreCommandRouter::volumioGetQueue Oct 09 00:09:56 volumio volumio[1095]: info: CoreStateMachine::getQueue Oct 09 00:09:56 volumio volumio[1095]: info: CorePlayQueue::getQueue Oct 09 00:09:56 volumio volumio[1095]: info: Listing playlists Oct 09 00:09:56 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 09 00:09:56 volumio volumio[1095]: info: Received Get System Info Oct 09 00:09:56 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 00:09:56 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 00:09:56 volumio volumio[1095]: info: Discovery: Getting this device information Oct 09 00:09:56 volumio volumio[1095]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:56 volumio volumio[1095]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:56 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 00:09:56 volumio volumio[1095]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:56 volumio volumio[1095]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:56 volumio volumio[1095]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 09 00:09:56 volumio volumio[1095]: info: CURURI: albums:// Oct 09 00:09:56 volumio volumio[1095]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 09 00:09:56 volumio volumio[1095]: TypeError: Cannot read property 'sendCommand' of undefined Oct 09 00:09:56 volumio volumio[1095]: at /volumio/app/plugins/music_service/mpd/index.js:2986:22 Oct 09 00:09:56 volumio volumio[1095]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Oct 09 00:09:56 volumio volumio[1095]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 09 00:09:56 volumio sudo[1280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-09 00:08 Oct 09 00:09:56 volumio sudo[1280]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:09:57 volumio sudo[1280]: pam_unix(sudo:session): session closed for user root Oct 09 00:09:57 volumio volumio-remote-updater[593]: [2024-10-09 00:09:57] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 09 00:09:57 volumio volumio-remote-updater[593]: [2024-10-09 00:09:57] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 09 00:09:57 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 09 00:09:57 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 09 00:09:57 volumio systemd[1]: Started dynamicswap service. Oct 09 00:09:57 volumio systemd[1]: dynamicswap.service: Succeeded. Oct 09 00:09:57 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Oct 09 00:09:57 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Oct 09 00:09:57 volumio systemd[1]: Started dynamicswap service. Oct 09 00:09:57 volumio systemd[1]: Stopped Volumio Backend Module. Oct 09 00:09:57 volumio systemd[1]: Started Volumio Backend Module. Oct 09 00:09:57 volumio systemd[1]: dynamicswap.service: Succeeded. Oct 09 00:09:57 volumio volumio[1292]: info: ------------------------------------------- Oct 09 00:09:57 volumio volumio[1292]: info: ----- Volumio3 ---- Oct 09 00:09:57 volumio volumio[1292]: info: ------------------------------------------- Oct 09 00:09:57 volumio volumio[1292]: info: ----- System startup ---- Oct 09 00:09:57 volumio volumio[1292]: info: ------------------------------------------- Oct 09 00:09:57 volumio volumio[1292]: info: MYVOLUMIO Environment detected Oct 09 00:09:57 volumio volumio[1292]: info: Plugin folders cleanup Oct 09 00:09:57 volumio volumio[1292]: info: Scanning into folder /volumio/app/plugins/ Oct 09 00:09:57 volumio volumio[1292]: info: Scanning category audio_interface Oct 09 00:09:57 volumio volumio[1292]: info: Scanning category miscellanea Oct 09 00:09:57 volumio volumio[1292]: info: Scanning category music_service Oct 09 00:09:57 volumio volumio[1292]: info: Scanning category plugins.json Oct 09 00:09:57 volumio volumio[1292]: info: Scanning category system_controller Oct 09 00:09:57 volumio volumio[1292]: info: Scanning category user_interface Oct 09 00:09:57 volumio volumio[1292]: info: Scanning into folder /data/plugins/ Oct 09 00:09:57 volumio volumio[1292]: info: Scanning category audio_interface Oct 09 00:09:57 volumio volumio[1292]: info: Scanning category music_service Oct 09 00:09:57 volumio volumio[1292]: info: Scanning category system_hardware Oct 09 00:09:57 volumio volumio[1292]: info: Scanning category user_interface Oct 09 00:09:57 volumio volumio[1292]: info: Plugin folders cleanup completed Oct 09 00:09:57 volumio volumio[1292]: info: ------------------------------------------- Oct 09 00:09:57 volumio volumio[1292]: info: ----- Core plugins startup ---- Oct 09 00:09:57 volumio volumio[1292]: info: ------------------------------------------- Oct 09 00:09:57 volumio volumio[1292]: info: Loading plugins from folder /volumio/app/plugins/ Oct 09 00:09:57 volumio volumio[1292]: info: Adding plugin upnp to MyMusic Plugins Oct 09 00:09:57 volumio volumio[1292]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 09 00:09:57 volumio volumio[1292]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 09 00:09:57 volumio volumio[1292]: info: Loading plugins from folder /data/plugins/ Oct 09 00:09:57 volumio volumio[1292]: info: Loading plugin "system"... Oct 09 00:09:57 volumio volumio[1292]: info: Loading plugin "appearance"... Oct 09 00:09:57 volumio volumio[1292]: info: Loading plugin "network"... Oct 09 00:09:57 volumio volumio[1292]: info: Refreshing Cached IP Addresses Oct 09 00:09:57 volumio sudo[1318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 09 00:09:57 volumio volumio[1292]: info: Loading plugin "services"... Oct 09 00:09:57 volumio sudo[1318]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:09:57 volumio volumio[1292]: info: Loading plugin "alsa_controller"... Oct 09 00:09:57 volumio sudo[1318]: pam_unix(sudo:session): session closed for user root Oct 09 00:09:57 volumio sudo[1320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 09 00:09:57 volumio sudo[1320]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:09:57 volumio sudo[1320]: pam_unix(sudo:session): session closed for user root Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "wizard"... Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "networkfs"... Oct 09 00:09:58 volumio volumio[1292]: info: Starting Udev Watcher for removable devices Oct 09 00:09:58 volumio volumio[1292]: info: Ignoring mount for partition: boot Oct 09 00:09:58 volumio volumio[1292]: info: Ignoring mount for partition: volumio Oct 09 00:09:58 volumio volumio[1292]: info: Ignoring mount for partition: volumio_data Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "volumio_command_line_client"... Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "upnp"... Oct 09 00:09:58 volumio volumio[1292]: info: [1728425398019] Starting Upmpd Daemon Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "my_music"... Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "mpd"... Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "upnp_browser"... Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "alarm-clock"... Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "airplay_emulation"... Oct 09 00:09:58 volumio volumio[1292]: info: Starting Shairport Sync Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "last_100"... Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "webradio"... Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "i2s_dacs"... Oct 09 00:09:58 volumio volumio[1292]: info: I2S DAC not set, start Auto-detection Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "volumiodiscovery"... Oct 09 00:09:58 volumio volumio[1292]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 09 00:09:58 volumio node[1292]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 09 00:09:58 volumio node[1292]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:09:58 volumio volumio[1292]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:09:58 volumio volumio[1292]: *** WARNING *** For more information see Oct 09 00:09:58 volumio volumio[1292]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 09 00:09:58 volumio volumio[1292]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:09:58 volumio volumio[1292]: *** WARNING *** For more information see Oct 09 00:09:58 volumio node[1292]: *** WARNING *** For more information see Oct 09 00:09:58 volumio node[1292]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 09 00:09:58 volumio node[1292]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:09:58 volumio node[1292]: *** WARNING *** For more information see Oct 09 00:09:58 volumio volumio[1292]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 09 00:09:58 volumio volumio[1292]: info: Discovery: Started advertising with name: Volumio Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 09 00:09:58 volumio volumio[1292]: info: Plugin spop is not enabled Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "gpio-buttons"... Oct 09 00:09:58 volumio volumio[1292]: info: GPIO-Buttons initialized Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "peppy_screensaver"... Oct 09 00:09:58 volumio volumio[1292]: info: Applying required configuration parameters for plugin peppy_screensaver Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "outputs"... Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "albumart"... Oct 09 00:09:58 volumio volumio[1292]: info: Plugin example_plugin is not enabled Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "inputs"... Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "updater_comm"... Oct 09 00:09:58 volumio volumio[1292]: info: Plugin mpdemulation is not enabled Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "rest_api"... Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "websocket"... Oct 09 00:09:58 volumio volumio[1292]: info: Plugin fusiondsp is not enabled Oct 09 00:09:58 volumio volumio[1292]: info: Plugin radio_paradise is not enabled Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "gpio_control"... Oct 09 00:09:58 volumio volumio[1292]: Forking 3 albumart workers Oct 09 00:09:58 volumio volumio[1292]: info: Applying required configuration parameters for plugin gpio_control Oct 09 00:09:58 volumio volumio[1292]: info: [GPIO_Control] Detected Raspberry Pi 5 Model B Rev 1.0 Oct 09 00:09:58 volumio volumio[1292]: info: [GPIO_Control] 40 GPIOs: true Oct 09 00:09:58 volumio volumio[1292]: info: [GPIO_Control] Initialized Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "rotaryencoder2"... Oct 09 00:09:58 volumio volumio[1292]: info: Plugin Systeminfo is not enabled Oct 09 00:09:58 volumio volumio[1292]: info: Loading plugin "touch_display"... Oct 09 00:09:58 volumio volumio[1292]: Starting albumart workers Oct 09 00:09:58 volumio volumio[1292]: Starting albumart workers Oct 09 00:09:58 volumio volumio[1292]: info: Applying required configuration parameters for plugin touch_display Oct 09 00:09:58 volumio volumio[1292]: Starting albumart workers Oct 09 00:09:58 volumio volumio[1292]: info: Loading i18n strings for locale en Oct 09 00:09:58 volumio volumio[1292]: Updating browse sources language Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::initPlayerControls Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 00:09:58 volumio volumio[1292]: Express server listening on port 3000 Oct 09 00:09:58 volumio volumio[1292]: [Metrics] WebUI: 1s 351.14ms Oct 09 00:09:58 volumio volumio[1292]: info: CoreStateMachine::resetVolumioState Oct 09 00:09:58 volumio volumio[1292]: info: CoreStateMachine::getcurrentVolume Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::volumioRetrievevolume Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 09 00:09:58 volumio volumio[1292]: verbose: New Socket.io Connection to 192.168.178.7:3000 from 192.168.178.191 UA: Dart/3.4 (dart:io) Total Clients: 1 Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 00:09:58 volumio volumio[1292]: info: Discovery: Getting this device information Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:58 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 00:09:58 volumio volumio[1292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Oct 09 00:09:58 volumio volumio[1292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 Oct 09 00:09:58 volumio volumio[1292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4 Oct 09 00:09:58 volumio volumio[1292]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5 Oct 09 00:09:58 volumio volumio[1292]: info: CoreStateMachine::pushState Oct 09 00:09:58 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Oct 09 00:09:58 volumio volumio[1292]: info: CoreStateMachine::updateTrackBlock Oct 09 00:09:58 volumio volumio[1292]: info: CorePlayQueue::getTrackBlock Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::volumioRetrievevolume Oct 09 00:09:58 volumio volumio[1292]: info: Reloading queue from file Oct 09 00:09:58 volumio volumio[1292]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Oct 09 00:09:58 volumio volumio[1292]: info: CoreStateMachine::setRepeat null single undefined Oct 09 00:09:58 volumio volumio[1292]: info: CoreStateMachine::pushState Oct 09 00:09:58 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Oct 09 00:09:58 volumio volumio[1292]: info: CoreStateMachine::setRandom null Oct 09 00:09:58 volumio volumio[1292]: info: CoreStateMachine::pushState Oct 09 00:09:58 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Oct 09 00:09:58 volumio volumio[1292]: info: CoreStateMachine::pushState Oct 09 00:09:58 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Oct 09 00:09:58 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Oct 09 00:09:58 volumio volumio[1292]: info: Setting Device type: Raspberry PI Oct 09 00:09:59 volumio volumio[1292]: verbose: New Socket.io Connection to 192.168.178.7 from 192.168.178.191 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 6 Oct 09 00:09:59 volumio volumio[1292]: info: Discovery: adding 035af7b2-7f1f-4ffe-8f43-ece295115eb4 Oct 09 00:09:59 volumio volumio[1292]: info: Discovery: Found device Volumio Oct 09 00:09:59 volumio volumio[1292]: info: CoreCommandRouter::volumioGetState Oct 09 00:09:59 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:00 volumio volumio[1292]: verbose: New Socket.io Connection to 192.168.178.7 from 192.168.178.191 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 7 Oct 09 00:10:00 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 09 00:10:00 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 09 00:10:00 volumio volumio[1292]: info: CoreCommandRouter::volumioGetVisibleSources Oct 09 00:10:00 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 00:10:00 volumio volumio[1292]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:00 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:00 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 09 00:10:00 volumio volumio[1292]: info: CoreCommandRouter::volumioGetQueue Oct 09 00:10:00 volumio volumio[1292]: info: CoreStateMachine::getQueue Oct 09 00:10:00 volumio volumio[1292]: info: CorePlayQueue::getQueue Oct 09 00:10:00 volumio volumio[1292]: info: Listing playlists Oct 09 00:10:00 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 09 00:10:00 volumio volumio[1292]: info: Received Get System Info Oct 09 00:10:00 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 00:10:00 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 00:10:00 volumio volumio[1292]: info: Discovery: Getting this device information Oct 09 00:10:00 volumio volumio[1292]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:00 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:00 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 00:10:00 volumio volumio[1292]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:00 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:02 volumio volumio-remote-updater[593]: [2024-10-09 00:10:02] [connect] Successful connection Oct 09 00:10:02 volumio volumio-remote-updater[593]: [2024-10-09 00:10:02] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1728425402 101 Oct 09 00:10:02 volumio volumio[1292]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 8 Oct 09 00:10:03 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 00:10:03 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 00:10:03 volumio volumio[1292]: info: Discovery: Getting this device information Oct 09 00:10:03 volumio volumio[1292]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:03 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:03 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 00:10:08 volumio sudo[1444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 09 00:10:08 volumio sudo[1444]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:10:08 volumio sudo[1444]: pam_unix(sudo:session): session closed for user root Oct 09 00:10:08 volumio sudo[1447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 09 00:10:08 volumio sudo[1447]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:10:08 volumio sudo[1447]: pam_unix(sudo:session): session closed for user root Oct 09 00:10:08 volumio sudo[1450]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 09 00:10:08 volumio sudo[1450]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:10:08 volumio sudo[1450]: pam_unix(sudo:session): session closed for user root Oct 09 00:10:08 volumio volumio[1292]: info: Upmpdcli Daemon Started Oct 09 00:10:08 volumio volumio[1292]: verbose: New Socket.io Connection to 192.168.178.7 from 192.168.178.8 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/17.6 Safari/605.1.15 Total Clients: 9 Oct 09 00:10:08 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 09 00:10:08 volumio volumio[1292]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 09 00:10:08 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 09 00:10:08 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 09 00:10:08 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 09 00:10:08 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 09 00:10:08 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 00:10:08 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 00:10:08 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 00:10:08 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 00:10:08 volumio volumio[1292]: info: CoreCommandRouter::volumioGetBrowseSources Oct 09 00:10:08 volumio volumio[1292]: info: CoreCommandRouter::volumioGetBrowseSources Oct 09 00:10:08 volumio volumio[1292]: info: CoreCommandRouter::volumioGetBrowseSources Oct 09 00:10:09 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 09 00:10:09 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 09 00:10:09 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 09 00:10:09 volumio volumio[1292]: info: CoreCommandRouter::volumioGetVisibleSources Oct 09 00:10:09 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 00:10:09 volumio volumio[1292]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:09 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:09 volumio volumio[1292]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:09 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:09 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 09 00:10:09 volumio volumio[1292]: info: CoreCommandRouter::volumioGetQueue Oct 09 00:10:09 volumio volumio[1292]: info: CoreStateMachine::getQueue Oct 09 00:10:09 volumio volumio[1292]: info: CorePlayQueue::getQueue Oct 09 00:10:09 volumio volumio[1292]: info: Listing playlists Oct 09 00:10:09 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 09 00:10:09 volumio volumio[1292]: info: Received Get System Info Oct 09 00:10:09 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 00:10:09 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 00:10:09 volumio volumio[1292]: info: Discovery: Getting this device information Oct 09 00:10:09 volumio volumio[1292]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:09 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:09 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 00:10:09 volumio volumio[1292]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:09 volumio volumio[1292]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:12 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 09 00:10:14 volumio volumio[1292]: info: Disabling MyMusic plugin upnp_browser Oct 09 00:10:14 volumio volumio[1292]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesMedia Servers Oct 09 00:10:14 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 00:10:14 volumio volumio[1292]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 09 00:10:14 volumio volumio[1292]: TypeError: Cannot read property 'stop' of undefined Oct 09 00:10:14 volumio volumio[1292]: at ControllerUPNPBrowser.onStop (/volumio/app/plugins/music_service/upnp_browser/index.js:147:10) Oct 09 00:10:14 volumio volumio[1292]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Oct 09 00:10:14 volumio volumio[1292]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Oct 09 00:10:14 volumio volumio[1292]: at PluginManager.enableDisableMyMusicPlugin (/volumio/app/pluginmanager.js:2048:26) Oct 09 00:10:14 volumio volumio[1292]: at CoreCommandRouter.enableDisableMyMusicPlugin (/volumio/app/index.js:2077:29) Oct 09 00:10:14 volumio volumio[1292]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1866:59) Oct 09 00:10:14 volumio volumio[1292]: at Socket.emit (events.js:315:20) Oct 09 00:10:14 volumio volumio[1292]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 09 00:10:14 volumio volumio[1292]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Oct 09 00:10:14 volumio volumio[1292]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 09 00:10:14 volumio sudo[1461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-09 00:09 Oct 09 00:10:14 volumio sudo[1461]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:10:14 volumio sudo[1461]: pam_unix(sudo:session): session closed for user root Oct 09 00:10:14 volumio volumio-remote-updater[593]: [2024-10-09 00:10:14] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 09 00:10:14 volumio volumio-remote-updater[593]: [2024-10-09 00:10:14] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 09 00:10:14 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 09 00:10:14 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 09 00:10:14 volumio systemd[1]: Started dynamicswap service. Oct 09 00:10:14 volumio systemd[1]: dynamicswap.service: Succeeded. Oct 09 00:10:14 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Oct 09 00:10:14 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Oct 09 00:10:14 volumio systemd[1]: Started dynamicswap service. Oct 09 00:10:14 volumio systemd[1]: Stopped Volumio Backend Module. Oct 09 00:10:14 volumio systemd[1]: Started Volumio Backend Module. Oct 09 00:10:14 volumio systemd[1]: dynamicswap.service: Succeeded. Oct 09 00:10:15 volumio volumio[1475]: info: ------------------------------------------- Oct 09 00:10:15 volumio volumio[1475]: info: ----- Volumio3 ---- Oct 09 00:10:15 volumio volumio[1475]: info: ------------------------------------------- Oct 09 00:10:15 volumio volumio[1475]: info: ----- System startup ---- Oct 09 00:10:15 volumio volumio[1475]: info: ------------------------------------------- Oct 09 00:10:15 volumio volumio[1475]: info: MYVOLUMIO Environment detected Oct 09 00:10:15 volumio volumio[1475]: info: Plugin folders cleanup Oct 09 00:10:15 volumio volumio[1475]: info: Scanning into folder /volumio/app/plugins/ Oct 09 00:10:15 volumio volumio[1475]: info: Scanning category audio_interface Oct 09 00:10:15 volumio volumio[1475]: info: Scanning category miscellanea Oct 09 00:10:15 volumio volumio[1475]: info: Scanning category music_service Oct 09 00:10:15 volumio volumio[1475]: info: Scanning category plugins.json Oct 09 00:10:15 volumio volumio[1475]: info: Scanning category system_controller Oct 09 00:10:15 volumio volumio[1475]: info: Scanning category user_interface Oct 09 00:10:15 volumio volumio[1475]: info: Scanning into folder /data/plugins/ Oct 09 00:10:15 volumio volumio[1475]: info: Scanning category audio_interface Oct 09 00:10:15 volumio volumio[1475]: info: Scanning category music_service Oct 09 00:10:15 volumio volumio[1475]: info: Scanning category system_hardware Oct 09 00:10:15 volumio volumio[1475]: info: Scanning category user_interface Oct 09 00:10:15 volumio volumio[1475]: info: Plugin folders cleanup completed Oct 09 00:10:15 volumio volumio[1475]: info: ------------------------------------------- Oct 09 00:10:15 volumio volumio[1475]: info: ----- Core plugins startup ---- Oct 09 00:10:15 volumio volumio[1475]: info: ------------------------------------------- Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugins from folder /volumio/app/plugins/ Oct 09 00:10:15 volumio volumio[1475]: info: Adding plugin upnp to MyMusic Plugins Oct 09 00:10:15 volumio volumio[1475]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 09 00:10:15 volumio volumio[1475]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugins from folder /data/plugins/ Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "system"... Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "appearance"... Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "network"... Oct 09 00:10:15 volumio volumio[1475]: info: Refreshing Cached IP Addresses Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "services"... Oct 09 00:10:15 volumio sudo[1501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 09 00:10:15 volumio sudo[1501]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "alsa_controller"... Oct 09 00:10:15 volumio sudo[1501]: pam_unix(sudo:session): session closed for user root Oct 09 00:10:15 volumio sudo[1503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 09 00:10:15 volumio sudo[1503]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:10:15 volumio sudo[1503]: pam_unix(sudo:session): session closed for user root Oct 09 00:10:15 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "wizard"... Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "networkfs"... Oct 09 00:10:15 volumio volumio[1475]: info: Starting Udev Watcher for removable devices Oct 09 00:10:15 volumio volumio[1475]: info: Ignoring mount for partition: boot Oct 09 00:10:15 volumio volumio[1475]: info: Ignoring mount for partition: volumio Oct 09 00:10:15 volumio volumio[1475]: info: Ignoring mount for partition: volumio_data Oct 09 00:10:15 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "volumio_command_line_client"... Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "upnp"... Oct 09 00:10:15 volumio volumio[1475]: info: [1728425415525] Starting Upmpd Daemon Oct 09 00:10:15 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "my_music"... Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "mpd"... Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "upnp_browser"... Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "alarm-clock"... Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "airplay_emulation"... Oct 09 00:10:15 volumio volumio[1475]: info: Starting Shairport Sync Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "last_100"... Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "webradio"... Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "i2s_dacs"... Oct 09 00:10:15 volumio volumio[1475]: info: I2S DAC not set, start Auto-detection Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "volumiodiscovery"... Oct 09 00:10:15 volumio volumio[1475]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 09 00:10:15 volumio node[1475]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 09 00:10:15 volumio volumio[1475]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:10:15 volumio node[1475]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:10:15 volumio volumio[1475]: *** WARNING *** For more information see Oct 09 00:10:15 volumio node[1475]: *** WARNING *** For more information see Oct 09 00:10:15 volumio volumio[1475]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 09 00:10:15 volumio node[1475]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 09 00:10:15 volumio volumio[1475]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:10:15 volumio node[1475]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:10:15 volumio volumio[1475]: *** WARNING *** For more information see Oct 09 00:10:15 volumio node[1475]: *** WARNING *** For more information see Oct 09 00:10:15 volumio volumio[1475]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 09 00:10:15 volumio volumio[1475]: info: Discovery: Started advertising with name: Volumio Oct 09 00:10:15 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 09 00:10:15 volumio volumio[1475]: info: Plugin spop is not enabled Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "gpio-buttons"... Oct 09 00:10:15 volumio volumio[1475]: info: GPIO-Buttons initialized Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "peppy_screensaver"... Oct 09 00:10:15 volumio volumio[1475]: info: Applying required configuration parameters for plugin peppy_screensaver Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "outputs"... Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "albumart"... Oct 09 00:10:15 volumio volumio[1475]: info: Plugin example_plugin is not enabled Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "inputs"... Oct 09 00:10:15 volumio volumio[1475]: info: Loading plugin "updater_comm"... Oct 09 00:10:16 volumio volumio[1475]: info: Plugin mpdemulation is not enabled Oct 09 00:10:16 volumio volumio[1475]: info: Loading plugin "rest_api"... Oct 09 00:10:16 volumio volumio[1475]: info: Loading plugin "websocket"... Oct 09 00:10:16 volumio volumio[1475]: info: Plugin fusiondsp is not enabled Oct 09 00:10:16 volumio volumio[1475]: info: Plugin radio_paradise is not enabled Oct 09 00:10:16 volumio volumio[1475]: info: Loading plugin "gpio_control"... Oct 09 00:10:16 volumio volumio[1475]: Forking 3 albumart workers Oct 09 00:10:16 volumio volumio[1475]: info: Applying required configuration parameters for plugin gpio_control Oct 09 00:10:16 volumio volumio[1475]: info: [GPIO_Control] Detected Raspberry Pi 5 Model B Rev 1.0 Oct 09 00:10:16 volumio volumio[1475]: info: [GPIO_Control] 40 GPIOs: true Oct 09 00:10:16 volumio volumio[1475]: info: [GPIO_Control] Initialized Oct 09 00:10:16 volumio volumio[1475]: info: Loading plugin "rotaryencoder2"... Oct 09 00:10:16 volumio volumio[1475]: info: Plugin Systeminfo is not enabled Oct 09 00:10:16 volumio volumio[1475]: info: Loading plugin "touch_display"... Oct 09 00:10:16 volumio volumio[1475]: Starting albumart workers Oct 09 00:10:16 volumio volumio[1475]: Starting albumart workers Oct 09 00:10:16 volumio volumio[1475]: info: Applying required configuration parameters for plugin touch_display Oct 09 00:10:16 volumio volumio[1475]: info: Loading i18n strings for locale en Oct 09 00:10:16 volumio volumio[1475]: Updating browse sources language Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 00:10:16 volumio volumio[1475]: Starting albumart workers Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::initPlayerControls Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 00:10:16 volumio volumio[1475]: Express server listening on port 3000 Oct 09 00:10:16 volumio volumio[1475]: [Metrics] WebUI: 1s 397.05ms Oct 09 00:10:16 volumio volumio[1475]: info: CoreStateMachine::resetVolumioState Oct 09 00:10:16 volumio volumio[1475]: info: CoreStateMachine::getcurrentVolume Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::volumioRetrievevolume Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 09 00:10:16 volumio volumio[1475]: verbose: New Socket.io Connection to 192.168.178.7:3000 from 192.168.178.191 UA: Dart/3.4 (dart:io) Total Clients: 1 Oct 09 00:10:16 volumio volumio[1475]: verbose: New Socket.io Connection to 192.168.178.7 from 192.168.178.191 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 2 Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 00:10:16 volumio volumio[1475]: info: Discovery: Getting this device information Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:16 volumio volumio[1475]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 00:10:16 volumio volumio[1475]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 Oct 09 00:10:16 volumio volumio[1475]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4 Oct 09 00:10:16 volumio volumio[1475]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5 Oct 09 00:10:16 volumio volumio[1475]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6 Oct 09 00:10:16 volumio volumio[1475]: info: CoreStateMachine::pushState Oct 09 00:10:16 volumio volumio[1475]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::volumioPushState Oct 09 00:10:16 volumio volumio[1475]: info: CoreStateMachine::updateTrackBlock Oct 09 00:10:16 volumio volumio[1475]: info: CorePlayQueue::getTrackBlock Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::volumioRetrievevolume Oct 09 00:10:16 volumio volumio[1475]: info: Reloading queue from file Oct 09 00:10:16 volumio volumio[1475]: info: CoreStateMachine::setRepeat null single undefined Oct 09 00:10:16 volumio volumio[1475]: info: CoreStateMachine::pushState Oct 09 00:10:16 volumio volumio[1475]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::volumioPushState Oct 09 00:10:16 volumio volumio[1475]: info: CoreStateMachine::setRandom null Oct 09 00:10:16 volumio volumio[1475]: info: CoreStateMachine::pushState Oct 09 00:10:16 volumio volumio[1475]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::volumioPushState Oct 09 00:10:16 volumio volumio[1475]: info: Setting Device type: Raspberry PI Oct 09 00:10:16 volumio volumio[1475]: info: CoreStateMachine::pushState Oct 09 00:10:16 volumio volumio[1475]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::volumioPushState Oct 09 00:10:16 volumio volumio[1475]: info: Discovery: adding 035af7b2-7f1f-4ffe-8f43-ece295115eb4 Oct 09 00:10:16 volumio volumio[1475]: info: Discovery: Found device Volumio Oct 09 00:10:16 volumio volumio[1475]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:16 volumio volumio[1475]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:18 volumio volumio[1475]: verbose: New Socket.io Connection to 192.168.178.7 from 192.168.178.191 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 7 Oct 09 00:10:18 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 09 00:10:18 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 09 00:10:18 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 09 00:10:18 volumio volumio[1475]: info: CoreCommandRouter::volumioGetVisibleSources Oct 09 00:10:18 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 00:10:18 volumio volumio[1475]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:18 volumio volumio[1475]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:18 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 09 00:10:18 volumio volumio[1475]: info: CoreCommandRouter::volumioGetQueue Oct 09 00:10:18 volumio volumio[1475]: info: CoreStateMachine::getQueue Oct 09 00:10:18 volumio volumio[1475]: info: CorePlayQueue::getQueue Oct 09 00:10:18 volumio volumio[1475]: info: Listing playlists Oct 09 00:10:18 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 09 00:10:18 volumio volumio[1475]: info: Received Get System Info Oct 09 00:10:18 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 00:10:18 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 00:10:18 volumio volumio[1475]: info: Discovery: Getting this device information Oct 09 00:10:18 volumio volumio[1475]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:18 volumio volumio[1475]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:18 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 00:10:18 volumio volumio[1475]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:18 volumio volumio[1475]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:19 volumio volumio-remote-updater[593]: [2024-10-09 00:10:19] [connect] Successful connection Oct 09 00:10:19 volumio volumio-remote-updater[593]: [2024-10-09 00:10:19] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1728425419 101 Oct 09 00:10:19 volumio volumio[1475]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 8 Oct 09 00:10:25 volumio volumio[1475]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 09 00:10:25 volumio volumio[1475]: info: CURURI: albums:// Oct 09 00:10:25 volumio volumio[1475]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 09 00:10:25 volumio volumio[1475]: TypeError: Cannot read property 'sendCommand' of undefined Oct 09 00:10:25 volumio volumio[1475]: at /volumio/app/plugins/music_service/mpd/index.js:2986:22 Oct 09 00:10:25 volumio volumio[1475]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Oct 09 00:10:25 volumio volumio[1475]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 09 00:10:25 volumio sudo[1600]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-09 00:09 Oct 09 00:10:25 volumio sudo[1600]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:10:25 volumio sudo[1600]: pam_unix(sudo:session): session closed for user root Oct 09 00:10:25 volumio volumio-remote-updater[593]: [2024-10-09 00:10:25] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 09 00:10:25 volumio volumio-remote-updater[593]: [2024-10-09 00:10:25] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 09 00:10:25 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 09 00:10:25 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 09 00:10:25 volumio systemd[1]: Started dynamicswap service. Oct 09 00:10:25 volumio systemd[1]: dynamicswap.service: Succeeded. Oct 09 00:10:26 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Oct 09 00:10:26 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 4. Oct 09 00:10:26 volumio systemd[1]: Started dynamicswap service. Oct 09 00:10:26 volumio systemd[1]: Stopped Volumio Backend Module. Oct 09 00:10:26 volumio systemd[1]: Started Volumio Backend Module. Oct 09 00:10:26 volumio systemd[1]: dynamicswap.service: Succeeded. Oct 09 00:10:26 volumio volumio[1614]: info: ------------------------------------------- Oct 09 00:10:26 volumio volumio[1614]: info: ----- Volumio3 ---- Oct 09 00:10:26 volumio volumio[1614]: info: ------------------------------------------- Oct 09 00:10:26 volumio volumio[1614]: info: ----- System startup ---- Oct 09 00:10:26 volumio volumio[1614]: info: ------------------------------------------- Oct 09 00:10:26 volumio volumio[1614]: info: MYVOLUMIO Environment detected Oct 09 00:10:26 volumio volumio[1614]: info: Plugin folders cleanup Oct 09 00:10:26 volumio volumio[1614]: info: Scanning into folder /volumio/app/plugins/ Oct 09 00:10:26 volumio volumio[1614]: info: Scanning category audio_interface Oct 09 00:10:26 volumio volumio[1614]: info: Scanning category miscellanea Oct 09 00:10:26 volumio volumio[1614]: info: Scanning category music_service Oct 09 00:10:26 volumio volumio[1614]: info: Scanning category plugins.json Oct 09 00:10:26 volumio volumio[1614]: info: Scanning category system_controller Oct 09 00:10:26 volumio volumio[1614]: info: Scanning category user_interface Oct 09 00:10:26 volumio volumio[1614]: info: Scanning into folder /data/plugins/ Oct 09 00:10:26 volumio volumio[1614]: info: Scanning category audio_interface Oct 09 00:10:26 volumio volumio[1614]: info: Scanning category music_service Oct 09 00:10:26 volumio volumio[1614]: info: Scanning category system_hardware Oct 09 00:10:26 volumio volumio[1614]: info: Scanning category user_interface Oct 09 00:10:26 volumio volumio[1614]: info: Plugin folders cleanup completed Oct 09 00:10:26 volumio volumio[1614]: info: ------------------------------------------- Oct 09 00:10:26 volumio volumio[1614]: info: ----- Core plugins startup ---- Oct 09 00:10:26 volumio volumio[1614]: info: ------------------------------------------- Oct 09 00:10:26 volumio volumio[1614]: info: Loading plugins from folder /volumio/app/plugins/ Oct 09 00:10:26 volumio volumio[1614]: info: Adding plugin upnp to MyMusic Plugins Oct 09 00:10:26 volumio volumio[1614]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 09 00:10:26 volumio volumio[1614]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 09 00:10:26 volumio volumio[1614]: info: Loading plugins from folder /data/plugins/ Oct 09 00:10:26 volumio volumio[1614]: info: Loading plugin "system"... Oct 09 00:10:26 volumio volumio[1614]: info: Loading plugin "appearance"... Oct 09 00:10:26 volumio volumio[1614]: info: Loading plugin "network"... Oct 09 00:10:26 volumio volumio[1614]: info: Refreshing Cached IP Addresses Oct 09 00:10:26 volumio volumio[1614]: info: Loading plugin "services"... Oct 09 00:10:26 volumio sudo[1640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 09 00:10:26 volumio sudo[1640]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:10:26 volumio sudo[1640]: pam_unix(sudo:session): session closed for user root Oct 09 00:10:26 volumio volumio[1614]: info: Loading plugin "alsa_controller"... Oct 09 00:10:26 volumio sudo[1642]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 09 00:10:26 volumio sudo[1642]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 00:10:26 volumio sudo[1642]: pam_unix(sudo:session): session closed for user root Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "wizard"... Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "networkfs"... Oct 09 00:10:27 volumio volumio[1614]: info: Starting Udev Watcher for removable devices Oct 09 00:10:27 volumio volumio[1614]: info: Ignoring mount for partition: boot Oct 09 00:10:27 volumio volumio[1614]: info: Ignoring mount for partition: volumio Oct 09 00:10:27 volumio volumio[1614]: info: Ignoring mount for partition: volumio_data Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "volumio_command_line_client"... Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "upnp"... Oct 09 00:10:27 volumio volumio[1614]: info: [1728425427036] Starting Upmpd Daemon Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "my_music"... Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "mpd"... Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "upnp_browser"... Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "alarm-clock"... Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "airplay_emulation"... Oct 09 00:10:27 volumio volumio[1614]: info: Starting Shairport Sync Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "last_100"... Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "webradio"... Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "i2s_dacs"... Oct 09 00:10:27 volumio volumio[1614]: info: I2S DAC not set, start Auto-detection Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "volumiodiscovery"... Oct 09 00:10:27 volumio volumio[1614]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 09 00:10:27 volumio node[1614]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 09 00:10:27 volumio volumio[1614]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:10:27 volumio node[1614]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:10:27 volumio volumio[1614]: *** WARNING *** For more information see Oct 09 00:10:27 volumio node[1614]: *** WARNING *** For more information see Oct 09 00:10:27 volumio volumio[1614]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 09 00:10:27 volumio node[1614]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 09 00:10:27 volumio volumio[1614]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:10:27 volumio node[1614]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 09 00:10:27 volumio volumio[1614]: *** WARNING *** For more information see Oct 09 00:10:27 volumio node[1614]: *** WARNING *** For more information see Oct 09 00:10:27 volumio volumio[1614]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 09 00:10:27 volumio volumio[1614]: info: Discovery: Started advertising with name: Volumio Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 09 00:10:27 volumio volumio[1614]: info: Plugin spop is not enabled Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "gpio-buttons"... Oct 09 00:10:27 volumio volumio[1614]: info: GPIO-Buttons initialized Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "peppy_screensaver"... Oct 09 00:10:27 volumio volumio[1614]: info: Applying required configuration parameters for plugin peppy_screensaver Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "outputs"... Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "albumart"... Oct 09 00:10:27 volumio volumio[1614]: info: Plugin example_plugin is not enabled Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "inputs"... Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "updater_comm"... Oct 09 00:10:27 volumio volumio[1614]: info: Plugin mpdemulation is not enabled Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "rest_api"... Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "websocket"... Oct 09 00:10:27 volumio volumio[1614]: info: Plugin fusiondsp is not enabled Oct 09 00:10:27 volumio volumio[1614]: info: Plugin radio_paradise is not enabled Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "gpio_control"... Oct 09 00:10:27 volumio volumio[1614]: Forking 3 albumart workers Oct 09 00:10:27 volumio volumio[1614]: info: Applying required configuration parameters for plugin gpio_control Oct 09 00:10:27 volumio volumio[1614]: info: [GPIO_Control] Detected Raspberry Pi 5 Model B Rev 1.0 Oct 09 00:10:27 volumio volumio[1614]: info: [GPIO_Control] 40 GPIOs: true Oct 09 00:10:27 volumio volumio[1614]: info: [GPIO_Control] Initialized Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "rotaryencoder2"... Oct 09 00:10:27 volumio volumio[1614]: info: Plugin Systeminfo is not enabled Oct 09 00:10:27 volumio volumio[1614]: info: Loading plugin "touch_display"... Oct 09 00:10:27 volumio volumio[1614]: Starting albumart workers Oct 09 00:10:27 volumio volumio[1614]: Starting albumart workers Oct 09 00:10:27 volumio volumio[1614]: info: Applying required configuration parameters for plugin touch_display Oct 09 00:10:27 volumio volumio[1614]: info: Loading i18n strings for locale en Oct 09 00:10:27 volumio volumio[1614]: Updating browse sources language Oct 09 00:10:27 volumio volumio[1614]: Starting albumart workers Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::initPlayerControls Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 00:10:27 volumio volumio[1614]: Express server listening on port 3000 Oct 09 00:10:27 volumio volumio[1614]: [Metrics] WebUI: 1s 386.84ms Oct 09 00:10:27 volumio volumio[1614]: info: CoreStateMachine::resetVolumioState Oct 09 00:10:27 volumio volumio[1614]: info: CoreStateMachine::getcurrentVolume Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::volumioRetrievevolume Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 09 00:10:27 volumio volumio[1614]: verbose: New Socket.io Connection to 192.168.178.7 from 192.168.178.191 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 1 Oct 09 00:10:27 volumio volumio[1614]: verbose: New Socket.io Connection to 192.168.178.7:3000 from 192.168.178.191 UA: Dart/3.4 (dart:io) Total Clients: 2 Oct 09 00:10:27 volumio volumio[1614]: info: CoreStateMachine::pushState Oct 09 00:10:27 volumio volumio[1614]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::volumioPushState Oct 09 00:10:27 volumio volumio[1614]: info: CoreStateMachine::updateTrackBlock Oct 09 00:10:27 volumio volumio[1614]: info: CorePlayQueue::getTrackBlock Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::volumioRetrievevolume Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 00:10:27 volumio volumio[1614]: info: Discovery: Getting this device information Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:27 volumio volumio[1614]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 00:10:27 volumio volumio[1614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 Oct 09 00:10:27 volumio volumio[1614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4 Oct 09 00:10:27 volumio volumio[1614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5 Oct 09 00:10:27 volumio volumio[1614]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6 Oct 09 00:10:27 volumio volumio[1614]: info: Reloading queue from file Oct 09 00:10:27 volumio volumio[1614]: info: CoreStateMachine::pushState Oct 09 00:10:27 volumio volumio[1614]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 00:10:27 volumio volumio[1614]: info: CoreCommandRouter::volumioPushState Oct 09 00:10:28 volumio volumio[1614]: info: CoreStateMachine::setRepeat null single undefined Oct 09 00:10:28 volumio volumio[1614]: info: CoreStateMachine::pushState Oct 09 00:10:28 volumio volumio[1614]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:28 volumio volumio[1614]: info: CoreCommandRouter::volumioPushState Oct 09 00:10:28 volumio volumio[1614]: info: CoreStateMachine::setRandom null Oct 09 00:10:28 volumio volumio[1614]: info: CoreStateMachine::pushState Oct 09 00:10:28 volumio volumio[1614]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:28 volumio volumio[1614]: info: CoreCommandRouter::volumioPushState Oct 09 00:10:28 volumio volumio[1614]: info: Setting Device type: Raspberry PI Oct 09 00:10:28 volumio volumio[1614]: info: Discovery: adding 035af7b2-7f1f-4ffe-8f43-ece295115eb4 Oct 09 00:10:28 volumio volumio[1614]: info: Discovery: Found device Volumio Oct 09 00:10:28 volumio volumio[1614]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:28 volumio volumio[1614]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:28 volumio volumio[1614]: verbose: New Socket.io Connection to 192.168.178.7 from 192.168.178.191 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 7 Oct 09 00:10:28 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 09 00:10:28 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 09 00:10:28 volumio volumio[1614]: info: CoreCommandRouter::volumioGetVisibleSources Oct 09 00:10:28 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 00:10:28 volumio volumio[1614]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:28 volumio volumio[1614]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:28 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 09 00:10:28 volumio volumio[1614]: info: CoreCommandRouter::volumioGetQueue Oct 09 00:10:28 volumio volumio[1614]: info: CoreStateMachine::getQueue Oct 09 00:10:28 volumio volumio[1614]: info: CorePlayQueue::getQueue Oct 09 00:10:28 volumio volumio[1614]: info: Listing playlists Oct 09 00:10:28 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 09 00:10:28 volumio volumio[1614]: info: Received Get System Info Oct 09 00:10:28 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 00:10:28 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 00:10:28 volumio volumio[1614]: info: Discovery: Getting this device information Oct 09 00:10:28 volumio volumio[1614]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:28 volumio volumio[1614]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:28 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 00:10:28 volumio volumio[1614]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:28 volumio volumio[1614]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:30 volumio volumio-remote-updater[593]: [2024-10-09 00:10:30] [connect] Successful connection Oct 09 00:10:30 volumio volumio-remote-updater[593]: [2024-10-09 00:10:30] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1728425430 101 Oct 09 00:10:30 volumio volumio[1614]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 8 Oct 09 00:10:32 volumio volumio[1614]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Oct 09 00:10:33 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 09 00:10:33 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 09 00:10:33 volumio volumio[1614]: info: Discovery: Getting this device information Oct 09 00:10:33 volumio volumio[1614]: info: CoreCommandRouter::volumioGetState Oct 09 00:10:33 volumio volumio[1614]: info: CorePlayQueue::getTrack 0 Oct 09 00:10:33 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 09 00:10:34 volumio volumio[1614]: verbose: New Socket.io Connection to 192.168.178.7 from 192.168.178.8 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/17.6 Safari/605.1.15 Total Clients: 9 Oct 09 00:10:34 volumio volumio[1614]: Searching plugin music_service/mpd Oct 09 00:10:34 volumio volumio[1614]: info: CoreCommandRouter::executeOnPlugin: mpd , search Oct 09 00:10:34 volumio volumio[1614]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 09 00:10:34 volumio volumio[1614]: TypeError: Cannot read property 'then' of undefined Oct 09 00:10:34 volumio volumio[1614]: at ControllerMpd.search (/volumio/app/plugins/music_service/mpd/index.js:1582:17) Oct 09 00:10:34 volumio volumio[1614]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32) Oct 09 00:10:34 volumio volumio[1614]: at CoreMusicLibrary.search (/volumio/app/musiclibrary.js:477:37) Oct 09 00:10:34 volumio volumio[1614]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:457:44) Oct 09 00:10:34 volumio volumio[1614]: at Socket.emit (events.js:315:20) Oct 09 00:10:34 volumio volumio[1614]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 09 00:10:34 volumio volumio[1614]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Oct 09 00:10:34 volumio volumio[1614]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 09 00:10:34 volumio sudo[1739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-09 00:09 Oct 09 00:10:34 volumio sudo[1739]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"