-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Mon 2025-03-03 14:01:49 CET. -- Mar 03 14:01:09 hifi kernel: uart-pl011 fe201000.serial: there is not valid maps for state default Mar 03 14:01:09 hifi kernel: uart-pl011 fe201000.serial: cts_event_workaround enabled Mar 03 14:01:09 hifi kernel: fe201000.serial: ttyAMA1 at MMIO 0xfe201000 (irq = 51, base_baud = 0) is a PL011 rev2 Mar 03 14:01:09 hifi kernel: serial serial0: tty port ttyAMA1 registered Mar 03 14:01:09 hifi kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer Mar 03 14:01:09 hifi kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver Mar 03 14:01:09 hifi kernel: mmc-bcm2835 fe300000.mmcnr: mmc_debug:0 mmc_debug2:0 Mar 03 14:01:09 hifi kernel: mmc-bcm2835 fe300000.mmcnr: DMA channel allocated Mar 03 14:01:09 hifi kernel: of_cfs_init Mar 03 14:01:09 hifi kernel: of_cfs_init: OK Mar 03 14:01:09 hifi kernel: mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA Mar 03 14:01:09 hifi kernel: Freeing unused kernel image (initmem) memory: 2048K Mar 03 14:01:09 hifi kernel: mmc1: new high speed SDIO card at address 0001 Mar 03 14:01:09 hifi kernel: Run /init as init process Mar 03 14:01:09 hifi kernel: with arguments: Mar 03 14:01:09 hifi kernel: /init Mar 03 14:01:09 hifi kernel: splash Mar 03 14:01:09 hifi kernel: nodebug Mar 03 14:01:09 hifi kernel: with environment: Mar 03 14:01:09 hifi kernel: HOME=/ Mar 03 14:01:09 hifi kernel: TERM=linux Mar 03 14:01:09 hifi kernel: imgpart=UUID=0c3a77ec-ae84-4f1b-8028-c61cc251ffe5 Mar 03 14:01:09 hifi kernel: imgfile=/volumio_current.sqsh Mar 03 14:01:09 hifi kernel: bootpart=UUID=41CA-9A8B Mar 03 14:01:09 hifi kernel: datapart=UUID=0324d53a-d066-482b-b659-eb98af2b49e7 Mar 03 14:01:09 hifi kernel: uuidconfig=cmdline.txt Mar 03 14:01:09 hifi kernel: pcie_aspm=off Mar 03 14:01:09 hifi kernel: bootdelay=7 Mar 03 14:01:09 hifi kernel: use_kmsg=no Mar 03 14:01:09 hifi kernel: mmc0: new ultra high speed DDR50 SDHC card at address aaaa Mar 03 14:01:09 hifi kernel: mmcblk0: mmc0:aaaa SL32G 29.7 GiB Mar 03 14:01:09 hifi kernel: mmcblk0: p1 p2 p3 Mar 03 14:01:09 hifi kernel: mmcblk0: mmc0:aaaa SL32G 29.7 GiB (quirks 0x00004000) Mar 03 14:01:09 hifi kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Mar 03 14:01:09 hifi kernel: usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21 Mar 03 14:01:09 hifi kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Mar 03 14:01:09 hifi kernel: usb 1-1: Product: USB2.0 Hub Mar 03 14:01:09 hifi kernel: hub 1-1:1.0: USB hub found Mar 03 14:01:09 hifi kernel: hub 1-1:1.0: 4 ports detected Mar 03 14:01:09 hifi kernel: fuse: init (API version 7.37) Mar 03 14:01:09 hifi kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Mar 03 14:01:09 hifi kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Mar 03 14:01:09 hifi kernel: EXT4-fs (mmcblk0p2): recovery complete Mar 03 14:01:09 hifi kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none. Mar 03 14:01:09 hifi kernel: loop0: detected capacity change from 0 to 983360 Mar 03 14:01:09 hifi kernel: EXT4-fs (mmcblk0p3): recovery complete Mar 03 14:01:09 hifi kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Quota mode: none. Mar 03 14:01:09 hifi systemd[1]: System time before build time, advancing clock. Mar 03 14:01:09 hifi kernel: NET: Registered PF_INET6 protocol family Mar 03 14:01:09 hifi kernel: Segment Routing with IPv6 Mar 03 14:01:09 hifi kernel: In-situ OAM (IOAM) with IPv6 Mar 03 14:01:09 hifi systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid) Mar 03 14:01:09 hifi systemd[1]: Detected architecture arm. Mar 03 14:01:09 hifi systemd[1]: Set hostname to . Mar 03 14:01:09 hifi 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 03 14:01:09 hifi systemd[1]: Listening on RPCbind Server Activation Socket. Mar 03 14:01:09 hifi systemd[1]: Reached target System Time Synchronized. Mar 03 14:01:09 hifi systemd[1]: Started Forward Password Requests to Wall Directory Watch. Mar 03 14:01:09 hifi systemd[1]: Listening on udev Kernel Socket. Mar 03 14:01:09 hifi systemd[1]: Created slice system-getty.slice. Mar 03 14:01:09 hifi systemd[1]: Listening on fsck to fsckd communication Socket. Mar 03 14:01:09 hifi kernel: i2c_dev: i2c /dev entries driver Mar 03 14:01:09 hifi systemd-journald[317]: Journal started Mar 03 14:01:09 hifi systemd-journald[317]: Runtime journal (/run/log/journal/d5012141e8efab18115b4334669e938a) is 7.5M, max 30.0M, 22.5M free. Mar 03 14:01:09 hifi systemd-modules-load[314]: Inserted module 'i2c_dev' Mar 03 14:01:09 hifi fake-hwclock[319]: Mon Mar 3 13:01:09 UTC 2025 Mar 03 14:01:09 hifi systemd[1]: Mounted RPC Pipe File System. Mar 03 14:01:09 hifi systemd[1]: Mounted POSIX Message Queue File System. Mar 03 14:01:09 hifi systemd[1]: Mounted Kernel Debug File System. Mar 03 14:01:09 hifi systemd[1]: Started Restore / save the current clock. Mar 03 14:01:09 hifi systemd[1]: Started Remount Root and Kernel File Systems. Mar 03 14:01:09 hifi systemd[1]: Mounted FUSE Control File System. Mar 03 14:01:09 hifi systemd[1]: Mounted Kernel Configuration File System. Mar 03 14:01:09 hifi systemd[1]: Started Apply Kernel Variables. Mar 03 14:01:09 hifi systemd[1]: Starting Load/Save Random Seed... Mar 03 14:01:09 hifi systemd[1]: Starting Create System Users... Mar 03 14:01:09 hifi systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Mar 03 14:01:09 hifi systemd[1]: dynamicswap.service: Succeeded. Mar 03 14:01:09 hifi systemd[1]: Started Load/Save Random Seed. Mar 03 14:01:09 hifi systemd[1]: Started Create System Users. Mar 03 14:01:09 hifi systemd[1]: Starting Create Static Device Nodes in /dev... Mar 03 14:01:09 hifi systemd[1]: Started Create Static Device Nodes in /dev. Mar 03 14:01:09 hifi systemd[1]: Reached target Local File Systems (Pre). Mar 03 14:01:09 hifi systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Mar 03 14:01:09 hifi systemd[1]: Mounting /var/log... Mar 03 14:01:09 hifi systemd[1]: Mounting /var/spool/cups... Mar 03 14:01:09 hifi systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Mar 03 14:01:09 hifi systemd[1]: Mounting /tmp... Mar 03 14:01:09 hifi systemd[1]: Starting udev Kernel Device Manager... Mar 03 14:01:09 hifi systemd[1]: Mounted /var/log. Mar 03 14:01:09 hifi systemd[1]: Mounted /var/spool/cups. Mar 03 14:01:09 hifi systemd[1]: Mounted /tmp. Mar 03 14:01:09 hifi systemd[1]: Mounting /var/spool/cups/tmp... Mar 03 14:01:09 hifi systemd[1]: Starting Flush Journal to Persistent Storage... Mar 03 14:01:09 hifi systemd[1]: Started udev Coldplug all Devices. Mar 03 14:01:09 hifi systemd[1]: Starting Helper to synchronize boot up for ifupdown... Mar 03 14:01:09 hifi systemd[1]: Mounted /var/spool/cups/tmp. Mar 03 14:01:09 hifi systemd[1]: Started Helper to synchronize boot up for ifupdown. Mar 03 14:01:09 hifi systemd-udevd[354]: Network interface NamePolicy= disabled on kernel command line, ignoring. Mar 03 14:01:09 hifi systemd-journald[317]: Runtime journal (/run/log/journal/d5012141e8efab18115b4334669e938a) is 7.5M, max 30.0M, 22.5M free. Mar 03 14:01:09 hifi systemd[1]: Started Flush Journal to Persistent Storage. Mar 03 14:01:09 hifi systemd[1]: Started udev Kernel Device Manager. Mar 03 14:01:09 hifi systemd[1]: Starting Show Plymouth Boot Screen... Mar 03 14:01:09 hifi systemd[1]: plymouth-start.service: Succeeded. Mar 03 14:01:09 hifi systemd[1]: Started Show Plymouth Boot Screen. Mar 03 14:01:09 hifi systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Mar 03 14:01:09 hifi systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Mar 03 14:01:09 hifi systemd[1]: Reached target Local Encrypted Volumes. Mar 03 14:01:09 hifi systemd[1]: Reached target Paths. Mar 03 14:01:09 hifi systemd-udevd[359]: Using default interface naming scheme 'v240'. Mar 03 14:01:09 hifi kernel: mc: Linux media interface: v0.10 Mar 03 14:01:09 hifi systemd-udevd[359]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 03 14:01:10 hifi kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Mar 03 14:01:10 hifi kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Mar 03 14:01:10 hifi kernel: [vc_sm_connected_init]: start Mar 03 14:01:10 hifi kernel: videodev: Linux video capture interface: v2.00 Mar 03 14:01:10 hifi kernel: [vc_sm_connected_init]: installed successfully Mar 03 14:01:10 hifi kernel: rpi-gpiomem fe200000.gpiomem: window base 0xfe200000 size 0x00001000 Mar 03 14:01:10 hifi kernel: rpi-gpiomem fe200000.gpiomem: initialised 1 regions as /dev/gpiomem Mar 03 14:01:10 hifi kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Mar 03 14:01:10 hifi kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Mar 03 14:01:10 hifi kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Mar 03 14:01:10 hifi kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Mar 03 14:01:10 hifi kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Mar 03 14:01:10 hifi kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Mar 03 14:01:10 hifi kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Mar 03 14:01:10 hifi kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Mar 03 14:01:10 hifi kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Mar 03 14:01:10 hifi kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Mar 03 14:01:10 hifi kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Mar 03 14:01:10 hifi kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Mar 03 14:01:10 hifi kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Mar 03 14:01:10 hifi kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Mar 03 14:01:10 hifi kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Mar 03 14:01:10 hifi kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Mar 03 14:01:10 hifi kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Mar 03 14:01:10 hifi kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Mar 03 14:01:10 hifi kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Mar 03 14:01:10 hifi kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Mar 03 14:01:10 hifi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Mar 03 14:01:10 hifi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Mar 03 14:01:10 hifi kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Mar 03 14:01:10 hifi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Mar 03 14:01:10 hifi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Mar 03 14:01:10 hifi kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. Mar 03 14:01:10 hifi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Mar 03 14:01:10 hifi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Mar 03 14:01:10 hifi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Mar 03 14:01:10 hifi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Mar 03 14:01:10 hifi kernel: rpivid feb10000.codec: Device registered as /dev/video19 Mar 03 14:01:10 hifi kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 Mar 03 14:01:10 hifi kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image Mar 03 14:01:10 hifi kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Mar 03 14:01:10 hifi kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored Mar 03 14:01:10 hifi kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Mar 03 14:01:10 hifi kernel: Bluetooth: Core ver 2.22 Mar 03 14:01:10 hifi kernel: NET: Registered PF_BLUETOOTH protocol family Mar 03 14:01:10 hifi kernel: Bluetooth: HCI device and connection manager initialized Mar 03 14:01:10 hifi kernel: Bluetooth: HCI socket layer initialized Mar 03 14:01:10 hifi kernel: Bluetooth: L2CAP socket layer initialized Mar 03 14:01:10 hifi kernel: Bluetooth: SCO socket layer initialized Mar 03 14:01:10 hifi kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Mar 03 14:01:10 hifi kernel: Bluetooth: HCI UART driver ver 2.3 Mar 03 14:01:10 hifi kernel: Bluetooth: HCI UART protocol H4 registered Mar 03 14:01:10 hifi kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Mar 03 14:01:10 hifi kernel: Bluetooth: HCI UART protocol Broadcom registered Mar 03 14:01:10 hifi kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Mar 03 14:01:10 hifi kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Mar 03 14:01:10 hifi systemd[1]: Found device /dev/disk/by-uuid/41CA-9A8B. Mar 03 14:01:10 hifi systemd-udevd[363]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 03 14:01:10 hifi kernel: uart-pl011 fe201000.serial: no DMA platform data Mar 03 14:01:10 hifi kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Mar 03 14:01:11 hifi kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Mar 03 14:01:11 hifi kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Mar 03 14:01:11 hifi kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Mar 03 14:01:11 hifi kernel: Bluetooth: hci0: BCM: chip id 107 Mar 03 14:01:11 hifi kernel: Bluetooth: hci0: BCM: features 0x2f Mar 03 14:01:11 hifi kernel: Bluetooth: hci0: BCM4345C0 Mar 03 14:01:11 hifi kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 Mar 03 14:01:11 hifi kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch Mar 03 14:01:11 hifi kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Mar 03 14:01:11 hifi kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Mar 03 14:01:11 hifi kernel: usbcore: registered new interface driver brcmfmac Mar 03 14:01:11 hifi kernel: wm8804 1-003b: revision E Mar 03 14:01:11 hifi kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov 1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60 Mar 03 14:01:11 hifi systemd-udevd[364]: Using default interface naming scheme 'v240'. Mar 03 14:01:11 hifi systemd-udevd[364]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 03 14:01:11 hifi kernel: Bluetooth: hci0: BCM: features 0x2f Mar 03 14:01:11 hifi kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+ Mar 03 14:01:11 hifi kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342 Mar 03 14:01:12 hifi systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Mar 03 14:01:12 hifi systemd[1]: Condition check resulted in /sys/subsystem/net/devices/wlan0 being skipped. Mar 03 14:01:12 hifi systemd[1]: Created slice system-bthelper.slice. Mar 03 14:01:12 hifi systemd[1]: Starting Show Plymouth Boot Screen... Mar 03 14:01:12 hifi systemd[1]: Condition check resulted in Huge Pages File System being skipped. Mar 03 14:01:12 hifi systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Mar 03 14:01:12 hifi systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Mar 03 14:01:12 hifi systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Mar 03 14:01:12 hifi systemd[1]: Starting File System Check on /dev/disk/by-uuid/41CA-9A8B... Mar 03 14:01:12 hifi systemd[1]: Starting Load/Save RF Kill Switch Status... Mar 03 14:01:12 hifi systemd[1]: plymouth-start.service: Succeeded. Mar 03 14:01:12 hifi systemd[1]: Started Show Plymouth Boot Screen. Mar 03 14:01:12 hifi systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Mar 03 14:01:12 hifi systemd[1]: Started File System Check Daemon to report status. Mar 03 14:01:12 hifi systemd[1]: Started Load/Save RF Kill Switch Status. Mar 03 14:01:13 hifi systemd-fsck[512]: fsck.fat 4.1 (2017-01-24) Mar 03 14:01:13 hifi systemd-fsck[512]: 0x41: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Mar 03 14:01:13 hifi systemd-fsck[512]: Automatically removing dirty bit. Mar 03 14:01:13 hifi systemd-fsck[512]: Performing changes. Mar 03 14:01:13 hifi systemd-fsck[512]: /dev/mmcblk0p1: 446 files, 135819/184582 clusters Mar 03 14:01:13 hifi systemd[1]: Started File System Check on /dev/disk/by-uuid/41CA-9A8B. Mar 03 14:01:13 hifi systemd[1]: Mounting /boot... Mar 03 14:01:13 hifi systemd[1]: Mounted /boot. Mar 03 14:01:13 hifi systemd[1]: Reached target Local File Systems. Mar 03 14:01:13 hifi systemd[1]: Started ifup for wlan0. Mar 03 14:01:13 hifi systemd[1]: Starting Create Volatile Files and Directories... Mar 03 14:01:13 hifi systemd[1]: Started ifup for eth0. Mar 03 14:01:13 hifi systemd[1]: Starting Raise network interfaces... Mar 03 14:01:13 hifi systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Mar 03 14:01:13 hifi systemd[1]: Starting Preprocess NFS configuration... Mar 03 14:01:13 hifi systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Mar 03 14:01:13 hifi systemd[1]: Received SIGRTMIN+20 from PID 205 (plymouthd). Mar 03 14:01:13 hifi systemd[1]: plymouth-read-write.service: Succeeded. Mar 03 14:01:13 hifi systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Mar 03 14:01:13 hifi systemd[1]: nfs-config.service: Succeeded. Mar 03 14:01:13 hifi systemd[1]: Started Preprocess NFS configuration. Mar 03 14:01:13 hifi systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Mar 03 14:01:13 hifi systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Mar 03 14:01:13 hifi systemd[1]: Reached target NFS client services. Mar 03 14:01:13 hifi systemd[1]: Started Create Volatile Files and Directories. Mar 03 14:01:13 hifi systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Mar 03 14:01:13 hifi systemd[1]: Starting Update UTMP about System Boot/Shutdown... Mar 03 14:01:13 hifi systemd[1]: Starting RPC bind portmap service... Mar 03 14:01:13 hifi systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Mar 03 14:01:13 hifi systemd[1]: Started Update UTMP about System Boot/Shutdown. Mar 03 14:01:13 hifi systemd[1]: Reached target System Initialization. Mar 03 14:01:13 hifi systemd[1]: Started Daily Cleanup of Temporary Directories. Mar 03 14:01:13 hifi systemd[1]: apt-daily.timer: Not using persistent file timestamp Mon 2025-03-17 22:02:18 CET as it is in the future. Mar 03 14:01:13 hifi systemd[1]: Started Daily apt download activities. Mar 03 14:01:13 hifi systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Tue 2025-03-18 06:55:18 CET as it is in the future. Mar 03 14:01:13 hifi systemd[1]: Started Daily apt upgrade and clean activities. Mar 03 14:01:13 hifi systemd[1]: Reached target Timers. Mar 03 14:01:13 hifi systemd[1]: Listening on triggerhappy.socket. Mar 03 14:01:13 hifi kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 03 14:01:13 hifi systemd[1]: Listening on D-Bus System Message Bus Socket. Mar 03 14:01:13 hifi kernel: 8021q: 802.1Q VLAN Support v1.8 Mar 03 14:01:13 hifi systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Mar 03 14:01:13 hifi systemd[1]: Reached target Sockets. Mar 03 14:01:13 hifi systemd[1]: Reached target Basic System. Mar 03 14:01:13 hifi systemd[1]: Started Manage Sound Card State (restore and store). Mar 03 14:01:13 hifi systemd[1]: Started Volumio Iptables Module. Mar 03 14:01:13 hifi alsactl[599]: alsactl 1.1.8 daemon started Mar 03 14:01:13 hifi systemd[1]: Starting triggerhappy global hotkey daemon... Mar 03 14:01:13 hifi systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Mar 03 14:01:13 hifi systemd[1]: Started UPnP Renderer front-end to MPD. Mar 03 14:01:13 hifi thd[614]: Unable to parse trigger line: Mar 03 14:01:13 hifi thd[614]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Mar 03 14:01:13 hifi thd[614]: Unable to parse trigger line: Mar 03 14:01:13 hifi thd[614]: Found socket passed from systemd Mar 03 14:01:13 hifi systemd[1]: Starting Save/Restore Sound Card State... Mar 03 14:01:13 hifi systemd[1]: Starting Login Service... Mar 03 14:01:13 hifi systemd[1]: Starting Wireless Services... Mar 03 14:01:13 hifi systemd[1]: Started volumio-remote-updater.service. Mar 03 14:01:13 hifi systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Mar 03 14:01:13 hifi systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Mar 03 14:01:13 hifi systemd[1]: Starting dhcpcd on all interfaces... Mar 03 14:01:13 hifi systemd[1]: Starting Configure Bluetooth Modems connected by UART... Mar 03 14:01:13 hifi systemd[1]: Started D-Bus System Message Bus. Mar 03 14:01:13 hifi dhcpcd[630]: Not running dhcpcd because /etc/network/interfaces Mar 03 14:01:13 hifi dhcpcd[630]: defines some interfaces that will use a Mar 03 14:01:13 hifi dhcpcd[630]: DHCP client or static address Mar 03 14:01:14 hifi systemd[1]: Starting WPA supplicant... Mar 03 14:01:14 hifi systemd-logind[624]: New seat seat0. Mar 03 14:01:14 hifi systemd[1]: Started Volumio Log Rotation Service. Mar 03 14:01:14 hifi kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) Mar 03 14:01:14 hifi kernel: bcmgenet fd580000.ethernet eth0: Link is Down Mar 03 14:01:14 hifi dhcpcd[571]: eth0: waiting for carrier Mar 03 14:01:14 hifi sh[523]: eth0: waiting for carrier Mar 03 14:01:14 hifi systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Mar 03 14:01:14 hifi systemd[1]: Started RPC bind portmap service. Mar 03 14:01:14 hifi systemd[1]: Started triggerhappy global hotkey daemon. Mar 03 14:01:14 hifi systemd[1]: Started Save/Restore Sound Card State. Mar 03 14:01:14 hifi systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Mar 03 14:01:14 hifi systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Mar 03 14:01:14 hifi systemd[1]: Failed to start dhcpcd on all interfaces. Mar 03 14:01:14 hifi systemd[1]: hciuart.service: Succeeded. Mar 03 14:01:14 hifi systemd[1]: Started Configure Bluetooth Modems connected by UART. Mar 03 14:01:14 hifi sh[521]: wlan0=wlan0 Mar 03 14:01:14 hifi systemd[1]: Starting Raspberry Pi bluetooth helper... Mar 03 14:01:14 hifi systemd[1]: Reached target Sound Card. Mar 03 14:01:14 hifi systemd[1]: Reached target Remote File Systems (Pre). Mar 03 14:01:14 hifi systemd[1]: Reached target Remote File Systems. Mar 03 14:01:14 hifi systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Mar 03 14:01:14 hifi systemd[1]: Reached target RPC Port Mapper. Mar 03 14:01:14 hifi avahi-daemon[650]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Mar 03 14:01:14 hifi avahi-daemon[650]: Successfully dropped root privileges. Mar 03 14:01:14 hifi bthelper[652]: Raspberry Pi BDADDR already set Mar 03 14:01:14 hifi avahi-daemon[650]: avahi-daemon 0.7 starting up. Mar 03 14:01:15 hifi dbus-daemon[635]: [system] Successfully activated service 'org.freedesktop.systemd1' Mar 03 14:01:15 hifi systemd[1]: Started Login Service. Mar 03 14:01:15 hifi avahi-daemon[650]: Successfully called chroot(). Mar 03 14:01:15 hifi avahi-daemon[650]: Successfully dropped remaining capabilities. Mar 03 14:01:15 hifi systemd[1]: Started Raspberry Pi bluetooth helper. Mar 03 14:01:15 hifi wpa_supplicant[647]: Successfully initialized wpa_supplicant Mar 03 14:01:15 hifi avahi-daemon[650]: Loading service file /services/volumio.service. Mar 03 14:01:15 hifi avahi-daemon[650]: Network interface enumeration completed. Mar 03 14:01:15 hifi avahi-daemon[650]: Server startup complete. Host name is hifi.local. Local service cookie is 3366654840. Mar 03 14:01:15 hifi avahi-daemon[650]: Service "Hifi" (/services/volumio.service) successfully established. Mar 03 14:01:15 hifi systemd[1]: Started Raise network interfaces. Mar 03 14:01:15 hifi volumio-remote-updater[628]: Error: No active session Mar 03 14:01:15 hifi systemd[1]: Started Avahi mDNS/DNS-SD Stack. Mar 03 14:01:15 hifi systemd[1]: Started WPA supplicant. Mar 03 14:01:15 hifi volumio-remote-updater[628]: [2025-03-03 14:01:15] [info] asio async_connect error: system:111 (Connection refused) Mar 03 14:01:15 hifi volumio-remote-updater[628]: [2025-03-03 14:01:15] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 03 14:01:15 hifi volumio-remote-updater[628]: [2025-03-03 14:01:15] [error] handle_connect error: Underlying Transport Error Mar 03 14:01:15 hifi systemd[1]: Reached target Network. Mar 03 14:01:15 hifi systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Mar 03 14:01:15 hifi volumio[618]: Could not open config: /tmp/upmpdcli.conf Mar 03 14:01:15 hifi systemd[1]: Starting Permit User Sessions... Mar 03 14:01:15 hifi systemd[1]: Starting Network Time Service... Mar 03 14:01:15 hifi systemd[1]: Reached target Network is Online. Mar 03 14:01:15 hifi systemd[1]: Starting /etc/rc.local Compatibility... Mar 03 14:01:15 hifi systemd[1]: Starting Samba NMB Daemon... Mar 03 14:01:15 hifi systemd[1]: Starting LSB: Brings up/down network automatically... Mar 03 14:01:15 hifi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 03 14:01:15 hifi systemd[1]: Starting Bluetooth service... Mar 03 14:01:15 hifi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 03 14:01:15 hifi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 03 14:01:15 hifi systemd[1]: Started Permit User Sessions. Mar 03 14:01:15 hifi systemd[1]: Started /etc/rc.local Compatibility. Mar 03 14:01:15 hifi systemd[1]: iptables.service: Succeeded. Mar 03 14:01:15 hifi systemd[1]: Starting Hold until boot process finishes up... Mar 03 14:01:15 hifi systemd[1]: Starting Terminate Plymouth Boot Screen... Mar 03 14:01:15 hifi systemd[1]: plymouth-quit-wait.service: Succeeded. Mar 03 14:01:15 hifi systemd[1]: Started Hold until boot process finishes up. Mar 03 14:01:15 hifi systemd[1]: plymouth-quit.service: Succeeded. Mar 03 14:01:15 hifi systemd[1]: Started Terminate Plymouth Boot Screen. Mar 03 14:01:15 hifi systemd[1]: Received SIGRTMIN+21 from PID 205 (n/a). Mar 03 14:01:15 hifi systemd[1]: Received SIGRTMIN+21 from PID 205 (n/a). Mar 03 14:01:15 hifi systemd[1]: Started Getty on tty1. Mar 03 14:01:15 hifi systemd[1]: Reached target Login Prompts. Mar 03 14:01:15 hifi ifplugd(eth0)[769]: ifplugd 0.28 initializing. Mar 03 14:01:15 hifi ifplugd(eth0)[769]: Using interface eth0/D8:3A:DD:9C:2B:AE with driver (version: 6.1.69-v7l+) Mar 03 14:01:15 hifi ifplugd(eth0)[769]: Using detection mode: SIOCETHTOOL Mar 03 14:01:15 hifi ifplugd(eth0)[769]: Initialization complete, link beat not detected. Mar 03 14:01:15 hifi loadcpufreq[667]: Loading cpufreq kernel modules...done (none). Mar 03 14:01:15 hifi systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Mar 03 14:01:15 hifi systemd[1]: Starting LSB: set CPUFreq kernel parameters... Mar 03 14:01:15 hifi ifplugd[723]: Network Interface Plugging Daemon...start eth0...done. Mar 03 14:01:15 hifi ntpd[718]: ntpd 4.2.8p12@1.3728-o (1): Starting Mar 03 14:01:15 hifi ntpd[718]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Mar 03 14:01:15 hifi ntpd[774]: proto: precision = 2.055 usec (-19) Mar 03 14:01:15 hifi bluetoothd[726]: Bluetooth daemon 5.50 Mar 03 14:01:15 hifi systemd[1]: Started Network Time Service. Mar 03 14:01:15 hifi systemd[1]: Started LSB: Brings up/down network automatically. Mar 03 14:01:16 hifi ntpd[774]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 03 14:01:16 hifi ntpd[774]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Mar 03 14:01:16 hifi ntpd[774]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 66 days ago Mar 03 14:01:16 hifi ntpd[774]: Listen and drop on 0 v6wildcard [::]:123 Mar 03 14:01:16 hifi bluetoothd[726]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Mar 03 14:01:16 hifi ntpd[774]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 03 14:01:16 hifi ntpd[774]: Listen normally on 2 lo 127.0.0.1:123 Mar 03 14:01:16 hifi ntpd[774]: Listening on routing socket on fd #19 for interface updates Mar 03 14:01:16 hifi ntpd[774]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 03 14:01:16 hifi ntpd[774]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 03 14:01:16 hifi systemd[1]: Started Bluetooth service. Mar 03 14:01:16 hifi systemd[1]: Reached target Bluetooth. Mar 03 14:01:16 hifi bluetoothd[726]: Starting SDP server Mar 03 14:01:16 hifi bluetoothd[726]: Excluding (cli) sap Mar 03 14:01:16 hifi cpufrequtils[770]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Mar 03 14:01:16 hifi kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Mar 03 14:01:16 hifi kernel: Bluetooth: BNEP filters: protocol multicast Mar 03 14:01:16 hifi kernel: Bluetooth: BNEP socket layer initialized Mar 03 14:01:16 hifi systemd[1]: Started LSB: set CPUFreq kernel parameters. Mar 03 14:01:16 hifi dbus-daemon[635]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=726 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Mar 03 14:01:16 hifi bluetoothd[726]: Bluetooth management interface 1.22 initialized Mar 03 14:01:16 hifi kernel: Bluetooth: MGMT ver 1.22 Mar 03 14:01:16 hifi bluetoothd[726]: Failed to set privacy: Rejected (0x0b) Mar 03 14:01:16 hifi systemd[1]: Starting Hostname Service... Mar 03 14:01:16 hifi dbus-daemon[635]: [system] Successfully activated service 'org.freedesktop.hostname1' Mar 03 14:01:16 hifi systemd[1]: Started Hostname Service. Mar 03 14:01:16 hifi nmbd[737]: [2025/03/03 14:01:16.641865, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Mar 03 14:01:16 hifi nmbd[737]: started asyncdns process 794 Mar 03 14:01:16 hifi nmbd[737]: [2025/03/03 14:01:16.643723, 0] ../lib/util/become_daemon.c:149(daemon_status) Mar 03 14:01:16 hifi nmbd[737]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Mar 03 14:01:16 hifi nmbd[737]: [2025/03/03 14:01:16.643875, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Mar 03 14:01:16 hifi nmbd[737]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Mar 03 14:01:16 hifi haveged[560]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Mar 03 14:01:16 hifi haveged[560]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Mar 03 14:01:16 hifi haveged[560]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00099 Mar 03 14:01:16 hifi haveged[560]: haveged: fills: 0, generated: 0 Mar 03 14:01:16 hifi wireless.js[627]: Cleaning previous... Mar 03 14:01:16 hifi ntpd[774]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Mar 03 14:01:17 hifi sudo[802]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 03 14:01:17 hifi sudo[802]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:17 hifi sudo[802]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:17 hifi sudo[804]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 03 14:01:17 hifi sudo[804]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:17 hifi sudo[804]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:17 hifi wireless.js[627]: Stopped aP Mar 03 14:01:17 hifi systemd[1]: systemd-rfkill.service: Succeeded. Mar 03 14:01:17 hifi sudo[811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 03 14:01:17 hifi sudo[811]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:17 hifi kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 03 14:01:17 hifi sudo[811]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:17 hifi sudo[813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Mar 03 14:01:17 hifi sudo[813]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:17 hifi sudo[813]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:17 hifi sudo[820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 03 14:01:17 hifi sudo[820]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:17 hifi sudo[820]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:17 hifi sudo[822]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Mar 03 14:01:17 hifi sudo[822]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:17 hifi ntpd[774]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Mar 03 14:01:18 hifi ntpd[774]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Mar 03 14:01:19 hifi bthelper[652]: Changing power off succeeded Mar 03 14:01:19 hifi bthelper[652]: [CHG] Controller D8:3A:DD:9C:2B:B2 Class: 0x0000041c Mar 03 14:01:19 hifi bthelper[652]: Changing power on succeeded Mar 03 14:01:19 hifi ntpd[774]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Mar 03 14:01:20 hifi volumio-remote-updater[628]: [2025-03-03 14:01:20] [info] asio async_connect error: system:111 (Connection refused) Mar 03 14:01:20 hifi volumio-remote-updater[628]: [2025-03-03 14:01:20] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 03 14:01:20 hifi volumio-remote-updater[628]: [2025-03-03 14:01:20] [error] handle_connect error: Underlying Transport Error Mar 03 14:01:20 hifi sudo[822]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:20 hifi wireless.js[627]: SETTING APPROPRIATE REG DOMAIN: FO Mar 03 14:01:20 hifi sudo[833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 03 14:01:20 hifi sudo[833]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:20 hifi sudo[833]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:20 hifi sudo[835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set FO Mar 03 14:01:20 hifi sudo[835]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:20 hifi sudo[835]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:20 hifi wireless.js[627]: SUCCESSFULLY SET NEW REGDOMAIN: FO Mar 03 14:01:20 hifi wireless.js[627]: Start wireless flow Mar 03 14:01:20 hifi wireless.js[627]: Stopped hotspot (if there).. Mar 03 14:01:20 hifi sudo[841]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 03 14:01:20 hifi sudo[841]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:20 hifi sudo[841]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:20 hifi systemd-udevd[362]: Process '/sbin/crda' failed with exit code 255. Mar 03 14:01:20 hifi sudo[843]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 03 14:01:20 hifi sudo[843]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:21 hifi sudo[843]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:21 hifi wireless.js[627]: DHCP IP Mar 03 14:01:21 hifi wireless.js[627]: Start ap Mar 03 14:01:21 hifi wpa_supplicant[845]: Successfully initialized wpa_supplicant Mar 03 14:01:21 hifi sudo[846]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Mar 03 14:01:21 hifi sudo[846]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:21 hifi kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 03 14:01:21 hifi dhcpcd[847]: dev: loaded udev Mar 03 14:01:21 hifi dhcpcd-run-hooks[865]: wlan0: starting wpa_supplicant Mar 03 14:01:21 hifi dhcpcd-run-hooks[870]: wlan0: failed to start wpa_supplicant Mar 03 14:01:21 hifi dhcpcd-run-hooks[871]: 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 03 14:01:21 hifi dhcpcd[847]: wlan0: connected to Access Point `' Mar 03 14:01:21 hifi dhcpcd[847]: no interfaces have a carrier Mar 03 14:01:21 hifi dhcpcd[847]: forked to background, child pid 881 Mar 03 14:01:21 hifi dhcpcd[881]: eth0: waiting for carrier Mar 03 14:01:21 hifi dhcpcd[881]: wlan0: waiting for carrier Mar 03 14:01:21 hifi sudo[846]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:22 hifi wireless.js[627]: trying... Mar 03 14:01:22 hifi sudo[883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 03 14:01:22 hifi sudo[883]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:22 hifi sudo[883]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:23 hifi wireless.js[627]: trying... Mar 03 14:01:23 hifi sudo[886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 03 14:01:23 hifi sudo[886]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:23 hifi sudo[886]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:23 hifi wpa_supplicant[869]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Mar 03 14:01:23 hifi wpa_supplicant[869]: wlan0: Trying to associate with SSID 'boss' Mar 03 14:01:24 hifi wireless.js[627]: trying... Mar 03 14:01:24 hifi sudo[889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 03 14:01:24 hifi sudo[889]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:24 hifi sudo[889]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:25 hifi wireless.js[627]: trying... Mar 03 14:01:25 hifi sudo[892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 03 14:01:25 hifi sudo[892]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:25 hifi sudo[892]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:26 hifi wireless.js[627]: trying... Mar 03 14:01:26 hifi sudo[895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 03 14:01:26 hifi sudo[895]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:26 hifi sudo[895]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:26 hifi dhcpcd[881]: wlan0: carrier acquired Mar 03 14:01:26 hifi dhcpcd[881]: wlan0: connected to Access Point `boss' Mar 03 14:01:26 hifi wpa_supplicant[869]: wlan0: Associated with 34:97:f6:08:fb:7c Mar 03 14:01:26 hifi wpa_supplicant[869]: wlan0: CTRL-EVENT-CONNECTED - Connection to 34:97:f6:08:fb:7c completed [id=0 id_str=] Mar 03 14:01:26 hifi wpa_supplicant[869]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 03 14:01:26 hifi dhcpcd[881]: DUID 00:01:00:01:2e:31:53:02:d8:3a:dd:9c:2b:b0 Mar 03 14:01:26 hifi dhcpcd[881]: wlan0: IAID dd:9c:2b:b0 Mar 03 14:01:26 hifi dhcpcd[881]: wlan0: adding address fe80::508b:aca1:f774:2969 Mar 03 14:01:26 hifi dhcpcd[881]: ipv6_addaddr1: Permission denied Mar 03 14:01:26 hifi dhcpcd[881]: wlan0: carrier lost Mar 03 14:01:26 hifi systemd-udevd[897]: Process '/sbin/crda' failed with exit code 255. Mar 03 14:01:26 hifi dhcpcd[881]: wlan0: carrier acquired Mar 03 14:01:26 hifi dhcpcd[881]: wlan0: IAID dd:9c:2b:b0 Mar 03 14:01:26 hifi dhcpcd[881]: wlan0: soliciting an IPv6 router Mar 03 14:01:27 hifi dhcpcd[881]: wlan0: rebinding lease of 192.168.1.177 Mar 03 14:01:27 hifi dhcpcd[881]: wlan0: probing address 192.168.1.177/24 Mar 03 14:01:27 hifi wireless.js[627]: trying... Mar 03 14:01:27 hifi sudo[912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 03 14:01:27 hifi sudo[912]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:27 hifi sudo[912]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:27 hifi volumio-remote-updater[628]: [2025-03-03 14:01:27] [info] asio async_connect error: system:111 (Connection refused) Mar 03 14:01:27 hifi volumio-remote-updater[628]: [2025-03-03 14:01:27] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 03 14:01:27 hifi volumio-remote-updater[628]: [2025-03-03 14:01:27] [error] handle_connect error: Underlying Transport Error Mar 03 14:01:28 hifi wireless.js[627]: trying... Mar 03 14:01:28 hifi sudo[915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 03 14:01:28 hifi sudo[915]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:28 hifi sudo[915]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:29 hifi wireless.js[627]: trying... Mar 03 14:01:29 hifi sudo[918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 03 14:01:29 hifi sudo[918]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:29 hifi sudo[918]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:29 hifi wpa_supplicant[869]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Mar 03 14:01:30 hifi wireless.js[627]: trying... Mar 03 14:01:30 hifi sudo[921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 03 14:01:30 hifi sudo[921]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:30 hifi sudo[921]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:31 hifi wireless.js[627]: trying... Mar 03 14:01:31 hifi sudo[924]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 03 14:01:31 hifi sudo[924]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:31 hifi sudo[924]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:32 hifi wireless.js[627]: trying... Mar 03 14:01:32 hifi sudo[927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 03 14:01:32 hifi sudo[927]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:32 hifi sudo[927]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:32 hifi dhcpcd[881]: wlan0: leased 192.168.1.177 for 86400 seconds Mar 03 14:01:32 hifi avahi-daemon[650]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.177. Mar 03 14:01:32 hifi avahi-daemon[650]: New relevant interface wlan0.IPv4 for mDNS. Mar 03 14:01:32 hifi dhcpcd[881]: wlan0: adding route to 192.168.1.0/24 Mar 03 14:01:32 hifi avahi-daemon[650]: Registering new address record for 192.168.1.177 on wlan0.IPv4. Mar 03 14:01:32 hifi dhcpcd[881]: wlan0: adding default route via 192.168.1.1 Mar 03 14:01:33 hifi wireless.js[627]: trying... Mar 03 14:01:33 hifi sudo[950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 03 14:01:33 hifi sudo[950]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:33 hifi sudo[950]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:33 hifi wireless.js[627]: Connected to: ----boss Mar 03 14:01:33 hifi wireless.js[627]: ---- Mar 03 14:01:33 hifi sudo[953]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 03 14:01:33 hifi sudo[953]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:33 hifi sudo[953]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:33 hifi wireless.js[627]: ... joined AP, wlan0 IPv4 is 192.168.1.177, ipV6 is undefined Mar 03 14:01:33 hifi wireless.js[627]: It's done! AP Mar 03 14:01:33 hifi kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 03 14:01:33 hifi systemd[1]: Started Wireless Services. Mar 03 14:01:33 hifi systemd[1]: Started Volumio Backend Module. Mar 03 14:01:33 hifi systemd[1]: Started Volumio Cpu Tweaker. Mar 03 14:01:33 hifi volumio-cpu-tweak[959]: Setting RT Priority for mpd Mar 03 14:01:33 hifi volumio-cpu-tweak[959]: pid 35's current scheduling policy: SCHED_OTHER Mar 03 14:01:33 hifi volumio-cpu-tweak[959]: pid 35's current scheduling priority: 0 Mar 03 14:01:33 hifi volumio-cpu-tweak[959]: Setting MPD Affinity Mar 03 14:01:33 hifi volumio-cpu-tweak[959]: pid 3's current affinity mask: f Mar 03 14:01:33 hifi volumio-cpu-tweak[959]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Mar 03 14:01:33 hifi volumio-cpu-tweak[959]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Mar 03 14:01:33 hifi systemd[1]: volumio_cpu_tweak.service: Succeeded. Mar 03 14:01:33 hifi ntpd[774]: Listen normally on 3 wlan0 192.168.1.177:123 Mar 03 14:01:33 hifi ntpd[774]: new interface(s) found: waking up resolver Mar 03 14:01:35 hifi volumio[958]: info: ------------------------------------------- Mar 03 14:01:35 hifi volumio[958]: info: ----- Volumio3 ---- Mar 03 14:01:35 hifi volumio[958]: info: ------------------------------------------- Mar 03 14:01:35 hifi volumio[958]: info: ----- System startup ---- Mar 03 14:01:35 hifi volumio[958]: info: ------------------------------------------- Mar 03 14:01:35 hifi volumio[958]: info: MYVOLUMIO Environment detected Mar 03 14:01:35 hifi volumio[958]: info: Plugin folders cleanup Mar 03 14:01:35 hifi volumio[958]: info: Scanning into folder /volumio/app/plugins/ Mar 03 14:01:35 hifi volumio[958]: info: Scanning category audio_interface Mar 03 14:01:35 hifi volumio[958]: info: Scanning category miscellanea Mar 03 14:01:35 hifi volumio[958]: info: Scanning category music_service Mar 03 14:01:35 hifi volumio[958]: info: Scanning category plugins.json Mar 03 14:01:35 hifi volumio[958]: info: Scanning category system_controller Mar 03 14:01:35 hifi volumio[958]: info: Scanning category user_interface Mar 03 14:01:35 hifi volumio[958]: info: Scanning into folder /data/plugins/ Mar 03 14:01:35 hifi volumio[958]: info: Scanning category audio_interface Mar 03 14:01:35 hifi volumio[958]: info: Scanning category music_service Mar 03 14:01:35 hifi volumio[958]: info: Plugin folders cleanup completed Mar 03 14:01:35 hifi volumio[958]: info: ------------------------------------------- Mar 03 14:01:35 hifi volumio[958]: info: ----- Core plugins startup ---- Mar 03 14:01:35 hifi volumio[958]: info: ------------------------------------------- Mar 03 14:01:35 hifi volumio[958]: info: Loading plugins from folder /volumio/app/plugins/ Mar 03 14:01:35 hifi volumio[958]: info: Adding plugin upnp to MyMusic Plugins Mar 03 14:01:35 hifi volumio[958]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 03 14:01:35 hifi volumio[958]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 03 14:01:35 hifi volumio[958]: info: Loading plugins from folder /data/plugins/ Mar 03 14:01:35 hifi volumio[958]: info: Loading plugin "system"... Mar 03 14:01:35 hifi volumio[958]: info: Loading plugin "appearance"... Mar 03 14:01:36 hifi nmbd[737]: [2025/03/03 14:01:36.648064, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 03 14:01:36 hifi systemd[1]: Started Samba NMB Daemon. Mar 03 14:01:36 hifi nmbd[737]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Mar 03 14:01:36 hifi systemd[1]: Starting Samba Winbind Daemon... Mar 03 14:01:36 hifi winbindd[988]: [2025/03/03 14:01:36.960699, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Mar 03 14:01:36 hifi winbindd[988]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Mar 03 14:01:36 hifi winbindd[988]: [2025/03/03 14:01:36.983252, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 03 14:01:36 hifi systemd[1]: Started Samba Winbind Daemon. Mar 03 14:01:36 hifi winbindd[988]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Mar 03 14:01:37 hifi systemd[1]: Starting Samba SMB Daemon... Mar 03 14:01:37 hifi volumio[958]: info: Loading plugin "network"... Mar 03 14:01:37 hifi volumio[958]: info: Refreshing Cached IP Addresses Mar 03 14:01:37 hifi sudo[995]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 03 14:01:37 hifi sudo[995]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:37 hifi sudo[995]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:37 hifi volumio[958]: info: Loading plugin "services"... Mar 03 14:01:37 hifi sudo[997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 03 14:01:37 hifi volumio[958]: info: Loading plugin "alsa_controller"... Mar 03 14:01:37 hifi sudo[997]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:37 hifi sudo[997]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:37 hifi sudo[1000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 03 14:01:37 hifi sudo[1000]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:37 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 03 14:01:37 hifi volumio[958]: info: Loading plugin "wizard"... Mar 03 14:01:37 hifi volumio[958]: info: Loading plugin "networkfs"... Mar 03 14:01:37 hifi volumio[958]: info: Starting Udev Watcher for removable devices Mar 03 14:01:37 hifi sudo[1007]: 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.26/delat /mnt/NAS/delat Mar 03 14:01:37 hifi sudo[1007]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:37 hifi volumio[958]: info: Ignoring mount for partition: boot Mar 03 14:01:37 hifi volumio[958]: info: Ignoring mount for partition: volumio Mar 03 14:01:37 hifi volumio[958]: info: Ignoring mount for partition: volumio_data Mar 03 14:01:37 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 03 14:01:37 hifi volumio[958]: info: Loading plugin "volumio_command_line_client"... Mar 03 14:01:37 hifi volumio[958]: info: Loading plugin "upnp"... Mar 03 14:01:37 hifi volumio[958]: info: [1741006897402] Starting Upmpd Daemon Mar 03 14:01:37 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 03 14:01:37 hifi volumio[958]: info: Loading plugin "my_music"... Mar 03 14:01:37 hifi volumio[958]: info: Loading plugin "mpd"... Mar 03 14:01:37 hifi smbd[993]: [2025/03/03 14:01:37.472973, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 03 14:01:37 hifi systemd[1]: Started Samba SMB Daemon. Mar 03 14:01:37 hifi smbd[993]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Mar 03 14:01:37 hifi systemd[1]: Reached target Multi-User System. Mar 03 14:01:37 hifi systemd[1]: Reached target Graphical Interface. Mar 03 14:01:37 hifi systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 03 14:01:37 hifi systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 03 14:01:37 hifi kernel: Key type cifs.spnego registered Mar 03 14:01:37 hifi kernel: Key type cifs.idmap registered Mar 03 14:01:37 hifi 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. Mar 03 14:01:37 hifi kernel: CIFS: Attempting to mount \\192.168.1.26\delat Mar 03 14:01:37 hifi systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 03 14:01:37 hifi systemd[1]: Startup finished in 16.041s (kernel) + 30.449s (userspace) = 46.491s. Mar 03 14:01:37 hifi volumio-remote-updater[628]: [2025-03-03 14:01:37] [connect] Successful connection Mar 03 14:01:37 hifi volumio[958]: info: Loading plugin "upnp_browser"... Mar 03 14:01:38 hifi volumio[958]: info: Loading plugin "alarm-clock"... Mar 03 14:01:38 hifi volumio[958]: info: Loading plugin "airplay_emulation"... Mar 03 14:01:38 hifi volumio[958]: info: Starting Shairport Sync Mar 03 14:01:38 hifi volumio[958]: info: Loading plugin "last_100"... Mar 03 14:01:38 hifi volumio[958]: info: Loading plugin "webradio"... Mar 03 14:01:38 hifi kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Mar 03 14:01:38 hifi kernel: CIFS: VFS: \\192.168.1.26 Send error in SessSetup = -13 Mar 03 14:01:38 hifi kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Mar 03 14:01:38 hifi sudo[1007]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:38 hifi volumio[958]: info: Loading plugin "i2s_dacs"... Mar 03 14:01:38 hifi volumio[958]: info: Loading plugin "volumiodiscovery"... Mar 03 14:01:38 hifi volumio[958]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 03 14:01:38 hifi volumio[958]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 03 14:01:38 hifi volumio[958]: *** WARNING *** For more information see Mar 03 14:01:38 hifi node[958]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 03 14:01:38 hifi volumio[958]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 03 14:01:38 hifi volumio[958]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 03 14:01:38 hifi volumio[958]: *** WARNING *** For more information see Mar 03 14:01:38 hifi node[958]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 03 14:01:38 hifi node[958]: *** WARNING *** For more information see Mar 03 14:01:38 hifi node[958]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 03 14:01:38 hifi node[958]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 03 14:01:38 hifi node[958]: *** WARNING *** For more information see Mar 03 14:01:38 hifi volumio[958]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 03 14:01:38 hifi volumio[958]: info: Discovery: Started advertising with name: Hifi Mar 03 14:01:38 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 03 14:01:38 hifi volumio[958]: info: Loading plugin "spop"... Mar 03 14:01:39 hifi volumio[958]: info: Loading plugin "outputs"... Mar 03 14:01:39 hifi volumio[958]: info: Loading plugin "albumart"... Mar 03 14:01:39 hifi volumio[958]: info: Plugin example_plugin is not enabled Mar 03 14:01:39 hifi volumio[958]: info: Loading plugin "inputs"... Mar 03 14:01:39 hifi volumio[958]: info: Loading plugin "updater_comm"... Mar 03 14:01:39 hifi volumio[958]: info: Plugin mpdemulation is not enabled Mar 03 14:01:39 hifi volumio[958]: info: Loading plugin "rest_api"... Mar 03 14:01:39 hifi volumio[958]: info: Loading plugin "websocket"... Mar 03 14:01:39 hifi volumio[958]: info: Starting Socket.io Server version 2.3.0 Mar 03 14:01:39 hifi volumio[958]: info: Loading plugin "fusiondsp"... Mar 03 14:01:39 hifi volumio[958]: Forking 3 albumart workers Mar 03 14:01:40 hifi volumio[958]: info: Applying required configuration parameters for plugin fusiondsp Mar 03 14:01:40 hifi sudo[1000]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:40 hifi volumio[958]: info: Loading i18n strings for locale en Mar 03 14:01:40 hifi volumio[958]: Updating browse sources language Mar 03 14:01:40 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 03 14:01:40 hifi volumio[958]: Starting albumart workers Mar 03 14:01:40 hifi volumio[958]: Starting albumart workers Mar 03 14:01:40 hifi volumio[958]: Starting albumart workers Mar 03 14:01:40 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 14:01:40 hifi volumio[958]: info: CoreCommandRouter::initPlayerControls Mar 03 14:01:40 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:40 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:40 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:40 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:40 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:40 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:40 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:40 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:40 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 14:01:40 hifi volumio[958]: Express server listening on port 3000 Mar 03 14:01:40 hifi volumio[958]: [Metrics] WebUI: 6s 286.42ms Mar 03 14:01:40 hifi volumio[958]: info: CoreStateMachine::resetVolumioState Mar 03 14:01:40 hifi volumio[958]: info: CoreStateMachine::getcurrentVolume Mar 03 14:01:40 hifi volumio[958]: info: CoreCommandRouter::volumioRetrievevolume Mar 03 14:01:40 hifi volumio[958]: info: Cannot mount NAS delat at system boot, trial number 1 ,retrying in 5 seconds Mar 03 14:01:40 hifi volumio-remote-updater[628]: [2025-03-03 14:01:40] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1741006897 101 Mar 03 14:01:40 hifi volumio[958]: 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: 1 Mar 03 14:01:40 hifi volumio[958]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Mar 03 14:01:40 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: VolumeController:: Volume=undefined Mute =false Mar 03 14:01:41 hifi volumio[958]: info: CoreStateMachine::pushState Mar 03 14:01:41 hifi volumio[958]: info: CorePlayQueue::getTrack 0 Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::volumioPushState Mar 03 14:01:41 hifi volumio[958]: info: CoreStateMachine::updateTrackBlock Mar 03 14:01:41 hifi volumio[958]: info: CorePlayQueue::getTrackBlock Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::volumioRetrievevolume Mar 03 14:01:41 hifi volumio[958]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Mar 03 14:01:41 hifi volumio[958]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03115 Mar 03 14:01:41 hifi volumio[958]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Mar 03 14:01:41 hifi volumio[958]: info: CoreStateMachine::setRepeat null single undefined Mar 03 14:01:41 hifi volumio[958]: info: CoreStateMachine::pushState Mar 03 14:01:41 hifi volumio[958]: info: CorePlayQueue::getTrack 0 Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::volumioPushState Mar 03 14:01:41 hifi volumio[958]: info: CoreStateMachine::setRandom null Mar 03 14:01:41 hifi volumio[958]: info: CoreStateMachine::pushState Mar 03 14:01:41 hifi volumio[958]: info: CorePlayQueue::getTrack 0 Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::volumioPushState Mar 03 14:01:41 hifi volumio[958]: info: Setting Device type: Raspberry PI Mar 03 14:01:41 hifi volumio[958]: info: Completed loading Core Plugins Mar 03 14:01:41 hifi volumio[958]: info: Preparing to generate the ALSA configuration file Mar 03 14:01:41 hifi volumio[958]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 03 14:01:41 hifi volumio[958]: info: Reading ALSA contributions from plugins. Mar 03 14:01:41 hifi volumio[958]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Mar 03 14:01:41 hifi volumio[958]: info: Asound.conf file unchanged, so no further update is needed Mar 03 14:01:41 hifi volumio[958]: info: Output device has changed, restarting MPD Mar 03 14:01:41 hifi volumio[958]: info: Output device has changed, restarting Shairport Sync Mar 03 14:01:41 hifi sudo[1108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 14:01:41 hifi sudo[1108]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:41 hifi sudo[1108]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:41 hifi sudo[1110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 03 14:01:41 hifi sudo[1110]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:41 hifi volumio[958]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 03 14:01:41 hifi volumio[958]: info: ___________ START PLUGINS ___________ Mar 03 14:01:41 hifi volumio[958]: info: ControllerMpd::onStart: Initializing MPD Mar 03 14:01:41 hifi volumio[958]: info: Creating MPD Configuration file Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 03 14:01:41 hifi sudo[1118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 03 14:01:41 hifi sudo[1118]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 03 14:01:41 hifi volumio[958]: info: [1741006901205] CoreMusicLibrary::Adding element Media Servers Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 03 14:01:41 hifi sudo[1118]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:41 hifi systemd[1]: Listening on mpd.socket. Mar 03 14:01:41 hifi systemd[1]: Starting Music Player Daemon... Mar 03 14:01:41 hifi sudo[1120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 03 14:01:41 hifi sudo[1120]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 14:01:41 hifi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 03 14:01:41 hifi systemd[1]: mpd.service: Succeeded. Mar 03 14:01:41 hifi systemd[1]: Stopped Music Player Daemon. Mar 03 14:01:41 hifi systemd[1]: Starting Music Player Daemon... Mar 03 14:01:41 hifi volumio[958]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 03 14:01:41 hifi sudo[1127]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 03 14:01:41 hifi volumio[958]: info: [1741006901311] CoreMusicLibrary::Adding element Last_100 Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 03 14:01:41 hifi sudo[1127]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 03 14:01:41 hifi volumio[958]: info: [1741006901314] CoreMusicLibrary::Adding element Webradio Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 03 14:01:41 hifi sudo[1127]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 03 14:01:41 hifi sudo[1127]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:41 hifi volumio[958]: info: Initializing BBC Radios Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: Creating Spotify config file Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: Loading i18n strings for locale en Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: FusionDsp - mixtype--------------------- undefined Mar 03 14:01:41 hifi volumio[958]: info: Volumio Calling Home Mar 03 14:01:41 hifi volumio[958]: info: Preparing to generate the ALSA configuration file Mar 03 14:01:41 hifi volumio[958]: info: Discovery: adding 2e387222-6bec-4a45-b90b-0d7f896ec08c Mar 03 14:01:41 hifi volumio[958]: info: Discovery: Found device Hifi Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::volumioGetState Mar 03 14:01:41 hifi volumio[958]: info: CorePlayQueue::getTrack 0 Mar 03 14:01:41 hifi volumio[958]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 03 14:01:41 hifi volumio[958]: info: Reading ALSA contributions from plugins. Mar 03 14:01:41 hifi volumio[958]: info: MPD Permissions set Mar 03 14:01:41 hifi volumio[958]: info: MPD Permissions set Mar 03 14:01:41 hifi volumio[958]: info: VolumeController:: Volume=undefined Mute =false Mar 03 14:01:41 hifi volumio[958]: info: CoreStateMachine::pushState Mar 03 14:01:41 hifi volumio[958]: info: CorePlayQueue::getTrack 0 Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::volumioPushState Mar 03 14:01:41 hifi volumio[958]: info: Spotify config file written Mar 03 14:01:41 hifi sudo[1147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Mar 03 14:01:41 hifi sudo[1147]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:41 hifi volumio[958]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Mar 03 14:01:41 hifi volumio[958]: info: Volumio called home Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:41 hifi systemd[1]: Started go-librespot Daemon. Mar 03 14:01:41 hifi go-librespot[1157]: Librespot-go daemon starting... Mar 03 14:01:41 hifi sudo[1147]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:41 hifi volumio[958]: info: Starting Shairport Sync Mar 03 14:01:41 hifi volumio[958]: info: Starting Shairport Sync Mar 03 14:01:41 hifi volumio[958]: info: Starting Shairport Sync Mar 03 14:01:41 hifi sudo[1160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 03 14:01:41 hifi sudo[1160]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:41 hifi sudo[1162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 03 14:01:41 hifi sudo[1162]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:41 hifi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 03 14:01:41 hifi systemd[1]: shairport-sync.service: Succeeded. Mar 03 14:01:41 hifi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 03 14:01:41 hifi sudo[1166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 03 14:01:41 hifi sudo[1166]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::volumioGetState Mar 03 14:01:41 hifi volumio[958]: info: CorePlayQueue::getTrack 0 Mar 03 14:01:41 hifi volumio[958]: error: error Mar 03 14:01:41 hifi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 03 14:01:41 hifi volumio[958]: info: Asound.conf file unchanged, so no further update is needed Mar 03 14:01:41 hifi volumio[958]: info: Output device has changed, restarting MPD Mar 03 14:01:41 hifi sudo[1160]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:41 hifi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 03 14:01:41 hifi systemd[1]: shairport-sync.service: Succeeded. Mar 03 14:01:41 hifi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 03 14:01:41 hifi volumio[958]: info: Output device has changed, restarting Shairport Sync Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:41 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 14:01:41 hifi sudo[1175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 03 14:01:41 hifi sudo[1175]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:41 hifi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 03 14:01:41 hifi sudo[1175]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:41 hifi sudo[1166]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:41 hifi sudo[1162]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:41 hifi sudo[1182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 03 14:01:41 hifi sudo[1182]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:42 hifi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Mar 03 14:01:42 hifi systemd[1]: mpd.service: Succeeded. Mar 03 14:01:42 hifi systemd[1]: Stopped Music Player Daemon. Mar 03 14:01:42 hifi systemd[1]: Starting Music Player Daemon... Mar 03 14:01:42 hifi volumio[958]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 03 14:01:42 hifi volumio[958]: info: An error occurred while refreshing Spotify Token Error: Bad Request Mar 03 14:01:42 hifi volumio[958]: info: MPD Permissions set Mar 03 14:01:42 hifi volumio[958]: info: Shairport-Sync Started Mar 03 14:01:42 hifi volumio[958]: Error adding Membership: Error: addMembership EINVAL Mar 03 14:01:42 hifi volumio[958]: info: Shairport-Sync Started Mar 03 14:01:42 hifi volumio[958]: info: Shairport-Sync Started Mar 03 14:01:42 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:42 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:42 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:42 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:42 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:42 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:42 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:42 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:42 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 03 14:01:42 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:42 hifi sudo[1189]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 03 14:01:42 hifi sudo[1189]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:42 hifi volumio[958]: info: Starting Shairport Sync Mar 03 14:01:42 hifi sudo[1189]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Mar 03 14:01:42 hifi sudo[1189]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:42 hifi sudo[1197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 03 14:01:42 hifi sudo[1197]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:42 hifi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 03 14:01:42 hifi systemd[1]: shairport-sync.service: Succeeded. Mar 03 14:01:42 hifi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 03 14:01:42 hifi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 03 14:01:42 hifi sudo[1197]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:42 hifi go-librespot[1157]: time="2025-03-03T14:01:42+01:00" level=info msg="generated new device id: 55e5beb73f170ccd2e0133f146288cf1ccd79b51" Mar 03 14:01:42 hifi volumio[958]: info: Shairport-Sync Started Mar 03 14:01:42 hifi go-librespot[1157]: time="2025-03-03T14:01:42+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Mar 03 14:01:42 hifi go-librespot[1157]: time="2025-03-03T14:01:42+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Mar 03 14:01:42 hifi go-librespot[1157]: time="2025-03-03T14:01:42+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Mar 03 14:01:42 hifi go-librespot[1157]: time="2025-03-03T14:01:42+01:00" level=debug msg="zeroconf server listening on port 37761" Mar 03 14:01:43 hifi systemd[1]: systemd-fsckd.service: Succeeded. Mar 03 14:01:43 hifi volumio[958]: info: camilladsp spawned new process with pid 1209, instance 1, run: true Mar 03 14:01:43 hifi volumio[958]: info: camilladsp service started and running in background, instance 1 Mar 03 14:01:43 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 03 14:01:43 hifi volumio[958]: info: FusionDsp - AAAAAAAAAAAAAA-> 44100 48000 88200 96000 176400 192000 <-AAAAAAAAAAAAA Mar 03 14:01:43 hifi volumio[958]: info: FusionDsp loaded Mar 03 14:01:43 hifi volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 03 14:01:43 hifi volumio[958]: info: FusionDsp - Reporting Fusion DSP Enabled Mar 03 14:01:43 hifi volumio[958]: info: Adding Signal Path Element [object Object] Mar 03 14:01:43 hifi volumio[958]: info: Adding fusiondspeq DSP Signal Path Element Mar 03 14:01:43 hifi sudo[1213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Mar 03 14:01:43 hifi volumio[958]: info: FusionDsp - ---- installed callbackRead Mar 03 14:01:43 hifi sudo[1213]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:43 hifi volumio[958]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 03 14:01:43 hifi volumio[958]: error: FusionDsp - WebSocket error: [object Object] Mar 03 14:01:43 hifi volumio[958]: 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 03 14:01:43 hifi systemd[1]: Started FusionDsp Daemon. Mar 03 14:01:43 hifi sudo[1213]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:43 hifi mpd[1196]: Mar 03 14:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 03 14:01:43 hifi systemd[1]: Started Music Player Daemon. Mar 03 14:01:43 hifi sudo[1120]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:43 hifi sudo[1110]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:43 hifi sudo[1182]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:43 hifi volumio[958]: info: Completed starting Core Plugins Mar 03 14:01:43 hifi volumio[958]: info: ------------------------------------------- Mar 03 14:01:43 hifi volumio[958]: info: ----- MyVolumio plugins startup ---- Mar 03 14:01:43 hifi volumio[958]: info: ------------------------------------------- Mar 03 14:01:43 hifi volumio[958]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 03 14:01:43 hifi volumio[958]: info: MPD running with PID1196 Mar 03 14:01:43 hifi volumio[958]: ,establishing connection Mar 03 14:01:44 hifi volumio[958]: error: MPD error: The expression evaluated to a falsy value: Mar 03 14:01:44 hifi volumio[958]: assert.ok(self.idling) Mar 03 14:01:44 hifi volumio[958]: error: The expression evaluated to a falsy value: Mar 03 14:01:44 hifi volumio[958]: assert.ok(self.idling) Mar 03 14:01:44 hifi volumio[958]: error: MPD error: The expression evaluated to a falsy value: Mar 03 14:01:44 hifi volumio[958]: assert.ok(self.idling) Mar 03 14:01:44 hifi volumio[958]: error: The expression evaluated to a falsy value: Mar 03 14:01:44 hifi volumio[958]: assert.ok(self.idling) Mar 03 14:01:44 hifi volumio[958]: error: MPD error: The expression evaluated to a falsy value: Mar 03 14:01:44 hifi volumio[958]: assert.ok(self.idling) Mar 03 14:01:44 hifi volumio[958]: error: The expression evaluated to a falsy value: Mar 03 14:01:44 hifi volumio[958]: assert.ok(self.idling) Mar 03 14:01:44 hifi volumio[958]: error: updateQueue error: null Mar 03 14:01:44 hifi sh[523]: timed out Mar 03 14:01:44 hifi dhcpcd[571]: timed out Mar 03 14:01:44 hifi sh[523]: dhcpcd exited Mar 03 14:01:44 hifi dhcpcd[571]: dhcpcd exited Mar 03 14:01:44 hifi sh[523]: ifup: failed to bring up eth0 Mar 03 14:01:44 hifi systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Mar 03 14:01:44 hifi systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Mar 03 14:01:44 hifi volumio[958]: info: go-librespot daemon successfully initialized Mar 03 14:01:45 hifi sudo[1228]: 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.26/delat /mnt/NAS/delat Mar 03 14:01:45 hifi sudo[1228]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:45 hifi kernel: CIFS: Attempting to mount \\192.168.1.26\delat Mar 03 14:01:45 hifi sudo[1228]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:45 hifi volumio[958]: info: Cannot mount NAS delat at system boot, trial number 2 ,retrying in 5 seconds Mar 03 14:01:45 hifi kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Mar 03 14:01:45 hifi kernel: CIFS: VFS: \\192.168.1.26 Send error in SessSetup = -13 Mar 03 14:01:45 hifi kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Mar 03 14:01:46 hifi systemd[1]: systemd-hostnamed.service: Succeeded. Mar 03 14:01:46 hifi go-librespot[1157]: time="2025-03-03T14:01:46+01:00" level=debug msg="obtained new client token: AADBJEU4z+8An5/9AXTEgoOprZ1IYRtkLie3MlxHIdo+56Ipi55uqar8t6Urw3+h3aMkH7HJGFi6nfd0PCgJLkDw5MOYJVE9BV1XxxB2QrJFJJ6HuGp6+9L8Z2MOon+csbLKsNWJYY4RSmG0CMXqO2vXnYCsTYCaNCqpbO5zyaKyZC123x/eOfX8YVu/u3SZVQ40NhNrrTGIvxrGW8y7vXUb1KGIuJMlK1cmil0JEU2CQ4E5rILDiukNOvM=" Mar 03 14:01:46 hifi go-librespot[1157]: time="2025-03-03T14:01:46+01:00" level=debug msg="completed keyexchange" Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="completed challenge" Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="authenticated as kon87" Mar 03 14:01:47 hifi sudo[1236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 03 14:01:47 hifi sudo[1236]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:47 hifi sudo[1236]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:47 hifi sudo[1238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 03 14:01:47 hifi sudo[1238]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:47 hifi sudo[1238]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:47 hifi sudo[1242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 03 14:01:47 hifi sudo[1242]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="authenticated as kon87" Mar 03 14:01:47 hifi systemd[1]: Started UPnP Renderer front-end to MPD. Mar 03 14:01:47 hifi sudo[1242]: pam_unix(sudo:session): session closed for user root Mar 03 14:01:47 hifi volumio[958]: info: Upmpdcli Daemon Started Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="dealer connection opened" Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=info msg="accepted zeroconf user kon87 from MacBook Pro som tillhör Alfred" Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="autoplay enabled: false" Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="received connection id: NWM5OTExOTYtMjBkNS00NzVhLWFkYTctOWM4MDU1YWViYWU0K2RlYWxlcit0Y3A6Ly8wYWNhNTk3Zi5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArMjlGMDA3NDgwOERDOEZBN0Y5NEMwMTA1NEZFNkNEQzIzQkNBMzUxM0E3Qjg5OTkyMTc5NjJBMzFCRjI2MkREQg==" Mar 03 14:01:47 hifi volumio[1244]: Generating RSA private key, 4096 bit long modulus (2 primes) Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="put connect state because NEW_DEVICE" Mar 03 14:01:47 hifi volumio[958]: info: Initializing connection to go-librespot Websocket Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="new websocket client" Mar 03 14:01:47 hifi volumio[958]: info: Connection to go-librespot Websocket established Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="handling transfer player command from 9c289a7863899c9c010cefd9dfc3cfe5a967ddf3" Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="resolved context of track" uri="spotify:album:68dXoZCxqqp7W1wLphO7Cq" Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=trace msg="fetched new page 0 with 8 items (list: 8)" uri="spotify:album:68dXoZCxqqp7W1wLphO7Cq" Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="loading track (paused: false, position: -1362810042ms)" uri="spotify:track:4rmaBAW0kBuJcpCgMAobFI" Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=trace msg="emitting websocket event: will_play" Mar 03 14:01:47 hifi volumio[958]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:4rmaBAW0kBuJcpCgMAobFI","play_origin":"album"}} Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="selected format OGG_VORBIS_320 (09e1db0f4d2fe6aa6a2ffc0e1b4228ff5e0c6f3e)" uri="spotify:track:4rmaBAW0kBuJcpCgMAobFI" Mar 03 14:01:47 hifi go-librespot[1157]: time="2025-03-03T14:01:47+01:00" level=debug msg="requested aes key for file 09e1db0f4d2fe6aa6a2ffc0e1b4228ff5e0c6f3e, gid: 4rmaBAW0kBuJcpCgMAobFI" Mar 03 14:01:48 hifi volumio[1244]: .............++++ Mar 03 14:01:48 hifi volumio[958]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=debug msg="fetched first chunk of 38, total size is 19814660 bytes" uri="spotify:track:4rmaBAW0kBuJcpCgMAobFI" Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:4rmaBAW0kBuJcpCgMAobFI" Mar 03 14:01:49 hifi volumio[958]: info: FusionDsp - ---- read samplerate, raw: Mar 03 14:01:49 hifi volumio[958]: error: FusionDsp - invalid sample rate Mar 03 14:01:49 hifi volumio[958]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 03 14:01:49 hifi volumio[958]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 03 14:01:49 hifi volumio[958]: info: camilladsp stopping service pid 1209... Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=debug msg="created new output device" Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=info msg="loaded track \"Under Your Wings I'll Hide\" (paused: false, position: -1362810042ms, duration: 533906ms, prefetched: false)" uri="spotify:track:4rmaBAW0kBuJcpCgMAobFI" Mar 03 14:01:49 hifi volumio[958]: info: camilladsp service terminated, instance 1 Mar 03 14:01:49 hifi volumio[958]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=debug msg="fetched chunk 1/37, size: 524288" uri="spotify:track:4rmaBAW0kBuJcpCgMAobFI" Mar 03 14:01:49 hifi volumio[958]: info: camilladsp service started and running in background, instance 1 Mar 03 14:01:49 hifi volumio[958]: info: camilladsp spawned new process with pid 1265, instance 1, run: true Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=debug msg="fetched chunk 2/37, size: 524288" uri="spotify:track:4rmaBAW0kBuJcpCgMAobFI" Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=trace msg="scheduling prefetch in 503s" Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=trace msg="emitting websocket event: metadata" Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=trace msg="emitting websocket event: active" Mar 03 14:01:49 hifi volumio[958]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:4rmaBAW0kBuJcpCgMAobFI","name":"Under Your Wings I'll Hide","artist_names":["Immanu El"],"album_name":"They'll Come, They Come","album_cover_url":"https://i.scdn.co/image/ab67616d00001e025abb17b2b6a6da35693a9359","position":-1362810042,"duration":533906,"release_date":"year:2013 month:3 day:24","track_number":1,"disc_number":1}} Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=debug msg="sending successful reply for dealer request" Mar 03 14:01:49 hifi volumio[958]: SPOTIFY: received: {"type":"active","data":null} Mar 03 14:01:49 hifi volumio[958]: info: Aligning Spotify Volume to Volumio Volume Mar 03 14:01:49 hifi volumio[958]: info: CoreCommandRouter::volumioGetState Mar 03 14:01:49 hifi volumio[958]: info: CorePlayQueue::getTrack 0 Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=debug msg="fetched chunk 3/37, size: 524288" uri="spotify:track:4rmaBAW0kBuJcpCgMAobFI" Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=trace msg="emitting websocket event: playing" Mar 03 14:01:49 hifi volumio[958]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:4rmaBAW0kBuJcpCgMAobFI","play_origin":"album"}} Mar 03 14:01:49 hifi volumio[958]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 03 14:01:49 hifi volumio[958]: TypeError: Cannot read property 'service' of undefined Mar 03 14:01:49 hifi volumio[958]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:336:50) Mar 03 14:01:49 hifi volumio[958]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:262:18) Mar 03 14:01:49 hifi volumio[958]: at WebSocket.message (/data/plugins/music_service/spop/index.js:189:14) Mar 03 14:01:49 hifi volumio[958]: at WebSocket.emit (events.js:315:20) Mar 03 14:01:49 hifi volumio[958]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1220:20) Mar 03 14:01:49 hifi volumio[958]: at Receiver.emit (events.js:315:20) Mar 03 14:01:49 hifi volumio[958]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:596:14) Mar 03 14:01:49 hifi volumio[958]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:496:10) Mar 03 14:01:49 hifi volumio[958]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:16) Mar 03 14:01:49 hifi volumio[958]: at Receiver._write (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:94:10) Mar 03 14:01:49 hifi volumio[958]: at writeOrBuffer (internal/streams/writable.js:358:12) Mar 03 14:01:49 hifi volumio[958]: at Receiver.Writable.write (internal/streams/writable.js:303:10) Mar 03 14:01:49 hifi volumio[958]: at Socket.socketOnData (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1355:35) Mar 03 14:01:49 hifi volumio[958]: at Socket.emit (events.js:315:20) Mar 03 14:01:49 hifi volumio[958]: at addChunk (internal/streams/readable.js:309:12) Mar 03 14:01:49 hifi volumio[958]: at readableAddChunk (internal/streams/readable.js:284:9) Mar 03 14:01:49 hifi volumio[958]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 345" Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 3159" Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Mar 03 14:01:49 hifi sudo[1281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-03 14:00 Mar 03 14:01:49 hifi sudo[1281]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 2022" Mar 03 14:01:49 hifi go-librespot[1157]: time="2025-03-03T14:01:49+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"