-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sat 2023-05-27 22:14:20 UTC. -- May 27 22:13:24 musicpi fake-hwclock[201]: Sat May 27 22:13:24 UTC 2023 May 27 22:13:24 musicpi systemd[1]: Started Restore / save the current clock. May 27 22:13:24 musicpi systemd[1]: Started Apply Kernel Variables. May 27 22:13:24 musicpi systemd[1]: Started Load/Save Random Seed. May 27 22:13:24 musicpi systemd[1]: Started Create System Users. May 27 22:13:24 musicpi systemd[1]: Starting Create Static Device Nodes in /dev... May 27 22:13:24 musicpi systemd[1]: dynamicswap.service: Succeeded. May 27 22:13:24 musicpi systemd[1]: Started Create Static Device Nodes in /dev. May 27 22:13:24 musicpi systemd[1]: Reached target Local File Systems (Pre). May 27 22:13:24 musicpi systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. May 27 22:13:24 musicpi systemd[1]: Mounting /tmp... May 27 22:13:24 musicpi systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. May 27 22:13:24 musicpi systemd[1]: Mounting /var/log... May 27 22:13:24 musicpi systemd[1]: Mounting /var/spool/cups... May 27 22:13:24 musicpi systemd[1]: Starting udev Kernel Device Manager... May 27 22:13:24 musicpi systemd[1]: Mounted /tmp. May 27 22:13:24 musicpi systemd[1]: Mounted /var/log. May 27 22:13:24 musicpi systemd[1]: Starting Flush Journal to Persistent Storage... May 27 22:13:24 musicpi systemd[1]: Mounted /var/spool/cups. May 27 22:13:24 musicpi systemd[1]: Mounting /var/spool/cups/tmp... May 27 22:13:24 musicpi systemd[1]: Mounted /var/spool/cups/tmp. May 27 22:13:24 musicpi systemd-udevd[223]: Network interface NamePolicy= disabled on kernel command line, ignoring. May 27 22:13:24 musicpi systemd-journald[192]: Runtime journal (/run/log/journal/f67eb8adba804d11b617d1be61ee763c) is 7.5M, max 30.0M, 22.5M free. May 27 22:13:24 musicpi systemd[1]: Started Flush Journal to Persistent Storage. May 27 22:13:24 musicpi systemd[1]: Started udev Coldplug all Devices. May 27 22:13:24 musicpi systemd[1]: Starting Helper to synchronize boot up for ifupdown... May 27 22:13:24 musicpi systemd[1]: Started udev Kernel Device Manager. May 27 22:13:24 musicpi systemd[1]: Starting Show Plymouth Boot Screen... May 27 22:13:24 musicpi systemd[1]: Received SIGRTMIN+20 from PID 244 (plymouthd). May 27 22:13:24 musicpi systemd[1]: Started Show Plymouth Boot Screen. May 27 22:13:24 musicpi systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. May 27 22:13:24 musicpi systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. May 27 22:13:24 musicpi systemd[1]: Reached target Local Encrypted Volumes. May 27 22:13:24 musicpi systemd[1]: Reached target Paths. May 27 22:13:24 musicpi systemd-udevd[229]: Using default interface naming scheme 'v240'. May 27 22:13:24 musicpi kernel: rpivid-mem feb00000.hevc-decoder: rpivid-hevcmem initialised: Registers at 0xfeb00000 length 0x00010000 May 27 22:13:24 musicpi kernel: rpivid-mem feb10000.rpivid-local-intc: rpivid-intcmem initialised: Registers at 0xfeb10000 length 0x00001000 May 27 22:13:24 musicpi kernel: rpivid-mem feb20000.h264-decoder: rpivid-h264mem initialised: Registers at 0xfeb20000 length 0x00010000 May 27 22:13:24 musicpi kernel: rpivid-mem feb30000.vp9-decoder: rpivid-vp9mem initialised: Registers at 0xfeb30000 length 0x00010000 May 27 22:13:24 musicpi systemd-udevd[229]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 27 22:13:24 musicpi kernel: mc: Linux media interface: v0.10 May 27 22:13:24 musicpi kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. May 27 22:13:24 musicpi kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver May 27 22:13:24 musicpi kernel: [vc_sm_connected_init]: start May 27 22:13:24 musicpi kernel: [vc_sm_connected_init]: installed successfully May 27 22:13:25 musicpi kernel: pinctrl-bcm2835 fe200000.gpio: pin gpio3 already requested by fe804000.i2c; cannot claim for soc:shutdown_button@3 May 27 22:13:25 musicpi kernel: pinctrl-bcm2835 fe200000.gpio: pin-3 (soc:shutdown_button@3) status -22 May 27 22:13:25 musicpi kernel: pinctrl-bcm2835 fe200000.gpio: could not request pin 3 (gpio3) from group gpio3 on device pinctrl-bcm2711 May 27 22:13:25 musicpi kernel: gpio-keys soc:shutdown_button@3: Error applying setting, reverse things back May 27 22:13:25 musicpi kernel: gpio-keys: probe of soc:shutdown_button@3 failed with error -22 May 27 22:13:25 musicpi kernel: input: raspberrypi-ts as /devices/platform/soc/soc:firmware/soc:firmware:touchscreen/input/input0 May 27 22:13:25 musicpi systemd-udevd[233]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 27 22:13:25 musicpi kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. May 27 22:13:25 musicpi kernel: videodev: Linux video capture interface: v2.00 May 27 22:13:25 musicpi kernel: bcm2835_audio bcm2835_audio: card created with 8 channels May 27 22:13:25 musicpi kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. May 27 22:13:25 musicpi kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. May 27 22:13:25 musicpi kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. May 27 22:13:25 musicpi kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. May 27 22:13:25 musicpi kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 May 27 22:13:25 musicpi kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 May 27 22:13:25 musicpi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 May 27 22:13:25 musicpi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode May 27 22:13:25 musicpi kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 May 27 22:13:25 musicpi kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 May 27 22:13:25 musicpi kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller May 27 22:13:25 musicpi kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller May 27 22:13:25 musicpi kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller May 27 22:13:25 musicpi kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller May 27 22:13:25 musicpi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 May 27 22:13:25 musicpi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode May 27 22:13:25 musicpi kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 May 27 22:13:25 musicpi kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 May 27 22:13:25 musicpi kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 May 27 22:13:25 musicpi kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 May 27 22:13:25 musicpi kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller May 27 22:13:25 musicpi kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller May 27 22:13:25 musicpi kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller May 27 22:13:25 musicpi kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller May 27 22:13:25 musicpi kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp May 27 22:13:25 musicpi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 May 27 22:13:25 musicpi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp May 27 22:13:25 musicpi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 May 27 22:13:25 musicpi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx May 27 22:13:26 musicpi systemd-udevd[237]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 27 22:13:26 musicpi kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database May 27 22:13:26 musicpi kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' May 27 22:13:26 musicpi systemd-udevd[247]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 27 22:13:26 musicpi kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 May 27 22:13:26 musicpi kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 May 27 22:13:26 musicpi kernel: usbcore: registered new interface driver brcmfmac May 27 22:13:27 musicpi kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 May 27 22:13:27 musicpi kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 May 27 22:13:27 musicpi kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Jan 4 2021 19:56:29 version 7.45.229 (617f1f5 CY) FWID 01-2dbd9d2e May 27 22:13:27 musicpi systemd-udevd[237]: Using default interface naming scheme 'v240'. May 27 22:13:27 musicpi systemd-udevd[237]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 27 22:13:27 musicpi systemd[1]: Found device /dev/mmcblk0p1. May 27 22:13:28 musicpi systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. May 27 22:13:28 musicpi systemd[1]: Condition check resulted in Huge Pages File System being skipped. May 27 22:13:28 musicpi systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. May 27 22:13:28 musicpi systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. May 27 22:13:28 musicpi systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. May 27 22:13:28 musicpi systemd[1]: Condition check resulted in FUSE Control File System being skipped. May 27 22:13:28 musicpi systemd[1]: Starting File System Check on /dev/mmcblk0p1... May 27 22:13:28 musicpi systemd[1]: Created slice system-systemd\x2dbacklight.slice. May 27 22:13:28 musicpi systemd[1]: Starting Load/Save Screen Backlight Brightness of backlight:rpi_backlight... May 27 22:13:28 musicpi systemd[1]: Found device /sys/subsystem/net/devices/eth0. May 27 22:13:28 musicpi systemd[1]: Started Load/Save Screen Backlight Brightness of backlight:rpi_backlight. May 27 22:13:28 musicpi systemd[1]: Started File System Check Daemon to report status. May 27 22:13:28 musicpi systemd[1]: Starting Load/Save RF Kill Switch Status... May 27 22:13:28 musicpi systemd-fsck[401]: fsck.fat 4.1 (2017-01-24) May 27 22:13:28 musicpi systemd-fsck[401]: /dev/mmcblk0p1: 297 files, 27484/46774 clusters May 27 22:13:28 musicpi systemd[1]: Found device /sys/subsystem/net/devices/wlan0. May 27 22:13:28 musicpi systemd[1]: Started Load/Save RF Kill Switch Status. May 27 22:13:28 musicpi systemd[1]: Started Helper to synchronize boot up for ifupdown. May 27 22:13:28 musicpi systemd[1]: Started File System Check on /dev/mmcblk0p1. May 27 22:13:28 musicpi systemd[1]: Mounting /boot... May 27 22:13:29 musicpi systemd[1]: Mounted /boot. May 27 22:13:29 musicpi systemd[1]: Reached target Local File Systems. May 27 22:13:29 musicpi systemd[1]: Starting Create Volatile Files and Directories... May 27 22:13:29 musicpi systemd[1]: Starting Preprocess NFS configuration... May 27 22:13:29 musicpi systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. May 27 22:13:29 musicpi systemd[1]: Starting Raise network interfaces... May 27 22:13:29 musicpi systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... May 27 22:13:29 musicpi systemd[1]: Started ifup for eth0. May 27 22:13:29 musicpi systemd[1]: Started ifup for wlan0. May 27 22:13:29 musicpi systemd[1]: nfs-config.service: Succeeded. May 27 22:13:29 musicpi systemd[1]: Started Preprocess NFS configuration. May 27 22:13:29 musicpi systemd[1]: plymouth-read-write.service: Succeeded. May 27 22:13:29 musicpi systemd[1]: Started Tell Plymouth To Write Out Runtime Data. May 27 22:13:29 musicpi systemd[1]: Received SIGRTMIN+20 from PID 244 (plymouthd). May 27 22:13:29 musicpi systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. May 27 22:13:29 musicpi systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. May 27 22:13:29 musicpi systemd[1]: Reached target NFS client services. May 27 22:13:29 musicpi systemd[1]: Started Create Volatile Files and Directories. May 27 22:13:29 musicpi systemd[1]: Condition check resulted in Network Time Synchronization being skipped. May 27 22:13:29 musicpi systemd[1]: Starting Update UTMP about System Boot/Shutdown... May 27 22:13:29 musicpi systemd[1]: Starting RPC bind portmap service... May 27 22:13:29 musicpi systemd[1]: Started Entropy daemon using the HAVEGE algorithm. May 27 22:13:29 musicpi systemd[1]: Started Update UTMP about System Boot/Shutdown. May 27 22:13:29 musicpi systemd[1]: Reached target System Initialization. May 27 22:13:29 musicpi systemd[1]: Started Daily man-db regeneration. May 27 22:13:29 musicpi systemd[1]: Listening on D-Bus System Message Bus Socket. May 27 22:13:29 musicpi systemd[1]: Started Daily Cleanup of Temporary Directories. May 27 22:13:29 musicpi systemd[1]: Listening on triggerhappy.socket. May 27 22:13:29 musicpi systemd[1]: Started Daily apt download activities. May 27 22:13:29 musicpi systemd[1]: Started Daily apt upgrade and clean activities. May 27 22:13:29 musicpi systemd[1]: Reached target Timers. May 27 22:13:29 musicpi systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. May 27 22:13:29 musicpi systemd[1]: Listening on mpd.socket. May 27 22:13:29 musicpi systemd[1]: Reached target Sockets. May 27 22:13:29 musicpi systemd[1]: Reached target Basic System. May 27 22:13:29 musicpi systemd[1]: Starting Wireless Services... May 27 22:13:29 musicpi systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. May 27 22:13:29 musicpi systemd[1]: Started Volumio Iptables Module. May 27 22:13:29 musicpi systemd[1]: Started UPnP Renderer front-end to MPD. May 27 22:13:29 musicpi systemd[1]: Starting Avahi mDNS/DNS-SD Stack... May 27 22:13:29 musicpi systemd[1]: Started D-Bus System Message Bus. May 27 22:13:29 musicpi systemd[1]: Starting Login Service... May 27 22:13:29 musicpi systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. May 27 22:13:29 musicpi systemd[1]: Starting dhcpcd on all interfaces... May 27 22:13:29 musicpi systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. May 27 22:13:29 musicpi systemd[1]: Starting WPA supplicant... May 27 22:13:29 musicpi systemd[1]: Starting Configure Bluetooth Modems connected by UART... May 27 22:13:29 musicpi systemd[1]: Starting triggerhappy global hotkey daemon... May 27 22:13:29 musicpi systemd[1]: Started volumio-remote-updater.service. May 27 22:13:29 musicpi systemd[1]: Started Manage Sound Card State (restore and store). May 27 22:13:29 musicpi systemd[1]: Starting Save/Restore Sound Card State... May 27 22:13:29 musicpi alsactl[492]: alsactl 1.1.8 daemon started May 27 22:13:30 musicpi dhcpcd[487]: Not running dhcpcd because /etc/network/interfaces May 27 22:13:30 musicpi dhcpcd[487]: defines some interfaces that will use a May 27 22:13:30 musicpi dhcpcd[487]: DHCP client or static address May 27 22:13:30 musicpi thd[490]: Unable to parse trigger line: May 27 22:13:30 musicpi thd[490]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle May 27 22:13:30 musicpi thd[490]: Unable to parse trigger line: May 27 22:13:30 musicpi thd[490]: Unable to parse trigger line: May 27 22:13:30 musicpi thd[490]: Unable to parse trigger line: May 27 22:13:30 musicpi thd[490]: Unable to parse trigger line: May 27 22:13:30 musicpi thd[490]: Unable to parse trigger line: May 27 22:13:30 musicpi thd[490]: Unable to parse trigger line: May 27 22:13:30 musicpi kernel: 8021q: 802.1Q VLAN Support v1.8 May 27 22:13:30 musicpi kernel: uart-pl011 fe201000.serial: no DMA platform data May 27 22:13:30 musicpi thd[490]: Found socket passed from systemd May 27 22:13:30 musicpi avahi-daemon[481]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). May 27 22:13:30 musicpi avahi-daemon[481]: Successfully dropped root privileges. May 27 22:13:30 musicpi avahi-daemon[481]: avahi-daemon 0.7 starting up. May 27 22:13:31 musicpi sh[415]: eth0: waiting for carrier May 27 22:13:31 musicpi dhcpcd[461]: eth0: waiting for carrier May 27 22:13:31 musicpi kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) May 27 22:13:31 musicpi kernel: bcmgenet fd580000.ethernet eth0: Link is Down May 27 22:13:31 musicpi systemd-logind[486]: New seat seat0. May 27 22:13:31 musicpi kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 27 22:13:31 musicpi systemd[1]: Started triggerhappy global hotkey daemon. May 27 22:13:31 musicpi systemd[1]: Started RPC bind portmap service. May 27 22:13:31 musicpi systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED May 27 22:13:31 musicpi systemd[1]: dhcpcd.service: Failed with result 'exit-code'. May 27 22:13:31 musicpi systemd[1]: Failed to start dhcpcd on all interfaces. May 27 22:13:31 musicpi systemd[1]: Started Save/Restore Sound Card State. May 27 22:13:31 musicpi avahi-daemon[481]: Successfully called chroot(). May 27 22:13:31 musicpi avahi-daemon[481]: Successfully dropped remaining capabilities. May 27 22:13:31 musicpi avahi-daemon[481]: Loading service file /services/volumio.service. May 27 22:13:31 musicpi avahi-daemon[481]: Network interface enumeration completed. May 27 22:13:31 musicpi avahi-daemon[481]: Server startup complete. Host name is musicpi.local. Local service cookie is 2603506816. May 27 22:13:31 musicpi avahi-daemon[481]: Service "MusicPi" (/services/volumio.service) successfully established. May 27 22:13:31 musicpi systemd[1]: Started Login Service. May 27 22:13:31 musicpi systemd[1]: Started Avahi mDNS/DNS-SD Stack. May 27 22:13:31 musicpi systemd[1]: Reached target Sound Card. May 27 22:13:31 musicpi systemd[1]: Reached target RPC Port Mapper. May 27 22:13:31 musicpi ifup[411]: ifup: waiting for lock on /run/network/ifstate.wlan0 May 27 22:13:31 musicpi systemd[1]: Reached target Remote File Systems (Pre). May 27 22:13:31 musicpi systemd[1]: Reached target Remote File Systems. May 27 22:13:31 musicpi systemd[1]: Starting listen-for-shutdown.service... May 27 22:13:31 musicpi listen-for-shutdown.sh[546]: Starting listen-for-shutdown.py May 27 22:13:31 musicpi systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... May 27 22:13:31 musicpi systemd[1]: Started listen-for-shutdown.service. May 27 22:13:31 musicpi sh[417]: wlan0=wlan0 May 27 22:13:31 musicpi systemd[1]: Started Raise network interfaces. May 27 22:13:32 musicpi loadcpufreq[548]: Loading cpufreq kernel modules...done (none). May 27 22:13:32 musicpi systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. May 27 22:13:32 musicpi systemd[1]: Starting LSB: set CPUFreq kernel parameters... May 27 22:13:32 musicpi cpufrequtils[604]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. May 27 22:13:32 musicpi systemd[1]: Started LSB: set CPUFreq kernel parameters. May 27 22:13:32 musicpi haveged[451]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K May 27 22:13:32 musicpi haveged[451]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 May 27 22:13:32 musicpi haveged[451]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99767 May 27 22:13:32 musicpi haveged[451]: haveged: fills: 0, generated: 0 May 27 22:13:32 musicpi systemd[1]: iptables.service: Succeeded. May 27 22:13:32 musicpi kernel: random: crng init done May 27 22:13:32 musicpi kernel: random: 7 urandom warning(s) missed due to ratelimiting May 27 22:13:33 musicpi systemd[1]: Started WPA supplicant. May 27 22:13:33 musicpi wpa_supplicant[488]: Successfully initialized wpa_supplicant May 27 22:13:33 musicpi systemd[1]: Reached target Network. May 27 22:13:33 musicpi systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. May 27 22:13:33 musicpi systemd[1]: Starting Permit User Sessions... May 27 22:13:33 musicpi systemd[1]: Starting Music Player Daemon... May 27 22:13:33 musicpi systemd[1]: Starting OpenBSD Secure Shell server... May 27 22:13:33 musicpi systemd[1]: Reached target Network is Online. May 27 22:13:33 musicpi systemd[1]: Starting /etc/rc.local Compatibility... May 27 22:13:33 musicpi systemd[1]: Starting LSB: Brings up/down network automatically... May 27 22:13:33 musicpi systemd[1]: Starting Samba NMB Daemon... May 27 22:13:33 musicpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 27 22:13:33 musicpi systemd[1]: Starting Network Time Service... May 27 22:13:33 musicpi systemd[1]: Started Permit User Sessions. May 27 22:13:33 musicpi systemd[1]: Started /etc/rc.local Compatibility. May 27 22:13:33 musicpi systemd[1]: Starting Hold until boot process finishes up... May 27 22:13:33 musicpi systemd[1]: Starting Terminate Plymouth Boot Screen... May 27 22:13:33 musicpi systemd[1]: systemd-rfkill.service: Succeeded. May 27 22:13:33 musicpi systemd[1]: plymouth-start.service: Succeeded. May 27 22:13:33 musicpi systemd[1]: plymouth-quit-wait.service: Succeeded. May 27 22:13:33 musicpi systemd[1]: Started Hold until boot process finishes up. May 27 22:13:33 musicpi systemd[1]: plymouth-quit.service: Succeeded. May 27 22:13:33 musicpi systemd[1]: Started Terminate Plymouth Boot Screen. May 27 22:13:33 musicpi systemd[1]: Received SIGRTMIN+21 from PID 244 (n/a). May 27 22:13:33 musicpi systemd[1]: Received SIGRTMIN+21 from PID 244 (n/a). May 27 22:13:33 musicpi systemd[1]: Started Getty on tty1. May 27 22:13:33 musicpi systemd[1]: Reached target Login Prompts. May 27 22:13:33 musicpi ifplugd(eth0)[654]: ifplugd 0.28 initializing. May 27 22:13:33 musicpi ifplugd(eth0)[654]: Using interface eth0/E4:5F:01:78:26:32 with driver (version: 5.10.90-v7l+) May 27 22:13:33 musicpi ifplugd(eth0)[654]: Using detection mode: SIOCETHTOOL May 27 22:13:33 musicpi ifplugd(eth0)[654]: Initialization complete, link beat not detected. May 27 22:13:33 musicpi ifplugd[628]: Network Interface Plugging Daemon...start eth0...done. May 27 22:13:33 musicpi systemd[1]: Started LSB: Brings up/down network automatically. May 27 22:13:33 musicpi ntpd[633]: ntpd 4.2.8p12@1.3728-o (1): Starting May 27 22:13:33 musicpi ntpd[633]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 May 27 22:13:33 musicpi systemd[1]: Started Network Time Service. May 27 22:13:33 musicpi ntpd[658]: proto: precision = 0.778 usec (-20) May 27 22:13:33 musicpi ntpd[658]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 27 22:13:33 musicpi ntpd[658]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 May 27 22:13:33 musicpi ntpd[658]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 334 days ago May 27 22:13:33 musicpi ntpd[658]: Listen and drop on 0 v6wildcard [::]:123 May 27 22:13:33 musicpi ntpd[658]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 27 22:13:33 musicpi ntpd[658]: Listen normally on 2 lo 127.0.0.1:123 May 27 22:13:33 musicpi ntpd[658]: Listening on routing socket on fd #19 for interface updates May 27 22:13:33 musicpi ntpd[658]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 27 22:13:33 musicpi ntpd[658]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 27 22:13:34 musicpi listen-for-shutdown.sh[546]: /usr/local/bin/listen-for-shutdown.py:9: RuntimeWarning: This channel is already in use, continuing anyway. Use GPIO.setwarnings(False) to disable warnings. May 27 22:13:34 musicpi listen-for-shutdown.sh[546]: GPIO.setup(3, GPIO.IN, pull_up_down=GPIO.PUD_UP) May 27 22:13:34 musicpi listen-for-shutdown.sh[546]: /usr/local/bin/listen-for-shutdown.py:9: RuntimeWarning: A physical pull up resistor is fitted on this channel! May 27 22:13:34 musicpi listen-for-shutdown.sh[546]: GPIO.setup(3, GPIO.IN, pull_up_down=GPIO.PUD_UP) May 27 22:13:34 musicpi volumio-remote-updater[491]: Error: No active session May 27 22:13:34 musicpi volumio-remote-updater[491]: [2023-05-27 22:13:34] [info] asio async_connect error: system:111 (Connection refused) May 27 22:13:34 musicpi volumio-remote-updater[491]: [2023-05-27 22:13:34] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 27 22:13:34 musicpi volumio-remote-updater[491]: [2023-05-27 22:13:34] [error] handle_connect error: Underlying Transport Error May 27 22:13:34 musicpi volumio[480]: Could not open config: /tmp/upmpdcli.conf May 27 22:13:34 musicpi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE May 27 22:13:34 musicpi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. May 27 22:13:34 musicpi sshd[676]: Server listening on 0.0.0.0 port 22. May 27 22:13:34 musicpi sshd[676]: Server listening on :: port 22. May 27 22:13:34 musicpi systemd[1]: Started OpenBSD Secure Shell server. May 27 22:13:34 musicpi ntpd[658]: error resolving pool 0.debian.pool.ntp.org: System error (-11) May 27 22:13:35 musicpi ntpd[658]: error resolving pool 1.debian.pool.ntp.org: System error (-11) May 27 22:13:36 musicpi nmbd[634]: [2023/05/27 22:13:36.171722, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) May 27 22:13:36 musicpi nmbd[634]: started asyncdns process 688 May 27 22:13:36 musicpi nmbd[634]: [2023/05/27 22:13:36.173721, 0] ../lib/util/become_daemon.c:149(daemon_status) May 27 22:13:36 musicpi nmbd[634]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... May 27 22:13:36 musicpi nmbd[634]: [2023/05/27 22:13:36.173872, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) May 27 22:13:36 musicpi nmbd[634]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). May 27 22:13:36 musicpi ntpd[658]: error resolving pool 2.debian.pool.ntp.org: System error (-11) May 27 22:13:37 musicpi wireless.js[475]: WIRELESS DAEMON: start May 27 22:13:37 musicpi wireless.js[475]: WIRELESS: Loaded configuration May 27 22:13:37 musicpi wireless.js[475]: Cleaning previous... May 27 22:13:37 musicpi sudo[693]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 27 22:13:37 musicpi sudo[693]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:37 musicpi sudo[693]: pam_unix(sudo:session): session closed for user root May 27 22:13:37 musicpi sudo[698]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 27 22:13:37 musicpi sudo[698]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:37 musicpi kernel: Bluetooth: Core ver 2.22 May 27 22:13:37 musicpi kernel: NET: Registered protocol family 31 May 27 22:13:37 musicpi kernel: Bluetooth: HCI device and connection manager initialized May 27 22:13:37 musicpi kernel: Bluetooth: HCI socket layer initialized May 27 22:13:37 musicpi kernel: Bluetooth: L2CAP socket layer initialized May 27 22:13:37 musicpi kernel: Bluetooth: SCO socket layer initialized May 27 22:13:37 musicpi kernel: Bluetooth: HCI UART driver ver 2.3 May 27 22:13:37 musicpi kernel: Bluetooth: HCI UART protocol H4 registered May 27 22:13:37 musicpi kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered May 27 22:13:37 musicpi kernel: Bluetooth: HCI UART protocol Broadcom registered May 27 22:13:37 musicpi btuart[489]: bcm43xx_init May 27 22:13:37 musicpi btuart[489]: Flash firmware /lib/firmware/brcm/BCM4345C0.hcd May 27 22:13:37 musicpi btuart[489]: Set Controller UART speed to 3000000 bit/s May 27 22:13:37 musicpi btuart[489]: Device setup complete May 27 22:13:37 musicpi systemd[1]: Starting Load/Save RF Kill Switch Status... May 27 22:13:37 musicpi systemd[1]: Started Configure Bluetooth Modems connected by UART. May 27 22:13:37 musicpi systemd[1]: Started Load/Save RF Kill Switch Status. May 27 22:13:37 musicpi systemd[1]: Created slice system-bthelper.slice. May 27 22:13:37 musicpi systemd[1]: Starting Raspberry Pi bluetooth helper... May 27 22:13:37 musicpi sudo[698]: pam_unix(sudo:session): session closed for user root May 27 22:13:37 musicpi mpd[644]: May 27 22:13 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 27 22:13:37 musicpi bthelper[706]: Raspberry Pi BDADDR already set May 27 22:13:37 musicpi systemd[1]: Started Raspberry Pi bluetooth helper. May 27 22:13:37 musicpi systemd[1]: Starting Bluetooth service... May 27 22:13:37 musicpi ntpd[658]: error resolving pool 3.debian.pool.ntp.org: System error (-11) May 27 22:13:37 musicpi bluetoothd[717]: Bluetooth daemon 5.50 May 27 22:13:37 musicpi bluetoothd[717]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf May 27 22:13:37 musicpi systemd[1]: Started Bluetooth service. May 27 22:13:37 musicpi systemd[1]: Reached target Bluetooth. May 27 22:13:37 musicpi wireless.js[475]: Stopped aP May 27 22:13:37 musicpi wireless.js[475]: Start wireless flow May 27 22:13:37 musicpi wireless.js[475]: Stopped hotspot (if there).. May 27 22:13:37 musicpi bluetoothd[717]: Starting SDP server May 27 22:13:37 musicpi bluetoothd[717]: Excluding (cli) sap May 27 22:13:37 musicpi kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 May 27 22:13:37 musicpi kernel: Bluetooth: BNEP filters: protocol multicast May 27 22:13:37 musicpi kernel: Bluetooth: BNEP socket layer initialized May 27 22:13:37 musicpi bluetoothd[717]: Bluetooth management interface 1.18 initialized May 27 22:13:37 musicpi dbus-daemon[484]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=717 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") May 27 22:13:37 musicpi sudo[723]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 27 22:13:37 musicpi sudo[723]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:37 musicpi sudo[723]: pam_unix(sudo:session): session closed for user root May 27 22:13:37 musicpi systemd[1]: Starting Hostname Service... May 27 22:13:37 musicpi sudo[725]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 27 22:13:37 musicpi sudo[725]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:37 musicpi sudo[725]: pam_unix(sudo:session): session closed for user root May 27 22:13:37 musicpi wireless.js[475]: DHCP IP May 27 22:13:37 musicpi wireless.js[475]: Start ap May 27 22:13:37 musicpi wpa_supplicant[728]: Successfully initialized wpa_supplicant May 27 22:13:38 musicpi sudo[729]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd May 27 22:13:38 musicpi sudo[729]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:38 musicpi kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 27 22:13:38 musicpi dhcpcd[730]: dev: loaded udev May 27 22:13:38 musicpi bluetoothd[717]: Failed to set privacy: Rejected (0x0b) May 27 22:13:38 musicpi dbus-daemon[484]: [system] Successfully activated service 'org.freedesktop.hostname1' May 27 22:13:38 musicpi systemd[1]: Started Hostname Service. May 27 22:13:38 musicpi dhcpcd-run-hooks[748]: wlan0: starting wpa_supplicant May 27 22:13:38 musicpi dhcpcd-run-hooks[756]: wlan0: failed to start wpa_supplicant May 27 22:13:38 musicpi dhcpcd-run-hooks[757]: 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 May 27 22:13:38 musicpi dhcpcd[730]: wlan0: connected to Access Point `' May 27 22:13:38 musicpi dhcpcd[730]: no interfaces have a carrier May 27 22:13:38 musicpi dhcpcd[730]: forked to background, child pid 767 May 27 22:13:38 musicpi dhcpcd[767]: eth0: waiting for carrier May 27 22:13:38 musicpi dhcpcd[767]: wlan0: waiting for carrier May 27 22:13:38 musicpi sudo[729]: pam_unix(sudo:session): session closed for user root May 27 22:13:38 musicpi mpd[644]: May 27 22:13 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured May 27 22:13:38 musicpi mpd[644]: May 27 22:13 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured May 27 22:13:38 musicpi systemd[1]: Started Music Player Daemon. May 27 22:13:38 musicpi wireless.js[475]: trying... May 27 22:13:39 musicpi sudo[771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 27 22:13:39 musicpi sudo[771]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:39 musicpi sudo[771]: pam_unix(sudo:session): session closed for user root May 27 22:13:39 musicpi volumio-remote-updater[491]: [2023-05-27 22:13:39] [info] asio async_connect error: system:111 (Connection refused) May 27 22:13:39 musicpi volumio-remote-updater[491]: [2023-05-27 22:13:39] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 27 22:13:39 musicpi volumio-remote-updater[491]: [2023-05-27 22:13:39] [error] handle_connect error: Underlying Transport Error May 27 22:13:39 musicpi wireless.js[475]: trying... May 27 22:13:40 musicpi sudo[777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 27 22:13:40 musicpi sudo[777]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:40 musicpi sudo[777]: pam_unix(sudo:session): session closed for user root May 27 22:13:40 musicpi wpa_supplicant[755]: wlan0: Trying to associate with SSID 'U.N.I.T HQ' May 27 22:13:40 musicpi wireless.js[475]: trying... May 27 22:13:41 musicpi sudo[783]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 27 22:13:41 musicpi sudo[783]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:41 musicpi sudo[783]: pam_unix(sudo:session): session closed for user root May 27 22:13:41 musicpi wireless.js[475]: trying... May 27 22:13:42 musicpi sudo[789]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 27 22:13:42 musicpi sudo[789]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:42 musicpi sudo[789]: pam_unix(sudo:session): session closed for user root May 27 22:13:42 musicpi systemd[1]: systemd-rfkill.service: Succeeded. May 27 22:13:42 musicpi bthelper[706]: Changing power off succeeded May 27 22:13:42 musicpi wireless.js[475]: trying... May 27 22:13:43 musicpi sudo[798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 27 22:13:43 musicpi sudo[798]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:43 musicpi sudo[798]: pam_unix(sudo:session): session closed for user root May 27 22:13:43 musicpi bthelper[706]: [CHG] Controller E4:5F:01:78:26:34 Class: 0x0000041c May 27 22:13:43 musicpi bthelper[706]: Changing power on succeeded May 27 22:13:43 musicpi bthelper[706]: [CHG] Controller E4:5F:01:78:26:34 Powered: yes May 27 22:13:43 musicpi dhcpcd[767]: wlan0: carrier acquired May 27 22:13:43 musicpi dhcpcd[767]: wlan0: connected to Access Point `U.N.I.T HQ' May 27 22:13:43 musicpi wpa_supplicant[755]: wlan0: Associated with b0:be:76:c4:4e:f5 May 27 22:13:43 musicpi wpa_supplicant[755]: wlan0: CTRL-EVENT-CONNECTED - Connection to b0:be:76:c4:4e:f5 completed [id=0 id_str=] May 27 22:13:43 musicpi wpa_supplicant[755]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 May 27 22:13:43 musicpi dhcpcd[767]: DUID 00:01:00:01:29:81:35:6b:e4:5f:01:78:26:32 May 27 22:13:43 musicpi dhcpcd[767]: wlan0: IAID 01:78:26:33 May 27 22:13:43 musicpi dhcpcd[767]: wlan0: adding address fe80::e65f:1ff:fe78:2633 May 27 22:13:43 musicpi dhcpcd[767]: ipv6_addaddr1: Permission denied May 27 22:13:43 musicpi dhcpcd[767]: wlan0: carrier lost May 27 22:13:43 musicpi dhcpcd[767]: wlan0: carrier acquired May 27 22:13:43 musicpi dhcpcd[767]: wlan0: IAID 01:78:26:33 May 27 22:13:43 musicpi dhcpcd[767]: wlan0: soliciting an IPv6 router May 27 22:13:43 musicpi dhcpcd[767]: wlan0: rebinding lease of 192.168.1.172 May 27 22:13:43 musicpi dhcpcd[767]: wlan0: probing address 192.168.1.172/24 May 27 22:13:43 musicpi wireless.js[475]: trying... May 27 22:13:44 musicpi sudo[820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 27 22:13:44 musicpi sudo[820]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:44 musicpi sudo[820]: pam_unix(sudo:session): session closed for user root May 27 22:13:44 musicpi wireless.js[475]: trying... May 27 22:13:45 musicpi sudo[826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 27 22:13:45 musicpi sudo[826]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:45 musicpi sudo[826]: pam_unix(sudo:session): session closed for user root May 27 22:13:45 musicpi kernel: cam-dummy-reg: disabling May 27 22:13:45 musicpi kernel: cam1-reg: disabling May 27 22:13:45 musicpi wireless.js[475]: trying... May 27 22:13:46 musicpi sudo[832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 27 22:13:46 musicpi sudo[832]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:46 musicpi sudo[832]: pam_unix(sudo:session): session closed for user root May 27 22:13:46 musicpi volumio-remote-updater[491]: [2023-05-27 22:13:46] [info] asio async_connect error: system:111 (Connection refused) May 27 22:13:46 musicpi volumio-remote-updater[491]: [2023-05-27 22:13:46] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 27 22:13:46 musicpi volumio-remote-updater[491]: [2023-05-27 22:13:46] [error] handle_connect error: Underlying Transport Error May 27 22:13:46 musicpi wireless.js[475]: trying... May 27 22:13:47 musicpi sudo[838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 27 22:13:47 musicpi sudo[838]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:47 musicpi sudo[838]: pam_unix(sudo:session): session closed for user root May 27 22:13:47 musicpi wireless.js[475]: trying... May 27 22:13:48 musicpi sudo[844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 27 22:13:48 musicpi sudo[844]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:48 musicpi sudo[844]: pam_unix(sudo:session): session closed for user root May 27 22:13:48 musicpi dhcpcd[767]: wlan0: leased 192.168.1.172 for 7200 seconds May 27 22:13:48 musicpi avahi-daemon[481]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.172. May 27 22:13:48 musicpi dhcpcd[767]: wlan0: adding route to 192.168.1.0/24 May 27 22:13:48 musicpi dhcpcd[767]: wlan0: adding default route via 192.168.1.1 May 27 22:13:48 musicpi avahi-daemon[481]: New relevant interface wlan0.IPv4 for mDNS. May 27 22:13:48 musicpi avahi-daemon[481]: Registering new address record for 192.168.1.172 on wlan0.IPv4. May 27 22:13:48 musicpi wireless.js[475]: trying... May 27 22:13:49 musicpi sudo[870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 27 22:13:49 musicpi sudo[870]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:49 musicpi sudo[870]: pam_unix(sudo:session): session closed for user root May 27 22:13:49 musicpi wireless.js[475]: Connected to: ----U.N.I.T HQ May 27 22:13:49 musicpi wireless.js[475]: ---- May 27 22:13:49 musicpi sudo[873]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 27 22:13:49 musicpi sudo[873]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:49 musicpi sudo[873]: pam_unix(sudo:session): session closed for user root May 27 22:13:49 musicpi wireless.js[475]: ... joined AP, wlan0 IPv4 is 192.168.1.172, ipV6 is undefined May 27 22:13:49 musicpi wireless.js[475]: It's done! AP May 27 22:13:49 musicpi systemd[1]: Started Wireless Services. May 27 22:13:49 musicpi systemd[1]: Started Volumio Backend Module. May 27 22:13:49 musicpi systemd[1]: Started Volumio Streaming Daemon. May 27 22:13:49 musicpi volumio-streaming-daemon[878]: ############################ May 27 22:13:49 musicpi volumio-streaming-daemon[878]: # Volumio Streaming Daemon # May 27 22:13:49 musicpi volumio-streaming-daemon[878]: # Running on port 7777 # May 27 22:13:49 musicpi volumio-streaming-daemon[878]: ############################ May 27 22:13:49 musicpi volumio-streaming-daemon[878]: Environment: production May 27 22:13:49 musicpi ntpd[658]: Listen normally on 3 wlan0 192.168.1.172:123 May 27 22:13:49 musicpi ntpd[658]: new interface(s) found: waking up resolver May 27 22:13:51 musicpi volumio[877]: info: ------------------------------------------- May 27 22:13:51 musicpi volumio[877]: info: ----- Volumio3 ---- May 27 22:13:51 musicpi volumio[877]: info: ------------------------------------------- May 27 22:13:51 musicpi volumio[877]: info: ----- System startup ---- May 27 22:13:51 musicpi volumio[877]: info: ------------------------------------------- May 27 22:13:51 musicpi nmbd[634]: [2023/05/27 22:13:51.181374, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 27 22:13:51 musicpi nmbd[634]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections May 27 22:13:51 musicpi systemd[1]: Started Samba NMB Daemon. May 27 22:13:51 musicpi systemd[1]: Starting Samba Winbind Daemon... May 27 22:13:51 musicpi nmbd[634]: [2023/05/27 22:13:51.286743, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 27 22:13:51 musicpi nmbd[634]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.172 for name WORKGROUP<1d>. May 27 22:13:51 musicpi nmbd[634]: This response was from IP 192.168.1.147, reporting an IP address of 192.168.1.147. May 27 22:13:51 musicpi winbindd[904]: [2023/05/27 22:13:51.420895, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) May 27 22:13:51 musicpi winbindd[904]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 May 27 22:13:51 musicpi winbindd[904]: [2023/05/27 22:13:51.451275, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 27 22:13:51 musicpi systemd[1]: Started Samba Winbind Daemon. May 27 22:13:51 musicpi winbindd[904]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections May 27 22:13:51 musicpi systemd[1]: Starting Samba SMB Daemon... May 27 22:13:51 musicpi smbd[912]: [2023/05/27 22:13:51.971418, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 27 22:13:51 musicpi smbd[912]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections May 27 22:13:51 musicpi systemd[1]: Started Samba SMB Daemon. May 27 22:13:51 musicpi systemd[1]: Reached target Multi-User System. May 27 22:13:51 musicpi systemd[1]: Reached target Graphical Interface. May 27 22:13:51 musicpi systemd[1]: Starting Update UTMP about System Runlevel Changes... May 27 22:13:52 musicpi systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 27 22:13:52 musicpi systemd[1]: Started Update UTMP about System Runlevel Changes. May 27 22:13:52 musicpi systemd[1]: Startup finished in 9.849s (kernel) + 29.752s (userspace) = 39.602s. May 27 22:13:52 musicpi volumio[877]: info: MYVOLUMIO Environment detected May 27 22:13:52 musicpi volumio[877]: info: Plugin folders cleanup May 27 22:13:52 musicpi volumio[877]: info: Scanning into folder /volumio/app/plugins/ May 27 22:13:52 musicpi volumio[877]: info: Scanning category audio_interface May 27 22:13:52 musicpi volumio[877]: info: Scanning category miscellanea May 27 22:13:52 musicpi volumio[877]: info: Scanning category music_service May 27 22:13:52 musicpi volumio[877]: info: Scanning category plugins.json May 27 22:13:52 musicpi volumio[877]: info: Scanning category system_controller May 27 22:13:52 musicpi volumio[877]: info: Scanning category user_interface May 27 22:13:52 musicpi volumio[877]: info: Scanning into folder /data/plugins/ May 27 22:13:52 musicpi volumio[877]: info: Scanning category user_interface May 27 22:13:52 musicpi volumio[877]: info: Plugin folders cleanup completed May 27 22:13:52 musicpi volumio[877]: info: ------------------------------------------- May 27 22:13:52 musicpi volumio[877]: info: ----- Core plugins startup ---- May 27 22:13:52 musicpi volumio[877]: info: ------------------------------------------- May 27 22:13:52 musicpi volumio[877]: info: Loading plugins from folder /volumio/app/plugins/ May 27 22:13:52 musicpi volumio[877]: info: Adding plugin upnp to MyMusic Plugins May 27 22:13:52 musicpi volumio[877]: info: Adding plugin airplay_emulation to MyMusic Plugins May 27 22:13:52 musicpi volumio[877]: info: Adding plugin upnp_browser to MyMusic Plugins May 27 22:13:52 musicpi volumio[877]: info: Loading plugins from folder /data/plugins/ May 27 22:13:52 musicpi volumio[877]: info: Loading plugin "system"... May 27 22:13:52 musicpi volumio[877]: info: Loading plugin "appearance"... May 27 22:13:53 musicpi volumio[877]: info: Loading plugin "network"... May 27 22:13:53 musicpi volumio[877]: info: Refreshing Cached IP Addresses May 27 22:13:53 musicpi sudo[930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 27 22:13:53 musicpi sudo[930]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:53 musicpi sudo[930]: pam_unix(sudo:session): session closed for user root May 27 22:13:53 musicpi volumio[877]: info: Loading plugin "services"... May 27 22:13:53 musicpi sudo[932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 27 22:13:53 musicpi sudo[932]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:53 musicpi volumio[877]: info: Loading plugin "alsa_controller"... May 27 22:13:53 musicpi sudo[932]: pam_unix(sudo:session): session closed for user root May 27 22:13:53 musicpi sudo[935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 27 22:13:53 musicpi sudo[935]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:53 musicpi volumio[877]: info: Loading plugin "wizard"... May 27 22:13:53 musicpi volumio[877]: info: Loading plugin "volumio_command_line_client"... May 27 22:13:53 musicpi volumio[877]: info: Loading plugin "upnp"... May 27 22:13:53 musicpi volumio[877]: info: [1685225633487] Starting Upmpd Daemon May 27 22:13:53 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 27 22:13:53 musicpi volumio[877]: info: Loading plugin "my_music"... May 27 22:13:53 musicpi volumio[877]: info: Loading plugin "mpd"... May 27 22:13:53 musicpi volumio[877]: info: Creating MPD Configuration file May 27 22:13:53 musicpi volumio[877]: info: Loading plugin "upnp_browser"... May 27 22:13:53 musicpi sudo[943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 27 22:13:53 musicpi sudo[943]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:53 musicpi sudo[943]: pam_unix(sudo:session): session closed for user root May 27 22:13:53 musicpi sudo[945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 27 22:13:53 musicpi sudo[945]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:53 musicpi systemd[1]: Stopping Music Player Daemon... May 27 22:13:54 musicpi systemd[1]: mpd.service: Succeeded. May 27 22:13:54 musicpi systemd[1]: Stopped Music Player Daemon. May 27 22:13:54 musicpi systemd[1]: Starting Music Player Daemon... May 27 22:13:54 musicpi volumio[877]: info: Loading plugin "networkfs"... May 27 22:13:54 musicpi volumio[877]: info: Starting Udev Watcher for removable devices May 27 22:13:54 musicpi sudo[956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.145/Public\Music Library /mnt/NAS/MyCloud May 27 22:13:54 musicpi sudo[956]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:54 musicpi kernel: FS-Cache: Netfs 'cifs' registered for caching May 27 22:13:54 musicpi kernel: Key type cifs.spnego registered May 27 22:13:54 musicpi kernel: Key type cifs.idmap registered May 27 22:13:54 musicpi kernel: CIFS: Attempting to mount //192.168.1.145/Public\Music Library May 27 22:13:54 musicpi kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. May 27 22:13:54 musicpi mpd[950]: May 27 22:13 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 27 22:13:54 musicpi volumio[877]: info: Ignoring mount for partition: boot May 27 22:13:54 musicpi volumio[877]: info: Ignoring mount for partition: volumio May 27 22:13:54 musicpi volumio[877]: info: Ignoring mount for partition: volumio_data May 27 22:13:54 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 27 22:13:54 musicpi volumio[877]: info: Loading plugin "alarm-clock"... May 27 22:13:55 musicpi volumio[877]: info: Loading plugin "airplay_emulation"... May 27 22:13:55 musicpi volumio[877]: info: Starting Shairport Sync May 27 22:13:55 musicpi volumio[877]: info: Loading plugin "last_100"... May 27 22:13:55 musicpi volumio[877]: info: Loading plugin "webradio"... May 27 22:13:55 musicpi volumio[877]: info: Loading plugin "i2s_dacs"... May 27 22:13:55 musicpi volumio[877]: info: I2S DAC not set, start Auto-detection May 27 22:13:55 musicpi volumio[877]: info: Loading plugin "volumiodiscovery"... May 27 22:13:55 musicpi volumio[877]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 27 22:13:55 musicpi node[877]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 27 22:13:55 musicpi volumio[877]: *** WARNING *** Please fix your application to use the native API of Avahi! May 27 22:13:55 musicpi node[877]: *** WARNING *** Please fix your application to use the native API of Avahi! May 27 22:13:55 musicpi volumio[877]: *** WARNING *** For more information see May 27 22:13:55 musicpi node[877]: *** WARNING *** For more information see May 27 22:13:55 musicpi volumio[877]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 27 22:13:55 musicpi node[877]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 27 22:13:55 musicpi volumio[877]: *** WARNING *** Please fix your application to use the native API of Avahi! May 27 22:13:55 musicpi node[877]: *** WARNING *** Please fix your application to use the native API of Avahi! May 27 22:13:55 musicpi volumio[877]: *** WARNING *** For more information see May 27 22:13:55 musicpi node[877]: *** WARNING *** For more information see May 27 22:13:55 musicpi volumio[877]: info: Applying required configuration parameters for plugin volumiodiscovery May 27 22:13:55 musicpi volumio[877]: info: Discovery: Started advertising with name: MusicPi May 27 22:13:55 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 27 22:13:55 musicpi volumio[877]: info: Loading plugin "outputs"... May 27 22:13:55 musicpi volumio[877]: info: Loading plugin "albumart"... May 27 22:13:55 musicpi volumio[877]: info: Plugin example_plugin is not enabled May 27 22:13:55 musicpi volumio[877]: info: Loading plugin "inputs"... May 27 22:13:55 musicpi volumio[877]: info: Loading plugin "updater_comm"... May 27 22:13:55 musicpi sudo[956]: pam_unix(sudo:session): session closed for user root May 27 22:13:55 musicpi kernel: CIFS: VFS: cifs_mount failed w/return code = -2 May 27 22:13:55 musicpi volumio[877]: info: Plugin mpdemulation is not enabled May 27 22:13:55 musicpi volumio[877]: info: Loading plugin "rest_api"... May 27 22:13:55 musicpi volumio[877]: info: Loading plugin "websocket"... May 27 22:13:55 musicpi volumio[877]: info: Loading plugin "touch_display"... May 27 22:13:55 musicpi volumio[877]: Forking 3 albumart workers May 27 22:13:55 musicpi mpd[950]: May 27 22:13 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured May 27 22:13:55 musicpi mpd[950]: May 27 22:13 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured May 27 22:13:55 musicpi systemd[1]: Started Music Player Daemon. May 27 22:13:55 musicpi sudo[945]: pam_unix(sudo:session): session closed for user root May 27 22:13:55 musicpi volumio[877]: info: Applying required configuration parameters for plugin touch_display May 27 22:13:56 musicpi volumio[877]: info: Loading i18n strings for locale en May 27 22:13:56 musicpi volumio[877]: Updating browse sources language May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::initPlayerControls May 27 22:13:56 musicpi volumio[877]: Starting albumart workers May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: Starting albumart workers May 27 22:13:56 musicpi volumio[877]: Starting albumart workers May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 22:13:56 musicpi volumio[877]: Express server listening on port 3000 May 27 22:13:56 musicpi volumio[877]: [Metrics] WebUI: 5s 776.19ms May 27 22:13:56 musicpi volumio[877]: info: CoreStateMachine::resetVolumioState May 27 22:13:56 musicpi volumio[877]: info: CoreStateMachine::getcurrentVolume May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::volumioRetrievevolume May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: Cannot mount NAS MyCloud at system boot, trial number 1 ,retrying in 5 seconds May 27 22:13:56 musicpi volumio[877]: info: MPD Permissions set May 27 22:13:56 musicpi volumio[877]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1 May 27 22:13:56 musicpi volumio[877]: info: MPD running with PID950 May 27 22:13:56 musicpi volumio[877]: ,establishing connection May 27 22:13:56 musicpi volumio[877]: info: Reloading queue from file May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: error: updateQueue error: null May 27 22:13:56 musicpi volumio[877]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory May 27 22:13:56 musicpi volumio[877]: info: VolumeController:: Volume=90 Mute =false May 27 22:13:56 musicpi volumio[877]: info: CoreStateMachine::pushState May 27 22:13:56 musicpi volumio[877]: info: CorePlayQueue::getTrack 0 May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::volumioPushState May 27 22:13:56 musicpi volumio[877]: info: CoreStateMachine::updateTrackBlock May 27 22:13:56 musicpi volumio[877]: info: CorePlayQueue::getTrackBlock May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::volumioRetrievevolume May 27 22:13:56 musicpi volumio[877]: info: CoreStateMachine::setRepeat true single undefined May 27 22:13:56 musicpi volumio[877]: info: CoreStateMachine::pushState May 27 22:13:56 musicpi volumio[877]: info: CorePlayQueue::getTrack 0 May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::volumioPushState May 27 22:13:56 musicpi volumio[877]: info: CoreStateMachine::setRandom false May 27 22:13:56 musicpi volumio[877]: info: CoreStateMachine::pushState May 27 22:13:56 musicpi volumio[877]: info: CorePlayQueue::getTrack 0 May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::volumioPushState May 27 22:13:56 musicpi volumio[877]: info: Setting Device type: Raspberry PI May 27 22:13:56 musicpi volumio[877]: info: Completed loading Core Plugins May 27 22:13:56 musicpi volumio[877]: info: Preparing to generate the ALSA configuration file May 27 22:13:56 musicpi volumio[877]: info: Discovery: adding 3ee61dba-6921-45dc-af6c-96f7ffe558f0 May 27 22:13:56 musicpi volumio[877]: info: mDNS: Found device MusicPi May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::volumioGetState May 27 22:13:56 musicpi volumio[877]: info: CorePlayQueue::getTrack 0 May 27 22:13:56 musicpi volumio[877]: info: Asound.conf file unchanged, so no further update is needed May 27 22:13:56 musicpi volumio[877]: info: Output device has changed, restarting MPD May 27 22:13:56 musicpi volumio-remote-updater[491]: [2023-05-27 22:13:56] [connect] Successful connection May 27 22:13:56 musicpi sudo[1064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 27 22:13:56 musicpi volumio[877]: info: Output device has changed, restarting Shairport Sync May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 22:13:56 musicpi sudo[1064]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:56 musicpi sudo[1064]: pam_unix(sudo:session): session closed for user root May 27 22:13:56 musicpi sudo[1066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 27 22:13:56 musicpi sudo[1066]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:56 musicpi systemd[1]: Stopping Music Player Daemon... May 27 22:13:56 musicpi volumio[877]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 27 22:13:56 musicpi volumio[877]: info: ___________ START PLUGINS ___________ May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 27 22:13:56 musicpi volumio[877]: info: [1685225636933] CoreMusicLibrary::Adding element Media Servers May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 27 22:13:56 musicpi volumio[877]: Cannot find translation for sourceMedia Servers May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:56 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 22:13:57 musicpi volumio[877]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 27 22:13:57 musicpi volumio[877]: info: [1685225637019] CoreMusicLibrary::Adding element Last_100 May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 27 22:13:57 musicpi volumio[877]: Cannot find translation for sourceMedia Servers May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 27 22:13:57 musicpi volumio[877]: info: [1685225637022] CoreMusicLibrary::Adding element Webradio May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 27 22:13:57 musicpi volumio[877]: Cannot find translation for sourceMedia Servers May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 27 22:13:57 musicpi volumio[877]: info: Loading i18n strings for locale en May 27 22:13:57 musicpi volumio[877]: info: Volumio Calling Home May 27 22:13:57 musicpi sudo[1079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload May 27 22:13:57 musicpi sudo[1079]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:57 musicpi systemd[1]: Reloading. May 27 22:13:57 musicpi sudo[935]: pam_unix(sudo:session): session closed for user root May 27 22:13:57 musicpi volumio[877]: info: VolumeController:: Volume=90 Mute =false May 27 22:13:57 musicpi volumio[877]: info: CoreStateMachine::pushState May 27 22:13:57 musicpi volumio[877]: info: CorePlayQueue::getTrack 0 May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::volumioPushState May 27 22:13:57 musicpi volumio[877]: info: MPD Permissions set May 27 22:13:57 musicpi volumio-remote-updater[491]: [2023-05-27 22:13:57] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1685225636 101 May 27 22:13:57 musicpi volumio[877]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2 May 27 22:13:57 musicpi volumio[877]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:13:57 musicpi volumio[877]: info: Starting Shairport Sync May 27 22:13:57 musicpi volumio[877]: info: Starting Shairport Sync May 27 22:13:57 musicpi 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. May 27 22:13:57 musicpi sudo[1105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 27 22:13:57 musicpi sudo[1105]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:57 musicpi volumio[877]: info: Starting Shairport Sync May 27 22:13:57 musicpi sudo[1110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 27 22:13:57 musicpi sudo[1110]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:57 musicpi sudo[1109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 27 22:13:57 musicpi sudo[1109]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::volumioGetState May 27 22:13:57 musicpi volumio[877]: info: CorePlayQueue::getTrack 0 May 27 22:13:57 musicpi volumio[877]: info: Volumio called home May 27 22:13:57 musicpi systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. May 27 22:13:57 musicpi systemd[1]: ifup@eth0.service: Current command vanished from the unit file, execution of the command list won't be resumed. May 27 22:13:57 musicpi sudo[1079]: pam_unix(sudo:session): session closed for user root May 27 22:13:57 musicpi volumio[877]: info: touch_display: systemctl daemon-reload succeeded. May 27 22:13:57 musicpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 27 22:13:57 musicpi systemd[1]: shairport-sync.service: Succeeded. May 27 22:13:57 musicpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 27 22:13:57 musicpi sudo[1114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service May 27 22:13:57 musicpi sudo[1114]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:57 musicpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 27 22:13:57 musicpi sudo[1110]: pam_unix(sudo:session): session closed for user root May 27 22:13:57 musicpi sudo[1109]: pam_unix(sudo:session): session closed for user root May 27 22:13:57 musicpi volumio[877]: error: MPD error: Error: write EPIPE May 27 22:13:57 musicpi sudo[1105]: pam_unix(sudo:session): session closed for user root May 27 22:13:57 musicpi volumio[877]: info: Shairport-Sync Started May 27 22:13:57 musicpi volumio[877]: Error adding Membership: Error: addMembership EINVAL May 27 22:13:57 musicpi volumio[877]: info: Shairport-Sync Started May 27 22:13:57 musicpi volumio[877]: info: Shairport-Sync Started May 27 22:13:57 musicpi systemd[1]: Started Volumio Kiosk. May 27 22:13:57 musicpi sudo[1114]: pam_unix(sudo:session): session closed for user root May 27 22:13:57 musicpi volumio[877]: info: touch_display: systemctl start volumio-kiosk.service succeeded. May 27 22:13:57 musicpi volumio[877]: info: touch_display: Volumio Kiosk started May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::volumioGetState May 27 22:13:57 musicpi volumio[877]: info: CorePlayQueue::getTrack 0 May 27 22:13:57 musicpi volumio[877]: info: Completed starting Core Plugins May 27 22:13:57 musicpi volumio[877]: info: ------------------------------------------- May 27 22:13:57 musicpi volumio[877]: info: ----- MyVolumio plugins startup ---- May 27 22:13:57 musicpi volumio[877]: info: ------------------------------------------- May 27 22:13:57 musicpi volumio[877]: info: [MyVolumio PluginManager] Fetching plans data.... May 27 22:13:57 musicpi volumio[877]: info: CoreCommandRouter::volumioGetState May 27 22:13:57 musicpi volumio[877]: info: CorePlayQueue::getTrack 0 May 27 22:13:57 musicpi volumio[877]: info: touch_display: Raspberry Pi Foundation touch screen detected. May 27 22:13:57 musicpi volumio[877]: info: touch_display: Backlight module of a Raspberry Pi Foundation touch screen detected. May 27 22:13:57 musicpi systemd[1]: mpd.service: Succeeded. May 27 22:13:57 musicpi systemd[1]: Stopped Music Player Daemon. May 27 22:13:57 musicpi systemd[1]: Starting Music Player Daemon... May 27 22:13:57 musicpi volumio[877]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X May 27 22:13:57 musicpi sudo[1148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/devices/platform/rpi_backlight/backlight/rpi_backlight/brightness May 27 22:13:57 musicpi sudo[1148]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:57 musicpi sudo[1148]: pam_unix(sudo:session): session closed for user root May 27 22:13:57 musicpi volumio[877]: info: touch_display: File permissions for backlight brightness control set. May 27 22:13:57 musicpi sudo[1140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i -e /Option "TransformationMatrix"/d /etc/X11/xorg.conf.d/95-touch_display-plugin.conf May 27 22:13:57 musicpi sudo[1140]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:13:57 musicpi sudo[1140]: pam_unix(sudo:session): session closed for user root May 27 22:13:57 musicpi volumio[877]: info: touch_display: Touchscreen transformation matrix removed. May 27 22:13:57 musicpi volumio[877]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 May 27 22:13:57 musicpi startx[1119]: X.Org X Server 1.20.4 May 27 22:13:57 musicpi startx[1119]: X Protocol Version 11, Revision 0 May 27 22:13:57 musicpi startx[1119]: Build Operating System: Linux 5.4.0-72-generic armv8l Raspbian May 27 22:13:57 musicpi startx[1119]: Current Operating System: Linux musicpi 5.10.90-v7l+ #1512 SMP Thu Jan 13 16:33:39 GMT 2022 armv7l May 27 22:13:57 musicpi startx[1119]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=800 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=E4:5F:01:78:26:32 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh rootwait bootdelay=5 elevator=noop logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 loglevel=0 May 27 22:13:57 musicpi startx[1119]: Build Date: 04 January 2022 10:05:34AM May 27 22:13:57 musicpi startx[1119]: xorg-server 2:1.20.4-1+rpt4+deb10u4 (https://www.debian.org/support) May 27 22:13:57 musicpi startx[1119]: Current version of pixman: 0.36.0 May 27 22:13:57 musicpi startx[1119]: Before reporting problems, check http://wiki.x.org May 27 22:13:57 musicpi startx[1119]: to make sure that you have the latest version. May 27 22:13:57 musicpi startx[1119]: Markers: (--) probed, (**) from config file, (==) default setting, May 27 22:13:57 musicpi startx[1119]: (++) from command line, (!!) notice, (II) informational, May 27 22:13:57 musicpi startx[1119]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. May 27 22:13:57 musicpi startx[1119]: (==) Log file: "/var/log/Xorg.0.log", Time: Sat May 27 22:13:57 2023 May 27 22:13:57 musicpi startx[1119]: (==) Using config directory: "/etc/X11/xorg.conf.d" May 27 22:13:57 musicpi startx[1119]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" May 27 22:13:58 musicpi volumio[877]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 May 27 22:13:58 musicpi systemd[1]: systemd-fsckd.service: Succeeded. May 27 22:13:58 musicpi mpd[1155]: May 27 22:13 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 27 22:13:59 musicpi mpd[1155]: May 27 22:13 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured May 27 22:13:59 musicpi mpd[1155]: May 27 22:13 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured May 27 22:13:59 musicpi systemd[1]: Started Music Player Daemon. May 27 22:13:59 musicpi sudo[1066]: pam_unix(sudo:session): session closed for user root May 27 22:13:59 musicpi volumio[877]: error: updateQueue error: null May 27 22:14:00 musicpi volumio[877]: info: touch_display: Setting screensaver timeout to 0 seconds. May 27 22:14:01 musicpi sh[415]: timed out May 27 22:14:01 musicpi dhcpcd[461]: timed out May 27 22:14:01 musicpi sh[415]: dhcpcd exited May 27 22:14:01 musicpi dhcpcd[461]: dhcpcd exited May 27 22:14:01 musicpi sh[415]: ifup: failed to bring up eth0 May 27 22:14:01 musicpi systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE May 27 22:14:01 musicpi systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. May 27 22:14:01 musicpi sudo[1229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.145/Public\Music Library /mnt/NAS/MyCloud May 27 22:14:01 musicpi sudo[1229]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:14:01 musicpi kernel: CIFS: Attempting to mount //192.168.1.145/Public\Music Library May 27 22:14:01 musicpi sudo[1229]: pam_unix(sudo:session): session closed for user root May 27 22:14:01 musicpi volumio[877]: info: Cannot mount NAS MyCloud at system boot, trial number 2 ,retrying in 5 seconds May 27 22:14:01 musicpi kernel: CIFS: VFS: cifs_mount failed w/return code = -2 May 27 22:14:02 musicpi volumio[877]: error: updateQueue error: null May 27 22:14:03 musicpi sudo[1269]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 27 22:14:03 musicpi sudo[1269]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:14:03 musicpi sudo[1269]: pam_unix(sudo:session): session closed for user root May 27 22:14:03 musicpi sudo[1271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 27 22:14:03 musicpi sudo[1271]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:14:03 musicpi sudo[1271]: pam_unix(sudo:session): session closed for user root May 27 22:14:03 musicpi sudo[1275]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 27 22:14:03 musicpi sudo[1275]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:14:03 musicpi systemd[1]: Started UPnP Renderer front-end to MPD. May 27 22:14:03 musicpi sudo[1275]: pam_unix(sudo:session): session closed for user root May 27 22:14:03 musicpi volumio[877]: info: Upmpdcli Daemon Started May 27 22:14:03 musicpi volumio[1277]: Generating RSA private key, 4096 bit long modulus (2 primes) May 27 22:14:05 musicpi volumio[1277]: .................++++ May 27 22:14:06 musicpi sudo[1315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.145/Public\Music Library /mnt/NAS/MyCloud May 27 22:14:06 musicpi sudo[1315]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:14:06 musicpi kernel: CIFS: Attempting to mount //192.168.1.145/Public\Music Library May 27 22:14:06 musicpi sudo[1315]: pam_unix(sudo:session): session closed for user root May 27 22:14:06 musicpi volumio[877]: info: Cannot mount NAS MyCloud at system boot, trial number 3 ,retrying in 5 seconds May 27 22:14:06 musicpi kernel: CIFS: VFS: cifs_mount failed w/return code = -2 May 27 22:14:08 musicpi systemd[1]: systemd-hostnamed.service: Succeeded. May 27 22:14:10 musicpi volumio[1277]: ...................................................++++ May 27 22:14:10 musicpi volumio[1277]: e is 65537 (0x010001) May 27 22:14:10 musicpi volumio[1277]: writing RSA key May 27 22:14:11 musicpi sudo[1427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.145/Public\Music Library /mnt/NAS/MyCloud May 27 22:14:11 musicpi sudo[1427]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:14:11 musicpi kernel: CIFS: Attempting to mount //192.168.1.145/Public\Music Library May 27 22:14:12 musicpi sudo[1427]: pam_unix(sudo:session): session closed for user root May 27 22:14:12 musicpi kernel: CIFS: VFS: cifs_mount failed w/return code = -2 May 27 22:14:12 musicpi volumio[877]: info: Cannot mount NAS MyCloud at system boot, trial number 4 ,retrying in 5 seconds May 27 22:14:16 musicpi volumio[877]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 4 May 27 22:14:17 musicpi sudo[1505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.145/Public\Music Library /mnt/NAS/MyCloud May 27 22:14:17 musicpi sudo[1505]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 22:14:17 musicpi kernel: CIFS: Attempting to mount //192.168.1.145/Public\Music Library May 27 22:14:17 musicpi sudo[1505]: pam_unix(sudo:session): session closed for user root May 27 22:14:17 musicpi kernel: CIFS: VFS: cifs_mount failed w/return code = -2 May 27 22:14:17 musicpi volumio[877]: info: Cannot mount NAS at system boot, trial number 4 ,stopping May 27 22:14:17 musicpi volumio[877]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 4 May 27 22:14:17 musicpi volumio[877]: error: MyVolumio Plugin failed to start in a timely fashion May 27 22:14:17 musicpi volumio[877]: info: BOOT COMPLETED May 27 22:14:17 musicpi volumio[877]: [Metrics] CommandRouter: 26s 662.22ms May 27 22:14:17 musicpi volumio[877]: info: CoreCommandRouter::volumiosetStartupVolume May 27 22:14:17 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 27 22:14:17 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 27 22:14:17 musicpi volumio[877]: info: CoreCommandRouter::Close All Modals sent May 27 22:14:17 musicpi volumio[877]: info: CoreCommandRouter::Close All Modals sent May 27 22:14:18 musicpi volumio[877]: info: CoreCommandRouter::volumioGetState May 27 22:14:18 musicpi volumio[877]: info: CorePlayQueue::getTrack 0 May 27 22:14:18 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 27 22:14:18 musicpi volumio[877]: info: Listing playlists May 27 22:14:18 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 27 22:14:18 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 27 22:14:18 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 27 22:14:18 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 27 22:14:18 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 27 22:14:18 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 27 22:14:18 musicpi volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 27 22:14:19 musicpi volumio[877]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 27 22:14:19 musicpi volumio[877]: Error: certificate is not yet valid May 27 22:14:19 musicpi volumio[877]: at TLSSocket.onConnectSecure (_tls_wrap.js:1497:34) May 27 22:14:19 musicpi volumio[877]: at TLSSocket.emit (events.js:315:20) May 27 22:14:19 musicpi volumio[877]: at TLSSocket._finishInit (_tls_wrap.js:932:8) May 27 22:14:19 musicpi volumio[877]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:706:12) { May 27 22:14:19 musicpi volumio[877]: code: 'CERT_NOT_YET_VALID' May 27 22:14:19 musicpi volumio[877]: } May 27 22:14:19 musicpi volumio[877]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 27 22:14:20 musicpi sudo[1710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-05-27 22:13 May 27 22:14:20 musicpi sudo[1710]: 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="e5f8795c07ba36ff2b02d7ba0a21c7a0f29b897e" VOLUMIO_FE_VERSION="473d8facbed5f9754db84a81b093baace7aa4b64" VOLUMIO_FE3_VERSION="934cddf6d46478e7a53a8d3664cd346f4de7cb34" VOLUMIO_BE_VERSION="359b2717b79cfc72b7d1c918d0fc2885a93bca70" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 24 Jan 2022 10:51:57 AM CET" VOLUMIO_VERSION="3.198" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="74e6a9ad035e912732893c8d6b060b17"