-- Logs begin at Wed 2024-10-09 00:08:53 CEST, end at Wed 2024-10-09 00:10:25 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)
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"