-- Logs begin at Thu 2019-02-14 05:11:59 EST, end at Sun 2025-03-16 16:29:31 EDT. --
Mar 16 16:28:00 volumio3b systemd[1]: Started Entropy daemon using the HAVEGE algorithm.
Mar 16 16:28:00 volumio3b kernel: 8021q: 802.1Q VLAN Support v1.8
Mar 16 16:28:00 volumio3b systemd[1]: Started ifup for wlan0.
Mar 16 16:28:00 volumio3b systemd[1]: Started Update UTMP about System Boot/Shutdown.
Mar 16 16:28:00 volumio3b systemd[1]: Reached target System Initialization.
Mar 16 16:28:00 volumio3b kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211
Mar 16 16:28:00 volumio3b systemd[1]: Listening on D-Bus System Message Bus Socket.
Mar 16 16:28:00 volumio3b systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
Mar 16 16:28:00 volumio3b systemd[1]: Started Daily Cleanup of Temporary Directories.
Mar 16 16:28:00 volumio3b systemd[1]: Listening on triggerhappy.socket.
Mar 16 16:28:00 volumio3b systemd[1]: Reached target Sockets.
Mar 16 16:28:00 volumio3b systemd[1]: Reached target Basic System.
Mar 16 16:28:00 volumio3b kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Mar 16 16:28:00 volumio3b systemd[1]: Starting Configure Bluetooth Modems connected by UART...
Mar 16 16:28:00 volumio3b systemd[1]: Started D-Bus System Message Bus.
Mar 16 16:28:00 volumio3b systemd[1]: Started volumio-remote-updater.service.
Mar 16 16:28:00 volumio3b systemd[1]: Starting triggerhappy global hotkey daemon...
Mar 16 16:28:00 volumio3b systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped.
Mar 16 16:28:00 volumio3b systemd[1]: Starting Volumio Time Update Utility...
Mar 16 16:28:00 volumio3b systemd[1]: Started Volumio Log Rotation Service.
Mar 16 16:28:00 volumio3b systemd[1]: Started Daily apt download activities.
Mar 16 16:28:00 volumio3b systemd[1]: Started MPD Monitor Service.
Mar 16 16:28:00 volumio3b systemd[1]: Starting Wireless Services...
Mar 16 16:28:00 volumio3b systemd[1]: Started Daily apt upgrade and clean activities.
Mar 16 16:28:00 volumio3b systemd[1]: Condition check resulted in Volumio SSH enabler being skipped.
Mar 16 16:28:00 volumio3b systemd[1]: Started UPnP Renderer front-end to MPD.
Mar 16 16:28:00 volumio3b systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
Mar 16 16:28:00 volumio3b systemd[1]: Started Daily man-db regeneration.
Mar 16 16:28:00 volumio3b systemd[1]: Reached target Timers.
Mar 16 16:28:00 volumio3b systemd[1]: Started Volumio Iptables Module.
Mar 16 16:28:00 volumio3b systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped.
Mar 16 16:28:00 volumio3b systemd[1]: Reached target Login Prompts.
Mar 16 16:28:00 volumio3b systemd[1]: Starting Login Service...
Mar 16 16:28:00 volumio3b systemd[1]: Starting dhcpcd on all interfaces...
Mar 16 16:28:00 volumio3b systemd[1]: Started Manage Sound Card State (restore and store).
Mar 16 16:28:00 volumio3b systemd[1]: Starting Save/Restore Sound Card State...
Mar 16 16:28:00 volumio3b alsactl[626]: alsactl 1.1.8 daemon started
Mar 16 16:28:00 volumio3b systemd[1]: Starting WPA supplicant...
Mar 16 16:28:00 volumio3b volumio-time-update[615]: volumio-time-update-util: Fetching time from Volumio...
Mar 16 16:28:00 volumio3b mpd_monitor.sh[618]: MPD Monitor Service: Starting MPD Monitor Service
Mar 16 16:28:00 volumio3b systemd[1]: Started RPC bind portmap service.
Mar 16 16:28:00 volumio3b systemd[1]: Reached target RPC Port Mapper.
Mar 16 16:28:00 volumio3b systemd[1]: Reached target Remote File Systems (Pre).
Mar 16 16:28:00 volumio3b systemd[1]: Reached target Remote File Systems.
Mar 16 16:28:00 volumio3b systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling...
Mar 16 16:28:00 volumio3b thd[614]: Unable to parse trigger line:
Mar 16 16:28:00 volumio3b thd[614]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle
Mar 16 16:28:00 volumio3b thd[614]: Unable to parse trigger line:
Mar 16 16:28:00 volumio3b thd[614]: Found socket passed from systemd
Mar 16 16:28:00 volumio3b dhcpcd[624]: Not running dhcpcd because /etc/network/interfaces
Mar 16 16:28:00 volumio3b dhcpcd[624]: defines some interfaces that will use a
Mar 16 16:28:00 volumio3b dhcpcd[624]: DHCP client or static address
Mar 16 16:28:00 volumio3b systemd-logind[623]: New seat seat0.
Mar 16 16:28:00 volumio3b mpd_monitor.sh[618]: MPD error: Connection refused
Mar 16 16:28:00 volumio3b mpd_monitor.sh[618]: MPD Monitor Service: MPD Appears to be inactive, restarting
Mar 16 16:28:00 volumio3b avahi-daemon[621]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113).
Mar 16 16:28:00 volumio3b avahi-daemon[621]: Successfully dropped root privileges.
Mar 16 16:28:00 volumio3b avahi-daemon[621]: avahi-daemon 0.7 starting up.
Mar 16 16:28:00 volumio3b mpd_monitor.sh[618]: mpd: no process found
Mar 16 16:28:00 volumio3b sh[520]: eth0: waiting for carrier
Mar 16 16:28:00 volumio3b dhcpcd[557]: eth0: waiting for carrier
Mar 16 16:28:00 volumio3b kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup
Mar 16 16:28:00 volumio3b kernel: smsc95xx 1-1.1:1.0 eth0: Link is Down
Mar 16 16:28:01 volumio3b systemd[1]: Started triggerhappy global hotkey daemon.
Mar 16 16:28:01 volumio3b systemd[1]: hciuart.service: Succeeded.
Mar 16 16:28:01 volumio3b systemd[1]: Started Configure Bluetooth Modems connected by UART.
Mar 16 16:28:01 volumio3b systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED
Mar 16 16:28:01 volumio3b systemd[1]: dhcpcd.service: Failed with result 'exit-code'.
Mar 16 16:28:01 volumio3b systemd[1]: Failed to start dhcpcd on all interfaces.
Mar 16 16:28:01 volumio3b avahi-daemon[621]: Successfully called chroot().
Mar 16 16:28:01 volumio3b avahi-daemon[621]: Successfully dropped remaining capabilities.
Mar 16 16:28:01 volumio3b systemd[1]: Started Save/Restore Sound Card State.
Mar 16 16:28:01 volumio3b wpa_supplicant[635]: Successfully initialized wpa_supplicant
Mar 16 16:28:01 volumio3b avahi-daemon[621]: Loading service file /services/volumio.service.
Mar 16 16:28:01 volumio3b avahi-daemon[621]: Network interface enumeration completed.
Mar 16 16:28:01 volumio3b avahi-daemon[621]: Server startup complete. Host name is volumio3b.local. Local service cookie is 3156310366.
Mar 16 16:28:01 volumio3b avahi-daemon[621]: Service "Volumio3b" (/services/volumio.service) successfully established.
Mar 16 16:28:01 volumio3b volumio-remote-updater[613]: Error: No active session
Mar 16 16:28:01 volumio3b volumio-remote-updater[613]: [2025-03-16 16:28:01] [info] asio async_connect error: system:111 (Connection refused)
Mar 16 16:28:01 volumio3b volumio-remote-updater[613]: [2025-03-16 16:28:01] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Mar 16 16:28:01 volumio3b volumio-remote-updater[613]: [2025-03-16 16:28:01] [error] handle_connect error: Underlying Transport Error
Mar 16 16:28:01 volumio3b sh[588]: wlan0=wlan0
Mar 16 16:28:01 volumio3b volumio[620]: Could not open config: /tmp/upmpdcli.conf
Mar 16 16:28:01 volumio3b volumio-time-update[615]: volumio-time-update-util: Date not found in response
Mar 16 16:28:01 volumio3b volumio-time-update[615]: volumio-time-update-util: Retrying in 5 seconds...
Mar 16 16:28:01 volumio3b systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Mar 16 16:28:01 volumio3b systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Mar 16 16:28:01 volumio3b systemd[1]: Started Login Service.
Mar 16 16:28:01 volumio3b systemd[1]: Started Avahi mDNS/DNS-SD Stack.
Mar 16 16:28:01 volumio3b systemd[1]: Started Raise network interfaces.
Mar 16 16:28:01 volumio3b systemd[1]: Started WPA supplicant.
Mar 16 16:28:01 volumio3b systemd[1]: Listening on mpd.socket.
Mar 16 16:28:01 volumio3b systemd[1]: Reached target Sound Card.
Mar 16 16:28:01 volumio3b systemd[1]: Reached target Network.
Mar 16 16:28:01 volumio3b systemd[1]: Starting OpenBSD Secure Shell server...
Mar 16 16:28:01 volumio3b systemd[1]: Starting Network Time Service...
Mar 16 16:28:01 volumio3b systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped.
Mar 16 16:28:01 volumio3b systemd[1]: Starting Permit User Sessions...
Mar 16 16:28:01 volumio3b systemd[1]: Starting Music Player Daemon...
Mar 16 16:28:01 volumio3b systemd[1]: Reached target Network is Online.
Mar 16 16:28:01 volumio3b systemd[1]: Starting Samba NMB Daemon...
Mar 16 16:28:01 volumio3b systemd[1]: Starting LSB: Brings up/down network automatically...
Mar 16 16:28:01 volumio3b systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Mar 16 16:28:01 volumio3b systemd[1]: Starting /etc/rc.local Compatibility...
Mar 16 16:28:01 volumio3b systemd[1]: Starting Raspberry Pi bluetooth helper...
Mar 16 16:28:01 volumio3b systemd[1]: Started Permit User Sessions.
Mar 16 16:28:01 volumio3b haveged[586]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K
Mar 16 16:28:01 volumio3b haveged[586]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488
Mar 16 16:28:01 volumio3b haveged[586]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99968
Mar 16 16:28:01 volumio3b haveged[586]: haveged: fills: 0, generated: 0
Mar 16 16:28:01 volumio3b systemd[1]: Started /etc/rc.local Compatibility.
Mar 16 16:28:01 volumio3b systemd[1]: iptables.service: Succeeded.
Mar 16 16:28:01 volumio3b loadcpufreq[653]: Loading cpufreq kernel modules...done (none).
Mar 16 16:28:01 volumio3b systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling.
Mar 16 16:28:01 volumio3b systemd[1]: Starting LSB: set CPUFreq kernel parameters...
Mar 16 16:28:01 volumio3b systemd[1]: Starting Hold until boot process finishes up...
Mar 16 16:28:01 volumio3b systemd[1]: Starting Terminate Plymouth Boot Screen...
Mar 16 16:28:01 volumio3b bthelper[773]: Raspberry Pi BDADDR already set
Mar 16 16:28:02 volumio3b systemd[1]: Started Raspberry Pi bluetooth helper.
Mar 16 16:28:02 volumio3b systemd[1]: plymouth-quit-wait.service: Succeeded.
Mar 16 16:28:02 volumio3b systemd[1]: Started Hold until boot process finishes up.
Mar 16 16:28:02 volumio3b systemd[1]: plymouth-quit.service: Succeeded.
Mar 16 16:28:02 volumio3b systemd[1]: Started Terminate Plymouth Boot Screen.
Mar 16 16:28:02 volumio3b systemd[1]: Received SIGRTMIN+21 from PID 197 (n/a).
Mar 16 16:28:02 volumio3b systemd[1]: Received SIGRTMIN+21 from PID 197 (n/a).
Mar 16 16:28:02 volumio3b ifplugd(eth0)[807]: ifplugd 0.28 initializing.
Mar 16 16:28:02 volumio3b ifplugd(eth0)[807]: Using interface eth0/B8:27:EB:84:74:ED with driver (version: 6.6.62-v7+)
Mar 16 16:28:02 volumio3b systemd[1]: Starting Bluetooth service...
Mar 16 16:28:02 volumio3b ifplugd(eth0)[807]: Using detection mode: SIOCETHTOOL
Mar 16 16:28:02 volumio3b ifplugd(eth0)[807]: Initialization complete, link beat not detected.
Mar 16 16:28:02 volumio3b ntpd[754]: ntpd 4.2.8p12@1.3728-o (1): Starting
Mar 16 16:28:02 volumio3b ntpd[754]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103
Mar 16 16:28:02 volumio3b systemd[1]: Started Network Time Service.
Mar 16 16:28:02 volumio3b ntpd[811]: proto: precision = 0.677 usec (-20)
Mar 16 16:28:02 volumio3b ifplugd[764]: Network Interface Plugging Daemon...start eth0...done.
Mar 16 16:28:02 volumio3b systemd[1]: Started LSB: Brings up/down network automatically.
Mar 16 16:28:02 volumio3b ntpd[811]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Mar 16 16:28:02 volumio3b ntpd[811]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Mar 16 16:28:02 volumio3b ntpd[811]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 79 days ago
Mar 16 16:28:02 volumio3b ntpd[811]: Listen and drop on 0 v6wildcard [::]:123
Mar 16 16:28:02 volumio3b ntpd[811]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Mar 16 16:28:02 volumio3b sshd[812]: Server listening on 0.0.0.0 port 22.
Mar 16 16:28:02 volumio3b sshd[812]: Server listening on :: port 22.
Mar 16 16:28:02 volumio3b ntpd[811]: Listen normally on 2 lo 127.0.0.1:123
Mar 16 16:28:02 volumio3b ntpd[811]: Listening on routing socket on fd #19 for interface updates
Mar 16 16:28:02 volumio3b systemd[1]: Started OpenBSD Secure Shell server.
Mar 16 16:28:02 volumio3b ntpd[811]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Mar 16 16:28:02 volumio3b ntpd[811]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Mar 16 16:28:02 volumio3b cpufrequtils[790]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done.
Mar 16 16:28:02 volumio3b systemd[1]: Started LSB: set CPUFreq kernel parameters.
Mar 16 16:28:02 volumio3b bluetoothd[798]: Bluetooth daemon 5.50
Mar 16 16:28:02 volumio3b bluetoothd[798]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf
Mar 16 16:28:02 volumio3b systemd[1]: Started Bluetooth service.
Mar 16 16:28:02 volumio3b systemd[1]: Reached target Bluetooth.
Mar 16 16:28:02 volumio3b sudo[757]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Mar 16 16:28:02 volumio3b sudo[757]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:02 volumio3b sudo[757]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Mar 16 16:28:02 volumio3b sudo[757]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:02 volumio3b bluetoothd[798]: Starting SDP server
Mar 16 16:28:02 volumio3b bluetoothd[798]: Excluding (cli) sap
Mar 16 16:28:02 volumio3b kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Mar 16 16:28:02 volumio3b kernel: Bluetooth: BNEP filters: protocol multicast
Mar 16 16:28:02 volumio3b kernel: Bluetooth: BNEP socket layer initialized
Mar 16 16:28:02 volumio3b bluetoothd[798]: Bluetooth management interface 1.22 initialized
Mar 16 16:28:02 volumio3b dbus-daemon[612]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=798 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ")
Mar 16 16:28:02 volumio3b kernel: Bluetooth: MGMT ver 1.22
Mar 16 16:28:02 volumio3b bluetoothd[798]: Failed to set privacy: Rejected (0x0b)
Mar 16 16:28:02 volumio3b systemd[1]: Starting Hostname Service...
Mar 16 16:28:02 volumio3b dbus-daemon[612]: [system] Successfully activated service 'org.freedesktop.hostname1'
Mar 16 16:28:02 volumio3b systemd[1]: Started Hostname Service.
Mar 16 16:28:03 volumio3b ntpd[811]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Mar 16 16:28:03 volumio3b nmbd[782]: [2025/03/16 16:28:03.500992, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns)
Mar 16 16:28:03 volumio3b nmbd[782]: started asyncdns process 834
Mar 16 16:28:03 volumio3b nmbd[782]: [2025/03/16 16:28:03.503585, 0] ../lib/util/become_daemon.c:149(daemon_status)
Mar 16 16:28:03 volumio3b nmbd[782]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...
Mar 16 16:28:03 volumio3b nmbd[782]: [2025/03/16 16:28:03.503768, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets)
Mar 16 16:28:03 volumio3b nmbd[782]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
Mar 16 16:28:03 volumio3b wireless.js[619]: Cleaning previous...
Mar 16 16:28:04 volumio3b sudo[842]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Mar 16 16:28:04 volumio3b sudo[842]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:04 volumio3b sudo[842]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:04 volumio3b sudo[844]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Mar 16 16:28:04 volumio3b sudo[844]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:04 volumio3b ntpd[811]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Mar 16 16:28:04 volumio3b sudo[844]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:04 volumio3b wireless.js[619]: Stopped aP
Mar 16 16:28:04 volumio3b sudo[851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Mar 16 16:28:04 volumio3b sudo[851]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:04 volumio3b sudo[851]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:04 volumio3b kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Mar 16 16:28:04 volumio3b sudo[853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get
Mar 16 16:28:04 volumio3b sudo[853]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:04 volumio3b sudo[853]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:04 volumio3b sudo[860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Mar 16 16:28:04 volumio3b sudo[860]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:04 volumio3b sudo[860]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:04 volumio3b sudo[862]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan
Mar 16 16:28:04 volumio3b sudo[862]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:04 volumio3b systemd[1]: systemd-rfkill.service: Succeeded.
Mar 16 16:28:05 volumio3b ntpd[811]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Mar 16 16:28:05 volumio3b sudo[862]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:05 volumio3b wireless.js[619]: SETTING APPROPRIATE REG DOMAIN: CA
Mar 16 16:28:05 volumio3b sudo[867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Mar 16 16:28:05 volumio3b sudo[867]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:05 volumio3b sudo[867]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:05 volumio3b sudo[869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set CA
Mar 16 16:28:05 volumio3b sudo[869]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:05 volumio3b sudo[869]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:05 volumio3b wireless.js[619]: SUCCESSFULLY SET NEW REGDOMAIN: CA
Mar 16 16:28:05 volumio3b wireless.js[619]: Start wireless flow
Mar 16 16:28:05 volumio3b wireless.js[619]: Stopped hotspot (if there)..
Mar 16 16:28:05 volumio3b sudo[874]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Mar 16 16:28:05 volumio3b sudo[874]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:05 volumio3b sudo[874]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:05 volumio3b sudo[876]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Mar 16 16:28:05 volumio3b sudo[876]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:06 volumio3b mpd[830]: Mar 16 16:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Mar 16 16:28:06 volumio3b systemd[1]: Started Music Player Daemon.
Mar 16 16:28:06 volumio3b mpd_monitor.sh[618]: MPD Monitor Service: MPD restarted due to no mpc output.
Mar 16 16:28:06 volumio3b sudo[876]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:06 volumio3b wireless.js[619]: DHCP IP
Mar 16 16:28:06 volumio3b wireless.js[619]: Start ap
Mar 16 16:28:06 volumio3b wpa_supplicant[881]: Successfully initialized wpa_supplicant
Mar 16 16:28:06 volumio3b sudo[882]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd
Mar 16 16:28:06 volumio3b sudo[882]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:06 volumio3b kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Mar 16 16:28:06 volumio3b dhcpcd[883]: dev: loaded udev
Mar 16 16:28:06 volumio3b dhcpcd-run-hooks[901]: wlan0: starting wpa_supplicant
Mar 16 16:28:06 volumio3b ntpd[811]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Mar 16 16:28:06 volumio3b volumio-remote-updater[613]: [2025-03-16 16:28:06] [info] asio async_connect error: system:111 (Connection refused)
Mar 16 16:28:06 volumio3b volumio-remote-updater[613]: [2025-03-16 16:28:06] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Mar 16 16:28:06 volumio3b volumio-remote-updater[613]: [2025-03-16 16:28:06] [error] handle_connect error: Underlying Transport Error
Mar 16 16:28:06 volumio3b dhcpcd-run-hooks[906]: wlan0: failed to start wpa_supplicant
Mar 16 16:28:06 volumio3b dhcpcd-run-hooks[907]: wlan0: Successfully initialized wpa_supplicant
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Ma
Mar 16 16:28:06 volumio3b dhcpcd[883]: wlan0: connected to Access Point `'
Mar 16 16:28:06 volumio3b volumio-time-update[615]: volumio-time-update-util: Fetching time from Volumio...
Mar 16 16:28:06 volumio3b dhcpcd[883]: no interfaces have a carrier
Mar 16 16:28:06 volumio3b dhcpcd[919]: eth0: waiting for carrier
Mar 16 16:28:06 volumio3b dhcpcd[919]: wlan0: waiting for carrier
Mar 16 16:28:06 volumio3b dhcpcd[883]: forked to background, child pid 919
Mar 16 16:28:06 volumio3b sudo[882]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:06 volumio3b volumio-time-update[615]: volumio-time-update-util: Date not found in response
Mar 16 16:28:06 volumio3b volumio-time-update[615]: volumio-time-update-util: Retrying in 5 seconds...
Mar 16 16:28:06 volumio3b wpa_supplicant[905]: wlan0: Trying to associate with SSID 'HouseNETWORK'
Mar 16 16:28:06 volumio3b dhcpcd[919]: wlan0: carrier acquired
Mar 16 16:28:06 volumio3b dhcpcd[919]: wlan0: connected to Access Point `HouseNETWORK'
Mar 16 16:28:06 volumio3b wpa_supplicant[905]: wlan0: Associated with 00:ab:48:66:fe:65
Mar 16 16:28:06 volumio3b wpa_supplicant[905]: wlan0: CTRL-EVENT-CONNECTED - Connection to 00:ab:48:66:fe:65 completed [id=0 id_str=]
Mar 16 16:28:06 volumio3b wpa_supplicant[905]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Mar 16 16:28:06 volumio3b wpa_supplicant[905]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=CA
Mar 16 16:28:06 volumio3b dhcpcd[919]: DUID 00:01:00:01:2f:53:00:66:b8:27:eb:d1:21:b8
Mar 16 16:28:06 volumio3b dhcpcd[919]: wlan0: IAID eb:d1:21:b8
Mar 16 16:28:06 volumio3b dhcpcd[919]: wlan0: adding address fe80::bd81:4b4c:6699:117c
Mar 16 16:28:06 volumio3b dhcpcd[919]: ipv6_addaddr1: Permission denied
Mar 16 16:28:06 volumio3b dhcpcd[919]: wlan0: carrier lost
Mar 16 16:28:07 volumio3b dhcpcd[919]: wlan0: carrier acquired
Mar 16 16:28:07 volumio3b bthelper[773]: Changing power off succeeded
Mar 16 16:28:07 volumio3b dhcpcd[919]: wlan0: IAID eb:d1:21:b8
Mar 16 16:28:07 volumio3b wireless.js[619]: trying...
Mar 16 16:28:07 volumio3b sudo[938]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 16 16:28:07 volumio3b sudo[938]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:07 volumio3b sudo[938]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:07 volumio3b bthelper[773]: [CHG] Controller B8:27:EB:2E:DE:47 Class: 0x0000041c
Mar 16 16:28:07 volumio3b bthelper[773]: Changing power on succeeded
Mar 16 16:28:07 volumio3b dhcpcd[919]: wlan0: soliciting an IPv6 router
Mar 16 16:28:07 volumio3b dhcpcd[919]: wlan0: rebinding lease of 192.168.4.47
Mar 16 16:28:07 volumio3b dhcpcd[919]: wlan0: probing address 192.168.4.47/22
Mar 16 16:28:08 volumio3b wireless.js[619]: trying...
Mar 16 16:28:08 volumio3b sudo[946]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 16 16:28:08 volumio3b sudo[946]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:08 volumio3b sudo[946]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:09 volumio3b wireless.js[619]: trying...
Mar 16 16:28:09 volumio3b sudo[949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 16 16:28:09 volumio3b sudo[949]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:09 volumio3b sudo[949]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:10 volumio3b wireless.js[619]: trying...
Mar 16 16:28:10 volumio3b sudo[952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 16 16:28:10 volumio3b sudo[952]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:10 volumio3b sudo[952]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:11 volumio3b wireless.js[619]: trying...
Mar 16 16:28:11 volumio3b sudo[955]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 16 16:28:11 volumio3b sudo[955]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:11 volumio3b sudo[955]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:11 volumio3b volumio-time-update[615]: volumio-time-update-util: Fetching time from Volumio...
Mar 16 16:28:11 volumio3b volumio-time-update[615]: volumio-time-update-util: Date not found in response
Mar 16 16:28:11 volumio3b volumio-time-update[615]: volumio-time-update-util: Retrying in 5 seconds...
Mar 16 16:28:12 volumio3b wireless.js[619]: trying...
Mar 16 16:28:12 volumio3b sudo[963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 16 16:28:12 volumio3b sudo[963]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:12 volumio3b sudo[963]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:12 volumio3b dhcpcd[919]: wlan0: leased 192.168.4.47 for 11485 seconds
Mar 16 16:28:12 volumio3b avahi-daemon[621]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.4.47.
Mar 16 16:28:12 volumio3b avahi-daemon[621]: New relevant interface wlan0.IPv4 for mDNS.
Mar 16 16:28:12 volumio3b dhcpcd[919]: wlan0: adding route to 192.168.4.0/22
Mar 16 16:28:12 volumio3b avahi-daemon[621]: Registering new address record for 192.168.4.47 on wlan0.IPv4.
Mar 16 16:28:12 volumio3b dhcpcd[919]: wlan0: adding default route via 192.168.4.1
Mar 16 16:28:13 volumio3b wireless.js[619]: trying...
Mar 16 16:28:13 volumio3b sudo[986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 16 16:28:13 volumio3b sudo[986]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:13 volumio3b sudo[986]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:13 volumio3b wireless.js[619]: Connected to: ----HouseNETWORK
Mar 16 16:28:13 volumio3b wireless.js[619]: ----
Mar 16 16:28:13 volumio3b sudo[989]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 16 16:28:13 volumio3b sudo[989]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:13 volumio3b sudo[989]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:13 volumio3b wireless.js[619]: ... joined AP, wlan0 IPv4 is 192.168.4.47, ipV6 is undefined
Mar 16 16:28:13 volumio3b wireless.js[619]: It's done! AP
Mar 16 16:28:13 volumio3b systemd[1]: Started Wireless Services.
Mar 16 16:28:13 volumio3b kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Mar 16 16:28:13 volumio3b systemd[1]: Started Volumio Backend Module.
Mar 16 16:28:13 volumio3b systemd[1]: Started Volumio Cpu Tweaker.
Mar 16 16:28:13 volumio3b volumio-cpu-tweak[995]: Setting RT Priority for mpd
Mar 16 16:28:13 volumio3b volumio-cpu-tweak[995]: Setting MPD Affinity
Mar 16 16:28:13 volumio3b volumio-cpu-tweak[995]: pid 830's current affinity mask: f
Mar 16 16:28:13 volumio3b volumio-cpu-tweak[995]: pid 830's new affinity mask: 3
Mar 16 16:28:13 volumio3b volumio-cpu-tweak[995]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input
Mar 16 16:28:13 volumio3b volumio-cpu-tweak[995]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance
Mar 16 16:28:13 volumio3b systemd[1]: volumio_cpu_tweak.service: Succeeded.
Mar 16 16:28:13 volumio3b nmbd[782]: [2025/03/16 16:28:13.511173, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Mar 16 16:28:13 volumio3b nmbd[782]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Mar 16 16:28:13 volumio3b systemd[1]: Started Samba NMB Daemon.
Mar 16 16:28:13 volumio3b nmbd[782]: [2025/03/16 16:28:13.530960, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Mar 16 16:28:13 volumio3b nmbd[782]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.4.47 for name WORKGROUP<1d>.
Mar 16 16:28:13 volumio3b nmbd[782]: This response was from IP 192.168.4.202, reporting an IP address of 192.168.4.202.
Mar 16 16:28:13 volumio3b systemd[1]: Starting Samba Winbind Daemon...
Mar 16 16:28:13 volumio3b volumio-remote-updater[613]: [2025-03-16 16:28:13] [info] asio async_connect error: system:111 (Connection refused)
Mar 16 16:28:13 volumio3b volumio-remote-updater[613]: [2025-03-16 16:28:13] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Mar 16 16:28:13 volumio3b volumio-remote-updater[613]: [2025-03-16 16:28:13] [error] handle_connect error: Underlying Transport Error
Mar 16 16:28:13 volumio3b winbindd[1011]: [2025/03/16 16:28:13.904067, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Mar 16 16:28:13 volumio3b winbindd[1011]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Mar 16 16:28:13 volumio3b winbindd[1011]: [2025/03/16 16:28:13.931805, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Mar 16 16:28:13 volumio3b systemd[1]: Started Samba Winbind Daemon.
Mar 16 16:28:13 volumio3b winbindd[1011]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Mar 16 16:28:13 volumio3b systemd[1]: Starting Samba SMB Daemon...
Mar 16 16:28:14 volumio3b ntpd[811]: Listen normally on 3 wlan0 192.168.4.47:123
Mar 16 16:28:14 volumio3b ntpd[811]: new interface(s) found: waking up resolver
Mar 16 16:28:14 volumio3b smbd[1016]: [2025/03/16 16:28:14.562077, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Mar 16 16:28:14 volumio3b smbd[1016]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Mar 16 16:28:14 volumio3b systemd[1]: Started Samba SMB Daemon.
Mar 16 16:28:16 volumio3b volumio[994]: info: -------------------------------------------
Mar 16 16:28:16 volumio3b volumio[994]: info: ----- Volumio3 ----
Mar 16 16:28:16 volumio3b volumio[994]: info: -------------------------------------------
Mar 16 16:28:16 volumio3b volumio[994]: info: ----- System startup ----
Mar 16 16:28:16 volumio3b volumio[994]: info: -------------------------------------------
Mar 16 16:28:16 volumio3b sshd[1032]: Accepted password for volumio from 192.168.4.224 port 56974 ssh2
Mar 16 16:28:16 volumio3b sshd[1032]: pam_unix(sshd:session): session opened for user volumio by (uid=0)
Mar 16 16:28:16 volumio3b volumio-time-update[615]: volumio-time-update-util: Fetching time from Volumio...
Mar 16 16:28:16 volumio3b systemd[1]: Created slice User Slice of UID 1000.
Mar 16 16:28:16 volumio3b systemd[1]: Starting User Runtime Directory /run/user/1000...
Mar 16 16:28:16 volumio3b systemd-logind[623]: New session 1 of user volumio.
Mar 16 16:28:16 volumio3b systemd[1]: Started User Runtime Directory /run/user/1000.
Mar 16 16:28:16 volumio3b systemd[1]: Starting User Manager for UID 1000...
Mar 16 16:28:16 volumio3b systemd[1039]: pam_unix(systemd-user:session): session opened for user volumio by (uid=0)
Mar 16 16:28:16 volumio3b volumio-time-update[615]: volumio-time-update-util: Setting system time to: 2025-03-16 16:28:38
Mar 16 16:28:16 volumio3b sudo[1049]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-03-16 16:28:38
Mar 16 16:28:16 volumio3b sudo[1049]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:16 volumio3b dbus-daemon[612]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.12' (uid=0 pid=1050 comm="timedatectl set-time 2025-03-16 16:28:38 ")
Mar 16 16:28:17 volumio3b systemd[1]: Starting Time & Date Service...
Mar 16 16:28:17 volumio3b systemd[1039]: Listening on GnuPG cryptographic agent and passphrase cache.
Mar 16 16:28:17 volumio3b systemd[1039]: Reached target Paths.
Mar 16 16:28:17 volumio3b systemd[1039]: Listening on GnuPG cryptographic agent and passphrase cache (restricted).
Mar 16 16:28:17 volumio3b systemd[1039]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
Mar 16 16:28:17 volumio3b systemd[1039]: Listening on Sound System.
Mar 16 16:28:17 volumio3b systemd[1039]: Reached target Timers.
Mar 16 16:28:17 volumio3b systemd[1039]: Listening on GnuPG cryptographic agent (ssh-agent emulation).
Mar 16 16:28:17 volumio3b systemd[1039]: Starting D-Bus User Message Bus Socket.
Mar 16 16:28:17 volumio3b systemd[1039]: Listening on GnuPG network certificate management daemon.
Mar 16 16:28:17 volumio3b systemd[1039]: Listening on D-Bus User Message Bus Socket.
Mar 16 16:28:17 volumio3b systemd[1039]: Reached target Sockets.
Mar 16 16:28:17 volumio3b systemd[1039]: Reached target Basic System.
Mar 16 16:28:17 volumio3b systemd[1039]: Reached target Default.
Mar 16 16:28:17 volumio3b systemd[1039]: Startup finished in 357ms.
Mar 16 16:28:17 volumio3b systemd[1]: Started User Manager for UID 1000.
Mar 16 16:28:17 volumio3b systemd[1]: Started Session 1 of user volumio.
Mar 16 16:28:17 volumio3b dbus-daemon[612]: [system] Successfully activated service 'org.freedesktop.timedate1'
Mar 16 16:28:17 volumio3b systemd[1]: Started Time & Date Service.
Mar 16 16:28:38 volumio3b systemd-timedated[1052]: Changed local time to Sun Mar 16 16:28:38 2025
Mar 16 16:28:38 volumio3b sudo[1049]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:38 volumio3b volumio-time-update[615]: volumio-time-update-util: System time updated successfully.
Mar 16 16:28:38 volumio3b systemd[1]: Started Volumio Time Update Utility.
Mar 16 16:28:38 volumio3b systemd[1]: Reached target Multi-User System.
Mar 16 16:28:38 volumio3b systemd[1]: Reached target Graphical Interface.
Mar 16 16:28:38 volumio3b systemd[1]: Starting Update UTMP about System Runlevel Changes...
Mar 16 16:28:38 volumio3b systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Mar 16 16:28:38 volumio3b systemd[1]: Started Update UTMP about System Runlevel Changes.
Mar 16 16:28:38 volumio3b systemd[1]: Startup finished in 13.567s (kernel) + 21.713s (userspace) = 35.280s.
Mar 16 16:28:38 volumio3b volumio[994]: info: MYVOLUMIO Environment detected
Mar 16 16:28:38 volumio3b volumio[994]: info: Plugin folders cleanup
Mar 16 16:28:38 volumio3b volumio[994]: info: Scanning into folder /volumio/app/plugins/
Mar 16 16:28:38 volumio3b volumio[994]: info: Scanning category audio_interface
Mar 16 16:28:38 volumio3b volumio[994]: info: Scanning category miscellanea
Mar 16 16:28:38 volumio3b volumio[994]: info: Scanning category music_service
Mar 16 16:28:38 volumio3b volumio[994]: info: Scanning category plugins.json
Mar 16 16:28:38 volumio3b volumio[994]: info: Scanning category system_controller
Mar 16 16:28:38 volumio3b volumio[994]: info: Scanning category user_interface
Mar 16 16:28:38 volumio3b volumio[994]: info: Scanning into folder /data/plugins/
Mar 16 16:28:38 volumio3b volumio[994]: info: Scanning category user_interface
Mar 16 16:28:38 volumio3b volumio[994]: info: Plugin folders cleanup completed
Mar 16 16:28:38 volumio3b volumio[994]: info: -------------------------------------------
Mar 16 16:28:38 volumio3b volumio[994]: info: ----- Core plugins startup ----
Mar 16 16:28:38 volumio3b volumio[994]: info: -------------------------------------------
Mar 16 16:28:38 volumio3b volumio[994]: info: Loading plugins from folder /volumio/app/plugins/
Mar 16 16:28:38 volumio3b volumio[994]: info: Adding plugin upnp to MyMusic Plugins
Mar 16 16:28:38 volumio3b volumio[994]: info: Adding plugin airplay_emulation to MyMusic Plugins
Mar 16 16:28:38 volumio3b volumio[994]: info: Adding plugin upnp_browser to MyMusic Plugins
Mar 16 16:28:38 volumio3b volumio[994]: info: Loading plugins from folder /data/plugins/
Mar 16 16:28:38 volumio3b volumio[994]: info: Loading plugin "system"...
Mar 16 16:28:38 volumio3b volumio[994]: info: Loading plugin "appearance"...
Mar 16 16:28:40 volumio3b volumio[994]: info: Loading plugin "network"...
Mar 16 16:28:40 volumio3b volumio[994]: info: Refreshing Cached IP Addresses
Mar 16 16:28:40 volumio3b sudo[1070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 16 16:28:40 volumio3b sudo[1070]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:40 volumio3b sudo[1070]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:40 volumio3b sudo[1072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 16 16:28:40 volumio3b sudo[1072]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:40 volumio3b sudo[1072]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:40 volumio3b volumio[994]: info: Loading plugin "services"...
Mar 16 16:28:40 volumio3b volumio[994]: info: Loading plugin "alsa_controller"...
Mar 16 16:28:40 volumio3b sudo[1080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Mar 16 16:28:40 volumio3b sudo[1080]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:40 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 16 16:28:40 volumio3b volumio[994]: info: Loading plugin "wizard"...
Mar 16 16:28:40 volumio3b volumio[994]: info: Loading plugin "networkfs"...
Mar 16 16:28:40 volumio3b volumio[994]: info: Starting Udev Watcher for removable devices
Mar 16 16:28:40 volumio3b volumio[994]: info: Ignoring mount for partition: boot
Mar 16 16:28:40 volumio3b volumio[994]: info: Ignoring mount for partition: volumio
Mar 16 16:28:40 volumio3b volumio[994]: info: Ignoring mount for partition: volumio_data
Mar 16 16:28:40 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Mar 16 16:28:40 volumio3b volumio[994]: info: Loading plugin "volumio_command_line_client"...
Mar 16 16:28:40 volumio3b volumio[994]: info: Loading plugin "upnp"...
Mar 16 16:28:40 volumio3b volumio[994]: info: [1742156920347] Starting Upmpd Daemon
Mar 16 16:28:40 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Mar 16 16:28:40 volumio3b volumio[994]: info: Loading plugin "my_music"...
Mar 16 16:28:40 volumio3b volumio[994]: info: Loading plugin "mpd"...
Mar 16 16:28:40 volumio3b volumio[994]: info: Loading plugin "upnp_browser"...
Mar 16 16:28:40 volumio3b sudo[1080]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:41 volumio3b volumio[994]: info: Loading plugin "alarm-clock"...
Mar 16 16:28:41 volumio3b volumio[994]: info: Loading plugin "airplay_emulation"...
Mar 16 16:28:41 volumio3b volumio[994]: info: Starting Shairport Sync
Mar 16 16:28:41 volumio3b volumio[994]: info: Loading plugin "last_100"...
Mar 16 16:28:41 volumio3b volumio[994]: info: Loading plugin "webradio"...
Mar 16 16:28:41 volumio3b volumio[994]: info: Loading plugin "i2s_dacs"...
Mar 16 16:28:41 volumio3b volumio[994]: info: I2S DAC not set, start Auto-detection
Mar 16 16:28:41 volumio3b volumio[994]: info: Loading plugin "volumiodiscovery"...
Mar 16 16:28:41 volumio3b volumio[994]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Mar 16 16:28:41 volumio3b volumio[994]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 16 16:28:41 volumio3b volumio[994]: *** WARNING *** For more information see
Mar 16 16:28:41 volumio3b volumio[994]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Mar 16 16:28:41 volumio3b volumio[994]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 16 16:28:41 volumio3b node[994]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Mar 16 16:28:41 volumio3b volumio[994]: *** WARNING *** For more information see
Mar 16 16:28:41 volumio3b node[994]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 16 16:28:41 volumio3b node[994]: *** WARNING *** For more information see
Mar 16 16:28:41 volumio3b node[994]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Mar 16 16:28:41 volumio3b node[994]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 16 16:28:41 volumio3b node[994]: *** WARNING *** For more information see
Mar 16 16:28:41 volumio3b volumio[994]: info: Applying required configuration parameters for plugin volumiodiscovery
Mar 16 16:28:41 volumio3b volumio[994]: info: Discovery: Started advertising with name: Volumio3b
Mar 16 16:28:41 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Mar 16 16:28:41 volumio3b volumio[994]: info: Loading plugin "outputs"...
Mar 16 16:28:41 volumio3b volumio[994]: info: Loading plugin "albumart"...
Mar 16 16:28:41 volumio3b volumio[994]: info: Plugin example_plugin is not enabled
Mar 16 16:28:41 volumio3b volumio[994]: info: Loading plugin "inputs"...
Mar 16 16:28:41 volumio3b volumio[994]: info: Loading plugin "updater_comm"...
Mar 16 16:28:42 volumio3b volumio[994]: info: Plugin mpdemulation is not enabled
Mar 16 16:28:42 volumio3b volumio[994]: info: Loading plugin "rest_api"...
Mar 16 16:28:42 volumio3b volumio[994]: info: Loading plugin "websocket"...
Mar 16 16:28:42 volumio3b volumio[994]: info: Starting Socket.io Server version 2.3.0
Mar 16 16:28:42 volumio3b volumio[994]: info: Loading plugin "touch_display"...
Mar 16 16:28:42 volumio3b volumio[994]: Forking 3 albumart workers
Mar 16 16:28:42 volumio3b volumio[994]: info: Applying required configuration parameters for plugin touch_display
Mar 16 16:28:43 volumio3b volumio[994]: info: Loading i18n strings for locale en
Mar 16 16:28:43 volumio3b volumio[994]: Updating browse sources language
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 16 16:28:43 volumio3b volumio[994]: Starting albumart workers
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 16 16:28:43 volumio3b volumio[994]: Starting albumart workers
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::initPlayerControls
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 16 16:28:43 volumio3b volumio[994]: Express server listening on port 3000
Mar 16 16:28:43 volumio3b volumio[994]: [Metrics] WebUI: 7s 609.71ms
Mar 16 16:28:43 volumio3b volumio[994]: Starting albumart workers
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreStateMachine::resetVolumioState
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreStateMachine::getcurrentVolume
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::volumioRetrievevolume
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 16 16:28:43 volumio3b volumio[994]: info: Cannot read play queue from file
Mar 16 16:28:43 volumio3b volumio[994]: info: Volumio Network Manager: Network status updated: 2
Mar 16 16:28:43 volumio3b volumio[994]: verbose: New Socket.io Connection to 192.168.4.47 from 192.168.4.224 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Mar 16 16:28:43 volumio3b volumio[994]: verbose: New Socket.io Connection to 192.168.4.47:3000 from 192.168.4.233 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 16 16:28:43 volumio3b volumio[994]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::volumioGetState
Mar 16 16:28:43 volumio3b volumio[994]: info: CorePlayQueue::getTrack 0
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::volumioGetState
Mar 16 16:28:43 volumio3b volumio[994]: info: CorePlayQueue::getTrack 0
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Mar 16 16:28:43 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 16 16:28:44 volumio3b volumio[994]: info: Received Get System Info
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 16 16:28:44 volumio3b volumio[994]: info: Discovery: Getting this device information
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::volumioGetState
Mar 16 16:28:44 volumio3b volumio[994]: info: CorePlayQueue::getTrack 0
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::volumioGetState
Mar 16 16:28:44 volumio3b volumio[994]: info: CorePlayQueue::getTrack 0
Mar 16 16:28:44 volumio3b volumio[994]: info: Listing playlists
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreStateMachine::setRepeat null single undefined
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreStateMachine::pushState
Mar 16 16:28:44 volumio3b volumio[994]: info: CorePlayQueue::getTrack 0
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::volumioPushState
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreStateMachine::setRandom null
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreStateMachine::pushState
Mar 16 16:28:44 volumio3b volumio[994]: info: CorePlayQueue::getTrack 0
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::volumioPushState
Mar 16 16:28:44 volumio3b volumio[994]: info: Setting Device type: Raspberry PI
Mar 16 16:28:44 volumio3b volumio[994]: info: Completed loading Core Plugins
Mar 16 16:28:44 volumio3b volumio[994]: info: Preparing to generate the ALSA configuration file
Mar 16 16:28:44 volumio3b volumio[994]: info: VolumeController:: Volume=86 Mute =false
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreStateMachine::pushState
Mar 16 16:28:44 volumio3b volumio[994]: info: CorePlayQueue::getTrack 0
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::volumioPushState
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreStateMachine::updateTrackBlock
Mar 16 16:28:44 volumio3b volumio[994]: info: CorePlayQueue::getTrackBlock
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::volumioRetrievevolume
Mar 16 16:28:44 volumio3b volumio[994]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Mar 16 16:28:44 volumio3b volumio[994]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082
Mar 16 16:28:44 volumio3b volumio[994]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::volumioGetState
Mar 16 16:28:44 volumio3b volumio[994]: info: CorePlayQueue::getTrack 0
Mar 16 16:28:44 volumio3b volumio[994]: info: Discovery: adding 41d8c214-2fa8-44c8-ab80-0e65111d308d
Mar 16 16:28:44 volumio3b volumio[994]: info: Discovery: Found device Volumio RPI5
Mar 16 16:28:44 volumio3b volumio[994]: info: Discovery: Connecting to remote: 192.168.4.233
Mar 16 16:28:44 volumio3b volumio[994]: info: Discovery: adding e00707ed-07a3-40e0-8447-6a1d0f0fbb77
Mar 16 16:28:44 volumio3b volumio[994]: info: Discovery: Found device Volumio3b
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::volumioGetState
Mar 16 16:28:44 volumio3b volumio[994]: info: CorePlayQueue::getTrack 0
Mar 16 16:28:44 volumio3b volumio[994]: info: Asound.conf file unchanged, so no further update is needed
Mar 16 16:28:44 volumio3b volumio[994]: info: Output device has changed, restarting MPD
Mar 16 16:28:44 volumio3b volumio[994]: info: Output device has changed, restarting Shairport Sync
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 16 16:28:44 volumio3b sudo[1165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Mar 16 16:28:44 volumio3b sudo[1165]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:44 volumio3b sudo[1165]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:44 volumio3b sudo[1167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Mar 16 16:28:44 volumio3b sudo[1167]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:44 volumio3b systemd[1]: Stopping Music Player Daemon...
Mar 16 16:28:44 volumio3b volumio-remote-updater[613]: [2025-03-16 16:28:44] [connect] Successful connection
Mar 16 16:28:44 volumio3b volumio[994]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Mar 16 16:28:44 volumio3b volumio[994]: info: ___________ START PLUGINS ___________
Mar 16 16:28:44 volumio3b volumio[994]: info: ControllerMpd::onStart: Initializing MPD
Mar 16 16:28:44 volumio3b volumio[994]: info: Creating MPD Configuration file
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 16 16:28:44 volumio3b volumio[994]: info: [1742156924672] CoreMusicLibrary::Adding element Media Servers
Mar 16 16:28:44 volumio3b sudo[1174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Mar 16 16:28:44 volumio3b sudo[1174]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 16 16:28:44 volumio3b sudo[1174]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:44 volumio3b sudo[1176]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Mar 16 16:28:44 volumio3b sudo[1176]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 16 16:28:44 volumio3b volumio[994]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 16 16:28:44 volumio3b systemd[1]: mpd.service: Succeeded.
Mar 16 16:28:44 volumio3b systemd[1]: Stopped Music Player Daemon.
Mar 16 16:28:44 volumio3b volumio[994]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 16 16:28:44 volumio3b volumio[994]: info: [1742156924815] CoreMusicLibrary::Adding element Last_100
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 16 16:28:44 volumio3b volumio[994]: info: [1742156924819] CoreMusicLibrary::Adding element Webradio
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 16 16:28:44 volumio3b volumio[994]: info: Initializing BBC Radios
Mar 16 16:28:44 volumio3b systemd[1]: Starting Music Player Daemon...
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 16 16:28:44 volumio3b volumio[994]: info: Loading i18n strings for locale en
Mar 16 16:28:44 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 16 16:28:44 volumio3b volumio[994]: info: Volumio Calling Home
Mar 16 16:28:44 volumio3b sudo[1183]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Mar 16 16:28:44 volumio3b sudo[1183]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:44 volumio3b sudo[1183]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:45 volumio3b sudo[1202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service
Mar 16 16:28:45 volumio3b sudo[1202]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:45 volumio3b sudo[1204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service
Mar 16 16:28:45 volumio3b sudo[1204]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:45 volumio3b sudo[1207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload
Mar 16 16:28:45 volumio3b sudo[1207]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:45 volumio3b systemd[1]: Reloading.
Mar 16 16:28:45 volumio3b volumio[994]: info: VolumeController:: Volume=86 Mute =false
Mar 16 16:28:45 volumio3b volumio[994]: info: CoreStateMachine::pushState
Mar 16 16:28:45 volumio3b volumio[994]: info: CorePlayQueue::getTrack 0
Mar 16 16:28:45 volumio3b volumio[994]: info: CoreCommandRouter::volumioPushState
Mar 16 16:28:45 volumio3b volumio[994]: info: touch_display: No backlight interface detected.
Mar 16 16:28:45 volumio3b volumio[994]: info: MPD Permissions set
Mar 16 16:28:45 volumio3b volumio[994]: info: MPD Permissions set
Mar 16 16:28:45 volumio3b volumio[994]: info: Discovery: Connected to remote: 192.168.4.233
Mar 16 16:28:45 volumio3b volumio-remote-updater[613]: [2025-03-16 16:28:45] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1742156924 101
Mar 16 16:28:45 volumio3b volumio[994]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 4
Mar 16 16:28:45 volumio3b volumio[994]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Mar 16 16:28:45 volumio3b volumio[994]: info: Volumio called home
Mar 16 16:28:45 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:45 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:45 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:45 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:45 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:45 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:45 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:45 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:45 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 16 16:28:45 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:45 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:45 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:45 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 16 16:28:45 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:28:45 volumio3b volumio[994]: info: touch_display: No Raspberry Pi Foundation touch screen detected.
Mar 16 16:28:45 volumio3b sudo[1232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf
Mar 16 16:28:45 volumio3b sudo[1232]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:45 volumio3b sudo[1232]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:45 volumio3b systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Mar 16 16:28:45 volumio3b volumio[994]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set.
Mar 16 16:28:45 volumio3b volumio[994]: info: Starting Shairport Sync
Mar 16 16:28:45 volumio3b volumio[994]: info: Starting Shairport Sync
Mar 16 16:28:45 volumio3b volumio[994]: info: Starting Shairport Sync
Mar 16 16:28:45 volumio3b sudo[1235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Mar 16 16:28:45 volumio3b sudo[1235]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:45 volumio3b sudo[1237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Mar 16 16:28:45 volumio3b sudo[1237]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:45 volumio3b volumio[994]: info: CoreCommandRouter::volumioGetState
Mar 16 16:28:45 volumio3b volumio[994]: info: CorePlayQueue::getTrack 0
Mar 16 16:28:45 volumio3b sudo[1239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Mar 16 16:28:45 volumio3b sudo[1239]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:46 volumio3b systemd[1]: ifup@eth0.service: Current command vanished from the unit file, execution of the command list won't be resumed.
Mar 16 16:28:46 volumio3b sudo[1207]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:46 volumio3b volumio[994]: info: touch_display: systemctl daemon-reload succeeded.
Mar 16 16:28:46 volumio3b systemd[1]: Reloading.
Mar 16 16:28:46 volumio3b sudo[1245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service
Mar 16 16:28:46 volumio3b sudo[1245]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:46 volumio3b systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Mar 16 16:28:46 volumio3b mpd[1200]: Mar 16 16:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Mar 16 16:28:47 volumio3b systemd[1]: Started Music Player Daemon.
Mar 16 16:28:47 volumio3b sudo[1204]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:47 volumio3b sudo[1176]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:47 volumio3b volumio[994]: info: touch_display: systemctl disable getty@tty1.service succeeded.
Mar 16 16:28:47 volumio3b sudo[1167]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:47 volumio3b sudo[1202]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:47 volumio3b volumio[994]: info: touch_display: systemctl stop getty@tty1.service succeeded.
Mar 16 16:28:47 volumio3b sudo[1245]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:47 volumio3b systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Mar 16 16:28:47 volumio3b systemd[1]: shairport-sync.service: Succeeded.
Mar 16 16:28:47 volumio3b systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Mar 16 16:28:47 volumio3b volumio[994]: error: MPD error: The expression evaluated to a falsy value:
Mar 16 16:28:47 volumio3b volumio[994]: assert.ok(self.idling)
Mar 16 16:28:47 volumio3b volumio[994]: error: The expression evaluated to a falsy value:
Mar 16 16:28:47 volumio3b volumio[994]: assert.ok(self.idling)
Mar 16 16:28:47 volumio3b volumio[994]: error: updateQueue error: null
Mar 16 16:28:47 volumio3b volumio[994]: error: touch_display: Failed to start volumio-kiosk.service: Error: Command failed: /usr/bin/sudo /bin/systemctl start volumio-kiosk.service
Mar 16 16:28:47 volumio3b volumio[994]: Failed to start volumio-kiosk.service: Unit volumio-kiosk.service not found.
Mar 16 16:28:47 volumio3b volumio[994]: info: Completed starting Core Plugins
Mar 16 16:28:47 volumio3b volumio[994]: info: -------------------------------------------
Mar 16 16:28:47 volumio3b volumio[994]: info: ----- MyVolumio plugins startup ----
Mar 16 16:28:47 volumio3b volumio[994]: info: -------------------------------------------
Mar 16 16:28:47 volumio3b volumio[994]: info: [MyVolumio PluginManager] Fetching plans data....
Mar 16 16:28:47 volumio3b systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Mar 16 16:28:47 volumio3b sudo[1239]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:47 volumio3b sudo[1237]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:47 volumio3b sudo[1235]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:47 volumio3b volumio[994]: info: MPD running with PID1200
Mar 16 16:28:47 volumio3b volumio[994]: ,establishing connection
Mar 16 16:28:47 volumio3b volumio[994]: info: Shairport-Sync Started
Mar 16 16:28:47 volumio3b volumio[994]: Error adding Membership: Error: addMembership EINVAL
Mar 16 16:28:47 volumio3b volumio[994]: info: Shairport-Sync Started
Mar 16 16:28:47 volumio3b volumio[994]: info: Shairport-Sync Started
Mar 16 16:28:47 volumio3b volumio[994]: error: updateQueue error: null
Mar 16 16:28:49 volumio3b systemd[1]: systemd-fsckd.service: Succeeded.
Mar 16 16:28:50 volumio3b sudo[1285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 16 16:28:50 volumio3b sudo[1285]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:50 volumio3b sudo[1285]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:50 volumio3b sudo[1287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 16 16:28:50 volumio3b sudo[1287]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:50 volumio3b sudo[1287]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:50 volumio3b sudo[1291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Mar 16 16:28:50 volumio3b sudo[1291]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:50 volumio3b systemd[1]: Started UPnP Renderer front-end to MPD.
Mar 16 16:28:50 volumio3b sudo[1291]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:50 volumio3b volumio[994]: info: Upmpdcli Daemon Started
Mar 16 16:28:50 volumio3b volumio[1293]: Generating RSA private key, 4096 bit long modulus (2 primes)
Mar 16 16:28:51 volumio3b sh[520]: timed out
Mar 16 16:28:51 volumio3b dhcpcd[557]: timed out
Mar 16 16:28:51 volumio3b sh[520]: dhcpcd exited
Mar 16 16:28:51 volumio3b dhcpcd[557]: dhcpcd exited
Mar 16 16:28:51 volumio3b sh[520]: ifup: failed to bring up eth0
Mar 16 16:28:51 volumio3b systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE
Mar 16 16:28:51 volumio3b systemd[1]: ifup@eth0.service: Failed with result 'exit-code'.
Mar 16 16:28:52 volumio3b volumio[994]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Mar 16 16:28:53 volumio3b systemd[1]: systemd-hostnamed.service: Succeeded.
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Mar 16 16:28:55 volumio3b volumio[994]: info: Adding plugin bluetooth to MyMusic Plugins
Mar 16 16:28:55 volumio3b volumio[994]: info: Adding plugin multiroom to MyMusic Plugins
Mar 16 16:28:55 volumio3b volumio[994]: info: Adding plugin metavolumio to MyMusic Plugins
Mar 16 16:28:55 volumio3b volumio[994]: info: Adding plugin cd_controller to MyMusic Plugins
Mar 16 16:28:55 volumio3b volumio[994]: info: Adding plugin smart_inputs to MyMusic Plugins
Mar 16 16:28:55 volumio3b volumio[994]: info: Adding plugin tidalconnect to MyMusic Plugins
Mar 16 16:28:55 volumio3b volumio[994]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Mar 16 16:28:57 volumio3b volumio[994]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Mar 16 16:28:57 volumio3b volumio[994]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Mar 16 16:28:57 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 16 16:28:57 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 16 16:28:57 volumio3b volumio[994]: info: Starting MyVolumio Remote Streaming Endpoints
Mar 16 16:28:57 volumio3b volumio[994]: info: MyVolumio login type: Token
Mar 16 16:28:57 volumio3b volumio[994]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Mar 16 16:28:57 volumio3b volumio[994]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Mar 16 16:28:58 volumio3b volumio[994]: info: Starting Streaming Service Transparent Proxy
Mar 16 16:28:58 volumio3b volumio[994]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Mar 16 16:28:58 volumio3b volumio[994]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Mar 16 16:28:58 volumio3b volumio[994]: info: Streaming services startup
Mar 16 16:28:58 volumio3b volumio[994]: info: Starting Streaming Daemon
Mar 16 16:28:58 volumio3b sudo[1320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Mar 16 16:28:58 volumio3b sudo[1320]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:28:58 volumio3b volumio[994]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Mar 16 16:28:58 volumio3b sudo[1320]: pam_unix(sudo:session): session closed for user root
Mar 16 16:28:59 volumio3b volumio[994]: error: Cannot start Volumio Streaming Daemon
Mar 16 16:28:59 volumio3b volumio[994]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Mar 16 16:28:59 volumio3b volumio[994]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Mar 16 16:28:59 volumio3b volumio[994]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Mar 16 16:29:00 volumio3b volumio[994]: STREAMING PROXY: Starting server on port 3245
Mar 16 16:29:00 volumio3b volumio[994]: Node JS runtime: 14
Mar 16 16:29:00 volumio3b volumio[994]: info: MyVolumio token set successfully
Mar 16 16:29:00 volumio3b volumio[994]: info: MYVOLUMIO: Adding device
Mar 16 16:29:00 volumio3b volumio[994]: info: MYVOLUMIO: Evaluating Server
Mar 16 16:29:01 volumio3b volumio[994]: info: MyVolumio status changed
Mar 16 16:29:01 volumio3b volumio[994]: info: Streaming services startup
Mar 16 16:29:01 volumio3b volumio[994]: info: Starting Streaming Daemon
Mar 16 16:29:01 volumio3b volumio[994]: info: Removing browser output: myVolumio user plan is not superstar
Mar 16 16:29:01 volumio3b volumio[994]: info: Removing audio output:
Mar 16 16:29:01 volumio3b volumio[994]: info: Stoppping Tunnel 1
Mar 16 16:29:01 volumio3b sudo[1360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Mar 16 16:29:01 volumio3b sudo[1360]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:29:01 volumio3b sudo[1362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Mar 16 16:29:01 volumio3b sudo[1362]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:29:01 volumio3b sudo[1360]: pam_unix(sudo:session): session closed for user root
Mar 16 16:29:01 volumio3b volumio[994]: error: Cannot start Volumio Streaming Daemon
Mar 16 16:29:01 volumio3b volumio[994]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Mar 16 16:29:01 volumio3b volumio[994]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Mar 16 16:29:01 volumio3b sudo[1362]: pam_unix(sudo:session): session closed for user root
Mar 16 16:29:01 volumio3b volumio[994]: info: Remote SSH Stopped
Mar 16 16:29:01 volumio3b volumio[994]: info: Setting Geolocation for MyVolumio to us1
Mar 16 16:29:01 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 16 16:29:01 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 16 16:29:01 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 16 16:29:02 volumio3b volumio[994]: info: Successfully Added MyVolumio device
Mar 16 16:29:02 volumio3b volumio[994]: info: Updating MyVolumio device info
Mar 16 16:29:02 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 16 16:29:02 volumio3b volumio[1293]: .......................................................................................++++
Mar 16 16:29:02 volumio3b volumio[994]: info: Successfully Updated MyVolumio device
Mar 16 16:29:05 volumio3b volumio[1293]: .....................++++
Mar 16 16:29:05 volumio3b volumio[1293]: e is 65537 (0x010001)
Mar 16 16:29:05 volumio3b volumio[1293]: writing RSA key
Mar 16 16:29:08 volumio3b systemd[1]: systemd-timedated.service: Succeeded.
Mar 16 16:29:12 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 16 16:29:12 volumio3b volumio[994]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Mar 16 16:29:12 volumio3b volumio[994]: info: CoreCommandRouter::volumioGetState
Mar 16 16:29:12 volumio3b volumio[994]: info: CorePlayQueue::getTrack 0
Mar 16 16:29:14 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 16 16:29:14 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 16 16:29:14 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 16 16:29:14 volumio3b volumio-remote-updater[613]: No test mode
Mar 16 16:29:14 volumio3b volumio-remote-updater[613]: No alpha test mode
Mar 16 16:29:14 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Mar 16 16:29:15 volumio3b volumio[994]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Mar 16 16:29:15 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Mar 16 16:29:17 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:29:17 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:29:17 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Mar 16 16:29:17 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Mar 16 16:29:17 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Mar 16 16:29:17 volumio3b volumio[994]: info: CoreCommandRouter::volumioGetBrowseSources
Mar 16 16:29:17 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 16 16:29:18 volumio3b volumio[994]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Mar 16 16:29:18 volumio3b volumio[994]: info: Completed starting MyVolumio Plugin
Mar 16 16:29:18 volumio3b volumio[994]: [Metrics] CommandRouter: 42s 74.05ms
Mar 16 16:29:18 volumio3b volumio[994]: info: CoreCommandRouter::volumiosetStartupVolume
Mar 16 16:29:18 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 16 16:29:18 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 16 16:29:18 volumio3b volumio[994]: info: CoreCommandRouter::Close All Modals sent
Mar 16 16:29:18 volumio3b volumio[994]: info: CoreCommandRouter::Close All Modals sent
Mar 16 16:29:19 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Mar 16 16:29:19 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Mar 16 16:29:20 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Mar 16 16:29:24 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 16 16:29:24 volumio3b volumio[994]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Mar 16 16:29:25 volumio3b volumio[994]: info: BOOT COMPLETED
Mar 16 16:29:28 volumio3b ntpd[811]: Soliciting pool server 199.182.221.110
Mar 16 16:29:29 volumio3b ntpd[811]: Soliciting pool server 155.138.150.39
Mar 16 16:29:30 volumio3b volumio[994]: info: Starting Uninstall of plugin user_interface - touch_display
Mar 16 16:29:30 volumio3b volumio[994]: info: Uninstalling plugin touch_display
Mar 16 16:29:30 volumio3b sudo[1462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf
Mar 16 16:29:30 volumio3b sudo[1462]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:29:30 volumio3b sudo[1462]: pam_unix(sudo:session): session closed for user root
Mar 16 16:29:30 volumio3b sudo[1464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service
Mar 16 16:29:30 volumio3b sudo[1464]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:29:30 volumio3b sudo[1467]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service
Mar 16 16:29:30 volumio3b sudo[1467]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:29:30 volumio3b volumio[994]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set.
Mar 16 16:29:30 volumio3b volumio[994]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 16 16:29:30 volumio3b volumio[994]: TypeError: Cannot read property 'split' of undefined
Mar 16 16:29:30 volumio3b volumio[994]: at /data/plugins/user_interface/touch_display/index.js:1258:37
Mar 16 16:29:30 volumio3b volumio[994]: at ChildProcess.exithandler (child_process.js:299:7)
Mar 16 16:29:30 volumio3b volumio[994]: at ChildProcess.emit (events.js:315:20)
Mar 16 16:29:30 volumio3b volumio[994]: at maybeClose (internal/child_process.js:1048:16)
Mar 16 16:29:30 volumio3b volumio[994]: at Socket. (internal/child_process.js:439:11)
Mar 16 16:29:30 volumio3b volumio[994]: at Socket.emit (events.js:315:20)
Mar 16 16:29:30 volumio3b volumio[994]: at Pipe. (net.js:673:12)
Mar 16 16:29:30 volumio3b volumio[994]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 16 16:29:30 volumio3b sudo[1478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service
Mar 16 16:29:30 volumio3b sudo[1478]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 16 16:29:30 volumio3b systemd[1]: Reloading.
Mar 16 16:29:30 volumio3b systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Mar 16 16:29:30 volumio3b ntpd[811]: Soliciting pool server 142.4.192.253
Mar 16 16:29:30 volumio3b ntpd[811]: Soliciting pool server 198.50.127.72
Mar 16 16:29:31 volumio3b sudo[1509]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-16 16:28
Mar 16 16:29:31 volumio3b sudo[1509]: 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="147953990fca4aa103a8f90538ef56fb0454638c"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET"
VOLUMIO_VERSION="3.795"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"