-- Logs begin at Thu 2019-02-14 18:12:04 CST, end at Mon 2025-01-20 22:03:18 CST. -- Jan 20 22:02:07 volumio kernel: hub 1-0:1.0: USB hub found Jan 20 22:02:07 volumio kernel: hub 1-0:1.0: 1 port detected Jan 20 22:02:07 volumio kernel: xhci-hcd xhci-hcd.0.auto: xHCI Host Controller Jan 20 22:02:07 volumio kernel: xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 2 Jan 20 22:02:07 volumio kernel: xhci-hcd xhci-hcd.0.auto: hcc params 0x0220fe64 hci version 0x110 quirks 0x0000000002010010 Jan 20 22:02:07 volumio kernel: xhci-hcd xhci-hcd.0.auto: irq 31, io mem 0xff600000 Jan 20 22:02:07 volumio kernel: ehci-platform ff5c0000.usb: EHCI Host Controller Jan 20 22:02:07 volumio kernel: ohci-platform ff5d0000.usb: Generic Platform OHCI controller Jan 20 22:02:07 volumio kernel: ehci-platform ff5c0000.usb: new USB bus registered, assigned bus number 3 Jan 20 22:02:07 volumio kernel: ohci-platform ff5d0000.usb: new USB bus registered, assigned bus number 4 Jan 20 22:02:07 volumio kernel: xhci-hcd xhci-hcd.0.auto: xHCI Host Controller Jan 20 22:02:07 volumio kernel: xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 5 Jan 20 22:02:07 volumio kernel: xhci-hcd xhci-hcd.0.auto: Host supports USB 3.0 SuperSpeed Jan 20 22:02:07 volumio kernel: ohci-platform ff5d0000.usb: irq 34, io mem 0xff5d0000 Jan 20 22:02:07 volumio kernel: ehci-platform ff5c0000.usb: irq 33, io mem 0xff5c0000 Jan 20 22:02:07 volumio kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01 Jan 20 22:02:07 volumio kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 20 22:02:07 volumio kernel: usb usb2: Product: xHCI Host Controller Jan 20 22:02:07 volumio kernel: usb usb2: Manufacturer: Linux 6.1.49-rockchip64 xhci-hcd Jan 20 22:02:07 volumio kernel: usb usb2: SerialNumber: xhci-hcd.0.auto Jan 20 22:02:07 volumio kernel: hub 2-0:1.0: USB hub found Jan 20 22:02:07 volumio kernel: hub 2-0:1.0: 1 port detected Jan 20 22:02:07 volumio kernel: usb usb5: We don't know the algorithms for LPM for this host, disabling LPM. Jan 20 22:02:07 volumio kernel: usb usb5: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.01 Jan 20 22:02:07 volumio kernel: usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 20 22:02:07 volumio kernel: usb usb5: Product: xHCI Host Controller Jan 20 22:02:07 volumio kernel: usb usb5: Manufacturer: Linux 6.1.49-rockchip64 xhci-hcd Jan 20 22:02:07 volumio kernel: usb usb5: SerialNumber: xhci-hcd.0.auto Jan 20 22:02:07 volumio kernel: hub 5-0:1.0: USB hub found Jan 20 22:02:07 volumio kernel: hub 5-0:1.0: 1 port detected Jan 20 22:02:07 volumio kernel: usbcore: registered new interface driver usb-storage Jan 20 22:02:07 volumio kernel: mousedev: PS/2 mouse device common for all mice Jan 20 22:02:07 volumio kernel: i2c_dev: i2c /dev entries driver Jan 20 22:02:07 volumio kernel: ehci-platform ff5c0000.usb: USB 2.0 started, EHCI 1.00 Jan 20 22:02:07 volumio kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01 Jan 20 22:02:07 volumio kernel: rk808 1-0018: chip id: 0x8050 Jan 20 22:02:07 volumio kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 20 22:02:07 volumio kernel: usb usb3: Product: EHCI Host Controller Jan 20 22:02:07 volumio kernel: usb usb3: Manufacturer: Linux 6.1.49-rockchip64 ehci_hcd Jan 20 22:02:07 volumio kernel: usb usb3: SerialNumber: ff5c0000.usb Jan 20 22:02:07 volumio kernel: hub 3-0:1.0: USB hub found Jan 20 22:02:07 volumio kernel: hub 3-0:1.0: 1 port detected Jan 20 22:02:07 volumio kernel: rk808-regulator rk808-regulator: there is no dvs0 gpio Jan 20 22:02:07 volumio kernel: rk808-regulator rk808-regulator: there is no dvs1 gpio Jan 20 22:02:07 volumio kernel: rk808-regulator rk808-regulator: max buck steps per change: 8 Jan 20 22:02:07 volumio kernel: rk808-rtc rk808-rtc: registered as rtc0 Jan 20 22:02:07 volumio kernel: rk808-rtc rk808-rtc: setting system clock to 2016-01-21T08:50:09 UTC (1453366209) Jan 20 22:02:07 volumio kernel: input: rk805 pwrkey as /devices/platform/ff160000.i2c/i2c-1/1-0018/rk805-pwrkey/input/input0 Jan 20 22:02:07 volumio kernel: usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.01 Jan 20 22:02:07 volumio kernel: usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 20 22:02:07 volumio kernel: usb usb4: Product: Generic Platform OHCI controller Jan 20 22:02:07 volumio kernel: usb usb4: Manufacturer: Linux 6.1.49-rockchip64 ohci_hcd Jan 20 22:02:07 volumio kernel: usb usb4: SerialNumber: ff5d0000.usb Jan 20 22:02:07 volumio kernel: rockchip-thermal ff250000.tsadc: Missing tshut mode property, using default (cru) Jan 20 22:02:07 volumio kernel: rockchip-thermal ff250000.tsadc: Missing tshut-polarity property, using default (low) Jan 20 22:02:07 volumio kernel: hub 4-0:1.0: USB hub found Jan 20 22:02:07 volumio kernel: hub 4-0:1.0: 1 port detected Jan 20 22:02:07 volumio kernel: dw_wdt ff1a0000.watchdog: No valid TOPs array specified Jan 20 22:02:07 volumio kernel: sdhci: Secure Digital Host Controller Interface driver Jan 20 22:02:07 volumio kernel: sdhci: Copyright(c) Pierre Ossman Jan 20 22:02:07 volumio kernel: Synopsys Designware Multimedia Card Interface Driver Jan 20 22:02:07 volumio kernel: sdhci-pltfm: SDHCI platform and OF driver helper Jan 20 22:02:07 volumio kernel: ledtrig-cpu: registered to indicate activity on CPUs Jan 20 22:02:07 volumio kernel: hid: raw HID events driver (C) Jiri Kosina Jan 20 22:02:07 volumio kernel: usbcore: registered new interface driver usbhid Jan 20 22:02:07 volumio kernel: usbhid: USB HID core driver Jan 20 22:02:07 volumio kernel: drop_monitor: Initializing network drop monitor service Jan 20 22:02:07 volumio kernel: NET: Registered PF_INET6 protocol family Jan 20 22:02:07 volumio kernel: Segment Routing with IPv6 Jan 20 22:02:07 volumio kernel: In-situ OAM (IOAM) with IPv6 Jan 20 22:02:07 volumio kernel: NET: Registered PF_PACKET protocol family Jan 20 22:02:07 volumio kernel: 8021q: 802.1Q VLAN Support v1.8 Jan 20 22:02:07 volumio kernel: Key type dns_resolver registered Jan 20 22:02:07 volumio kernel: registered taskstats version 1 Jan 20 22:02:07 volumio kernel: Loading compiled-in X.509 certificates Jan 20 22:02:07 volumio kernel: zswap: loaded using pool zstd/z3fold Jan 20 22:02:07 volumio kernel: Key type .fscrypt registered Jan 20 22:02:07 volumio kernel: Key type fscrypt-provisioning registered Jan 20 22:02:07 volumio kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=yes, fsverity=yes Jan 20 22:02:07 volumio kernel: Key type encrypted registered Jan 20 22:02:07 volumio kernel: AppArmor: AppArmor sha1 policy hashing enabled Jan 20 22:02:07 volumio kernel: friendlyelec-board board: Serial : 87cc8bfb1632b635 Jan 20 22:02:07 volumio kernel: rk3328-dmc ff780000.dmc: current ATF version 0x101 Jan 20 22:02:07 volumio kernel: dwmmc_rockchip ff500000.mmc: IDMAC supports 32-bit address mode. Jan 20 22:02:07 volumio kernel: dwmmc_rockchip ff500000.mmc: Using internal DMA controller. Jan 20 22:02:07 volumio kernel: dwmmc_rockchip ff500000.mmc: Version ID is 270a Jan 20 22:02:07 volumio kernel: dwmmc_rockchip ff500000.mmc: DW MMC controller at irq 48,32 bit host data width,256 deep fifo Jan 20 22:02:07 volumio kernel: WCN: marlin_init entry! Jan 20 22:02:07 volumio kernel: input: gpio-keys-user as /devices/platform/gpio-keys-user/input/input1 Jan 20 22:02:07 volumio kernel: input: gpio-keys as /devices/platform/gpio-keys/input/input2 Jan 20 22:02:07 volumio kernel: of_cfs_init Jan 20 22:02:07 volumio kernel: of_cfs_init: OK Jan 20 22:02:07 volumio kernel: dw-apb-uart ff130000.serial: forbid DMA for kernel console Jan 20 22:02:07 volumio kernel: mmc_host mmc0: Bus speed (slot 0) = 400000Hz (slot req 400000Hz, actual 400000HZ div = 0) Jan 20 22:02:07 volumio kernel: Freeing unused kernel memory: 3968K Jan 20 22:02:07 volumio kernel: Run /init as init process Jan 20 22:02:07 volumio kernel: with arguments: Jan 20 22:02:07 volumio kernel: /init Jan 20 22:02:07 volumio kernel: with environment: Jan 20 22:02:07 volumio kernel: HOME=/ Jan 20 22:02:07 volumio kernel: TERM=linux Jan 20 22:02:07 volumio kernel: splash=verbose Jan 20 22:02:07 volumio kernel: ubootpart=161eb627-01 Jan 20 22:02:07 volumio kernel: imgpart=/dev/mmcblk0p2 Jan 20 22:02:07 volumio kernel: imgfile=/volumio_current.sqsh Jan 20 22:02:07 volumio kernel: cgroup_enable=memory Jan 20 22:02:07 volumio kernel: cgroup_memory=1 Jan 20 22:02:07 volumio kernel: mmc_host mmc0: Bus speed (slot 0) = 150000000Hz (slot req 150000000Hz, actual 150000000HZ div = 0) Jan 20 22:02:07 volumio kernel: dwmmc_rockchip ff500000.mmc: Successfully tuned phase to 10 Jan 20 22:02:07 volumio kernel: mmc0: new ultra high speed SDR104 SDHC card at address aaaa Jan 20 22:02:07 volumio kernel: mmcblk0: mmc0:aaaa SL16G 14.8 GiB Jan 20 22:02:07 volumio kernel: mmcblk0: p1 p2 p3 Jan 20 22:02:07 volumio kernel: gpio-syscon ff100000.syscon:gpio: can't read the data register offset! Jan 20 22:02:07 volumio kernel: lima ff300000.gpu: gp - mali450 version major 0 minor 0 Jan 20 22:02:07 volumio kernel: lima ff300000.gpu: pp0 - mali450 version major 0 minor 0 Jan 20 22:02:07 volumio kernel: lima ff300000.gpu: pp1 - mali450 version major 0 minor 0 Jan 20 22:02:07 volumio kernel: lima ff300000.gpu: l2 cache 8K, 4-way, 64byte cache line, 128bit external bus Jan 20 22:02:07 volumio kernel: lima ff300000.gpu: l2 cache 64K, 4-way, 64byte cache line, 128bit external bus Jan 20 22:02:07 volumio kernel: lima ff300000.gpu: bus rate = 491520000 Jan 20 22:02:07 volumio kernel: lima ff300000.gpu: mod rate = 491520000 Jan 20 22:02:07 volumio kernel: lima ff300000.gpu: error -ENODEV: _opp_set_regulators: no regulator (mali) found Jan 20 22:02:07 volumio kernel: [drm] Initialized lima 1.1.0 20191231 for ff300000.gpu on minor 0 Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: IRQ eth_wake_irq not found Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: IRQ eth_lpi not found Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: PTP uses main clock Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: clock input or output? (input). Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: TX delay(0x24). Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: RX delay(0x18). Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: integrated PHY? (no). Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: clock input from PHY Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: init for RGMII Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: User ID: 0x10, Synopsys ID: 0x35 Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: DWMAC1000 Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: DMA HW capability register supported Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: RX Checksum Offload Engine supported Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: COE Type 2 Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: TX Checksum insertion supported Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: Wake-Up On Lan supported Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: Normal descriptors Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: Ring mode enabled Jan 20 22:02:07 volumio kernel: rk_gmac-dwmac ff540000.ethernet: Enable RX Mitigation via HW Watchdog Timer Jan 20 22:02:07 volumio kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Jan 20 22:02:07 volumio kernel: EXT4-fs (mmcblk0p2): recovery complete Jan 20 22:02:07 volumio kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none. Jan 20 22:02:07 volumio kernel: loop0: detected capacity change from 0 to 848456 Jan 20 22:02:07 volumio kernel: EXT4-fs (mmcblk0p3): recovery complete Jan 20 22:02:07 volumio kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Quota mode: none. Jan 20 22:02:07 volumio kernel: ext4 filesystem being mounted at /mnt/ext supports timestamps until 2038 (0x7fffffff) Jan 20 22:02:07 volumio kernel: overlayfs: null uuid detected in lower fs '/', falling back to xino=off,index=off,nfs_export=off. Jan 20 22:02:07 volumio systemd[1]: System time before build time, advancing clock. Jan 20 22:02:07 volumio systemd[1]: Inserted module 'autofs4' Jan 20 22:02:07 volumio 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) Jan 20 22:02:07 volumio systemd[1]: Detected architecture arm64. Jan 20 22:02:07 volumio systemd[1]: Set hostname to . Jan 20 22:02:07 volumio 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. Jan 20 22:02:07 volumio kernel: random: crng init done Jan 20 22:02:07 volumio systemd[1]: Started Forward Password Requests to Wall Directory Watch. Jan 20 22:02:07 volumio systemd[1]: Created slice system-serial\x2dgetty.slice. Jan 20 22:02:07 volumio systemd[1]: Listening on Journal Socket (/dev/log). Jan 20 22:02:07 volumio systemd[1]: Listening on Journal Audit Socket. Jan 20 22:02:07 volumio systemd[1]: Listening on udev Control Socket. Jan 20 22:02:07 volumio systemd[1]: Created slice system-getty.slice. Jan 20 22:02:07 volumio systemd[1]: Reached target System Time Synchronized. Jan 20 22:02:07 volumio systemd[1]: Listening on RPCbind Server Activation Socket. Jan 20 22:02:07 volumio systemd[1]: Listening on Journal Socket. Jan 20 22:02:07 volumio systemd[1]: Starting Load Kernel Modules... Jan 20 22:02:07 volumio kernel: RPC: Registered named UNIX socket transport module. Jan 20 22:02:07 volumio kernel: RPC: Registered udp transport module. Jan 20 22:02:07 volumio kernel: RPC: Registered tcp transport module. Jan 20 22:02:07 volumio kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Jan 20 22:02:07 volumio kernel: Removed cp15_barrier emulation handler Jan 20 22:02:07 volumio kernel: Enabled cp15_barrier support Jan 20 22:02:07 volumio systemd-journald[434]: Journal started Jan 20 22:02:07 volumio systemd-journald[434]: Runtime journal (/run/log/journal/26ad612599a153fe566747766533ce8a) is 7.5M, max 30.0M, 22.5M free. Jan 20 22:02:07 volumio fake-hwclock[436]: Mon Jan 20 14:02:07 UTC 2025 Jan 20 22:02:07 volumio systemd[1]: Started Create Static Device Nodes in /dev. Jan 20 22:02:07 volumio systemd[1]: Reached target Local File Systems (Pre). Jan 20 22:02:07 volumio systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Jan 20 22:02:07 volumio systemd[1]: Mounting /tmp... Jan 20 22:02:07 volumio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Jan 20 22:02:07 volumio systemd[1]: Mounting /var/log... Jan 20 22:02:07 volumio systemd[1]: Mounting /var/spool/cups... Jan 20 22:02:07 volumio systemd[1]: Starting udev Kernel Device Manager... Jan 20 22:02:07 volumio systemd[1]: Mounted /tmp. Jan 20 22:02:07 volumio systemd[1]: Mounted /var/log. Jan 20 22:02:07 volumio systemd[1]: Mounted /var/spool/cups. Jan 20 22:02:07 volumio systemd[1]: Mounting /var/spool/cups/tmp... Jan 20 22:02:07 volumio systemd[1]: Starting Flush Journal to Persistent Storage... Jan 20 22:02:07 volumio systemd[1]: Mounted /var/spool/cups/tmp. Jan 20 22:02:07 volumio systemd-udevd[469]: Network interface NamePolicy= disabled on kernel command line, ignoring. Jan 20 22:02:07 volumio systemd[1]: Started udev Coldplug all Devices. Jan 20 22:02:07 volumio systemd[1]: Starting Helper to synchronize boot up for ifupdown... Jan 20 22:02:07 volumio systemd[1]: Started udev Kernel Device Manager. Jan 20 22:02:07 volumio systemd-journald[434]: Runtime journal (/run/log/journal/26ad612599a153fe566747766533ce8a) is 7.5M, max 30.0M, 22.5M free. Jan 20 22:02:07 volumio systemd[1]: Starting Show Plymouth Boot Screen... Jan 20 22:02:07 volumio systemd[1]: Started Flush Journal to Persistent Storage. Jan 20 22:02:07 volumio systemd[1]: Started Helper to synchronize boot up for ifupdown. Jan 20 22:02:07 volumio systemd[1]: plymouth-start.service: Succeeded. Jan 20 22:02:07 volumio systemd[1]: Started Show Plymouth Boot Screen. Jan 20 22:02:07 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jan 20 22:02:07 volumio systemd[1]: Reached target Paths. Jan 20 22:02:07 volumio systemd[1]: Reached target Local Encrypted Volumes. Jan 20 22:02:07 volumio systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Jan 20 22:02:08 volumio systemd[1]: Found device /dev/ttyS2. Jan 20 22:02:08 volumio systemd-udevd[481]: Using default interface naming scheme 'v240'. Jan 20 22:02:08 volumio kernel: mc: Linux media interface: v0.10 Jan 20 22:02:08 volumio systemd-udevd[481]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jan 20 22:02:08 volumio systemd-udevd[481]: link_config: could not get ethtool features for eth0 Jan 20 22:02:08 volumio systemd-udevd[481]: Could not set offload features of eth0: Device or resource busy Jan 20 22:02:08 volumio kernel: videodev: Linux video capture interface: v2.00 Jan 20 22:02:08 volumio kernel: rockchip_vdec: module is from the staging directory, the quality is unknown, you have been warned. Jan 20 22:02:08 volumio kernel: rkvdec ff360000.video-codec: Adding to iommu group 1 Jan 20 22:02:08 volumio systemd-udevd[476]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 22:02:08 volumio kernel: rockchip-rga ff390000.rga: HW Version: 0x04.00 Jan 20 22:02:08 volumio kernel: hantro-vpu ff350000.video-codec: Adding to iommu group 0 Jan 20 22:02:08 volumio kernel: rockchip-rga ff390000.rga: Registered rockchip-rga as /dev/video1 Jan 20 22:02:08 volumio kernel: hantro-vpu ff350000.video-codec: registered rockchip,rk3328-vpu-dec as /dev/video2 Jan 20 22:02:08 volumio systemd-udevd[480]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 22:02:08 volumio systemd-udevd[487]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 20 22:02:08 volumio systemd[1]: Found device /dev/mmcblk0p1. Jan 20 22:02:08 volumio systemd-udevd[479]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jan 20 22:02:09 volumio systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Jan 20 22:02:09 volumio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Jan 20 22:02:09 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Jan 20 22:02:09 volumio systemd[1]: Starting Show Plymouth Boot Screen... Jan 20 22:02:09 volumio systemd[1]: Starting File System Check on /dev/mmcblk0p1... Jan 20 22:02:09 volumio systemd[1]: plymouth-start.service: Succeeded. Jan 20 22:02:09 volumio systemd[1]: Started Show Plymouth Boot Screen. Jan 20 22:02:09 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jan 20 22:02:09 volumio systemd[1]: Started File System Check Daemon to report status. Jan 20 22:02:09 volumio systemd-fsck[599]: fsck.fat 4.1 (2017-01-24) Jan 20 22:02:09 volumio systemd-fsck[599]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Jan 20 22:02:09 volumio systemd-fsck[599]: Automatically removing dirty bit. Jan 20 22:02:09 volumio systemd-fsck[599]: Performing changes. Jan 20 22:02:09 volumio systemd-fsck[599]: /dev/mmcblk0p1: 143 files, 27502/36271 clusters Jan 20 22:02:09 volumio systemd[1]: Started File System Check on /dev/mmcblk0p1. Jan 20 22:02:09 volumio systemd[1]: Mounting /boot... Jan 20 22:02:09 volumio systemd[1]: Mounted /boot. Jan 20 22:02:09 volumio systemd[1]: Reached target Local File Systems. Jan 20 22:02:09 volumio systemd[1]: Starting Create Volatile Files and Directories... Jan 20 22:02:09 volumio systemd[1]: Starting Preprocess NFS configuration... Jan 20 22:02:09 volumio systemd[1]: Starting Raise network interfaces... Jan 20 22:02:09 volumio systemd[1]: Started ifup for eth0. Jan 20 22:02:09 volumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Jan 20 22:02:09 volumio systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Jan 20 22:02:09 volumio systemd[1]: nfs-config.service: Succeeded. Jan 20 22:02:09 volumio systemd[1]: Started Preprocess NFS configuration. Jan 20 22:02:09 volumio systemd[1]: plymouth-read-write.service: Succeeded. Jan 20 22:02:09 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Jan 20 22:02:09 volumio systemd[1]: Received SIGRTMIN+20 from PID 333 (plymouthd). Jan 20 22:02:09 volumio systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Jan 20 22:02:09 volumio systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Jan 20 22:02:09 volumio systemd[1]: Reached target NFS client services. Jan 20 22:02:09 volumio systemd[1]: Started Create Volatile Files and Directories. Jan 20 22:02:09 volumio systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Jan 20 22:02:09 volumio systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Jan 20 22:02:09 volumio kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Jan 20 22:02:09 volumio kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Jan 20 22:02:09 volumio kernel: platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 Jan 20 22:02:09 volumio kernel: cfg80211: failed to load regulatory.db Jan 20 22:02:09 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown... Jan 20 22:02:09 volumio systemd[1]: Starting RPC bind portmap service... Jan 20 22:02:09 volumio ifup[608]: command failed: No such device (-19) Jan 20 22:02:09 volumio sh[609]: command failed: No such device (-19) Jan 20 22:02:09 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Jan 20 22:02:09 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown. Jan 20 22:02:09 volumio systemd[1]: Reached target System Initialization. Jan 20 22:02:09 volumio systemd[1]: Started Daily apt download activities. Jan 20 22:02:09 volumio systemd[1]: Started Daily apt upgrade and clean activities. Jan 20 22:02:09 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Jan 20 22:02:09 volumio systemd[1]: Listening on D-Bus System Message Bus Socket. Jan 20 22:02:09 volumio systemd[1]: Started Daily Cleanup of Temporary Directories. Jan 20 22:02:09 volumio systemd[1]: Reached target Timers. Jan 20 22:02:09 volumio systemd[1]: Listening on triggerhappy.socket. Jan 20 22:02:09 volumio systemd[1]: Reached target Sockets. Jan 20 22:02:09 volumio systemd[1]: Reached target Basic System. Jan 20 22:02:09 volumio systemd[1]: Started D-Bus System Message Bus. Jan 20 22:02:09 volumio systemd[1]: Started Manage Sound Card State (restore and store). Jan 20 22:02:09 volumio systemd[1]: Started volumio-remote-updater.service. Jan 20 22:02:09 volumio systemd[1]: Starting triggerhappy global hotkey daemon... Jan 20 22:02:09 volumio alsactl[662]: alsactl 1.1.8 daemon started Jan 20 22:02:09 volumio systemd[1]: Starting Wireless Services... Jan 20 22:02:09 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Jan 20 22:02:09 volumio systemd[1]: Started Volumio Iptables Module. Jan 20 22:02:09 volumio systemd[1]: Starting Save/Restore Sound Card State... Jan 20 22:02:09 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jan 20 22:02:09 volumio systemd[1]: Starting WPA supplicant... Jan 20 22:02:09 volumio thd[666]: Unable to parse trigger line: Jan 20 22:02:09 volumio thd[666]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Jan 20 22:02:09 volumio thd[666]: Unable to parse trigger line: Jan 20 22:02:09 volumio thd[666]: Found socket passed from systemd Jan 20 22:02:09 volumio systemd[1]: Starting Login Service... Jan 20 22:02:09 volumio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Jan 20 22:02:09 volumio ifup[608]: command failed: No such device (-19) Jan 20 22:02:09 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Jan 20 22:02:09 volumio systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Jan 20 22:02:09 volumio systemd[1]: Starting DHCP Client Daemon... Jan 20 22:02:09 volumio systemd[1]: Started Volumio Log Rotation Service. Jan 20 22:02:09 volumio systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Jan 20 22:02:09 volumio systemd[1]: Started RPC bind portmap service. Jan 20 22:02:09 volumio systemd[1]: Started triggerhappy global hotkey daemon. Jan 20 22:02:09 volumio systemd[1]: haveged.service: Main process exited, code=killed, status=11/SEGV Jan 20 22:02:09 volumio systemd[1]: haveged.service: Failed with result 'signal'. Jan 20 22:02:09 volumio systemd[1]: Reached target RPC Port Mapper. Jan 20 22:02:09 volumio systemd[1]: Reached target Remote File Systems (Pre). Jan 20 22:02:09 volumio systemd[1]: Reached target Remote File Systems. Jan 20 22:02:10 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Jan 20 22:02:10 volumio systemd-logind[677]: New seat seat0. Jan 20 22:02:10 volumio systemd-logind[677]: Watching system buttons on /dev/input/event0 (rk805 pwrkey) Jan 20 22:02:10 volumio systemd-logind[677]: Watching system buttons on /dev/input/event1 (gpio-keys-user) Jan 20 22:02:10 volumio avahi-daemon[679]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Jan 20 22:02:10 volumio avahi-daemon[679]: Successfully dropped root privileges. Jan 20 22:02:10 volumio avahi-daemon[679]: avahi-daemon 0.7 starting up. Jan 20 22:02:10 volumio dhcpcd[681]: no interfaces have a carrier Jan 20 22:02:10 volumio dhcpcd[681]: no interfaces have a carrier Jan 20 22:02:10 volumio kernel: rk_gmac-dwmac ff540000.ethernet eth0: Register MEM_TYPE_PAGE_POOL RxQ-0 Jan 20 22:02:10 volumio kernel: rk_gmac-dwmac ff540000.ethernet eth0: PHY [stmmac-0:00] driver [RTL8211E Gigabit Ethernet] (irq=POLL) Jan 20 22:02:10 volumio dhcpcd[681]: forked to background, child pid 742 Jan 20 22:02:10 volumio dhcpcd[681]: forked to background, child pid 742 Jan 20 22:02:10 volumio kernel: rk_gmac-dwmac ff540000.ethernet eth0: No Safety Features support found Jan 20 22:02:10 volumio kernel: rk_gmac-dwmac ff540000.ethernet eth0: PTP not supported by HW Jan 20 22:02:10 volumio kernel: rk_gmac-dwmac ff540000.ethernet eth0: configuring for phy/rgmii link mode Jan 20 22:02:10 volumio sh[609]: eth0: waiting for carrier Jan 20 22:02:10 volumio sh[609]: eth0: carrier acquired Jan 20 22:02:10 volumio dhcpcd[655]: eth0: waiting for carrier Jan 20 22:02:10 volumio dhcpcd[655]: eth0: carrier acquired Jan 20 22:02:10 volumio dhcpcd[742]: eth0: waiting for carrier Jan 20 22:02:10 volumio dhcpcd[742]: eth0: carrier acquired Jan 20 22:02:10 volumio sh[609]: DUID 00:01:00:01:2c:c6:8b:7b:f2:74:9c:a0:52:24 Jan 20 22:02:10 volumio sh[609]: eth0: IAID 9c:a0:52:24 Jan 20 22:02:10 volumio dhcpcd[742]: DUID 00:01:00:01:2c:c6:8b:7b:f2:74:9c:a0:52:24 Jan 20 22:02:10 volumio dhcpcd[655]: DUID 00:01:00:01:2c:c6:8b:7b:f2:74:9c:a0:52:24 Jan 20 22:02:10 volumio dhcpcd[742]: eth0: IAID 9c:a0:52:24 Jan 20 22:02:10 volumio dhcpcd[655]: eth0: IAID 9c:a0:52:24 Jan 20 22:02:10 volumio sh[609]: eth0: adding address fe80::8c9f:aee6:da8:80eb Jan 20 22:02:10 volumio sh[609]: ipv6_addaddr1: Permission denied Jan 20 22:02:10 volumio sh[609]: eth0: carrier lost Jan 20 22:02:10 volumio dhcpcd[742]: eth0: adding address fe80::8c9f:aee6:da8:80eb Jan 20 22:02:10 volumio dhcpcd[742]: ipv6_addaddr1: Permission denied Jan 20 22:02:10 volumio dhcpcd[742]: eth0: carrier lost Jan 20 22:02:10 volumio dhcpcd[655]: eth0: adding address fe80::8c9f:aee6:da8:80eb Jan 20 22:02:10 volumio dhcpcd[655]: ipv6_addaddr1: Permission denied Jan 20 22:02:10 volumio dhcpcd[655]: eth0: carrier lost Jan 20 22:02:10 volumio systemd[1]: Started Login Service. Jan 20 22:02:10 volumio avahi-daemon[679]: Successfully called chroot(). Jan 20 22:02:10 volumio avahi-daemon[679]: Successfully dropped remaining capabilities. Jan 20 22:02:10 volumio wpa_supplicant[676]: Successfully initialized wpa_supplicant Jan 20 22:02:10 volumio systemd[1]: Started Save/Restore Sound Card State. Jan 20 22:02:10 volumio systemd[1]: Started DHCP Client Daemon. Jan 20 22:02:10 volumio avahi-daemon[679]: No service file found in /etc/avahi/services. Jan 20 22:02:10 volumio avahi-daemon[679]: Network interface enumeration completed. Jan 20 22:02:10 volumio avahi-daemon[679]: Server startup complete. Host name is volumio.local. Local service cookie is 3604441858. Jan 20 22:02:10 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Jan 20 22:02:10 volumio systemd[1]: Started WPA supplicant. Jan 20 22:02:10 volumio systemd[1]: Reached target Sound Card. Jan 20 22:02:10 volumio systemd[1]: iptables.service: Succeeded. Jan 20 22:02:10 volumio volumio-remote-updater[664]: Error: No active session Jan 20 22:02:10 volumio volumio-remote-updater[664]: [2025-01-20 22:02:10] [info] asio async_connect error: system:111 (Connection refused) Jan 20 22:02:10 volumio volumio-remote-updater[664]: [2025-01-20 22:02:10] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 20 22:02:10 volumio volumio-remote-updater[664]: [2025-01-20 22:02:10] [error] handle_connect error: Underlying Transport Error Jan 20 22:02:10 volumio systemd[1]: Started Raise network interfaces. Jan 20 22:02:10 volumio systemd[1]: Reached target Network. Jan 20 22:02:10 volumio volumio[675]: Could not open config: /tmp/upmpdcli.conf Jan 20 22:02:10 volumio systemd[1]: Starting OpenBSD Secure Shell server... Jan 20 22:02:10 volumio systemd[1]: Starting Permit User Sessions... Jan 20 22:02:10 volumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Jan 20 22:02:10 volumio systemd[1]: Starting Network Time Service... Jan 20 22:02:10 volumio systemd[1]: Reached target Network is Online. Jan 20 22:02:10 volumio systemd[1]: Starting LSB: Brings up/down network automatically... Jan 20 22:02:10 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 20 22:02:11 volumio systemd[1]: Starting Samba NMB Daemon... Jan 20 22:02:11 volumio systemd[1]: Starting /etc/rc.local Compatibility... Jan 20 22:02:11 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jan 20 22:02:11 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jan 20 22:02:11 volumio systemd[1]: Started Permit User Sessions. Jan 20 22:02:11 volumio systemd[1]: Started /etc/rc.local Compatibility. Jan 20 22:02:11 volumio systemd[1]: Starting Hold until boot process finishes up... Jan 20 22:02:11 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... Jan 20 22:02:11 volumio loadcpufreq[690]: Loading cpufreq kernel modules...done (none). Jan 20 22:02:11 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Jan 20 22:02:11 volumio systemd[1]: Received SIGRTMIN+21 from PID 333 (plymouthd). Jan 20 22:02:11 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Jan 20 22:02:11 volumio systemd[1]: plymouth-quit-wait.service: Succeeded. Jan 20 22:02:11 volumio systemd[1]: Started Hold until boot process finishes up. Jan 20 22:02:11 volumio systemd[1]: plymouth-quit.service: Succeeded. Jan 20 22:02:11 volumio systemd[1]: Started Terminate Plymouth Boot Screen. Jan 20 22:02:11 volumio systemd[1]: Received SIGRTMIN+21 from PID 333 (n/a). Jan 20 22:02:11 volumio ntpd[812]: ntpd 4.2.8p12@1.3728-o (1): Starting Jan 20 22:02:11 volumio ntpd[812]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Jan 20 22:02:11 volumio sshd[847]: Server listening on 0.0.0.0 port 22. Jan 20 22:02:11 volumio sshd[847]: Server listening on :: port 22. Jan 20 22:02:11 volumio ifplugd(eth0)[860]: ifplugd 0.28 initializing. Jan 20 22:02:11 volumio ifplugd(eth0)[860]: Using interface eth0/F2:74:9C:A0:52:24 with driver (version: 6.1.49-rockchip64) Jan 20 22:02:11 volumio ifplugd(eth0)[860]: Using detection mode: SIOCETHTOOL Jan 20 22:02:11 volumio ifplugd(eth0)[860]: Initialization complete, link beat not detected. Jan 20 22:02:11 volumio systemd[1]: Started OpenBSD Secure Shell server. Jan 20 22:02:11 volumio systemd[1]: Started Network Time Service. Jan 20 22:02:11 volumio ntpd[855]: proto: precision = 1.166 usec (-20) Jan 20 22:02:11 volumio ntpd[855]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jan 20 22:02:11 volumio ntpd[855]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jan 20 22:02:11 volumio ntpd[855]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 755 days ago Jan 20 22:02:11 volumio ntpd[855]: Listen and drop on 0 v6wildcard [::]:123 Jan 20 22:02:11 volumio systemd[1]: Started Getty on tty1. Jan 20 22:02:11 volumio ntpd[855]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jan 20 22:02:11 volumio ntpd[855]: Listen normally on 2 lo 127.0.0.1:123 Jan 20 22:02:11 volumio ntpd[855]: Listening on routing socket on fd #19 for interface updates Jan 20 22:02:11 volumio ntpd[855]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 20 22:02:11 volumio ntpd[855]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 20 22:02:11 volumio systemd[1]: Started Serial Getty on ttyS2. Jan 20 22:02:11 volumio systemd[1]: Reached target Login Prompts. Jan 20 22:02:11 volumio ifplugd[814]: Network Interface Plugging Daemon...start eth0...done. Jan 20 22:02:11 volumio systemd[1]: Started LSB: Brings up/down network automatically. Jan 20 22:02:11 volumio cpufrequtils[838]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Jan 20 22:02:11 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Jan 20 22:02:11 volumio kernel: new mount options do not match the existing superblock, will be ignored Jan 20 22:02:11 volumio nmbd[829]: [2025/01/20 22:02:11.961900, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Jan 20 22:02:11 volumio nmbd[829]: started asyncdns process 876 Jan 20 22:02:11 volumio nmbd[829]: [2025/01/20 22:02:11.965604, 0] ../lib/util/become_daemon.c:149(daemon_status) Jan 20 22:02:11 volumio nmbd[829]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Jan 20 22:02:11 volumio nmbd[829]: [2025/01/20 22:02:11.965867, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Jan 20 22:02:11 volumio nmbd[829]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Jan 20 22:02:12 volumio volumio[671]: cset: --> shielding system active with Jan 20 22:02:12 volumio volumio[671]: cset: "system" cpuset of CPUSPEC(2-3) with 56 tasks running Jan 20 22:02:12 volumio volumio[671]: cset: "user" cpuset of CPUSPEC(0-1) with 0 tasks running Jan 20 22:02:12 volumio ntpd[855]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jan 20 22:02:12 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Jan 20 22:02:12 volumio wireless.js[669]: WIRELESS: No wireless interface, exiting Jan 20 22:02:12 volumio iw[891]: command failed: No such device (-19) Jan 20 22:02:12 volumio iwconfig[894]: Error for wireless request "Set Power Management" (8B2C) : Jan 20 22:02:12 volumio iwconfig[894]: SET failed on device wlan0 ; No such device. Jan 20 22:02:12 volumio systemd[1]: wireless.service: Succeeded. Jan 20 22:02:12 volumio systemd[1]: Started Wireless Services. Jan 20 22:02:12 volumio systemd[1]: Started Volumio Backend Module. Jan 20 22:02:12 volumio systemd[1]: Started Volumio Cpu Tweaker. Jan 20 22:02:12 volumio volumio-cpu-tweak[898]: Setting RT Priority for mpd Jan 20 22:02:12 volumio volumio-cpu-tweak[898]: pid 35's current scheduling policy: SCHED_OTHER Jan 20 22:02:12 volumio volumio-cpu-tweak[898]: pid 35's current scheduling priority: 0 Jan 20 22:02:12 volumio volumio-cpu-tweak[898]: Setting MPD Affinity Jan 20 22:02:12 volumio volumio-cpu-tweak[898]: pid 3's current affinity mask: f Jan 20 22:02:12 volumio volumio-cpu-tweak[898]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Jan 20 22:02:12 volumio volumio-cpu-tweak[898]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Jan 20 22:02:12 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Jan 20 22:02:13 volumio ntpd[855]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Jan 20 22:02:14 volumio ntpd[855]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Jan 20 22:02:15 volumio ntpd[855]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Jan 20 22:02:15 volumio volumio-remote-updater[664]: [2025-01-20 22:02:15] [connect] Successful connection Jan 20 22:02:15 volumio volumio[897]: info: ------------------------------------------- Jan 20 22:02:15 volumio volumio[897]: info: ----- Volumio3 ---- Jan 20 22:02:15 volumio volumio[897]: info: ------------------------------------------- Jan 20 22:02:15 volumio volumio[897]: info: ----- System startup ---- Jan 20 22:02:15 volumio volumio[897]: info: ------------------------------------------- Jan 20 22:02:17 volumio volumio[897]: info: MYVOLUMIO Environment detected Jan 20 22:02:17 volumio volumio[897]: info: Plugin folders cleanup Jan 20 22:02:17 volumio volumio[897]: info: Scanning into folder /volumio/app/plugins/ Jan 20 22:02:17 volumio volumio[897]: info: Scanning category audio_interface Jan 20 22:02:17 volumio volumio[897]: info: Scanning category miscellanea Jan 20 22:02:17 volumio volumio[897]: info: Scanning category music_service Jan 20 22:02:17 volumio volumio[897]: info: Scanning category plugins.json Jan 20 22:02:17 volumio volumio[897]: info: Scanning category system_controller Jan 20 22:02:17 volumio volumio[897]: info: Scanning category user_interface Jan 20 22:02:17 volumio volumio[897]: info: Scanning into folder /data/plugins/ Jan 20 22:02:17 volumio volumio[897]: info: Scanning category music_service Jan 20 22:02:17 volumio volumio[897]: info: Scanning category system_hardware Jan 20 22:02:17 volumio volumio[897]: info: Scanning category user_interface Jan 20 22:02:17 volumio volumio[897]: info: Plugin folders cleanup completed Jan 20 22:02:17 volumio volumio[897]: info: ------------------------------------------- Jan 20 22:02:17 volumio volumio[897]: info: ----- Core plugins startup ---- Jan 20 22:02:17 volumio volumio[897]: info: ------------------------------------------- Jan 20 22:02:17 volumio volumio[897]: info: Loading plugins from folder /volumio/app/plugins/ Jan 20 22:02:17 volumio volumio[897]: info: Adding plugin upnp to MyMusic Plugins Jan 20 22:02:17 volumio volumio[897]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 20 22:02:17 volumio volumio[897]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 20 22:02:17 volumio volumio[897]: info: Loading plugins from folder /data/plugins/ Jan 20 22:02:17 volumio volumio[897]: info: Loading plugin "system"... Jan 20 22:02:17 volumio volumio[897]: info: Loading plugin "appearance"... Jan 20 22:02:19 volumio volumio[897]: info: Loading plugin "network"... Jan 20 22:02:19 volumio volumio[897]: info: Refreshing Cached IP Addresses Jan 20 22:02:19 volumio volumio[897]: info: Loading plugin "services"... Jan 20 22:02:19 volumio volumio[897]: info: Loading plugin "alsa_controller"... Jan 20 22:02:19 volumio sudo[932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 20 22:02:19 volumio sudo[930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 20 22:02:19 volumio sudo[932]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:19 volumio sudo[928]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 20 22:02:19 volumio sudo[928]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:19 volumio sudo[930]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:19 volumio sudo[928]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:19 volumio sudo[932]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:19 volumio sudo[930]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:19 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:02:19 volumio volumio[897]: info: Loading plugin "wizard"... Jan 20 22:02:19 volumio volumio[897]: info: Loading plugin "networkfs"... Jan 20 22:02:19 volumio volumio[897]: info: Starting Udev Watcher for removable devices Jan 20 22:02:19 volumio volumio[897]: info: Ignoring mount for partition: boot Jan 20 22:02:19 volumio volumio[897]: info: Ignoring mount for partition: volumio Jan 20 22:02:19 volumio volumio[897]: info: Ignoring mount for partition: volumio_data Jan 20 22:02:19 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:02:19 volumio volumio[897]: info: Loading plugin "volumio_command_line_client"... Jan 20 22:02:19 volumio volumio[897]: info: Loading plugin "upnp"... Jan 20 22:02:19 volumio volumio[897]: info: [1737381739961] Starting Upmpd Daemon Jan 20 22:02:19 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:02:19 volumio volumio[897]: info: Loading plugin "my_music"... Jan 20 22:02:19 volumio volumio[897]: info: Loading plugin "mpd"... Jan 20 22:02:20 volumio volumio[897]: info: Loading plugin "upnp_browser"... Jan 20 22:02:21 volumio volumio[897]: info: Loading plugin "alarm-clock"... Jan 20 22:02:21 volumio volumio[897]: info: Loading plugin "airplay_emulation"... Jan 20 22:02:21 volumio volumio[897]: info: Starting Shairport Sync Jan 20 22:02:21 volumio volumio[897]: info: Loading plugin "last_100"... Jan 20 22:02:21 volumio volumio[897]: info: Loading plugin "webradio"... Jan 20 22:02:21 volumio volumio[897]: info: Loading plugin "i2s_dacs"... Jan 20 22:02:21 volumio volumio[897]: info: I2S DAC not set, start Auto-detection Jan 20 22:02:21 volumio volumio[897]: info: Loading plugin "volumiodiscovery"... Jan 20 22:02:21 volumio volumio[897]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 20 22:02:21 volumio volumio[897]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:02:21 volumio volumio[897]: *** WARNING *** For more information see Jan 20 22:02:21 volumio node[897]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 20 22:02:21 volumio volumio[897]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 20 22:02:21 volumio volumio[897]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:02:21 volumio volumio[897]: *** WARNING *** For more information see Jan 20 22:02:21 volumio node[897]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:02:21 volumio node[897]: *** WARNING *** For more information see Jan 20 22:02:21 volumio node[897]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 20 22:02:21 volumio node[897]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:02:21 volumio node[897]: *** WARNING *** For more information see Jan 20 22:02:21 volumio volumio[897]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 20 22:02:21 volumio volumio[897]: info: Discovery: Started advertising with name: Volumio Jan 20 22:02:21 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:02:21 volumio volumio[897]: info: Loading plugin "soundcloud"... Jan 20 22:02:22 volumio volumio[897]: info: Loading plugin "squeezelite_mc"... Jan 20 22:02:23 volumio volumio[897]: info: Loading plugin "ytmusic"... Jan 20 22:02:25 volumio volumio[897]: info: Loading plugin "outputs"... Jan 20 22:02:25 volumio volumio[897]: info: Loading plugin "albumart"... Jan 20 22:02:25 volumio volumio[897]: info: Plugin example_plugin is not enabled Jan 20 22:02:25 volumio volumio[897]: info: Loading plugin "inputs"... Jan 20 22:02:25 volumio volumio[897]: info: Loading plugin "updater_comm"... Jan 20 22:02:25 volumio volumio[897]: info: Plugin mpdemulation is not enabled Jan 20 22:02:25 volumio volumio[897]: info: Loading plugin "rest_api"... Jan 20 22:02:25 volumio volumio[897]: info: Loading plugin "websocket"... Jan 20 22:02:25 volumio volumio[897]: info: Starting Socket.io Server version 2.3.0 Jan 20 22:02:25 volumio volumio[897]: info: Loading plugin "podcast"... Jan 20 22:02:25 volumio volumio[897]: Forking 3 albumart workers Jan 20 22:02:26 volumio volumio[897]: info: ControllerPodcast::constructor Jan 20 22:02:26 volumio volumio[897]: info: Loading plugin "radio_paradise"... Jan 20 22:02:27 volumio volumio[897]: Starting albumart workers Jan 20 22:02:27 volumio volumio[897]: info: Applying required configuration parameters for plugin radio_paradise Jan 20 22:02:27 volumio volumio[897]: info: [1737381747411] [RadioParadise] API delay: 5 Jan 20 22:02:27 volumio volumio[897]: info: Loading plugin "music_services_shield"... Jan 20 22:02:27 volumio volumio[897]: Starting albumart workers Jan 20 22:02:27 volumio volumio[897]: Starting albumart workers Jan 20 22:02:28 volumio volumio[897]: info: Applying required configuration parameters for plugin music_services_shield Jan 20 22:02:28 volumio volumio[897]: info: Loading plugin "Systeminfo"... Jan 20 22:02:28 volumio volumio-remote-updater[664]: [2025-01-20 22:02:28] [connect] Successful connection Jan 20 22:02:29 volumio volumio[897]: info: Loading i18n strings for locale zh Jan 20 22:02:29 volumio volumio[897]: Updating browse sources language Jan 20 22:02:29 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:02:29 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:02:29 volumio volumio[897]: info: CoreCommandRouter::initPlayerControls Jan 20 22:02:29 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:29 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:29 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:29 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:29 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:29 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:29 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:29 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:29 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:02:29 volumio volumio[897]: Express server listening on port 3000 Jan 20 22:02:29 volumio volumio[897]: [Metrics] WebUI: 14s 840.80ms Jan 20 22:02:29 volumio volumio[897]: info: CoreStateMachine::resetVolumioState Jan 20 22:02:29 volumio volumio[897]: info: CoreStateMachine::getcurrentVolume Jan 20 22:02:29 volumio volumio[897]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:02:29 volumio volumio[897]: info: CoreStateMachine::pushState Jan 20 22:02:29 volumio volumio[897]: info: CorePlayQueue::getTrack 0 Jan 20 22:02:29 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:02:29 volumio volumio[897]: info: CoreCommandRouter::volumioPushState Jan 20 22:02:29 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:02:29 volumio volumio[897]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 20 22:02:29 volumio volumio[897]: info: Completed loading Core Plugins Jan 20 22:02:29 volumio volumio[897]: info: Preparing to generate the ALSA configuration file Jan 20 22:02:29 volumio volumio[897]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jan 20 22:02:29 volumio volumio[897]: wlan0 Interface doesn't support scanning. Jan 20 22:02:29 volumio volumio[897]: info: Cannot use regular scanning, forcing with ap-force Jan 20 22:02:29 volumio sudo[1006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jan 20 22:02:29 volumio sudo[1006]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:29 volumio sudo[1006]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:29 volumio volumio[897]: command failed: No such device (-19) Jan 20 22:02:29 volumio volumio[897]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jan 20 22:02:29 volumio volumio[897]: command failed: No such device (-19) Jan 20 22:02:29 volumio volumio[897]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jan 20 22:02:30 volumio volumio-remote-updater[664]: [2025-01-20 22:02:30] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1737381748 101 Jan 20 22:02:30 volumio volumio[897]: 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 Jan 20 22:02:30 volumio sudo[1011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 20 22:02:30 volumio sudo[1011]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:30 volumio sudo[1011]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:30 volumio sudo[1013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 20 22:02:30 volumio sudo[1013]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:30 volumio volumio[897]: info: Reloading queue from file Jan 20 22:02:30 volumio sudo[1013]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:30 volumio volumio[897]: info: CoreStateMachine::setRepeat null single undefined Jan 20 22:02:30 volumio volumio[897]: info: CoreStateMachine::pushState Jan 20 22:02:30 volumio volumio[897]: info: CorePlayQueue::getTrack 0 Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::volumioPushState Jan 20 22:02:30 volumio volumio[897]: info: CoreStateMachine::setRandom null Jan 20 22:02:30 volumio volumio[897]: info: CoreStateMachine::pushState Jan 20 22:02:30 volumio volumio[897]: info: CorePlayQueue::getTrack 0 Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::volumioPushState Jan 20 22:02:30 volumio volumio[897]: info: Asound.conf file unchanged, so no further update is needed Jan 20 22:02:30 volumio volumio[897]: info: Output device has changed, restarting MPD Jan 20 22:02:30 volumio volumio[897]: info: Output device has changed, restarting Shairport Sync Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:02:30 volumio sudo[1023]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 22:02:30 volumio sudo[1023]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:30 volumio sudo[1023]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:30 volumio sudo[1025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 22:02:30 volumio sudo[1025]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:30 volumio systemd[1]: musicservicesshield.service: Succeeded. Jan 20 22:02:30 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Jan 20 22:02:30 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Jan 20 22:02:30 volumio volumio[897]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:02:30 volumio volumio[897]: info: ___________ START PLUGINS ___________ Jan 20 22:02:30 volumio volumio[897]: info: ControllerMpd::onStart: Initializing MPD Jan 20 22:02:30 volumio volumio[897]: info: Creating MPD Configuration file Jan 20 22:02:30 volumio systemd[1]: Listening on mpd.socket. Jan 20 22:02:30 volumio systemd[1]: Starting Music Player Daemon... Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:02:30 volumio volumio[897]: info: [1737381750415] CoreMusicLibrary::Adding element 媒体服务器 Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:02:30 volumio sudo[1033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 22:02:30 volumio sudo[1036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 22:02:30 volumio sudo[1036]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:30 volumio sudo[1033]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:30 volumio sudo[1033]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:30 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 20 22:02:30 volumio systemd[1]: mpd.service: Succeeded. Jan 20 22:02:30 volumio systemd[1]: Stopped Music Player Daemon. Jan 20 22:02:30 volumio volumio[897]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:02:30 volumio systemd[1]: Starting Music Player Daemon... Jan 20 22:02:30 volumio volumio[897]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:02:30 volumio volumio[897]: info: [1737381750623] CoreMusicLibrary::Adding element Last_100 Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:02:30 volumio volumio[897]: info: [1737381750628] CoreMusicLibrary::Adding element Webradio Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:02:30 volumio volumio[897]: info: Initializing BBC Radios Jan 20 22:02:30 volumio sudo[1042]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 20 22:02:30 volumio sudo[1042]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:30 volumio sudo[1042]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jan 20 22:02:30 volumio sudo[1042]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:02:30 volumio volumio[897]: info: [1737381750755] CoreMusicLibrary::Adding element SoundCloud Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:02:30 volumio volumio[897]: Cannot find translation for source SoundCloud Jan 20 22:02:30 volumio volumio[897]: info: [squeezelite_mc] Starting proxy server... Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:02:30 volumio volumio[897]: info: [1737381750805] CoreMusicLibrary::Adding element YouTube Music Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:02:30 volumio volumio[897]: Cannot find translation for source SoundCloud Jan 20 22:02:30 volumio volumio[897]: Cannot find translation for source YouTube Music Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:02:30 volumio volumio[897]: info: [1737381750828] CoreMusicLibrary::Adding element Podcast Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:02:30 volumio volumio[897]: Cannot find translation for source SoundCloud Jan 20 22:02:30 volumio volumio[897]: Cannot find translation for source YouTube Music Jan 20 22:02:30 volumio volumio[897]: Cannot find translation for source Podcast Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:02:30 volumio volumio[897]: info: [1737381750843] CoreMusicLibrary::Adding element Radio Paradise Jan 20 22:02:30 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:02:30 volumio volumio[897]: Cannot find translation for source SoundCloud Jan 20 22:02:30 volumio volumio[897]: Cannot find translation for source YouTube Music Jan 20 22:02:30 volumio volumio[897]: Cannot find translation for source Podcast Jan 20 22:02:30 volumio volumio[897]: Cannot find translation for source Radio Paradise Jan 20 22:02:31 volumio volumio[897]: info: Volumio Calling Home Jan 20 22:02:31 volumio volumio[897]: info: [squeezelite_mc] Proxy server started on port 41009 Jan 20 22:02:31 volumio sudo[1085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh Jan 20 22:02:31 volumio sudo[1085]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:31 volumio volumio[897]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:02:31 volumio volumio[897]: info: CoreStateMachine::pushState Jan 20 22:02:31 volumio volumio[897]: info: CorePlayQueue::getTrack 0 Jan 20 22:02:31 volumio volumio[897]: info: CoreCommandRouter::volumioPushState Jan 20 22:02:31 volumio volumio[897]: info: [squeezelite_mc] Server discovery started Jan 20 22:02:31 volumio volumio[897]: info: [squeezelite_mc] Player finder started Jan 20 22:02:31 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:31 volumio volumio[897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:31 volumio volumio[897]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"","card":"0","mixerType":"None","mixer":null} Jan 20 22:02:31 volumio volumio[897]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Jan 20 22:02:31 volumio volumio[897]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:02:31 volumio volumio[897]: Error: send ENETUNREACH 255.255.255.255:3483 Jan 20 22:02:31 volumio volumio[897]: at doSend (dgram.js:714:16) Jan 20 22:02:31 volumio volumio[897]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:452:18) Jan 20 22:02:31 volumio volumio[897]: at afterDns (dgram.js:660:5) Jan 20 22:02:31 volumio volumio[897]: at processTicksAndRejections (internal/process/task_queues.js:83:21) { Jan 20 22:02:31 volumio volumio[897]: errno: -101, Jan 20 22:02:31 volumio volumio[897]: code: 'ENETUNREACH', Jan 20 22:02:31 volumio volumio[897]: syscall: 'send', Jan 20 22:02:31 volumio volumio[897]: address: '255.255.255.255', Jan 20 22:02:31 volumio volumio[897]: port: 3483 Jan 20 22:02:31 volumio volumio[897]: } Jan 20 22:02:31 volumio volumio[897]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:02:31 volumio sudo[1101]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Jan 20 22:02:31 volumio sudo[1101]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:31 volumio sudo[1101]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:32 volumio sudo[1085]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:32 volumio sudo[1123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-20 22:01 Jan 20 22:02:32 volumio sudo[1123]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:32 volumio sudo[1123]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:32 volumio volumio-remote-updater[664]: [2025-01-20 22:02:32] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jan 20 22:02:32 volumio volumio-remote-updater[664]: [2025-01-20 22:02:32] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jan 20 22:02:32 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 20 22:02:32 volumio sudo[1036]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:32 volumio sudo[1025]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:32 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 20 22:02:32 volumio systemd[1]: Started dynamicswap service. Jan 20 22:02:32 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 20 22:02:32 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 20 22:02:32 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Jan 20 22:02:33 volumio systemd[1]: Started dynamicswap service. Jan 20 22:02:33 volumio systemd[1]: Stopped Volumio Backend Module. Jan 20 22:02:33 volumio systemd[1]: Started Volumio Backend Module. Jan 20 22:02:33 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 20 22:02:33 volumio kernel: sched: RT throttling activated Jan 20 22:02:34 volumio mpd[1058]: Jan 20 22:02 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 20 22:02:34 volumio systemd[1]: Started Music Player Daemon. Jan 20 22:02:34 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Jan 20 22:02:35 volumio volumio[1137]: info: ------------------------------------------- Jan 20 22:02:35 volumio volumio[1137]: info: ----- Volumio3 ---- Jan 20 22:02:35 volumio volumio[1137]: info: ------------------------------------------- Jan 20 22:02:35 volumio volumio[1137]: info: ----- System startup ---- Jan 20 22:02:35 volumio volumio[1137]: info: ------------------------------------------- Jan 20 22:02:35 volumio volumio[1151]: cset: --> shielding system active with Jan 20 22:02:35 volumio volumio[1151]: cset: "system" cpuset of CPUSPEC(2-3) with 46 tasks running Jan 20 22:02:35 volumio volumio[1151]: cset: "user" cpuset of CPUSPEC(0-1) with 3 tasks running Jan 20 22:02:35 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Jan 20 22:02:36 volumio volumio[1137]: info: MYVOLUMIO Environment detected Jan 20 22:02:36 volumio volumio[1137]: info: Plugin folders cleanup Jan 20 22:02:36 volumio volumio[1137]: info: Scanning into folder /volumio/app/plugins/ Jan 20 22:02:36 volumio volumio[1137]: info: Scanning category audio_interface Jan 20 22:02:36 volumio volumio[1137]: info: Scanning category miscellanea Jan 20 22:02:36 volumio volumio[1137]: info: Scanning category music_service Jan 20 22:02:36 volumio volumio[1137]: info: Scanning category plugins.json Jan 20 22:02:36 volumio volumio[1137]: info: Scanning category system_controller Jan 20 22:02:36 volumio volumio[1137]: info: Scanning category user_interface Jan 20 22:02:36 volumio volumio[1137]: info: Scanning into folder /data/plugins/ Jan 20 22:02:36 volumio volumio[1137]: info: Scanning category music_service Jan 20 22:02:36 volumio volumio[1137]: info: Scanning category system_hardware Jan 20 22:02:36 volumio volumio[1137]: info: Scanning category user_interface Jan 20 22:02:36 volumio volumio[1137]: info: Plugin folders cleanup completed Jan 20 22:02:36 volumio volumio[1137]: info: ------------------------------------------- Jan 20 22:02:36 volumio volumio[1137]: info: ----- Core plugins startup ---- Jan 20 22:02:36 volumio volumio[1137]: info: ------------------------------------------- Jan 20 22:02:36 volumio volumio[1137]: info: Loading plugins from folder /volumio/app/plugins/ Jan 20 22:02:36 volumio volumio[1137]: info: Adding plugin upnp to MyMusic Plugins Jan 20 22:02:36 volumio volumio[1137]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 20 22:02:36 volumio volumio[1137]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 20 22:02:36 volumio volumio[1137]: info: Loading plugins from folder /data/plugins/ Jan 20 22:02:36 volumio volumio[1137]: info: Loading plugin "system"... Jan 20 22:02:36 volumio volumio[1137]: info: Loading plugin "appearance"... Jan 20 22:02:37 volumio volumio[1137]: info: Loading plugin "network"... Jan 20 22:02:37 volumio volumio[1137]: info: Refreshing Cached IP Addresses Jan 20 22:02:37 volumio sudo[1186]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 20 22:02:37 volumio sudo[1186]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:37 volumio volumio[1137]: info: Loading plugin "services"... Jan 20 22:02:37 volumio volumio[1137]: info: Loading plugin "alsa_controller"... Jan 20 22:02:37 volumio sudo[1189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 20 22:02:37 volumio sudo[1186]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:37 volumio sudo[1191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 20 22:02:37 volumio sudo[1191]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:37 volumio sudo[1189]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:37 volumio sudo[1189]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:37 volumio sudo[1191]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:37 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:02:37 volumio volumio[1137]: info: Loading plugin "wizard"... Jan 20 22:02:37 volumio volumio[1137]: info: Loading plugin "networkfs"... Jan 20 22:02:37 volumio volumio[1137]: info: Starting Udev Watcher for removable devices Jan 20 22:02:37 volumio volumio[1137]: info: Ignoring mount for partition: boot Jan 20 22:02:37 volumio volumio[1137]: info: Ignoring mount for partition: volumio Jan 20 22:02:37 volumio volumio[1137]: info: Ignoring mount for partition: volumio_data Jan 20 22:02:37 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:02:37 volumio volumio[1137]: info: Loading plugin "volumio_command_line_client"... Jan 20 22:02:37 volumio volumio[1137]: info: Loading plugin "upnp"... Jan 20 22:02:37 volumio volumio[1137]: info: [1737381757725] Starting Upmpd Daemon Jan 20 22:02:37 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:02:37 volumio volumio[1137]: info: Loading plugin "my_music"... Jan 20 22:02:37 volumio volumio[1137]: info: Loading plugin "mpd"... Jan 20 22:02:37 volumio volumio-remote-updater[664]: [2025-01-20 22:02:37] [connect] Successful connection Jan 20 22:02:38 volumio volumio[1137]: info: Loading plugin "upnp_browser"... Jan 20 22:02:38 volumio volumio[1137]: info: Loading plugin "alarm-clock"... Jan 20 22:02:38 volumio volumio[1137]: info: Loading plugin "airplay_emulation"... Jan 20 22:02:38 volumio volumio[1137]: info: Starting Shairport Sync Jan 20 22:02:38 volumio volumio[1137]: info: Loading plugin "last_100"... Jan 20 22:02:38 volumio volumio[1137]: info: Loading plugin "webradio"... Jan 20 22:02:38 volumio volumio[1137]: info: Loading plugin "i2s_dacs"... Jan 20 22:02:38 volumio volumio[1137]: info: I2S DAC not set, start Auto-detection Jan 20 22:02:38 volumio volumio[1137]: info: Loading plugin "volumiodiscovery"... Jan 20 22:02:38 volumio volumio[1137]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 20 22:02:38 volumio volumio[1137]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:02:38 volumio node[1137]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 20 22:02:38 volumio volumio[1137]: *** WARNING *** For more information see Jan 20 22:02:38 volumio volumio[1137]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 20 22:02:38 volumio volumio[1137]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:02:38 volumio volumio[1137]: *** WARNING *** For more information see Jan 20 22:02:38 volumio node[1137]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:02:38 volumio node[1137]: *** WARNING *** For more information see Jan 20 22:02:38 volumio node[1137]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 20 22:02:38 volumio node[1137]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:02:38 volumio node[1137]: *** WARNING *** For more information see Jan 20 22:02:38 volumio volumio[1137]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 20 22:02:38 volumio volumio[1137]: info: Discovery: Started advertising with name: Volumio Jan 20 22:02:38 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:02:38 volumio volumio[1137]: info: Loading plugin "soundcloud"... Jan 20 22:02:39 volumio volumio[1137]: info: Loading plugin "squeezelite_mc"... Jan 20 22:02:39 volumio systemd[1]: systemd-fsckd.service: Succeeded. Jan 20 22:02:40 volumio volumio[1137]: info: Loading plugin "ytmusic"... Jan 20 22:02:40 volumio sh[609]: timed out Jan 20 22:02:40 volumio sh[609]: dhcpcd exited Jan 20 22:02:40 volumio dhcpcd[655]: timed out Jan 20 22:02:40 volumio sh[609]: ifup: failed to bring up eth0 Jan 20 22:02:40 volumio dhcpcd[655]: dhcpcd exited Jan 20 22:02:40 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Jan 20 22:02:40 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Jan 20 22:02:41 volumio volumio[1137]: info: Loading plugin "outputs"... Jan 20 22:02:41 volumio volumio[1137]: info: Loading plugin "albumart"... Jan 20 22:02:41 volumio volumio[1137]: info: Plugin example_plugin is not enabled Jan 20 22:02:41 volumio volumio[1137]: info: Loading plugin "inputs"... Jan 20 22:02:41 volumio volumio[1137]: info: Loading plugin "updater_comm"... Jan 20 22:02:41 volumio volumio[1137]: info: Plugin mpdemulation is not enabled Jan 20 22:02:41 volumio volumio[1137]: info: Loading plugin "rest_api"... Jan 20 22:02:41 volumio volumio[1137]: info: Loading plugin "websocket"... Jan 20 22:02:41 volumio volumio[1137]: info: Starting Socket.io Server version 2.3.0 Jan 20 22:02:41 volumio volumio[1137]: info: Loading plugin "podcast"... Jan 20 22:02:41 volumio volumio[1137]: Forking 3 albumart workers Jan 20 22:02:41 volumio volumio[1137]: info: ControllerPodcast::constructor Jan 20 22:02:42 volumio volumio[1137]: info: Loading plugin "radio_paradise"... Jan 20 22:02:42 volumio volumio[1137]: info: Applying required configuration parameters for plugin radio_paradise Jan 20 22:02:42 volumio volumio[1137]: info: [1737381762689] [RadioParadise] API delay: 5 Jan 20 22:02:42 volumio volumio[1137]: info: Loading plugin "music_services_shield"... Jan 20 22:02:43 volumio volumio[1137]: info: Applying required configuration parameters for plugin music_services_shield Jan 20 22:02:43 volumio volumio[1137]: info: Loading plugin "Systeminfo"... Jan 20 22:02:43 volumio volumio[1137]: Starting albumart workers Jan 20 22:02:43 volumio volumio[1137]: Starting albumart workers Jan 20 22:02:44 volumio volumio[1137]: Starting albumart workers Jan 20 22:02:44 volumio volumio[1137]: info: Loading i18n strings for locale zh Jan 20 22:02:44 volumio volumio[1137]: Updating browse sources language Jan 20 22:02:44 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:02:44 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:02:44 volumio volumio[1137]: info: CoreCommandRouter::initPlayerControls Jan 20 22:02:44 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:44 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:44 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:44 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:44 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:44 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:44 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:44 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:44 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:02:44 volumio volumio[1137]: Express server listening on port 3000 Jan 20 22:02:44 volumio volumio[1137]: [Metrics] WebUI: 10s 265.41ms Jan 20 22:02:44 volumio volumio[1137]: info: CoreStateMachine::resetVolumioState Jan 20 22:02:44 volumio volumio[1137]: info: CoreStateMachine::getcurrentVolume Jan 20 22:02:44 volumio volumio[1137]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:02:44 volumio volumio[1137]: info: CoreStateMachine::pushState Jan 20 22:02:44 volumio volumio[1137]: info: CorePlayQueue::getTrack 0 Jan 20 22:02:44 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:02:44 volumio volumio[1137]: info: CoreCommandRouter::volumioPushState Jan 20 22:02:44 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:02:45 volumio volumio[1137]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 20 22:02:45 volumio volumio[1137]: info: Completed loading Core Plugins Jan 20 22:02:45 volumio volumio[1137]: info: Preparing to generate the ALSA configuration file Jan 20 22:02:45 volumio volumio[1137]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jan 20 22:02:45 volumio volumio[1137]: wlan0 Interface doesn't support scanning. Jan 20 22:02:45 volumio volumio[1137]: info: Cannot use regular scanning, forcing with ap-force Jan 20 22:02:45 volumio sudo[1256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jan 20 22:02:45 volumio sudo[1256]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:45 volumio sudo[1256]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:45 volumio volumio[1137]: command failed: No such device (-19) Jan 20 22:02:45 volumio volumio[1137]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jan 20 22:02:45 volumio volumio[1137]: command failed: No such device (-19) Jan 20 22:02:45 volumio volumio[1137]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jan 20 22:02:45 volumio volumio[1137]: info: Reloading queue from file Jan 20 22:02:45 volumio volumio[1137]: info: CoreStateMachine::setRepeat null single undefined Jan 20 22:02:45 volumio volumio[1137]: info: CoreStateMachine::pushState Jan 20 22:02:45 volumio volumio[1137]: info: CorePlayQueue::getTrack 0 Jan 20 22:02:45 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:02:45 volumio volumio[1137]: info: CoreCommandRouter::volumioPushState Jan 20 22:02:45 volumio volumio[1137]: info: CoreStateMachine::setRandom null Jan 20 22:02:45 volumio volumio[1137]: info: CoreStateMachine::pushState Jan 20 22:02:45 volumio volumio[1137]: info: CorePlayQueue::getTrack 0 Jan 20 22:02:45 volumio volumio[1137]: info: CoreCommandRouter::volumioPushState Jan 20 22:02:45 volumio volumio[1137]: info: Asound.conf file unchanged, so no further update is needed Jan 20 22:02:45 volumio volumio[1137]: info: Output device has changed, restarting MPD Jan 20 22:02:45 volumio volumio[1137]: info: Output device has changed, restarting Shairport Sync Jan 20 22:02:45 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:45 volumio sudo[1273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 22:02:45 volumio sudo[1273]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:45 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:02:45 volumio sudo[1273]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:45 volumio sudo[1276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 22:02:45 volumio sudo[1276]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:45 volumio volumio[1137]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:02:45 volumio systemd[1]: musicservicesshield.service: Succeeded. Jan 20 22:02:45 volumio volumio[1137]: info: ___________ START PLUGINS ___________ Jan 20 22:02:45 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Jan 20 22:02:45 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Jan 20 22:02:45 volumio systemd[1]: Stopping Music Player Daemon... Jan 20 22:02:45 volumio volumio[1137]: info: ControllerMpd::onStart: Initializing MPD Jan 20 22:02:45 volumio volumio[1137]: info: Creating MPD Configuration file Jan 20 22:02:45 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:02:45 volumio volumio[1137]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:02:45 volumio volumio[1137]: info: [1737381765741] CoreMusicLibrary::Adding element 媒体服务器 Jan 20 22:02:45 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:02:45 volumio sudo[1282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 22:02:45 volumio sudo[1282]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:45 volumio sudo[1282]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:45 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:45 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:02:45 volumio sudo[1285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 22:02:45 volumio sudo[1285]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:45 volumio systemd[1]: mpd.service: Succeeded. Jan 20 22:02:45 volumio systemd[1]: Stopped Music Player Daemon. Jan 20 22:02:45 volumio volumio[1137]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:02:45 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:45 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:02:45 volumio systemd[1]: Starting Music Player Daemon... Jan 20 22:02:45 volumio volumio[1137]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:02:45 volumio volumio[1137]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:02:45 volumio volumio[1137]: info: [1737381765931] CoreMusicLibrary::Adding element Last_100 Jan 20 22:02:45 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:02:45 volumio volumio[1137]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:02:45 volumio volumio[1137]: info: [1737381765937] CoreMusicLibrary::Adding element Webradio Jan 20 22:02:45 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:02:45 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:02:45 volumio volumio[1137]: info: Initializing BBC Radios Jan 20 22:02:46 volumio sudo[1290]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 20 22:02:46 volumio sudo[1290]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:46 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:02:46 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:02:46 volumio sudo[1290]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:46 volumio volumio[1137]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:02:46 volumio volumio[1137]: info: [1737381766068] CoreMusicLibrary::Adding element SoundCloud Jan 20 22:02:46 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:02:46 volumio volumio[1137]: Cannot find translation for source SoundCloud Jan 20 22:02:46 volumio volumio[1137]: info: [squeezelite_mc] Starting proxy server... Jan 20 22:02:46 volumio volumio[1137]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:02:46 volumio volumio[1137]: info: [1737381766107] CoreMusicLibrary::Adding element YouTube Music Jan 20 22:02:46 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:02:46 volumio volumio[1137]: Cannot find translation for source SoundCloud Jan 20 22:02:46 volumio volumio[1137]: Cannot find translation for source YouTube Music Jan 20 22:02:46 volumio volumio[1137]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:02:46 volumio volumio[1137]: info: [1737381766124] CoreMusicLibrary::Adding element Podcast Jan 20 22:02:46 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:02:46 volumio volumio[1137]: Cannot find translation for source SoundCloud Jan 20 22:02:46 volumio volumio[1137]: Cannot find translation for source YouTube Music Jan 20 22:02:46 volumio volumio[1137]: Cannot find translation for source Podcast Jan 20 22:02:46 volumio volumio[1137]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:02:46 volumio volumio[1137]: info: [1737381766135] CoreMusicLibrary::Adding element Radio Paradise Jan 20 22:02:46 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:02:46 volumio volumio[1137]: Cannot find translation for source SoundCloud Jan 20 22:02:46 volumio volumio[1137]: Cannot find translation for source YouTube Music Jan 20 22:02:46 volumio volumio[1137]: Cannot find translation for source Podcast Jan 20 22:02:46 volumio volumio[1137]: Cannot find translation for source Radio Paradise Jan 20 22:02:46 volumio volumio[1137]: info: Volumio Calling Home Jan 20 22:02:46 volumio sudo[1334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh Jan 20 22:02:46 volumio sudo[1334]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:46 volumio volumio[1137]: info: [squeezelite_mc] Proxy server started on port 41683 Jan 20 22:02:46 volumio volumio[1137]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:02:46 volumio volumio[1137]: info: CoreStateMachine::pushState Jan 20 22:02:46 volumio volumio[1137]: info: CorePlayQueue::getTrack 0 Jan 20 22:02:46 volumio volumio[1137]: info: CoreCommandRouter::volumioPushState Jan 20 22:02:46 volumio volumio[1137]: info: [squeezelite_mc] Server discovery started Jan 20 22:02:46 volumio volumio[1137]: info: [squeezelite_mc] Player finder started Jan 20 22:02:46 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:46 volumio volumio[1137]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:46 volumio volumio[1137]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"","card":"0","mixerType":"None","mixer":null} Jan 20 22:02:46 volumio volumio[1137]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Jan 20 22:02:46 volumio volumio[1137]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:02:46 volumio volumio[1137]: Error: send ENETUNREACH 255.255.255.255:3483 Jan 20 22:02:46 volumio volumio[1137]: at doSend (dgram.js:714:16) Jan 20 22:02:46 volumio volumio[1137]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:452:18) Jan 20 22:02:46 volumio volumio[1137]: at afterDns (dgram.js:660:5) Jan 20 22:02:46 volumio volumio[1137]: at processTicksAndRejections (internal/process/task_queues.js:83:21) { Jan 20 22:02:46 volumio volumio[1137]: errno: -101, Jan 20 22:02:46 volumio volumio[1137]: code: 'ENETUNREACH', Jan 20 22:02:46 volumio volumio[1137]: syscall: 'send', Jan 20 22:02:46 volumio volumio[1137]: address: '255.255.255.255', Jan 20 22:02:46 volumio volumio[1137]: port: 3483 Jan 20 22:02:46 volumio volumio[1137]: } Jan 20 22:02:46 volumio volumio[1137]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:02:47 volumio sudo[1348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Jan 20 22:02:47 volumio sudo[1348]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:47 volumio sudo[1348]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:47 volumio sudo[1334]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:47 volumio sudo[1371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-20 22:01 Jan 20 22:02:47 volumio sudo[1371]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:48 volumio sudo[1371]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:48 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 20 22:02:48 volumio sudo[1285]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:48 volumio sudo[1276]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:48 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 20 22:02:48 volumio systemd[1]: Started dynamicswap service. Jan 20 22:02:48 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 20 22:02:48 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 20 22:02:48 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Jan 20 22:02:48 volumio systemd[1]: Started dynamicswap service. Jan 20 22:02:48 volumio systemd[1]: Stopped Volumio Backend Module. Jan 20 22:02:48 volumio systemd[1]: Started Volumio Backend Module. Jan 20 22:02:48 volumio mpd[1306]: Jan 20 22:02 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 20 22:02:48 volumio systemd[1]: Started Music Player Daemon. Jan 20 22:02:48 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 20 22:02:48 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Jan 20 22:02:49 volumio volumio[1393]: cset: --> shielding system active with Jan 20 22:02:49 volumio volumio[1393]: cset: "system" cpuset of CPUSPEC(2-3) with 37 tasks running Jan 20 22:02:49 volumio volumio[1393]: cset: "user" cpuset of CPUSPEC(0-1) with 3 tasks running Jan 20 22:02:49 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Jan 20 22:02:50 volumio volumio-remote-updater[664]: [2025-01-20 22:02:50] [connect] Successful connection Jan 20 22:02:50 volumio volumio[1385]: info: ------------------------------------------- Jan 20 22:02:50 volumio volumio[1385]: info: ----- Volumio3 ---- Jan 20 22:02:50 volumio volumio[1385]: info: ------------------------------------------- Jan 20 22:02:50 volumio volumio[1385]: info: ----- System startup ---- Jan 20 22:02:50 volumio volumio[1385]: info: ------------------------------------------- Jan 20 22:02:51 volumio volumio[1385]: info: MYVOLUMIO Environment detected Jan 20 22:02:51 volumio volumio[1385]: info: Plugin folders cleanup Jan 20 22:02:51 volumio volumio[1385]: info: Scanning into folder /volumio/app/plugins/ Jan 20 22:02:51 volumio volumio[1385]: info: Scanning category audio_interface Jan 20 22:02:51 volumio volumio[1385]: info: Scanning category miscellanea Jan 20 22:02:51 volumio volumio[1385]: info: Scanning category music_service Jan 20 22:02:51 volumio volumio[1385]: info: Scanning category plugins.json Jan 20 22:02:51 volumio volumio[1385]: info: Scanning category system_controller Jan 20 22:02:51 volumio volumio[1385]: info: Scanning category user_interface Jan 20 22:02:51 volumio volumio[1385]: info: Scanning into folder /data/plugins/ Jan 20 22:02:51 volumio volumio[1385]: info: Scanning category music_service Jan 20 22:02:51 volumio volumio[1385]: info: Scanning category system_hardware Jan 20 22:02:51 volumio volumio[1385]: info: Scanning category user_interface Jan 20 22:02:51 volumio volumio[1385]: info: Plugin folders cleanup completed Jan 20 22:02:51 volumio volumio[1385]: info: ------------------------------------------- Jan 20 22:02:51 volumio volumio[1385]: info: ----- Core plugins startup ---- Jan 20 22:02:51 volumio volumio[1385]: info: ------------------------------------------- Jan 20 22:02:51 volumio volumio[1385]: info: Loading plugins from folder /volumio/app/plugins/ Jan 20 22:02:51 volumio volumio[1385]: info: Adding plugin upnp to MyMusic Plugins Jan 20 22:02:51 volumio volumio[1385]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 20 22:02:51 volumio volumio[1385]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 20 22:02:51 volumio volumio[1385]: info: Loading plugins from folder /data/plugins/ Jan 20 22:02:51 volumio volumio[1385]: info: Loading plugin "system"... Jan 20 22:02:51 volumio volumio[1385]: info: Loading plugin "appearance"... Jan 20 22:02:52 volumio volumio[1385]: info: Loading plugin "network"... Jan 20 22:02:52 volumio volumio[1385]: info: Refreshing Cached IP Addresses Jan 20 22:02:52 volumio sudo[1434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 20 22:02:52 volumio sudo[1434]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:52 volumio sudo[1434]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:52 volumio volumio[1385]: info: Loading plugin "services"... Jan 20 22:02:52 volumio volumio[1385]: info: Loading plugin "alsa_controller"... Jan 20 22:02:52 volumio sudo[1436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 20 22:02:52 volumio sudo[1436]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:52 volumio sudo[1439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 20 22:02:52 volumio sudo[1439]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:02:52 volumio sudo[1436]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:52 volumio sudo[1439]: pam_unix(sudo:session): session closed for user root Jan 20 22:02:52 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:02:52 volumio volumio[1385]: info: Loading plugin "wizard"... Jan 20 22:02:53 volumio volumio[1385]: info: Loading plugin "networkfs"... Jan 20 22:02:53 volumio volumio[1385]: info: Starting Udev Watcher for removable devices Jan 20 22:02:53 volumio volumio[1385]: info: Ignoring mount for partition: boot Jan 20 22:02:53 volumio volumio[1385]: info: Ignoring mount for partition: volumio Jan 20 22:02:53 volumio volumio[1385]: info: Ignoring mount for partition: volumio_data Jan 20 22:02:53 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:02:53 volumio volumio[1385]: info: Loading plugin "volumio_command_line_client"... Jan 20 22:02:53 volumio volumio[1385]: info: Loading plugin "upnp"... Jan 20 22:02:53 volumio volumio[1385]: info: [1737381773080] Starting Upmpd Daemon Jan 20 22:02:53 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:02:53 volumio volumio[1385]: info: Loading plugin "my_music"... Jan 20 22:02:53 volumio volumio[1385]: info: Loading plugin "mpd"... Jan 20 22:02:53 volumio volumio[1385]: info: Loading plugin "upnp_browser"... Jan 20 22:02:53 volumio volumio[1385]: info: Loading plugin "alarm-clock"... Jan 20 22:02:53 volumio volumio[1385]: info: Loading plugin "airplay_emulation"... Jan 20 22:02:53 volumio volumio[1385]: info: Starting Shairport Sync Jan 20 22:02:53 volumio volumio[1385]: info: Loading plugin "last_100"... Jan 20 22:02:54 volumio volumio[1385]: info: Loading plugin "webradio"... Jan 20 22:02:54 volumio volumio[1385]: info: Loading plugin "i2s_dacs"... Jan 20 22:02:54 volumio volumio[1385]: info: I2S DAC not set, start Auto-detection Jan 20 22:02:54 volumio volumio[1385]: info: Loading plugin "volumiodiscovery"... Jan 20 22:02:54 volumio volumio[1385]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 20 22:02:54 volumio volumio[1385]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:02:54 volumio node[1385]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 20 22:02:54 volumio volumio[1385]: *** WARNING *** For more information see Jan 20 22:02:54 volumio volumio[1385]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 20 22:02:54 volumio volumio[1385]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:02:54 volumio volumio[1385]: *** WARNING *** For more information see Jan 20 22:02:54 volumio node[1385]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:02:54 volumio node[1385]: *** WARNING *** For more information see Jan 20 22:02:54 volumio node[1385]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 20 22:02:54 volumio node[1385]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:02:54 volumio node[1385]: *** WARNING *** For more information see Jan 20 22:02:54 volumio volumio[1385]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 20 22:02:54 volumio volumio[1385]: info: Discovery: Started advertising with name: Volumio Jan 20 22:02:54 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:02:54 volumio volumio[1385]: info: Loading plugin "soundcloud"... Jan 20 22:02:54 volumio volumio[1385]: info: Loading plugin "squeezelite_mc"... Jan 20 22:02:55 volumio volumio[1385]: info: Loading plugin "ytmusic"... Jan 20 22:02:56 volumio volumio[1385]: info: Loading plugin "outputs"... Jan 20 22:02:56 volumio volumio[1385]: info: Loading plugin "albumart"... Jan 20 22:02:56 volumio volumio[1385]: info: Plugin example_plugin is not enabled Jan 20 22:02:56 volumio volumio[1385]: info: Loading plugin "inputs"... Jan 20 22:02:56 volumio volumio[1385]: info: Loading plugin "updater_comm"... Jan 20 22:02:56 volumio volumio[1385]: info: Plugin mpdemulation is not enabled Jan 20 22:02:56 volumio volumio[1385]: info: Loading plugin "rest_api"... Jan 20 22:02:56 volumio volumio[1385]: info: Loading plugin "websocket"... Jan 20 22:02:56 volumio volumio[1385]: info: Starting Socket.io Server version 2.3.0 Jan 20 22:02:56 volumio volumio[1385]: info: Loading plugin "podcast"... Jan 20 22:02:57 volumio volumio[1385]: info: ControllerPodcast::constructor Jan 20 22:02:57 volumio volumio[1385]: Forking 3 albumart workers Jan 20 22:02:57 volumio volumio[1385]: info: Loading plugin "radio_paradise"... Jan 20 22:02:57 volumio volumio[1385]: info: Applying required configuration parameters for plugin radio_paradise Jan 20 22:02:57 volumio volumio[1385]: info: [1737381777765] [RadioParadise] API delay: 5 Jan 20 22:02:57 volumio volumio[1385]: info: Loading plugin "music_services_shield"... Jan 20 22:02:58 volumio volumio[1385]: info: Applying required configuration parameters for plugin music_services_shield Jan 20 22:02:58 volumio volumio[1385]: info: Loading plugin "Systeminfo"... Jan 20 22:02:59 volumio volumio[1385]: Starting albumart workers Jan 20 22:02:59 volumio volumio[1385]: Starting albumart workers Jan 20 22:02:59 volumio volumio[1385]: info: Loading i18n strings for locale zh Jan 20 22:02:59 volumio volumio[1385]: Updating browse sources language Jan 20 22:02:59 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:02:59 volumio volumio[1385]: Starting albumart workers Jan 20 22:02:59 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:02:59 volumio volumio[1385]: info: CoreCommandRouter::initPlayerControls Jan 20 22:02:59 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:59 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:59 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:59 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:59 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:59 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:59 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:59 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:02:59 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:02:59 volumio volumio[1385]: Express server listening on port 3000 Jan 20 22:02:59 volumio volumio[1385]: [Metrics] WebUI: 9s 714.35ms Jan 20 22:02:59 volumio volumio[1385]: info: CoreStateMachine::resetVolumioState Jan 20 22:02:59 volumio volumio[1385]: info: CoreStateMachine::getcurrentVolume Jan 20 22:02:59 volumio volumio[1385]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:02:59 volumio volumio[1385]: info: CoreStateMachine::pushState Jan 20 22:02:59 volumio volumio[1385]: info: CorePlayQueue::getTrack 0 Jan 20 22:02:59 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:02:59 volumio volumio[1385]: info: CoreCommandRouter::volumioPushState Jan 20 22:02:59 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:02:59 volumio volumio[1385]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 20 22:02:59 volumio volumio[1385]: info: Completed loading Core Plugins Jan 20 22:02:59 volumio volumio[1385]: info: Preparing to generate the ALSA configuration file Jan 20 22:03:00 volumio volumio[1385]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jan 20 22:03:00 volumio volumio[1385]: wlan0 Interface doesn't support scanning. Jan 20 22:03:00 volumio volumio[1385]: info: Cannot use regular scanning, forcing with ap-force Jan 20 22:03:00 volumio sudo[1488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jan 20 22:03:00 volumio sudo[1488]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:00 volumio sudo[1488]: pam_unix(sudo:session): session closed for user root Jan 20 22:03:00 volumio volumio[1385]: command failed: No such device (-19) Jan 20 22:03:00 volumio volumio[1385]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jan 20 22:03:00 volumio volumio[1385]: command failed: No such device (-19) Jan 20 22:03:00 volumio volumio[1385]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jan 20 22:03:00 volumio volumio[1385]: info: Reloading queue from file Jan 20 22:03:00 volumio volumio[1385]: info: CoreStateMachine::setRepeat null single undefined Jan 20 22:03:00 volumio volumio[1385]: info: CoreStateMachine::pushState Jan 20 22:03:00 volumio volumio[1385]: info: CorePlayQueue::getTrack 0 Jan 20 22:03:00 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:03:00 volumio volumio[1385]: info: CoreCommandRouter::volumioPushState Jan 20 22:03:00 volumio volumio[1385]: info: CoreStateMachine::setRandom null Jan 20 22:03:00 volumio volumio[1385]: info: CoreStateMachine::pushState Jan 20 22:03:00 volumio volumio[1385]: info: CorePlayQueue::getTrack 0 Jan 20 22:03:00 volumio volumio[1385]: info: CoreCommandRouter::volumioPushState Jan 20 22:03:00 volumio volumio[1385]: info: Asound.conf file unchanged, so no further update is needed Jan 20 22:03:00 volumio volumio[1385]: info: Output device has changed, restarting MPD Jan 20 22:03:00 volumio volumio[1385]: info: Output device has changed, restarting Shairport Sync Jan 20 22:03:00 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:03:00 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:03:00 volumio sudo[1522]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 22:03:00 volumio sudo[1522]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:00 volumio sudo[1523]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 22:03:00 volumio sudo[1522]: pam_unix(sudo:session): session closed for user root Jan 20 22:03:00 volumio sudo[1523]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:00 volumio volumio[1385]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:03:00 volumio volumio[1385]: info: ___________ START PLUGINS ___________ Jan 20 22:03:00 volumio systemd[1]: musicservicesshield.service: Succeeded. Jan 20 22:03:00 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Jan 20 22:03:00 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Jan 20 22:03:00 volumio systemd[1]: Stopping Music Player Daemon... Jan 20 22:03:00 volumio volumio[1385]: info: ControllerMpd::onStart: Initializing MPD Jan 20 22:03:00 volumio volumio[1385]: info: Creating MPD Configuration file Jan 20 22:03:00 volumio systemd[1]: mpd.service: Succeeded. Jan 20 22:03:00 volumio systemd[1]: Stopped Music Player Daemon. Jan 20 22:03:00 volumio sudo[1530]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 22:03:00 volumio sudo[1530]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:00 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:03:00 volumio volumio[1385]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:03:00 volumio volumio[1385]: info: [1737381780948] CoreMusicLibrary::Adding element 媒体服务器 Jan 20 22:03:00 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:03:00 volumio sudo[1530]: pam_unix(sudo:session): session closed for user root Jan 20 22:03:00 volumio systemd[1]: Starting Music Player Daemon... Jan 20 22:03:00 volumio sudo[1534]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 22:03:00 volumio sudo[1534]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:03:01 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 20 22:03:01 volumio systemd[1]: mpd.service: Succeeded. Jan 20 22:03:01 volumio systemd[1]: Stopped Music Player Daemon. Jan 20 22:03:01 volumio volumio[1385]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:03:01 volumio systemd[1]: Starting Music Player Daemon... Jan 20 22:03:01 volumio volumio[1385]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:03:01 volumio volumio[1385]: info: [1737381781149] CoreMusicLibrary::Adding element Last_100 Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:03:01 volumio volumio[1385]: info: [1737381781155] CoreMusicLibrary::Adding element Webradio Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:03:01 volumio volumio[1385]: info: Initializing BBC Radios Jan 20 22:03:01 volumio sudo[1540]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 20 22:03:01 volumio sudo[1540]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:01 volumio sudo[1540]: pam_unix(sudo:session): session closed for user root Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:03:01 volumio volumio[1385]: info: [1737381781289] CoreMusicLibrary::Adding element SoundCloud Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:03:01 volumio volumio[1385]: Cannot find translation for source SoundCloud Jan 20 22:03:01 volumio volumio[1385]: info: [squeezelite_mc] Starting proxy server... Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:03:01 volumio volumio[1385]: info: [1737381781327] CoreMusicLibrary::Adding element YouTube Music Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:03:01 volumio volumio[1385]: Cannot find translation for source SoundCloud Jan 20 22:03:01 volumio volumio[1385]: Cannot find translation for source YouTube Music Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:03:01 volumio volumio[1385]: info: [1737381781342] CoreMusicLibrary::Adding element Podcast Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:03:01 volumio volumio[1385]: Cannot find translation for source SoundCloud Jan 20 22:03:01 volumio volumio[1385]: Cannot find translation for source YouTube Music Jan 20 22:03:01 volumio volumio[1385]: Cannot find translation for source Podcast Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:03:01 volumio volumio[1385]: info: [1737381781352] CoreMusicLibrary::Adding element Radio Paradise Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:03:01 volumio volumio[1385]: Cannot find translation for source SoundCloud Jan 20 22:03:01 volumio volumio[1385]: Cannot find translation for source YouTube Music Jan 20 22:03:01 volumio volumio[1385]: Cannot find translation for source Podcast Jan 20 22:03:01 volumio volumio[1385]: Cannot find translation for source Radio Paradise Jan 20 22:03:01 volumio volumio[1385]: info: Volumio Calling Home Jan 20 22:03:01 volumio sudo[1583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh Jan 20 22:03:01 volumio sudo[1583]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:01 volumio volumio[1385]: info: [squeezelite_mc] Proxy server started on port 35161 Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:03:01 volumio volumio[1385]: info: CoreStateMachine::pushState Jan 20 22:03:01 volumio volumio[1385]: info: CorePlayQueue::getTrack 0 Jan 20 22:03:01 volumio volumio[1385]: info: CoreCommandRouter::volumioPushState Jan 20 22:03:01 volumio volumio[1385]: info: [squeezelite_mc] Server discovery started Jan 20 22:03:02 volumio volumio[1385]: info: [squeezelite_mc] Player finder started Jan 20 22:03:02 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:03:02 volumio volumio[1385]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:03:02 volumio volumio[1385]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"","card":"0","mixerType":"None","mixer":null} Jan 20 22:03:02 volumio volumio[1385]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Jan 20 22:03:02 volumio volumio[1385]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:03:02 volumio volumio[1385]: Error: send ENETUNREACH 255.255.255.255:3483 Jan 20 22:03:02 volumio volumio[1385]: at doSend (dgram.js:714:16) Jan 20 22:03:02 volumio volumio[1385]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:452:18) Jan 20 22:03:02 volumio volumio[1385]: at afterDns (dgram.js:660:5) Jan 20 22:03:02 volumio volumio[1385]: at processTicksAndRejections (internal/process/task_queues.js:83:21) { Jan 20 22:03:02 volumio volumio[1385]: errno: -101, Jan 20 22:03:02 volumio volumio[1385]: code: 'ENETUNREACH', Jan 20 22:03:02 volumio volumio[1385]: syscall: 'send', Jan 20 22:03:02 volumio volumio[1385]: address: '255.255.255.255', Jan 20 22:03:02 volumio volumio[1385]: port: 3483 Jan 20 22:03:02 volumio volumio[1385]: } Jan 20 22:03:02 volumio volumio[1385]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:03:02 volumio sudo[1597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Jan 20 22:03:02 volumio sudo[1597]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:02 volumio sudo[1597]: pam_unix(sudo:session): session closed for user root Jan 20 22:03:03 volumio sudo[1583]: pam_unix(sudo:session): session closed for user root Jan 20 22:03:03 volumio sudo[1620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-20 22:02 Jan 20 22:03:03 volumio sudo[1620]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:03 volumio sudo[1620]: pam_unix(sudo:session): session closed for user root Jan 20 22:03:03 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 20 22:03:03 volumio sudo[1534]: pam_unix(sudo:session): session closed for user root Jan 20 22:03:03 volumio sudo[1523]: pam_unix(sudo:session): session closed for user root Jan 20 22:03:03 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 20 22:03:03 volumio systemd[1]: Started dynamicswap service. Jan 20 22:03:03 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 20 22:03:03 volumio mpd[1551]: Jan 20 22:03 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 20 22:03:03 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 20 22:03:03 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Jan 20 22:03:03 volumio systemd[1]: Started Music Player Daemon. Jan 20 22:03:03 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Jan 20 22:03:03 volumio systemd[1]: Stopped Volumio Backend Module. Jan 20 22:03:03 volumio systemd[1]: Started Volumio Backend Module. Jan 20 22:03:03 volumio systemd[1]: Started dynamicswap service. Jan 20 22:03:03 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 20 22:03:04 volumio volumio[1635]: cset: --> shielding system active with Jan 20 22:03:04 volumio volumio[1635]: cset: "system" cpuset of CPUSPEC(2-3) with 37 tasks running Jan 20 22:03:04 volumio volumio[1635]: cset: "user" cpuset of CPUSPEC(0-1) with 3 tasks running Jan 20 22:03:04 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Jan 20 22:03:05 volumio volumio-remote-updater[664]: [2025-01-20 22:03:05] [connect] Successful connection Jan 20 22:03:05 volumio volumio[1636]: info: ------------------------------------------- Jan 20 22:03:05 volumio volumio[1636]: info: ----- Volumio3 ---- Jan 20 22:03:05 volumio volumio[1636]: info: ------------------------------------------- Jan 20 22:03:05 volumio volumio[1636]: info: ----- System startup ---- Jan 20 22:03:05 volumio volumio[1636]: info: ------------------------------------------- Jan 20 22:03:06 volumio volumio[1636]: info: MYVOLUMIO Environment detected Jan 20 22:03:06 volumio volumio[1636]: info: Plugin folders cleanup Jan 20 22:03:06 volumio volumio[1636]: info: Scanning into folder /volumio/app/plugins/ Jan 20 22:03:06 volumio volumio[1636]: info: Scanning category audio_interface Jan 20 22:03:06 volumio volumio[1636]: info: Scanning category miscellanea Jan 20 22:03:06 volumio volumio[1636]: info: Scanning category music_service Jan 20 22:03:06 volumio volumio[1636]: info: Scanning category plugins.json Jan 20 22:03:06 volumio volumio[1636]: info: Scanning category system_controller Jan 20 22:03:06 volumio volumio[1636]: info: Scanning category user_interface Jan 20 22:03:06 volumio volumio[1636]: info: Scanning into folder /data/plugins/ Jan 20 22:03:06 volumio volumio[1636]: info: Scanning category music_service Jan 20 22:03:06 volumio volumio[1636]: info: Scanning category system_hardware Jan 20 22:03:06 volumio volumio[1636]: info: Scanning category user_interface Jan 20 22:03:06 volumio volumio[1636]: info: Plugin folders cleanup completed Jan 20 22:03:06 volumio volumio[1636]: info: ------------------------------------------- Jan 20 22:03:06 volumio volumio[1636]: info: ----- Core plugins startup ---- Jan 20 22:03:06 volumio volumio[1636]: info: ------------------------------------------- Jan 20 22:03:06 volumio volumio[1636]: info: Loading plugins from folder /volumio/app/plugins/ Jan 20 22:03:06 volumio volumio[1636]: info: Adding plugin upnp to MyMusic Plugins Jan 20 22:03:06 volumio volumio[1636]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 20 22:03:06 volumio volumio[1636]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 20 22:03:06 volumio volumio[1636]: info: Loading plugins from folder /data/plugins/ Jan 20 22:03:06 volumio volumio[1636]: info: Loading plugin "system"... Jan 20 22:03:06 volumio volumio[1636]: info: Loading plugin "appearance"... Jan 20 22:03:08 volumio volumio[1636]: info: Loading plugin "network"... Jan 20 22:03:08 volumio volumio[1636]: info: Refreshing Cached IP Addresses Jan 20 22:03:08 volumio sudo[1683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 20 22:03:08 volumio sudo[1683]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:08 volumio volumio[1636]: info: Loading plugin "services"... Jan 20 22:03:08 volumio volumio[1636]: info: Loading plugin "alsa_controller"... Jan 20 22:03:08 volumio sudo[1686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 20 22:03:08 volumio sudo[1683]: pam_unix(sudo:session): session closed for user root Jan 20 22:03:08 volumio sudo[1688]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 20 22:03:08 volumio sudo[1686]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:08 volumio sudo[1688]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:08 volumio sudo[1688]: pam_unix(sudo:session): session closed for user root Jan 20 22:03:08 volumio sudo[1686]: pam_unix(sudo:session): session closed for user root Jan 20 22:03:08 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:03:08 volumio volumio[1636]: info: Loading plugin "wizard"... Jan 20 22:03:08 volumio volumio[1636]: info: Loading plugin "networkfs"... Jan 20 22:03:08 volumio volumio[1636]: info: Starting Udev Watcher for removable devices Jan 20 22:03:08 volumio volumio[1636]: info: Ignoring mount for partition: boot Jan 20 22:03:08 volumio volumio[1636]: info: Ignoring mount for partition: volumio Jan 20 22:03:08 volumio volumio[1636]: info: Ignoring mount for partition: volumio_data Jan 20 22:03:08 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:03:08 volumio volumio[1636]: info: Loading plugin "volumio_command_line_client"... Jan 20 22:03:08 volumio volumio[1636]: info: Loading plugin "upnp"... Jan 20 22:03:08 volumio volumio[1636]: info: [1737381788318] Starting Upmpd Daemon Jan 20 22:03:08 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:03:08 volumio volumio[1636]: info: Loading plugin "my_music"... Jan 20 22:03:08 volumio volumio[1636]: info: Loading plugin "mpd"... Jan 20 22:03:08 volumio volumio[1636]: info: Loading plugin "upnp_browser"... Jan 20 22:03:09 volumio volumio[1636]: info: Loading plugin "alarm-clock"... Jan 20 22:03:09 volumio volumio[1636]: info: Loading plugin "airplay_emulation"... Jan 20 22:03:09 volumio volumio[1636]: info: Starting Shairport Sync Jan 20 22:03:09 volumio volumio[1636]: info: Loading plugin "last_100"... Jan 20 22:03:09 volumio volumio[1636]: info: Loading plugin "webradio"... Jan 20 22:03:09 volumio volumio[1636]: info: Loading plugin "i2s_dacs"... Jan 20 22:03:09 volumio volumio[1636]: info: I2S DAC not set, start Auto-detection Jan 20 22:03:09 volumio volumio[1636]: info: Loading plugin "volumiodiscovery"... Jan 20 22:03:09 volumio volumio[1636]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 20 22:03:09 volumio volumio[1636]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:03:09 volumio node[1636]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 20 22:03:09 volumio volumio[1636]: *** WARNING *** For more information see Jan 20 22:03:09 volumio volumio[1636]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 20 22:03:09 volumio volumio[1636]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:03:09 volumio volumio[1636]: *** WARNING *** For more information see Jan 20 22:03:09 volumio node[1636]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:03:09 volumio node[1636]: *** WARNING *** For more information see Jan 20 22:03:09 volumio node[1636]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 20 22:03:09 volumio node[1636]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 20 22:03:09 volumio node[1636]: *** WARNING *** For more information see Jan 20 22:03:09 volumio volumio[1636]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 20 22:03:09 volumio volumio[1636]: info: Discovery: Started advertising with name: Volumio Jan 20 22:03:09 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 20 22:03:09 volumio volumio[1636]: info: Loading plugin "soundcloud"... Jan 20 22:03:09 volumio volumio[1636]: info: Loading plugin "squeezelite_mc"... Jan 20 22:03:10 volumio volumio[1636]: info: Loading plugin "ytmusic"... Jan 20 22:03:11 volumio kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Jan 20 22:03:11 volumio dhcpcd[742]: eth0: carrier acquired Jan 20 22:03:11 volumio dhcpcd[742]: eth0: IAID 9c:a0:52:24 Jan 20 22:03:11 volumio volumio[1636]: info: Loading plugin "outputs"... Jan 20 22:03:11 volumio volumio[1636]: info: Loading plugin "albumart"... Jan 20 22:03:12 volumio volumio[1636]: info: Plugin example_plugin is not enabled Jan 20 22:03:12 volumio volumio[1636]: info: Loading plugin "inputs"... Jan 20 22:03:12 volumio volumio[1636]: info: Loading plugin "updater_comm"... Jan 20 22:03:12 volumio dhcpcd[742]: eth0: soliciting a DHCP lease Jan 20 22:03:12 volumio dhcpcd[742]: eth0: offered 192.168.2.32 from 192.168.2.1 Jan 20 22:03:12 volumio dhcpcd[742]: eth0: probing address 192.168.2.32/24 Jan 20 22:03:12 volumio volumio[1636]: info: Plugin mpdemulation is not enabled Jan 20 22:03:12 volumio volumio[1636]: info: Loading plugin "rest_api"... Jan 20 22:03:12 volumio volumio[1636]: info: Loading plugin "websocket"... Jan 20 22:03:12 volumio volumio[1636]: info: Starting Socket.io Server version 2.3.0 Jan 20 22:03:12 volumio volumio[1636]: info: Loading plugin "podcast"... Jan 20 22:03:12 volumio dhcpcd[742]: eth0: soliciting an IPv6 router Jan 20 22:03:12 volumio ifplugd(eth0)[860]: Link beat detected. Jan 20 22:03:12 volumio volumio[1636]: Forking 3 albumart workers Jan 20 22:03:12 volumio volumio[1636]: info: ControllerPodcast::constructor Jan 20 22:03:12 volumio ifplugd(eth0)[860]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Jan 20 22:03:12 volumio ifplugd(eth0)[860]: client: command failed: No such device (-19) Jan 20 22:03:12 volumio ifplugd(eth0)[860]: client: sending commands to master dhcpcd process Jan 20 22:03:12 volumio dhcpcd[1769]: sending commands to master dhcpcd process Jan 20 22:03:12 volumio dhcpcd[742]: control command: /sbin/dhcpcd eth0 Jan 20 22:03:12 volumio volumio[1636]: info: Loading plugin "radio_paradise"... Jan 20 22:03:13 volumio ifplugd(eth0)[860]: Program executed successfully. Jan 20 22:03:13 volumio volumio[1636]: info: Applying required configuration parameters for plugin radio_paradise Jan 20 22:03:13 volumio volumio[1636]: info: [1737381793399] [RadioParadise] API delay: 5 Jan 20 22:03:13 volumio volumio[1636]: info: Loading plugin "music_services_shield"... Jan 20 22:03:13 volumio volumio[1636]: info: Applying required configuration parameters for plugin music_services_shield Jan 20 22:03:13 volumio volumio[1636]: info: Loading plugin "Systeminfo"... Jan 20 22:03:14 volumio volumio[1636]: Starting albumart workers Jan 20 22:03:14 volumio volumio[1636]: info: Loading i18n strings for locale zh Jan 20 22:03:14 volumio volumio[1636]: Updating browse sources language Jan 20 22:03:14 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:03:14 volumio volumio[1636]: Starting albumart workers Jan 20 22:03:14 volumio volumio[1636]: Starting albumart workers Jan 20 22:03:14 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:03:14 volumio volumio[1636]: info: CoreCommandRouter::initPlayerControls Jan 20 22:03:14 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:03:14 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:03:14 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:03:14 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:03:14 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:03:14 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:03:14 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:03:14 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:03:14 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:03:14 volumio volumio[1636]: Express server listening on port 3000 Jan 20 22:03:14 volumio volumio[1636]: [Metrics] WebUI: 9s 712.80ms Jan 20 22:03:15 volumio volumio[1636]: info: CoreStateMachine::resetVolumioState Jan 20 22:03:15 volumio volumio[1636]: info: CoreStateMachine::getcurrentVolume Jan 20 22:03:15 volumio volumio[1636]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:03:15 volumio volumio[1636]: info: CoreStateMachine::pushState Jan 20 22:03:15 volumio volumio[1636]: info: CorePlayQueue::getTrack 0 Jan 20 22:03:15 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:03:15 volumio volumio[1636]: info: CoreCommandRouter::volumioPushState Jan 20 22:03:15 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:03:15 volumio volumio[1636]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 20 22:03:15 volumio volumio[1636]: info: Completed loading Core Plugins Jan 20 22:03:15 volumio volumio[1636]: info: Preparing to generate the ALSA configuration file Jan 20 22:03:15 volumio volumio[1636]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jan 20 22:03:15 volumio volumio[1636]: wlan0 Interface doesn't support scanning. Jan 20 22:03:15 volumio volumio[1636]: info: Cannot use regular scanning, forcing with ap-force Jan 20 22:03:15 volumio sudo[1816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jan 20 22:03:15 volumio sudo[1816]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:15 volumio sudo[1816]: pam_unix(sudo:session): session closed for user root Jan 20 22:03:15 volumio volumio[1636]: command failed: No such device (-19) Jan 20 22:03:15 volumio volumio[1636]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jan 20 22:03:15 volumio volumio[1636]: command failed: No such device (-19) Jan 20 22:03:15 volumio volumio[1636]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jan 20 22:03:16 volumio volumio[1636]: info: Reloading queue from file Jan 20 22:03:16 volumio volumio[1636]: info: CoreStateMachine::setRepeat null single undefined Jan 20 22:03:16 volumio volumio[1636]: info: CoreStateMachine::pushState Jan 20 22:03:16 volumio volumio[1636]: info: CorePlayQueue::getTrack 0 Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::volumioPushState Jan 20 22:03:16 volumio volumio[1636]: info: CoreStateMachine::setRandom null Jan 20 22:03:16 volumio volumio[1636]: info: CoreStateMachine::pushState Jan 20 22:03:16 volumio volumio[1636]: info: CorePlayQueue::getTrack 0 Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::volumioPushState Jan 20 22:03:16 volumio volumio[1636]: info: Asound.conf file unchanged, so no further update is needed Jan 20 22:03:16 volumio volumio[1636]: info: Output device has changed, restarting MPD Jan 20 22:03:16 volumio ntpd[855]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jan 20 22:03:16 volumio volumio[1636]: info: Output device has changed, restarting Shairport Sync Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:03:16 volumio sudo[1841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 22:03:16 volumio sudo[1841]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:16 volumio sudo[1841]: pam_unix(sudo:session): session closed for user root Jan 20 22:03:16 volumio sudo[1843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 22:03:16 volumio sudo[1843]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:16 volumio systemd[1]: musicservicesshield.service: Succeeded. Jan 20 22:03:16 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Jan 20 22:03:16 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Jan 20 22:03:16 volumio systemd[1]: Stopping Music Player Daemon... Jan 20 22:03:16 volumio volumio[1636]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:03:16 volumio volumio[1636]: info: ___________ START PLUGINS ___________ Jan 20 22:03:16 volumio volumio[1636]: info: ControllerMpd::onStart: Initializing MPD Jan 20 22:03:16 volumio volumio[1636]: info: Creating MPD Configuration file Jan 20 22:03:16 volumio systemd[1]: mpd.service: Succeeded. Jan 20 22:03:16 volumio systemd[1]: Stopped Music Player Daemon. Jan 20 22:03:16 volumio sudo[1851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 20 22:03:16 volumio systemd[1]: Starting Music Player Daemon... Jan 20 22:03:16 volumio sudo[1851]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:16 volumio sudo[1851]: pam_unix(sudo:session): session closed for user root Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:03:16 volumio volumio[1636]: info: [1737381796484] CoreMusicLibrary::Adding element 媒体服务器 Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:03:16 volumio sudo[1854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 20 22:03:16 volumio sudo[1854]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:03:16 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 20 22:03:16 volumio systemd[1]: mpd.service: Succeeded. Jan 20 22:03:16 volumio systemd[1]: Stopped Music Player Daemon. Jan 20 22:03:16 volumio systemd[1]: Starting Music Player Daemon... Jan 20 22:03:16 volumio volumio[1636]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:03:16 volumio volumio[1636]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:03:16 volumio volumio[1636]: info: [1737381796684] CoreMusicLibrary::Adding element Last_100 Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:03:16 volumio volumio[1636]: info: [1737381796690] CoreMusicLibrary::Adding element Webradio Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:03:16 volumio volumio[1636]: info: Initializing BBC Radios Jan 20 22:03:16 volumio sudo[1859]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 20 22:03:16 volumio sudo[1859]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:16 volumio sudo[1859]: pam_unix(sudo:session): session closed for user root Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:03:16 volumio volumio[1636]: info: [1737381796818] CoreMusicLibrary::Adding element SoundCloud Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:03:16 volumio volumio[1636]: Cannot find translation for source SoundCloud Jan 20 22:03:16 volumio volumio[1636]: info: [squeezelite_mc] Starting proxy server... Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:03:16 volumio volumio[1636]: info: [1737381796855] CoreMusicLibrary::Adding element YouTube Music Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:03:16 volumio volumio[1636]: Cannot find translation for source SoundCloud Jan 20 22:03:16 volumio volumio[1636]: Cannot find translation for source YouTube Music Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:03:16 volumio volumio[1636]: info: [1737381796871] CoreMusicLibrary::Adding element Podcast Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:03:16 volumio volumio[1636]: Cannot find translation for source SoundCloud Jan 20 22:03:16 volumio volumio[1636]: Cannot find translation for source YouTube Music Jan 20 22:03:16 volumio volumio[1636]: Cannot find translation for source Podcast Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 20 22:03:16 volumio volumio[1636]: info: [1737381796881] CoreMusicLibrary::Adding element Radio Paradise Jan 20 22:03:16 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 20 22:03:16 volumio volumio[1636]: Cannot find translation for source SoundCloud Jan 20 22:03:16 volumio volumio[1636]: Cannot find translation for source YouTube Music Jan 20 22:03:16 volumio volumio[1636]: Cannot find translation for source Podcast Jan 20 22:03:16 volumio volumio[1636]: Cannot find translation for source Radio Paradise Jan 20 22:03:17 volumio volumio[1636]: info: Volumio Calling Home Jan 20 22:03:17 volumio sudo[1902]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh Jan 20 22:03:17 volumio sudo[1902]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:17 volumio volumio[1636]: info: [squeezelite_mc] Proxy server started on port 34905 Jan 20 22:03:17 volumio volumio[1636]: info: CoreCommandRouter::volumioRetrievevolume Jan 20 22:03:17 volumio volumio[1636]: info: CoreStateMachine::pushState Jan 20 22:03:17 volumio volumio[1636]: info: CorePlayQueue::getTrack 0 Jan 20 22:03:17 volumio volumio[1636]: info: CoreCommandRouter::volumioPushState Jan 20 22:03:17 volumio volumio[1636]: info: [squeezelite_mc] Server discovery started Jan 20 22:03:17 volumio volumio[1636]: info: [squeezelite_mc] Player finder started Jan 20 22:03:17 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:03:17 volumio volumio[1636]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 20 22:03:17 volumio volumio[1636]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"","card":"0","mixerType":"None","mixer":null} Jan 20 22:03:17 volumio volumio[1636]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Jan 20 22:03:17 volumio volumio[1636]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:03:17 volumio volumio[1636]: Error: send ENETUNREACH 255.255.255.255:3483 Jan 20 22:03:17 volumio volumio[1636]: at doSend (dgram.js:714:16) Jan 20 22:03:17 volumio volumio[1636]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:452:18) Jan 20 22:03:17 volumio volumio[1636]: at afterDns (dgram.js:660:5) Jan 20 22:03:17 volumio volumio[1636]: at processTicksAndRejections (internal/process/task_queues.js:83:21) { Jan 20 22:03:17 volumio volumio[1636]: errno: -101, Jan 20 22:03:17 volumio volumio[1636]: code: 'ENETUNREACH', Jan 20 22:03:17 volumio volumio[1636]: syscall: 'send', Jan 20 22:03:17 volumio volumio[1636]: address: '255.255.255.255', Jan 20 22:03:17 volumio volumio[1636]: port: 3483 Jan 20 22:03:17 volumio volumio[1636]: } Jan 20 22:03:17 volumio volumio[1636]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 20 22:03:17 volumio dhcpcd[742]: eth0: leased 192.168.2.32 for 7200 seconds Jan 20 22:03:17 volumio dhcpcd[742]: eth0: adding route to 192.168.2.0/24 Jan 20 22:03:17 volumio dhcpcd[742]: eth0: adding default route via 192.168.2.1 Jan 20 22:03:17 volumio avahi-daemon[679]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.2.32. Jan 20 22:03:17 volumio avahi-daemon[679]: New relevant interface eth0.IPv4 for mDNS. Jan 20 22:03:17 volumio avahi-daemon[679]: Registering new address record for 192.168.2.32 on eth0.IPv4. Jan 20 22:03:17 volumio sudo[1916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Jan 20 22:03:17 volumio sudo[1916]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 20 22:03:18 volumio sudo[1916]: pam_unix(sudo:session): session closed for user root Jan 20 22:03:18 volumio ntpd[855]: ntpd exiting on signal 15 (Terminated) Jan 20 22:03:18 volumio systemd[1]: Stopping Network Time Service... Jan 20 22:03:18 volumio systemd[1]: ntp.service: Succeeded. Jan 20 22:03:18 volumio systemd[1]: Stopped Network Time Service. Jan 20 22:03:18 volumio systemd[1]: Starting Network Time Service... Jan 20 22:03:18 volumio ntpd[1962]: ntpd 4.2.8p12@1.3728-o (1): Starting Jan 20 22:03:18 volumio ntpd[1962]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Jan 20 22:03:18 volumio ntpd[1968]: proto: precision = 1.166 usec (-20) Jan 20 22:03:18 volumio systemd[1]: Started Network Time Service. Jan 20 22:03:18 volumio ntpd[1968]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jan 20 22:03:18 volumio ntpd[1968]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jan 20 22:03:18 volumio ntpd[1968]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 755 days ago Jan 20 22:03:18 volumio ntpd[1968]: Listen and drop on 0 v6wildcard [::]:123 Jan 20 22:03:18 volumio ntpd[1968]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jan 20 22:03:18 volumio ntpd[1968]: Listen normally on 2 lo 127.0.0.1:123 Jan 20 22:03:18 volumio ntpd[1968]: Listen normally on 3 eth0 192.168.2.32:123 Jan 20 22:03:18 volumio ntpd[1968]: Listening on routing socket on fd #20 for interface updates Jan 20 22:03:18 volumio ntpd[1968]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 20 22:03:18 volumio ntpd[1968]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jan 20 22:03:18 volumio sudo[1902]: pam_unix(sudo:session): session closed for user root Jan 20 22:03:18 volumio sudo[1980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-20 22:02 Jan 20 22:03:18 volumio sudo[1980]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Sep 2024 11:57:33 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="nanopineo3-armbian" VOLUMIO_DEVICENAME="NanoPi Neo3" VOLUMIO_HASH="eb918cf74a841e57e013ab897d48e098"