-- Logs begin at Thu 2019-02-14 10:11:58 UTC, end at Sun 2025-06-29 02:53:26 UTC. -- Jun 29 02:53:11 volumio kernel: rk_gmac-dwmac ff540000.ethernet: cannot get clock clk_mac_speed Jun 29 02:53:11 volumio kernel: rk_gmac-dwmac ff540000.ethernet: clock input from PHY Jun 29 02:53:11 volumio kernel: rk_gmac-dwmac ff540000.ethernet: init for RGMII Jun 29 02:53:11 volumio kernel: stmmac - user ID: 0x10, Synopsys ID: 0x35 Jun 29 02:53:11 volumio kernel: Ring mode enabled Jun 29 02:53:11 volumio kernel: DMA HW capability register supported Jun 29 02:53:11 volumio kernel: Normal descriptors Jun 29 02:53:11 volumio kernel: RX Checksum Offload Engine supported (type 2) Jun 29 02:53:11 volumio kernel: Wake-Up On Lan supported Jun 29 02:53:11 volumio kernel: Enable RX Mitigation via HW Watchdog Timer Jun 29 02:53:11 volumio kernel: of_get_named_gpiod_flags: parsed 'snps,reset-gpio' property of node '/ethernet@ff540000[0]' - status (0) Jun 29 02:53:11 volumio kernel: libphy: stmmac: probed Jun 29 02:53:11 volumio kernel: eth%d: PHY ID 001cc915 at 0 IRQ POLL (stmmac-0:00) active Jun 29 02:53:11 volumio kernel: eth%d: PHY ID 001cc915 at 1 IRQ POLL (stmmac-0:01) Jun 29 02:53:11 volumio kernel: Rockchip WiFi SYS interface (V1.00) ... Jun 29 02:53:11 volumio kernel: usbcore: registered new interface driver cdc_ether Jun 29 02:53:11 volumio kernel: usbcore: registered new interface driver rndis_host Jun 29 02:53:11 volumio kernel: phy phy-ff470000.usb3-phy.2: u3phy u2 power on Jun 29 02:53:11 volumio kernel: phy phy-ff470000.usb3-phy.3: u3phy u3 power on Jun 29 02:53:11 volumio kernel: dwc2 ff580000.usb: Looking up vusb_d-supply from device tree Jun 29 02:53:11 volumio kernel: dwc2 ff580000.usb: Looking up vusb_d-supply property in node /usb@ff580000 failed Jun 29 02:53:11 volumio kernel: ff580000.usb supply vusb_d not found, using dummy regulator Jun 29 02:53:11 volumio kernel: dwc2 ff580000.usb: Looking up vusb_a-supply from device tree Jun 29 02:53:11 volumio kernel: dwc2 ff580000.usb: Looking up vusb_a-supply property in node /usb@ff580000 failed Jun 29 02:53:11 volumio kernel: ff580000.usb supply vusb_a not found, using dummy regulator Jun 29 02:53:11 volumio kernel: dwc2 ff580000.usb: DWC OTG Controller Jun 29 02:53:11 volumio kernel: dwc2 ff580000.usb: new USB bus registered, assigned bus number 1 Jun 29 02:53:11 volumio kernel: dwc2 ff580000.usb: irq 41, io mem 0xff580000 Jun 29 02:53:11 volumio kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Jun 29 02:53:11 volumio kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jun 29 02:53:11 volumio kernel: usb usb1: Product: DWC OTG Controller Jun 29 02:53:11 volumio kernel: usb usb1: Manufacturer: Linux 4.4.154 dwc2_hsotg Jun 29 02:53:11 volumio kernel: usb usb1: SerialNumber: ff580000.usb Jun 29 02:53:11 volumio kernel: hub 1-0:1.0: USB hub found Jun 29 02:53:11 volumio kernel: hub 1-0:1.0: 1 port detected Jun 29 02:53:11 volumio kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Jun 29 02:53:11 volumio kernel: ehci-pci: EHCI PCI platform driver Jun 29 02:53:11 volumio kernel: ehci-platform: EHCI generic platform driver Jun 29 02:53:11 volumio kernel: ehci-platform ff5c0000.usb: EHCI Host Controller Jun 29 02:53:11 volumio kernel: ehci-platform ff5c0000.usb: new USB bus registered, assigned bus number 2 Jun 29 02:53:11 volumio kernel: ehci-platform ff5c0000.usb: irq 42, io mem 0xff5c0000 Jun 29 02:53:11 volumio kernel: ehci-platform ff5c0000.usb: USB 2.0 started, EHCI 1.00 Jun 29 02:53:11 volumio kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0002 Jun 29 02:53:11 volumio kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jun 29 02:53:11 volumio kernel: usb usb2: Product: EHCI Host Controller Jun 29 02:53:11 volumio kernel: usb usb2: Manufacturer: Linux 4.4.154 ehci_hcd Jun 29 02:53:11 volumio kernel: usb usb2: SerialNumber: ff5c0000.usb Jun 29 02:53:11 volumio kernel: hub 2-0:1.0: USB hub found Jun 29 02:53:11 volumio kernel: hub 2-0:1.0: 1 port detected Jun 29 02:53:11 volumio kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver Jun 29 02:53:11 volumio kernel: ohci-platform: OHCI generic platform driver Jun 29 02:53:11 volumio kernel: ohci-platform ff5d0000.usb: Generic Platform OHCI controller Jun 29 02:53:11 volumio kernel: ohci-platform ff5d0000.usb: new USB bus registered, assigned bus number 3 Jun 29 02:53:11 volumio kernel: ohci-platform ff5d0000.usb: irq 43, io mem 0xff5d0000 Jun 29 02:53:11 volumio kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0001 Jun 29 02:53:11 volumio kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jun 29 02:53:11 volumio kernel: usb usb3: Product: Generic Platform OHCI controller Jun 29 02:53:11 volumio kernel: usb usb3: Manufacturer: Linux 4.4.154 ohci_hcd Jun 29 02:53:11 volumio kernel: usb usb3: SerialNumber: ff5d0000.usb Jun 29 02:53:11 volumio kernel: hub 3-0:1.0: USB hub found Jun 29 02:53:11 volumio kernel: hub 3-0:1.0: 1 port detected Jun 29 02:53:11 volumio kernel: xhci-hcd xhci-hcd.9.auto: xHCI Host Controller Jun 29 02:53:11 volumio kernel: xhci-hcd xhci-hcd.9.auto: new USB bus registered, assigned bus number 4 Jun 29 02:53:11 volumio kernel: xhci-hcd xhci-hcd.9.auto: hcc params 0x0220fe64 hci version 0x110 quirks 0x00210010 Jun 29 02:53:11 volumio kernel: xhci-hcd xhci-hcd.9.auto: irq 179, io mem 0xff600000 Jun 29 02:53:11 volumio kernel: usb usb4: New USB device found, idVendor=1d6b, idProduct=0002 Jun 29 02:53:11 volumio kernel: usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jun 29 02:53:11 volumio kernel: usb usb4: Product: xHCI Host Controller Jun 29 02:53:11 volumio kernel: usb usb4: Manufacturer: Linux 4.4.154 xhci-hcd Jun 29 02:53:11 volumio kernel: usb usb4: SerialNumber: xhci-hcd.9.auto Jun 29 02:53:11 volumio kernel: hub 4-0:1.0: USB hub found Jun 29 02:53:11 volumio kernel: hub 4-0:1.0: 1 port detected Jun 29 02:53:11 volumio kernel: xhci-hcd xhci-hcd.9.auto: xHCI Host Controller Jun 29 02:53:11 volumio kernel: usb 1-1: new high-speed USB device number 2 using dwc2 Jun 29 02:53:11 volumio kernel: xhci-hcd xhci-hcd.9.auto: new USB bus registered, assigned bus number 5 Jun 29 02:53:11 volumio kernel: usb usb5: We don't know the algorithms for LPM for this host, disabling LPM. Jun 29 02:53:11 volumio kernel: usb usb5: New USB device found, idVendor=1d6b, idProduct=0003 Jun 29 02:53:11 volumio kernel: usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jun 29 02:53:11 volumio kernel: usb usb5: Product: xHCI Host Controller Jun 29 02:53:11 volumio kernel: usb usb5: Manufacturer: Linux 4.4.154 xhci-hcd Jun 29 02:53:11 volumio kernel: usb usb5: SerialNumber: xhci-hcd.9.auto Jun 29 02:53:11 volumio kernel: hub 5-0:1.0: USB hub found Jun 29 02:53:11 volumio kernel: hub 5-0:1.0: 1 port detected Jun 29 02:53:11 volumio kernel: usbcore: registered new interface driver iforce Jun 29 02:53:11 volumio kernel: usbcore: registered new interface driver xpad Jun 29 02:53:11 volumio kernel: usbcore: registered new interface driver usbtouchscreen Jun 29 02:53:11 volumio kernel: i2c /dev entries driver Jun 29 02:53:11 volumio kernel: rk808 1-0018: Pmic Chip id: 0x8050 Jun 29 02:53:11 volumio kernel: rk808 1-0018: source: on=0x40, off=0x00 Jun 29 02:53:11 volumio kernel: rk808 1-0018: Looking up vcc1-supply from device tree Jun 29 02:53:11 volumio kernel: DCDC_REG1: supplied by vcc_sys Jun 29 02:53:11 volumio kernel: vcc_sys: could not add device link regulator.5 err -2 Jun 29 02:53:11 volumio kernel: vdd_logic: 712 <--> 1450 mV at 1100 mV Jun 29 02:53:11 volumio kernel: reg-fixed-voltage sdmmc-regulator: Looking up vin-supply from device tree Jun 29 02:53:11 volumio kernel: vcc_sd: unable to resolve supply Jun 29 02:53:11 volumio kernel: rk808 1-0018: Looking up vcc2-supply from device tree Jun 29 02:53:11 volumio kernel: DCDC_REG2: supplied by vcc_sys Jun 29 02:53:11 volumio kernel: vcc_sys: could not add device link regulator.6 err -2 Jun 29 02:53:11 volumio kernel: vdd_arm: 712 <--> 1450 mV at 1100 mV Jun 29 02:53:11 volumio kernel: reg-fixed-voltage sdmmc-regulator: Looking up vin-supply from device tree Jun 29 02:53:11 volumio kernel: vcc_sd: unable to resolve supply Jun 29 02:53:11 volumio kernel: rk808 1-0018: Looking up vcc3-supply from device tree Jun 29 02:53:11 volumio kernel: DCDC_REG3: supplied by vcc_sys Jun 29 02:53:11 volumio kernel: vcc_sys: could not add device link regulator.7 err -2 Jun 29 02:53:11 volumio kernel: vcc_ddr: at 5000 mV Jun 29 02:53:11 volumio kernel: reg-fixed-voltage sdmmc-regulator: Looking up vin-supply from device tree Jun 29 02:53:11 volumio kernel: vcc_sd: unable to resolve supply Jun 29 02:53:11 volumio kernel: rk808 1-0018: Looking up vcc4-supply from device tree Jun 29 02:53:11 volumio kernel: DCDC_REG4: supplied by vcc_sys Jun 29 02:53:11 volumio kernel: vcc_sys: could not add device link regulator.8 err -2 Jun 29 02:53:11 volumio kernel: vcc_io: 3300 mV Jun 29 02:53:11 volumio kernel: reg-fixed-voltage sdmmc-regulator: Looking up vin-supply from device tree Jun 29 02:53:11 volumio kernel: vcc_sd: supplied by vcc_io Jun 29 02:53:11 volumio kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 29 02:53:11 volumio kernel: LDO_REG1: supplied by vcc_io Jun 29 02:53:11 volumio kernel: vcc_io: could not add device link regulator.9 err -2 Jun 29 02:53:11 volumio kernel: vdd_18: 1800 mV Jun 29 02:53:11 volumio kernel: rk808 1-0018: Looking up vcc5-supply from device tree Jun 29 02:53:11 volumio kernel: LDO_REG2: supplied by vcc_io Jun 29 02:53:11 volumio kernel: vcc_io: could not add device link regulator.10 err -2 Jun 29 02:53:11 volumio kernel: vcc18_emmc: 1800 mV Jun 29 02:53:11 volumio kernel: rk808 1-0018: Looking up vcc6-supply from device tree Jun 29 02:53:11 volumio kernel: LDO_REG3: supplied by vcc_sys Jun 29 02:53:11 volumio kernel: vcc_sys: could not add device link regulator.11 err -2 Jun 29 02:53:11 volumio kernel: vdd_10: 1000 mV Jun 29 02:53:11 volumio kernel: rk808 1-0018: register rk8050 regulators Jun 29 02:53:11 volumio kernel: gpiochip_find_base: found new base at 510 Jun 29 02:53:11 volumio kernel: gpiochip_add_data: registered GPIOs 510 to 511 on device: rk8xx-gpio Jun 29 02:53:11 volumio kernel: rk8xx-gpio rk8xx-gpio: register rk8050 gpio successful Jun 29 02:53:11 volumio kernel: input: rk8xx_pwrkey as /devices/platform/ff160000.i2c/i2c-1/1-0018/input/input0 Jun 29 02:53:11 volumio kernel: rk808-rtc rk808-rtc: rtc core: registered rk808-rtc as rtc0 Jun 29 02:53:11 volumio kernel: rk3x-i2c ff160000.i2c: Initialized RK3xxx I2C bus at ffffff8009a76000 Jun 29 02:53:11 volumio kernel: IR NEC protocol handler initialized Jun 29 02:53:11 volumio kernel: IR RC5(x/sz) protocol handler initialized Jun 29 02:53:11 volumio kernel: IR RC6 protocol handler initialized Jun 29 02:53:11 volumio kernel: IR JVC protocol handler initialized Jun 29 02:53:11 volumio kernel: IR Sony protocol handler initialized Jun 29 02:53:11 volumio kernel: IR SANYO protocol handler initialized Jun 29 02:53:11 volumio kernel: IR Sharp protocol handler initialized Jun 29 02:53:11 volumio kernel: IR MCE Keyboard/mouse protocol handler initialized Jun 29 02:53:11 volumio kernel: IR XMP protocol handler initialized Jun 29 02:53:11 volumio kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Jun 29 02:53:11 volumio kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Jun 29 02:53:11 volumio kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Jun 29 02:53:11 volumio kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio4-supply from device tree Jun 29 02:53:11 volumio kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio5-supply from device tree Jun 29 02:53:11 volumio kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio6-supply from device tree Jun 29 02:53:11 volumio kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up pmuio-supply from device tree Jun 29 02:53:11 volumio kernel: rockchip-thermal ff250000.tsadc: tsadc is probed successfully! Jun 29 02:53:11 volumio kernel: device-mapper: ioctl: 4.34.0-ioctl (2015-10-28) initialised: dm-devel@redhat.com Jun 29 02:53:11 volumio kernel: Bluetooth: Virtual HCI driver ver 1.5 Jun 29 02:53:11 volumio kernel: Bluetooth: HCI UART driver ver 2.3 Jun 29 02:53:11 volumio kernel: Bluetooth: HCI UART protocol H4 registered Jun 29 02:53:11 volumio kernel: Bluetooth: HCI UART protocol LL registered Jun 29 02:53:11 volumio kernel: Bluetooth: HCI UART protocol ATH3K registered Jun 29 02:53:11 volumio kernel: usbcore: registered new interface driver bfusb Jun 29 02:53:11 volumio kernel: usbcore: registered new interface driver btusb Jun 29 02:53:11 volumio kernel: cpu cpu0: Failed to get leakage Jun 29 02:53:11 volumio kernel: cpu cpu0: Looking up cpu-supply from device tree Jun 29 02:53:11 volumio kernel: cpu cpu0: Failed to get pvtm Jun 29 02:53:11 volumio kernel: cpu cpu0: Looking up cpu-supply from device tree Jun 29 02:53:11 volumio kernel: cpu cpu0: Looking up cpu-supply from device tree Jun 29 02:53:11 volumio kernel: sdhci: Secure Digital Host Controller Interface driver Jun 29 02:53:11 volumio kernel: sdhci: Copyright(c) Pierre Ossman Jun 29 02:53:11 volumio kernel: Synopsys Designware Multimedia Card Interface Driver Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff520000.dwmmc: IDMAC supports 32-bit address mode. Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff520000.dwmmc: Using internal DMA controller. Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff520000.dwmmc: Version ID is 270a Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff520000.dwmmc: DW MMC controller at irq 38,32 bit host data width,256 deep fifo Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff520000.dwmmc: Looking up vmmc-supply from device tree Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff520000.dwmmc: Looking up vqmmc-supply from device tree Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff520000.dwmmc: GPIO lookup for consumer wp Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff520000.dwmmc: using device tree for GPIO lookup Jun 29 02:53:11 volumio kernel: of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/dwmmc@ff520000[0]' Jun 29 02:53:11 volumio kernel: of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/dwmmc@ff520000[0]' Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff520000.dwmmc: using lookup tables for GPIO lookup Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff520000.dwmmc: lookup for GPIO wp failed Jun 29 02:53:11 volumio kernel: mmc_host mmc0: Bus speed (slot 0) = 400000Hz (slot req 400000Hz, actual 400000HZ div = 0) Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff520000.dwmmc: 1 slots initialized Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff500000.dwmmc: IDMAC supports 32-bit address mode. Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff500000.dwmmc: Using internal DMA controller. Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff500000.dwmmc: Version ID is 270a Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff500000.dwmmc: DW MMC controller at irq 39,32 bit host data width,256 deep fifo Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff500000.dwmmc: Looking up vmmc-supply from device tree Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff500000.dwmmc: Looking up vqmmc-supply from device tree Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff500000.dwmmc: GPIO lookup for consumer cd Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff500000.dwmmc: using device tree for GPIO lookup Jun 29 02:53:11 volumio kernel: of_get_named_gpiod_flags: can't parse 'cd-gpios' property of node '/dwmmc@ff500000[0]' Jun 29 02:53:11 volumio kernel: of_get_named_gpiod_flags: can't parse 'cd-gpio' property of node '/dwmmc@ff500000[0]' Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff500000.dwmmc: using lookup tables for GPIO lookup Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff500000.dwmmc: lookup for GPIO cd failed Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff500000.dwmmc: GPIO lookup for consumer wp Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff500000.dwmmc: using device tree for GPIO lookup Jun 29 02:53:11 volumio kernel: of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/dwmmc@ff500000[0]' Jun 29 02:53:11 volumio kernel: of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/dwmmc@ff500000[0]' Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff500000.dwmmc: using lookup tables for GPIO lookup Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff500000.dwmmc: lookup for GPIO wp failed Jun 29 02:53:11 volumio kernel: mmc_host mmc1: Bus speed (slot 0) = 400000Hz (slot req 400000Hz, actual 400000HZ div = 0) Jun 29 02:53:11 volumio kernel: mmc0: MAN_BKOPS_EN bit is not set Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff500000.dwmmc: 1 slots initialized Jun 29 02:53:11 volumio kernel: sdhci-pltfm: SDHCI platform and OF driver helper Jun 29 02:53:11 volumio kernel: of_get_named_gpiod_flags: parsed 'gpios' property of node '/leds/standby-led[0]' - status (0) Jun 29 02:53:11 volumio kernel: mmc_host mmc0: Bus speed (slot 0) = 200000000Hz (slot req 200000000Hz, actual 200000000HZ div = 0) Jun 29 02:53:11 volumio kernel: of_get_named_gpiod_flags: parsed 'gpios' property of node '/leds/power-led[0]' - status (0) Jun 29 02:53:11 volumio kernel: of_get_named_gpiod_flags: parsed 'gpios' property of node '/switches/usb-switch[0]' - status (0) Jun 29 02:53:11 volumio kernel: ledtrig-cpu: registered to indicate activity on CPUs Jun 29 02:53:11 volumio kernel: hidraw: raw HID events driver (C) Jiri Kosina Jun 29 02:53:11 volumio kernel: usbcore: registered new interface driver usbhid Jun 29 02:53:11 volumio kernel: usbhid: USB HID core driver Jun 29 02:53:11 volumio kernel: usbcore: registered new interface driver snd-usb-audio Jun 29 02:53:11 volumio kernel: rk3328-codec ff410000.codec: spk_depop_time use default value. Jun 29 02:53:11 volumio kernel: u32 classifier Jun 29 02:53:11 volumio kernel: Netfilter messages via NETLINK v0.30. Jun 29 02:53:11 volumio kernel: ip_set: protocol 6 Jun 29 02:53:11 volumio kernel: Initializing XFRM netlink socket Jun 29 02:53:11 volumio kernel: NET: Registered protocol family 10 Jun 29 02:53:11 volumio kernel: NET: Registered protocol family 17 Jun 29 02:53:11 volumio kernel: NET: Registered protocol family 15 Jun 29 02:53:11 volumio kernel: bridge: automatic filtering via arp/ip/ip6tables has been deprecated. Update your scripts to load br_netfilter if you need this. Jun 29 02:53:11 volumio kernel: Bridge firewalling registered Jun 29 02:53:11 volumio kernel: Bluetooth: RFCOMM socket layer initialized Jun 29 02:53:11 volumio kernel: Bluetooth: RFCOMM ver 1.11 Jun 29 02:53:11 volumio kernel: Bluetooth: HIDP (Human Interface Emulation) ver 1.2 Jun 29 02:53:11 volumio kernel: Bluetooth: HIDP socket layer initialized Jun 29 02:53:11 volumio kernel: 8021q: 802.1Q VLAN Support v1.8 Jun 29 02:53:11 volumio kernel: [WLAN_RFKILL]: Enter rfkill_wlan_init Jun 29 02:53:11 volumio kernel: [BT_RFKILL]: Enter rfkill_rk_init Jun 29 02:53:11 volumio kernel: Key type dns_resolver registered Jun 29 02:53:11 volumio kernel: Registered cp15_barrier emulation handler Jun 29 02:53:11 volumio kernel: Registered setend emulation handler Jun 29 02:53:11 volumio kernel: registered taskstats version 1 Jun 29 02:53:11 volumio kernel: Btrfs loaded, integrity-checker=on Jun 29 02:53:11 volumio kernel: BTRFS: selftest: Running btrfs free space cache tests Jun 29 02:53:11 volumio kernel: BTRFS: selftest: Running extent only tests Jun 29 02:53:11 volumio kernel: BTRFS: selftest: Running bitmap only tests Jun 29 02:53:11 volumio kernel: BTRFS: selftest: Running bitmap and extent tests Jun 29 02:53:11 volumio kernel: BTRFS: selftest: Running space stealing from bitmap to extent Jun 29 02:53:11 volumio kernel: BTRFS: selftest: Free space cache tests finished Jun 29 02:53:11 volumio kernel: BTRFS: selftest: Running extent buffer operation tests Jun 29 02:53:11 volumio kernel: BTRFS: selftest: Running btrfs_split_item tests Jun 29 02:53:11 volumio kernel: BTRFS: selftest: Running find delalloc tests Jun 29 02:53:11 volumio kernel: usb 4-1: new high-speed USB device number 2 using xhci-hcd Jun 29 02:53:11 volumio kernel: usb 1-1: New USB device found, idVendor=20b1, idProduct=3086 Jun 29 02:53:11 volumio kernel: usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Jun 29 02:53:11 volumio kernel: usb 1-1: Product: Singxer USB Audio 2.0 G3 Jun 29 02:53:11 volumio kernel: usb 1-1: Manufacturer: Singxer Jun 29 02:53:11 volumio kernel: usb 4-1: New USB device found, idVendor=05e3, idProduct=0610 Jun 29 02:53:11 volumio kernel: usb 4-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Jun 29 02:53:11 volumio kernel: usb 4-1: Product: USB2.0 Hub Jun 29 02:53:11 volumio kernel: usb 4-1: Manufacturer: GenesysLogic Jun 29 02:53:11 volumio kernel: hub 4-1:1.0: USB hub found Jun 29 02:53:11 volumio kernel: hub 4-1:1.0: 4 ports detected Jun 29 02:53:11 volumio kernel: hid-generic 0003:20B1:3086.0001: hiddev0,hidraw0: USB HID v1.10 Device [Singxer Singxer USB Audio 2.0 G3] on usb-ff580000.usb-1/input3 Jun 29 02:53:11 volumio kernel: dwmmc_rockchip ff520000.dwmmc: Successfully tuned phase to 240 Jun 29 02:53:11 volumio kernel: usb 5-1: new SuperSpeed USB device number 2 using xhci-hcd Jun 29 02:53:11 volumio kernel: mmc0: new HS200 MMC card at address 0001 Jun 29 02:53:11 volumio kernel: mmcblk0: mmc0:0001 DG4008 7.28 GiB Jun 29 02:53:11 volumio kernel: mmcblk0boot0: mmc0:0001 DG4008 partition 1 4.00 MiB Jun 29 02:53:11 volumio kernel: mmcblk0boot1: mmc0:0001 DG4008 partition 2 4.00 MiB Jun 29 02:53:11 volumio kernel: mmcblk0rpmb: mmc0:0001 DG4008 partition 3 4.00 MiB Jun 29 02:53:11 volumio kernel: mmcblk0: p1 p2 p3 Jun 29 02:53:11 volumio kernel: usb 5-1: New USB device found, idVendor=05e3, idProduct=0612 Jun 29 02:53:11 volumio kernel: usb 5-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Jun 29 02:53:11 volumio kernel: usb 5-1: Product: USB3.1 Hub Jun 29 02:53:11 volumio kernel: usb 5-1: Manufacturer: GenesysLogic Jun 29 02:53:11 volumio kernel: hub 5-1:1.0: USB hub found Jun 29 02:53:11 volumio kernel: hub 5-1:1.0: 4 ports detected Jun 29 02:53:11 volumio kernel: BTRFS: selftest: Running btrfs_get_extent tests Jun 29 02:53:11 volumio kernel: BTRFS: selftest: Running hole first btrfs_get_extent test Jun 29 02:53:11 volumio kernel: BTRFS: selftest: Running outstanding_extents tests Jun 29 02:53:11 volumio kernel: BTRFS: selftest: Running qgroup tests Jun 29 02:53:11 volumio kernel: BTRFS: selftest: Qgroup basic add Jun 29 02:53:11 volumio kernel: BTRFS: selftest: Qgroup multiple refs test Jun 29 02:53:11 volumio kernel: Key type encrypted registered Jun 29 02:53:11 volumio kernel: pvtm list NULL Jun 29 02:53:11 volumio kernel: of_get_named_gpiod_flags: can't parse 'simple-audio-card,hp-det-gpio' property of node '/sound[0]' Jun 29 02:53:11 volumio kernel: of_get_named_gpiod_flags: can't parse 'simple-audio-card,mic-det-gpio' property of node '/sound[0]' Jun 29 02:53:11 volumio kernel: asoc-simple-card sound: rk3328-hifi <-> ff010000.i2s mapping ok Jun 29 02:53:11 volumio kernel: asoc-simple-card sound: snd-soc-dummy-dai <-> ff010000.i2s mapping ok Jun 29 02:53:11 volumio kernel: of_get_named_gpiod_flags: can't parse 'simple-audio-card,hp-det-gpio' property of node '/spdif-sound[0]' Jun 29 02:53:11 volumio kernel: of_get_named_gpiod_flags: can't parse 'simple-audio-card,mic-det-gpio' property of node '/spdif-sound[0]' Jun 29 02:53:11 volumio kernel: asoc-simple-card spdif-sound: dit-hifi <-> ff030000.spdif mapping ok Jun 29 02:53:11 volumio kernel: rk808-rtc rk808-rtc: setting system clock to 2016-01-21 08:50:05 UTC (1453366205) Jun 29 02:53:11 volumio kernel: of_cfs_init Jun 29 02:53:11 volumio kernel: of_cfs_init: OK Jun 29 02:53:11 volumio kernel: vcc_sd: disabling Jun 29 02:53:11 volumio kernel: ALSA device list: Jun 29 02:53:11 volumio kernel: #0: Singxer Singxer USB Audio 2.0 G3 at usb-ff580000.usb-1, high speed Jun 29 02:53:11 volumio kernel: #1: I2S Jun 29 02:53:11 volumio kernel: #2: SPDIF Jun 29 02:53:11 volumio kernel: of_dma_request_slave_channel: dma-names property of node '/serial@ff130000' missing or empty Jun 29 02:53:11 volumio kernel: ttyS2 - failed to request DMA, use interrupt mode Jun 29 02:53:11 volumio kernel: Freeing unused kernel memory: 1216K Jun 29 02:53:11 volumio kernel: xhci-hcd xhci-hcd.9.auto: Timeout while waiting for setup device command Jun 29 02:53:11 volumio initramfs: Booting Volumio for Rock64 Jun 29 02:53:11 volumio initramfs: This script mounts rootfs RO with an overlay RW layer. Jun 29 02:53:11 volumio initramfs: IMGPART=/dev/mmcblk0p2 Jun 29 02:53:11 volumio initramfs: IMGFILE=/volumio_current.sqsh Jun 29 02:53:11 volumio initramfs: DATAPART=/dev/mmcblk0p3 Jun 29 02:53:11 volumio initramfs: BOOTPART=/dev/mmcblk0p1 Jun 29 02:53:11 volumio initramfs: BOOTCONFIG=/boot//extlinux/extlinux.conf Jun 29 02:53:11 volumio kernel: EXT4-fs (mmcblk0p2): recovery complete Jun 29 02:53:11 volumio kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) Jun 29 02:53:11 volumio initramfs: Checking for USB updates if you did not boot from USB... Jun 29 02:53:11 volumio initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline) Jun 29 02:53:11 volumio kernel: FAT-fs (mmcblk0p1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Jun 29 02:53:11 volumio kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Jun 29 02:53:11 volumio kernel: FAT-fs (mmcblk0p1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Jun 29 02:53:11 volumio kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Jun 29 02:53:11 volumio kernel: EXT4-fs (mmcblk0p3): recovery complete Jun 29 02:53:11 volumio kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null) Jun 29 02:53:11 volumio initramfs: With Option: Jun 29 02:53:11 volumio initramfs: found fstab entry with UUID=7FB8-6D8F for /boot Jun 29 02:53:11 volumio initramfs: VOLUMIO_VERSION="3.212" Jun 29 02:53:11 volumio initramfs: Finish initramfs, continue booting Volumio Jun 29 02:53:11 volumio systemd[1]: System time before build time, advancing clock. Jun 29 02:53:11 volumio systemd[1]: Inserted module 'autofs4' Jun 29 02:53:11 volumio kernel: ip_tables: (C) 2000-2006 Netfilter Core Team Jun 29 02:53:11 volumio kernel: cgroup: cgroup2: unknown option "nsdelegate" Jun 29 02:53:11 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) Jun 29 02:53:11 volumio systemd[1]: Detected architecture arm64. Jun 29 02:53:11 volumio systemd[1]: Set hostname to . Jun 29 02:53:11 volumio systemd[1]: File /lib/systemd/system/systemd-journald.service:12 configures an IP firewall (IPAddressDeny=any), but the local system does not support BPF/cgroup based firewalling. Jun 29 02:53:11 volumio systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.) Jun 29 02:53:11 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. Jun 29 02:53:11 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read, 61 bits of entropy available) Jun 29 02:53:11 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read, 61 bits of entropy available) Jun 29 02:53:11 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read, 61 bits of entropy available) Jun 29 02:53:11 volumio systemd[1]: Created slice system-getty.slice. Jun 29 02:53:11 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read, 61 bits of entropy available) Jun 29 02:53:11 volumio systemd[1]: Created slice system-serial\x2dgetty.slice. Jun 29 02:53:11 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read, 61 bits of entropy available) Jun 29 02:53:11 volumio systemd[1]: Listening on udev Control Socket. Jun 29 02:53:11 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read, 61 bits of entropy available) Jun 29 02:53:11 volumio systemd[1]: Listening on Journal Socket (/dev/log). Jun 29 02:53:11 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read, 61 bits of entropy available) Jun 29 02:53:11 volumio systemd[1]: Listening on fsck to fsckd communication Socket. Jun 29 02:53:11 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read, 61 bits of entropy available) Jun 29 02:53:11 volumio systemd[1]: Created slice User and Session Slice. Jun 29 02:53:11 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read, 61 bits of entropy available) Jun 29 02:53:11 volumio systemd[1]: Reached target Slices. Jun 29 02:53:11 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read, 62 bits of entropy available) Jun 29 02:53:11 volumio systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Jun 29 02:53:11 volumio systemd[1]: Listening on initctl Compatibility Named Pipe. Jun 29 02:53:11 volumio systemd[1]: Created slice system-systemd\x2dfsck.slice. Jun 29 02:53:11 volumio systemd[1]: Listening on Journal Audit Socket. Jun 29 02:53:11 volumio systemd[1]: Listening on udev Kernel Socket. Jun 29 02:53:11 volumio systemd[1]: Reached target System Time Synchronized. Jun 29 02:53:11 volumio systemd[1]: Listening on Journal Socket. Jun 29 02:53:11 volumio systemd[1]: Starting udev Coldplug all Devices... Jun 29 02:53:11 volumio systemd[1]: Condition check resulted in Kernel Module supporting RPCSEC_GSS being skipped. Jun 29 02:53:11 volumio systemd[1]: Starting Journal Service... Jun 29 02:53:11 volumio systemd[1]: Starting Restore / save the current clock... Jun 29 02:53:11 volumio systemd[1]: Mounting RPC Pipe File System... Jun 29 02:53:11 volumio systemd[1]: Mounting Huge Pages File System... Jun 29 02:53:11 volumio systemd[1]: Started dynamicswap service. Jun 29 02:53:11 volumio systemd[1]: Reached target Swap. Jun 29 02:53:11 volumio systemd[1]: Starting Load Kernel Modules... Jun 29 02:53:11 volumio systemd[1]: Mounting POSIX Message Queue File System... Jun 29 02:53:11 volumio systemd[1]: Mounting Kernel Debug File System... Jun 29 02:53:11 volumio systemd[1]: Starting Create list of required static device nodes for the current kernel... Jun 29 02:53:11 volumio systemd[1]: Started Forward Password Requests to Wall Directory Watch. Jun 29 02:53:11 volumio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Jun 29 02:53:11 volumio systemd[1]: Starting Remount Root and Kernel File Systems... Jun 29 02:53:11 volumio systemd[1]: Listening on RPCbind Server Activation Socket. Jun 29 02:53:11 volumio systemd[1]: Started Restore / save the current clock. Jun 29 02:53:11 volumio systemd[1]: Mounted RPC Pipe File System. Jun 29 02:53:11 volumio systemd[1]: Mounted Huge Pages File System. Jun 29 02:53:11 volumio systemd[1]: dynamicswap.service: Succeeded. Jun 29 02:53:11 volumio systemd[1]: Started Load Kernel Modules. Jun 29 02:53:11 volumio systemd[1]: Mounted POSIX Message Queue File System. Jun 29 02:53:11 volumio systemd[1]: Mounted Kernel Debug File System. Jun 29 02:53:11 volumio systemd[1]: Started Create list of required static device nodes for the current kernel. Jun 29 02:53:11 volumio systemd[1]: Started Remount Root and Kernel File Systems. Jun 29 02:53:11 volumio systemd-journald[272]: Journal started Jun 29 02:53:11 volumio systemd-journald[272]: Runtime journal (/run/log/journal/b15109d4193808c9249f0e6761f4677c) is 7.5M, max 30.0M, 22.5M free. Jun 29 02:53:11 volumio fake-hwclock[273]: Sun Jun 29 02:53:11 UTC 2025 Jun 29 02:53:11 volumio systemd[1]: Started Journal Service. Jun 29 02:53:11 volumio systemd[1]: Starting Load/Save Random Seed... Jun 29 02:53:11 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Jun 29 02:53:11 volumio systemd[1]: Starting Create System Users... Jun 29 02:53:11 volumio systemd[1]: Starting Apply Kernel Variables... Jun 29 02:53:11 volumio systemd[1]: Mounting Kernel Configuration File System... Jun 29 02:53:11 volumio systemd[1]: Mounting FUSE Control File System... Jun 29 02:53:11 volumio systemd[1]: Started udev Coldplug all Devices. Jun 29 02:53:11 volumio systemd[1]: Started Load/Save Random Seed. Jun 29 02:53:11 volumio kernel: Removed cp15_barrier emulation handler Jun 29 02:53:11 volumio kernel: Enabled cp15_barrier support Jun 29 02:53:11 volumio systemd[1]: Started Create System Users. Jun 29 02:53:11 volumio systemd[1]: Started Apply Kernel Variables. Jun 29 02:53:11 volumio systemd[1]: Mounted Kernel Configuration File System. Jun 29 02:53:11 volumio systemd[1]: Mounted FUSE Control File System. Jun 29 02:53:11 volumio systemd[1]: Starting Create Static Device Nodes in /dev... Jun 29 02:53:11 volumio systemd[1]: Starting Helper to synchronize boot up for ifupdown... Jun 29 02:53:11 volumio systemd[1]: Started Create Static Device Nodes in /dev. Jun 29 02:53:11 volumio systemd[1]: Starting udev Kernel Device Manager... Jun 29 02:53:11 volumio systemd[1]: Reached target Local File Systems (Pre). Jun 29 02:53:11 volumio systemd[1]: Mounting /var/spool/cups... Jun 29 02:53:11 volumio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Jun 29 02:53:11 volumio systemd[1]: Mounting /var/log... Jun 29 02:53:11 volumio systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Jun 29 02:53:11 volumio systemd[1]: Mounting /tmp... Jun 29 02:53:11 volumio systemd[1]: Mounted /var/spool/cups. Jun 29 02:53:11 volumio systemd[1]: Mounted /var/log. Jun 29 02:53:11 volumio systemd[1]: Mounted /tmp. Jun 29 02:53:11 volumio systemd[1]: Started udev Kernel Device Manager. Jun 29 02:53:11 volumio systemd[1]: Starting Show Plymouth Boot Screen... Jun 29 02:53:11 volumio systemd[1]: Starting Flush Journal to Persistent Storage... Jun 29 02:53:11 volumio systemd[1]: Mounting /var/spool/cups/tmp... Jun 29 02:53:11 volumio systemd[1]: Received SIGRTMIN+20 from PID 325 (plymouthd). Jun 29 02:53:11 volumio systemd[1]: Mounted /var/spool/cups/tmp. Jun 29 02:53:11 volumio systemd[1]: Started Show Plymouth Boot Screen. Jun 29 02:53:11 volumio systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Jun 29 02:53:11 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jun 29 02:53:11 volumio systemd[1]: Reached target Paths. Jun 29 02:53:11 volumio systemd-journald[272]: Runtime journal (/run/log/journal/b15109d4193808c9249f0e6761f4677c) is 7.5M, max 30.0M, 22.5M free. Jun 29 02:53:11 volumio systemd[1]: Reached target Local Encrypted Volumes. Jun 29 02:53:11 volumio systemd[1]: Started Flush Journal to Persistent Storage. Jun 29 02:53:11 volumio kernel: I : [File] : drivers/gpu/arm/mali400/mali/linux/mali_kernel_linux.c; [Line] : 417; [Func] : mali_module_init(); svn_rev_string_from_arm of this mali_ko is '', rk_ko_ver is '5', built at '18:16:11', on 'Jan 23 2021'. Jun 29 02:53:11 volumio kernel: mali-utgard ff300000.gpu: mali_platform_device->num_resources = 9 Jun 29 02:53:11 volumio kernel: mali-utgard ff300000.gpu: resource[0].start = 0x0x00000000ff300000 Jun 29 02:53:11 volumio systemd[1]: Found device /dev/ttyS2. Jun 29 02:53:11 volumio kernel: mali-utgard ff300000.gpu: resource[1].start = 0x0x00000000ff300000 Jun 29 02:53:11 volumio kernel: mali-utgard ff300000.gpu: resource[2].start = 0x0x0000000000000012 Jun 29 02:53:11 volumio kernel: mali-utgard ff300000.gpu: resource[3].start = 0x0x0000000000000013 Jun 29 02:53:11 volumio kernel: mali-utgard ff300000.gpu: resource[4].start = 0x0x0000000000000014 Jun 29 02:53:11 volumio kernel: mali-utgard ff300000.gpu: resource[5].start = 0x0x0000000000000015 Jun 29 02:53:11 volumio systemd-udevd[323]: Using default interface naming scheme 'v240'. Jun 29 02:53:11 volumio kernel: mali-utgard ff300000.gpu: resource[6].start = 0x0x0000000000000016 Jun 29 02:53:11 volumio kernel: mali-utgard ff300000.gpu: resource[7].start = 0x0x0000000000000017 Jun 29 02:53:11 volumio kernel: mali-utgard ff300000.gpu: resource[8].start = 0x0x0000000000000018 Jun 29 02:53:11 volumio kernel: D : [File] : drivers/gpu/arm/mali400/mali/platform/rk/rk.c; [Line] : 623; [Func] : mali_platform_device_init(); to add platform_specific_data to platform_device_of_mali. Jun 29 02:53:11 volumio kernel: mali-utgard ff300000.gpu: Looking up mali-supply from device tree Jun 29 02:53:11 volumio kernel: mali-utgard ff300000.gpu: Failed to get leakage Jun 29 02:53:11 volumio kernel: mali-utgard ff300000.gpu: Looking up mali-supply from device tree Jun 29 02:53:11 volumio kernel: vdd_logic: could not add device link ff300000.gpu err -17 Jun 29 02:53:11 volumio kernel: vdd_logic: Failed to create debugfs directory Jun 29 02:53:11 volumio kernel: mali-utgard ff300000.gpu: Failed to get pvtm Jun 29 02:53:11 volumio kernel: Mali: Mali device driver loaded Jun 29 02:53:11 volumio systemd-udevd[323]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jun 29 02:53:11 volumio systemd-udevd[323]: link_config: could not get ethtool features for eth0 Jun 29 02:53:11 volumio systemd-udevd[323]: Could not set offload features of eth0: Device or resource busy Jun 29 02:53:11 volumio kernel: of_get_named_gpiod_flags: can't parse 'simple-audio-card,hp-det-gpio' property of node '/hdmi-sound[0]' Jun 29 02:53:11 volumio kernel: of_get_named_gpiod_flags: can't parse 'simple-audio-card,mic-det-gpio' property of node '/hdmi-sound[0]' Jun 29 02:53:11 volumio kernel: asoc-simple-card hdmi-sound: i2s-hifi <-> ff000000.i2s mapping ok Jun 29 02:53:11 volumio kernel: devfreq ff300000.gpu: Couldn't update frequency transition information. Jun 29 02:53:11 volumio systemd-udevd[312]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 29 02:53:11 volumio systemd-udevd[315]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Jun 29 02:53:12 volumio systemd[1]: Found device /dev/disk/by-uuid/7FB8-6D8F. Jun 29 02:53:12 volumio systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Jun 29 02:53:12 volumio systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Jun 29 02:53:12 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Jun 29 02:53:12 volumio systemd[1]: Starting File System Check on /dev/disk/by-uuid/7FB8-6D8F... Jun 29 02:53:12 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Jun 29 02:53:12 volumio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Jun 29 02:53:12 volumio systemd[1]: Started File System Check Daemon to report status. Jun 29 02:53:12 volumio systemd-fsck[377]: fsck.fat 4.1 (2017-01-24) Jun 29 02:53:12 volumio systemd-fsck[377]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Jun 29 02:53:12 volumio systemd-fsck[377]: Automatically removing dirty bit. Jun 29 02:53:12 volumio systemd-fsck[377]: Performing changes. Jun 29 02:53:12 volumio systemd-fsck[377]: /dev/mmcblk0p1: 8 files, 12492/31161 clusters Jun 29 02:53:12 volumio systemd[1]: Started File System Check on /dev/disk/by-uuid/7FB8-6D8F. Jun 29 02:53:12 volumio systemd[1]: Mounting /boot... Jun 29 02:53:12 volumio kernel: FAT-fs (mmcblk0p1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Jun 29 02:53:12 volumio systemd[1]: Mounted /boot. Jun 29 02:53:12 volumio systemd[1]: Reached target Local File Systems. Jun 29 02:53:12 volumio systemd[1]: Starting Create Volatile Files and Directories... Jun 29 02:53:12 volumio systemd[1]: Starting Preprocess NFS configuration... Jun 29 02:53:12 volumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Jun 29 02:53:12 volumio systemd[1]: Started ifup for eth0. Jun 29 02:53:12 volumio systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Jun 29 02:53:12 volumio systemd[1]: Received SIGRTMIN+20 from PID 325 (plymouthd). Jun 29 02:53:12 volumio systemd[1]: plymouth-read-write.service: Succeeded. Jun 29 02:53:12 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Jun 29 02:53:12 volumio systemd[1]: nfs-config.service: Succeeded. Jun 29 02:53:12 volumio systemd[1]: Started Preprocess NFS configuration. Jun 29 02:53:12 volumio systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Jun 29 02:53:12 volumio systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Jun 29 02:53:12 volumio systemd[1]: Reached target NFS client services. Jun 29 02:53:12 volumio systemd[1]: Started Create Volatile Files and Directories. Jun 29 02:53:12 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Jun 29 02:53:12 volumio sh[386]: command failed: No such device (-19) Jun 29 02:53:12 volumio systemd[1]: Starting RPC bind portmap service... Jun 29 02:53:12 volumio systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Jun 29 02:53:12 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown... Jun 29 02:53:12 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown. Jun 29 02:53:12 volumio systemd[1]: Reached target System Initialization. Jun 29 02:53:12 volumio systemd[1]: apt-daily.timer: Not using persistent file timestamp Sat 2025-07-05 23:11:39 UTC as it is in the future. Jun 29 02:53:12 volumio systemd[1]: Started Daily apt download activities. Jun 29 02:53:12 volumio systemd[1]: Listening on D-Bus System Message Bus Socket. Jun 29 02:53:12 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Jun 29 02:53:12 volumio systemd[1]: Listening on lircd.socket. Jun 29 02:53:12 volumio systemd[1]: Started Daily Cleanup of Temporary Directories. Jun 29 02:53:12 volumio systemd[1]: Listening on triggerhappy.socket. Jun 29 02:53:12 volumio systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Sat 2025-07-05 23:11:39 UTC as it is in the future. Jun 29 02:53:12 volumio systemd[1]: Started Daily apt upgrade and clean activities. Jun 29 02:53:12 volumio systemd[1]: Reached target Timers. Jun 29 02:53:12 volumio systemd[1]: Listening on mpd.socket. Jun 29 02:53:12 volumio systemd[1]: Reached target Sockets. Jun 29 02:53:12 volumio systemd[1]: Reached target Basic System. Jun 29 02:53:12 volumio systemd[1]: Started Volumio Iptables Module. Jun 29 02:53:12 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Jun 29 02:53:12 volumio systemd[1]: Started D-Bus System Message Bus. Jun 29 02:53:12 volumio sh[386]: eth0: waiting for carrier Jun 29 02:53:12 volumio sh[386]: eth0: carrier acquired Jun 29 02:53:12 volumio dhcpcd[408]: eth0: waiting for carrier Jun 29 02:53:12 volumio dhcpcd[408]: eth0: carrier acquired Jun 29 02:53:12 volumio systemd[1]: Starting lircd(8) initialization helper tool... Jun 29 02:53:12 volumio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Jun 29 02:53:12 volumio systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Jun 29 02:53:12 volumio systemd[1]: Started volumio-remote-updater.service. Jun 29 02:53:12 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jun 29 02:53:12 volumio sh[386]: DUID 00:01:00:01:29:87:24:72:ee:d8:fd:35:36:8b Jun 29 02:53:12 volumio sh[386]: eth0: IAID fd:35:36:8b Jun 29 02:53:12 volumio sh[386]: eth0: adding address fe80::ecd8:fdff:fe35:368b Jun 29 02:53:12 volumio dhcpcd[408]: DUID 00:01:00:01:29:87:24:72:ee:d8:fd:35:36:8b Jun 29 02:53:12 volumio sh[386]: ipv6_addaddr1: Permission denied Jun 29 02:53:12 volumio dhcpcd[408]: eth0: IAID fd:35:36:8b Jun 29 02:53:12 volumio dhcpcd[408]: eth0: adding address fe80::ecd8:fdff:fe35:368b Jun 29 02:53:12 volumio dhcpcd[408]: ipv6_addaddr1: Permission denied Jun 29 02:53:12 volumio systemd[1]: Starting Wireless Services... Jun 29 02:53:12 volumio systemd[1]: Started Manage Sound Card State (restore and store). Jun 29 02:53:12 volumio systemd[1]: Starting Save/Restore Sound Card State... Jun 29 02:53:12 volumio systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Jun 29 02:53:12 volumio systemd[1]: Starting DHCP Client Daemon... Jun 29 02:53:12 volumio systemd[1]: Starting triggerhappy global hotkey daemon... Jun 29 02:53:12 volumio systemd[1]: Starting WPA supplicant... Jun 29 02:53:12 volumio alsactl[428]: alsactl 1.1.8 daemon started Jun 29 02:53:12 volumio sh[386]: eth0: soliciting an IPv6 router Jun 29 02:53:12 volumio dhcpcd[408]: eth0: soliciting an IPv6 router Jun 29 02:53:12 volumio systemd[1]: Starting Login Service... Jun 29 02:53:12 volumio systemd[1]: Started RPC bind portmap service. Jun 29 02:53:12 volumio systemd[1]: Reached target Remote File Systems (Pre). Jun 29 02:53:12 volumio systemd[1]: Reached target Remote File Systems. Jun 29 02:53:12 volumio thd[431]: Unable to parse trigger line: Jun 29 02:53:12 volumio thd[431]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Jun 29 02:53:12 volumio thd[431]: Unable to parse trigger line: Jun 29 02:53:12 volumio thd[431]: Unable to parse trigger line: Jun 29 02:53:12 volumio thd[431]: Found socket passed from systemd Jun 29 02:53:12 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Jun 29 02:53:12 volumio systemd[1]: Reached target RPC Port Mapper. Jun 29 02:53:12 volumio avahi-daemon[421]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Jun 29 02:53:12 volumio avahi-daemon[421]: Successfully dropped root privileges. Jun 29 02:53:12 volumio systemd[1]: Started triggerhappy global hotkey daemon. Jun 29 02:53:12 volumio avahi-daemon[421]: avahi-daemon 0.7 starting up. Jun 29 02:53:12 volumio dhcpcd[430]: DUID 00:01:00:01:29:87:24:72:ee:d8:fd:35:36:8b Jun 29 02:53:12 volumio dhcpcd[430]: eth0: IAID fd:35:36:8b Jun 29 02:53:12 volumio dhcpcd[430]: eth0: adding address fe80::ecd8:fdff:fe35:368b Jun 29 02:53:12 volumio dhcpcd[430]: ipv6_addaddr1: Permission denied Jun 29 02:53:12 volumio dhcpcd[430]: DUID 00:01:00:01:29:87:24:72:ee:d8:fd:35:36:8b Jun 29 02:53:12 volumio dhcpcd[430]: eth0: IAID fd:35:36:8b Jun 29 02:53:12 volumio dhcpcd[430]: eth0: adding address fe80::ecd8:fdff:fe35:368b Jun 29 02:53:12 volumio dhcpcd[430]: ipv6_addaddr1: Permission denied Jun 29 02:53:12 volumio dhcpcd[430]: eth0: rebinding lease of 192.168.3.102 Jun 29 02:53:12 volumio dhcpcd[430]: eth0: rebinding lease of 192.168.3.102 Jun 29 02:53:12 volumio systemd-logind[433]: New seat seat0. Jun 29 02:53:12 volumio systemd-logind[433]: Watching system buttons on /dev/input/event0 (rk8xx_pwrkey) Jun 29 02:53:13 volumio kernel: nf_tables: (c) 2007-2009 Patrick McHardy Jun 29 02:53:13 volumio systemd[1]: Started Login Service. Jun 29 02:53:13 volumio systemd[1]: Started Save/Restore Sound Card State. Jun 29 02:53:13 volumio wpa_supplicant[432]: Successfully initialized wpa_supplicant Jun 29 02:53:13 volumio avahi-daemon[421]: Successfully called chroot(). Jun 29 02:53:13 volumio avahi-daemon[421]: Successfully dropped remaining capabilities. Jun 29 02:53:13 volumio kernel: nf_tables_compat: (c) 2012 Pablo Neira Ayuso Jun 29 02:53:13 volumio kernel: usb 5-1.1: new SuperSpeed USB device number 3 using xhci-hcd Jun 29 02:53:13 volumio avahi-daemon[421]: No service file found in /etc/avahi/services. Jun 29 02:53:13 volumio avahi-daemon[421]: Network interface enumeration completed. Jun 29 02:53:13 volumio avahi-daemon[421]: Server startup complete. Host name is volumio.local. Local service cookie is 90763880. Jun 29 02:53:13 volumio kernel: usb 5-1.1: New USB device found, idVendor=05e3, idProduct=0735 Jun 29 02:53:13 volumio kernel: usb 5-1.1: New USB device strings: Mfr=4, Product=5, SerialNumber=6 Jun 29 02:53:13 volumio kernel: usb 5-1.1: Product: USB to S-ATA Jun 29 02:53:13 volumio kernel: usb 5-1.1: Manufacturer: Genesyslogic Jun 29 02:53:13 volumio kernel: usb 5-1.1: SerialNumber: 0000000000000014 Jun 29 02:53:13 volumio systemd[1]: Started WPA supplicant. Jun 29 02:53:13 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Jun 29 02:53:13 volumio sh[386]: eth0: rebinding lease of 192.168.3.102 Jun 29 02:53:13 volumio dhcpcd[408]: eth0: rebinding lease of 192.168.3.102 Jun 29 02:53:13 volumio systemd[1]: Reached target Sound Card. Jun 29 02:53:13 volumio dhcpcd[430]: eth0: soliciting an IPv6 router Jun 29 02:53:13 volumio dhcpcd[430]: eth0: soliciting an IPv6 router Jun 29 02:53:13 volumio kernel: nf_conntrack version 0.5.0 (7879 buckets, 31516 max) Jun 29 02:53:13 volumio volumio-remote-updater[425]: Error: No active session Jun 29 02:53:13 volumio volumio-remote-updater[425]: [2025-06-29 02:53:13] [info] asio async_connect error: system:111 (Connection refused) Jun 29 02:53:13 volumio volumio-remote-updater[425]: [2025-06-29 02:53:13] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 29 02:53:13 volumio volumio-remote-updater[425]: [2025-06-29 02:53:13] [error] handle_connect error: Underlying Transport Error Jun 29 02:53:13 volumio kernel: usb-storage 5-1.1:1.0: USB Mass Storage device detected Jun 29 02:53:13 volumio kernel: scsi host0: usb-storage 5-1.1:1.0 Jun 29 02:53:13 volumio kernel: usbcore: registered new interface driver usb-storage Jun 29 02:53:13 volumio loadcpufreq[434]: Loading cpufreq kernel modules...done (none). Jun 29 02:53:13 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Jun 29 02:53:13 volumio kernel: usbcore: registered new interface driver uas Jun 29 02:53:13 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Jun 29 02:53:13 volumio volumio[426]: Could not open config: /tmp/upmpdcli.conf Jun 29 02:53:13 volumio systemd[1]: Started Helper to synchronize boot up for ifupdown. Jun 29 02:53:13 volumio systemd[1]: Starting Raise network interfaces... Jun 29 02:53:13 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jun 29 02:53:13 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jun 29 02:53:13 volumio ifup[480]: command failed: No such device (-19) Jun 29 02:53:13 volumio ifup[480]: command failed: No such device (-19) Jun 29 02:53:13 volumio kernel: random: nonblocking pool is initialized Jun 29 02:53:13 volumio lircd-setup[424]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead. Jun 29 02:53:13 volumio lircd-setup[424]: parser = configparser.SafeConfigParser() Jun 29 02:53:13 volumio systemd[1]: lircd-setup.service: Succeeded. Jun 29 02:53:13 volumio systemd[1]: Started lircd(8) initialization helper tool. Jun 29 02:53:13 volumio cpufrequtils[478]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Jun 29 02:53:13 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Jun 29 02:53:13 volumio kernel: cfg80211: World regulatory domain updated: Jun 29 02:53:13 volumio kernel: cfg80211: DFS Master region: unset Jun 29 02:53:13 volumio kernel: cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Jun 29 02:53:13 volumio kernel: cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Jun 29 02:53:13 volumio kernel: cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz, 92000 KHz AUTO), (N/A, 2000 mBm), (N/A) Jun 29 02:53:13 volumio kernel: cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) Jun 29 02:53:13 volumio kernel: cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) Jun 29 02:53:13 volumio kernel: cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) Jun 29 02:53:13 volumio kernel: cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s) Jun 29 02:53:13 volumio kernel: cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) Jun 29 02:53:13 volumio kernel: cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A) Jun 29 02:53:13 volumio ifup[480]: command failed: No such device (-19) Jun 29 02:53:14 volumio systemd[1]: Started Raise network interfaces. Jun 29 02:53:14 volumio systemd[1]: Reached target Network. Jun 29 02:53:14 volumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Jun 29 02:53:14 volumio systemd[1]: Starting Music Player Daemon... Jun 29 02:53:14 volumio systemd[1]: Starting Permit User Sessions... Jun 29 02:53:14 volumio systemd[1]: Starting Network Time Service... Jun 29 02:53:14 volumio systemd[1]: Starting Flexible IR remote input/output application support... Jun 29 02:53:14 volumio systemd[1]: Reached target Network is Online. Jun 29 02:53:14 volumio systemd[1]: Starting Samba NMB Daemon... Jun 29 02:53:14 volumio systemd[1]: Starting LSB: Brings up/down network automatically... Jun 29 02:53:14 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 29 02:53:14 volumio lircd-0.10.1[614]: Info: lircd: Opening log, level: Info Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Version: lircd 0.10.1 Jun 29 02:53:14 volumio systemd[1]: Starting /etc/rc.local Compatibility... Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: System info: Linux volumio 4.4.154 #5 SMP Sat Jan 23 18:17:37 CET 2021 aarch64 GNU/Linux Jun 29 02:53:14 volumio systemd[1]: Started Permit User Sessions. Jun 29 02:53:14 volumio systemd[1]: Started /etc/rc.local Compatibility. Jun 29 02:53:14 volumio systemd[1]: Starting Hold until boot process finishes up... Jun 29 02:53:14 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... Jun 29 02:53:14 volumio ntpd[613]: ntpd 4.2.8p12@1.3728-o (1): Starting Jun 29 02:53:14 volumio ntpd[613]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Jun 29 02:53:14 volumio systemd[1]: Started Network Time Service. Jun 29 02:53:14 volumio ntpd[636]: proto: precision = 0.875 usec (-20) Jun 29 02:53:14 volumio systemd[1]: Received SIGRTMIN+21 from PID 325 (plymouthd). Jun 29 02:53:14 volumio systemd[1]: Received SIGRTMIN+21 from PID 325 (plymouthd). Jun 29 02:53:14 volumio systemd[1]: plymouth-start.service: Succeeded. Jun 29 02:53:14 volumio systemd[1]: plymouth-quit-wait.service: Succeeded. Jun 29 02:53:14 volumio systemd[1]: Started Hold until boot process finishes up. Jun 29 02:53:14 volumio ntpd[636]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jun 29 02:53:14 volumio ntpd[636]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jun 29 02:53:14 volumio ntpd[636]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 1098 days ago Jun 29 02:53:14 volumio ntpd[636]: Listen and drop on 0 v6wildcard [::]:123 Jun 29 02:53:14 volumio ntpd[636]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jun 29 02:53:14 volumio ntpd[636]: Listen normally on 2 lo 127.0.0.1:123 Jun 29 02:53:14 volumio ntpd[636]: Listening on routing socket on fd #19 for interface updates Jun 29 02:53:14 volumio systemd[1]: plymouth-quit.service: Succeeded. Jun 29 02:53:14 volumio systemd[1]: Started Terminate Plymouth Boot Screen. Jun 29 02:53:14 volumio ntpd[636]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 29 02:53:14 volumio ntpd[636]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 29 02:53:14 volumio systemd[1]: iptables.service: Succeeded. Jun 29 02:53:14 volumio systemd[1]: Started Serial Getty on ttyS2. Jun 29 02:53:14 volumio ifplugd(eth0)[645]: ifplugd 0.28 initializing. Jun 29 02:53:14 volumio systemd[1]: Started Getty on tty1. Jun 29 02:53:14 volumio systemd[1]: Reached target Login Prompts. Jun 29 02:53:14 volumio ifplugd(eth0)[645]: Using interface eth0/EE:D8:FD:35:36:8B with driver (version: March_2013) Jun 29 02:53:14 volumio ifplugd(eth0)[645]: Using detection mode: SIOCETHTOOL Jun 29 02:53:14 volumio ifplugd(eth0)[645]: Initialization complete, link beat detected. Jun 29 02:53:14 volumio lircd-0.10.1[614]: Info: Initial device: auto Jun 29 02:53:14 volumio lircd-0.10.1[614]: Info: Initial device: auto Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Options: driver: devinput Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Info: lircd: Opening log, level: Info Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Notice: Using systemd fd Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Warning: Running as root Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Options: output: /var/run/lirc/lircd Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Options: nodaemon: 1 Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Options: logfile: syslog Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Options: immediate-init: 0 Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Options: permission: 666 Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Options: driver-options: Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Options: pidfile: /var/run/lirc/lircd.pid Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Options: listen: 0 Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Options: connect: (null) Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Options: userelease: 0 Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Options: effective_user: (null) Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Options: release_suffix: _EVUP Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Options: allow_simulate: 0 Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Options: repeat_max: 600 Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Options: configfile: /etc/lirc/lircd.conf Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Options: dynamic_codes: (null) Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Current driver: devinput Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Driver API version: 4 Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Driver version: 0.10.0 Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/devinput.html Jun 29 02:53:14 volumio lircd-0.10.1[614]: Info: lircd: Opening log, level: Info Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: Using systemd fd Jun 29 02:53:14 volumio lircd-0.10.1[614]: Warning: Running as root Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Info: Using remote: devinput-64. Jun 29 02:53:14 volumio lircd-0.10.1[614]: Info: Using remote: devinput-64. Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-64: Multiple values for same code: BTN_MISC Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-64: Multiple values for same code: BTN_MOUSE Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-64: Multiple values for same code: BTN_MISC Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-64: Multiple values for same code: BTN_SOUTH Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-64: Multiple values for same code: BTN_TOOL_PEN Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-64: Multiple values for same code: BTN_TRIGGER Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-64: Multiple values for same code: BTN_TRIGGER_HAPPY1 Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-64: Multiple values for same code: BTN_MOUSE Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-64: Multiple values for same code: BTN_WHEEL Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Info: Using remote: devinput-32. Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-64: Multiple values for same code: BTN_SOUTH Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-64: Multiple values for same code: BTN_TOOL_PEN Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-64: Multiple values for same code: BTN_TRIGGER Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-64: Multiple values for same code: BTN_TRIGGER_HAPPY1 Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-64: Multiple values for same code: BTN_WHEEL Jun 29 02:53:14 volumio lircd-0.10.1[614]: Info: Using remote: devinput-32. Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-32: Multiple values for same code: BTN_MISC Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-32: Multiple values for same code: BTN_MOUSE Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-32: Multiple values for same code: BTN_MISC Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-32: Multiple values for same code: BTN_SOUTH Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-32: Multiple values for same code: BTN_TOOL_PEN Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-32: Multiple values for same code: BTN_TRIGGER Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-32: Multiple values for same code: BTN_TRIGGER_HAPPY1 Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-32: Multiple values for same code: BTN_MOUSE Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-32: Multiple values for same code: BTN_WHEEL Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-32: Multiple values for same code: BTN_SOUTH Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-32: Multiple values for same code: BTN_TOOL_PEN Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-32: Multiple values for same code: BTN_TRIGGER Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-32: Multiple values for same code: BTN_TRIGGER_HAPPY1 Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: /etc/lirc/lircd.conf.d/devinput.lircd.conf: devinput-32: Multiple values for same code: BTN_WHEEL Jun 29 02:53:14 volumio systemd[1]: Started Flexible IR remote input/output application support. Jun 29 02:53:14 volumio lircd[614]: lircd-0.10.1[614]: Notice: lircd(devinput) ready, using /var/run/lirc/lircd Jun 29 02:53:14 volumio lircd-0.10.1[614]: Notice: lircd(devinput) ready, using /var/run/lirc/lircd Jun 29 02:53:14 volumio ifplugd(eth0)[645]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Jun 29 02:53:14 volumio ifplugd(eth0)[645]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Jun 29 02:53:14 volumio haveged[398]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.3.0 CTV); collect: 128K Jun 29 02:53:14 volumio haveged[398]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 12/40; sz: 15012/57848 Jun 29 02:53:14 volumio haveged[398]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99901 Jun 29 02:53:14 volumio haveged[398]: haveged: fills: 0, generated: 0 Jun 29 02:53:14 volumio dhcpcd[430]: eth0: carrier lost Jun 29 02:53:14 volumio sh[386]: eth0: carrier lost Jun 29 02:53:14 volumio dhcpcd[430]: eth0: carrier lost Jun 29 02:53:14 volumio dhcpcd[408]: eth0: carrier lost Jun 29 02:53:14 volumio nmbd[627]: [2025/06/29 02:53:14.809424, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Jun 29 02:53:14 volumio nmbd[627]: started asyncdns process 691 Jun 29 02:53:14 volumio nmbd[627]: [2025/06/29 02:53:14.811538, 0] ../lib/util/become_daemon.c:149(daemon_status) Jun 29 02:53:14 volumio nmbd[627]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Jun 29 02:53:14 volumio nmbd[627]: [2025/06/29 02:53:14.811721, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Jun 29 02:53:14 volumio nmbd[627]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Jun 29 02:53:14 volumio wireless.js[427]: WIRELESS DAEMON: start Jun 29 02:53:14 volumio wireless.js[427]: WIRELESS: Loaded configuration Jun 29 02:53:14 volumio wireless.js[427]: Cleaning previous... Jun 29 02:53:15 volumio sudo[695]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 29 02:53:15 volumio sudo[695]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 02:53:15 volumio sudo[695]: pam_unix(sudo:session): session closed for user root Jun 29 02:53:15 volumio wireless.js[427]: Stopped aP Jun 29 02:53:15 volumio ntpd[636]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jun 29 02:53:15 volumio sudo[706]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 29 02:53:15 volumio sudo[706]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 02:53:15 volumio sudo[706]: pam_unix(sudo:session): session closed for user root Jun 29 02:53:15 volumio systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jun 29 02:53:15 volumio hostapd[720]: Configuration file: /etc/hostapd/hostapd.conf Jun 29 02:53:15 volumio hostapd[720]: Could not read interface wlan0 flags: No such device Jun 29 02:53:15 volumio hostapd[720]: nl80211: Driver does not support authentication/association or connect commands Jun 29 02:53:15 volumio hostapd[720]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jun 29 02:53:15 volumio hostapd[720]: Could not read interface wlan0 flags: No such device Jun 29 02:53:15 volumio hostapd[720]: nl80211 driver initialization failed. Jun 29 02:53:15 volumio hostapd[720]: wlan0: interface state UNINITIALIZED->DISABLED Jun 29 02:53:15 volumio hostapd[720]: wlan0: AP-DISABLED Jun 29 02:53:15 volumio hostapd[720]: wlan0: CTRL-EVENT-TERMINATING Jun 29 02:53:15 volumio hostapd[720]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jun 29 02:53:15 volumio systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jun 29 02:53:15 volumio systemd[1]: hostapd.service: Failed with result 'exit-code'. Jun 29 02:53:15 volumio systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jun 29 02:53:15 volumio systemd[1]: Starting dnsmasq - A lightweight DHCP and caching DNS server... Jun 29 02:53:15 volumio dnsmasq[727]: dnsmasq: syntax check OK. Jun 29 02:53:15 volumio kernel: scsi 0:0:0:0: Direct-Access Genesys USB3/SATA Bridge TB12 PQ: 0 ANSI: 6 Jun 29 02:53:15 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk Jun 29 02:53:15 volumio iw[733]: command failed: No such device (-19) Jun 29 02:53:15 volumio systemd[1]: wireless.service: Control process exited, code=exited, status=237/KEYRING Jun 29 02:53:15 volumio systemd[1]: wireless.service: Failed with result 'exit-code'. Jun 29 02:53:15 volumio systemd[1]: Failed to start Wireless Services. Jun 29 02:53:15 volumio dnsmasq[738]: started, version 2.80 cachesize 150 Jun 29 02:53:15 volumio dnsmasq[738]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect inotify dumpfile Jun 29 02:53:15 volumio dnsmasq[738]: warning: interface wlan0 does not currently exist Jun 29 02:53:15 volumio dnsmasq-dhcp[738]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Jun 29 02:53:15 volumio dnsmasq[738]: reading /etc/resolv.conf Jun 29 02:53:15 volumio dnsmasq[738]: using nameserver 208.67.222.222#53 Jun 29 02:53:15 volumio dnsmasq[738]: using nameserver 208.67.220.220#53 Jun 29 02:53:15 volumio dnsmasq[738]: read /etc/hosts - 5 addresses Jun 29 02:53:15 volumio systemd[1]: Started Volumio Backend Module. Jun 29 02:53:15 volumio systemd[1]: Started Volumio Streaming Daemon. Jun 29 02:53:15 volumio systemd[1]: Started dnsmasq - A lightweight DHCP and caching DNS server. Jun 29 02:53:15 volumio systemd[1]: Reached target Host and Network Name Lookups. Jun 29 02:53:15 volumio volumio-streaming-daemon[743]: ############################ Jun 29 02:53:15 volumio volumio-streaming-daemon[743]: # Volumio Streaming Daemon # Jun 29 02:53:15 volumio volumio-streaming-daemon[743]: # Running on port 7777 # Jun 29 02:53:15 volumio volumio-streaming-daemon[743]: ############################ Jun 29 02:53:15 volumio volumio-streaming-daemon[743]: Environment: production Jun 29 02:53:16 volumio ntpd[636]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Jun 29 02:53:16 volumio mpd[655]: Jun 29 02:53 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 29 02:53:16 volumio mpd[655]: Jun 29 02:53 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jun 29 02:53:16 volumio mpd[655]: Jun 29 02:53 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jun 29 02:53:16 volumio systemd[1]: Started Music Player Daemon. Jun 29 02:53:17 volumio ntpd[636]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Jun 29 02:53:17 volumio systemd[1]: hostapd.service: Service RestartSec=2s expired, scheduling restart. Jun 29 02:53:17 volumio systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 1. Jun 29 02:53:17 volumio systemd[1]: Stopping dnsmasq - A lightweight DHCP and caching DNS server... Jun 29 02:53:17 volumio dnsmasq[738]: exiting on receipt of SIGTERM Jun 29 02:53:17 volumio systemd[1]: dnsmasq.service: Succeeded. Jun 29 02:53:17 volumio systemd[1]: Stopped dnsmasq - A lightweight DHCP and caching DNS server. Jun 29 02:53:17 volumio systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jun 29 02:53:17 volumio systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jun 29 02:53:17 volumio hostapd[763]: Configuration file: /etc/hostapd/hostapd.conf Jun 29 02:53:17 volumio hostapd[763]: Could not read interface wlan0 flags: No such device Jun 29 02:53:17 volumio hostapd[763]: nl80211: Driver does not support authentication/association or connect commands Jun 29 02:53:17 volumio hostapd[763]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jun 29 02:53:17 volumio hostapd[763]: Could not read interface wlan0 flags: No such device Jun 29 02:53:17 volumio hostapd[763]: nl80211 driver initialization failed. Jun 29 02:53:17 volumio hostapd[763]: wlan0: interface state UNINITIALIZED->DISABLED Jun 29 02:53:17 volumio hostapd[763]: wlan0: AP-DISABLED Jun 29 02:53:17 volumio hostapd[763]: wlan0: CTRL-EVENT-TERMINATING Jun 29 02:53:17 volumio hostapd[763]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jun 29 02:53:17 volumio systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jun 29 02:53:17 volumio systemd[1]: hostapd.service: Failed with result 'exit-code'. Jun 29 02:53:17 volumio systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jun 29 02:53:17 volumio systemd[1]: Starting dnsmasq - A lightweight DHCP and caching DNS server... Jun 29 02:53:17 volumio dnsmasq[770]: dnsmasq: syntax check OK. Jun 29 02:53:17 volumio dnsmasq[776]: started, version 2.80 cachesize 150 Jun 29 02:53:17 volumio dnsmasq[776]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect inotify dumpfile Jun 29 02:53:17 volumio dnsmasq[776]: warning: interface wlan0 does not currently exist Jun 29 02:53:17 volumio dnsmasq-dhcp[776]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Jun 29 02:53:17 volumio dnsmasq[776]: reading /etc/resolv.conf Jun 29 02:53:17 volumio dnsmasq[776]: using nameserver 208.67.222.222#53 Jun 29 02:53:17 volumio dnsmasq[776]: using nameserver 208.67.220.220#53 Jun 29 02:53:17 volumio dnsmasq[776]: read /etc/hosts - 5 addresses Jun 29 02:53:17 volumio systemd[1]: Started dnsmasq - A lightweight DHCP and caching DNS server. Jun 29 02:53:18 volumio ntpd[636]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Jun 29 02:53:18 volumio volumio-remote-updater[425]: [2025-06-29 02:53:18] [connect] Successful connection Jun 29 02:53:18 volumio volumio[742]: info: ------------------------------------------- Jun 29 02:53:18 volumio volumio[742]: info: ----- Volumio3 ---- Jun 29 02:53:18 volumio volumio[742]: info: ------------------------------------------- Jun 29 02:53:18 volumio volumio[742]: info: ----- System startup ---- Jun 29 02:53:18 volumio volumio[742]: info: ------------------------------------------- Jun 29 02:53:18 volumio dhcpcd[430]: eth0: carrier acquired Jun 29 02:53:18 volumio dhcpcd[430]: eth0: carrier acquired Jun 29 02:53:18 volumio sh[386]: eth0: carrier acquired Jun 29 02:53:18 volumio kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Jun 29 02:53:18 volumio dhcpcd[408]: eth0: carrier acquired Jun 29 02:53:18 volumio sh[386]: eth0: IAID fd:35:36:8b Jun 29 02:53:18 volumio dhcpcd[430]: eth0: IAID fd:35:36:8b Jun 29 02:53:18 volumio dhcpcd[430]: eth0: IAID fd:35:36:8b Jun 29 02:53:18 volumio dhcpcd[408]: eth0: IAID fd:35:36:8b Jun 29 02:53:18 volumio dhcpcd[430]: eth0: soliciting an IPv6 router Jun 29 02:53:18 volumio dhcpcd[430]: eth0: soliciting an IPv6 router Jun 29 02:53:19 volumio dhcpcd[430]: eth0: rebinding lease of 192.168.3.102 Jun 29 02:53:19 volumio dhcpcd[430]: eth0: rebinding lease of 192.168.3.102 Jun 29 02:53:19 volumio sh[386]: eth0: rebinding lease of 192.168.3.102 Jun 29 02:53:19 volumio dhcpcd[408]: eth0: rebinding lease of 192.168.3.102 Jun 29 02:53:19 volumio dhcpcd[430]: eth0: NAK: Invalid Request Message from 192.168.3.1 Jun 29 02:53:19 volumio dhcpcd[430]: eth0: message: Invalid Request Message Jun 29 02:53:19 volumio dhcpcd[430]: eth0: NAK: Invalid Request Message from 192.168.3.1 Jun 29 02:53:19 volumio dhcpcd[430]: eth0: message: Invalid Request Message Jun 29 02:53:19 volumio dnsmasq[776]: reading /etc/resolv.conf Jun 29 02:53:19 volumio dnsmasq[776]: using nameserver 208.67.222.222#53 Jun 29 02:53:19 volumio dnsmasq[776]: using nameserver 208.67.220.220#53 Jun 29 02:53:19 volumio dhcpcd[430]: eth0: soliciting a DHCP lease Jun 29 02:53:19 volumio dhcpcd[430]: eth0: soliciting a DHCP lease Jun 29 02:53:19 volumio sh[386]: eth0: soliciting an IPv6 router Jun 29 02:53:19 volumio dhcpcd[408]: eth0: soliciting an IPv6 router Jun 29 02:53:19 volumio volumio[742]: info: MYVOLUMIO Environment detected Jun 29 02:53:19 volumio volumio[742]: info: Plugin folders cleanup Jun 29 02:53:19 volumio volumio[742]: info: Scanning into folder /volumio/app/plugins/ Jun 29 02:53:19 volumio volumio[742]: info: Scanning category audio_interface Jun 29 02:53:19 volumio volumio[742]: info: Scanning category miscellanea Jun 29 02:53:19 volumio volumio[742]: info: Scanning category music_service Jun 29 02:53:19 volumio volumio[742]: info: Scanning category plugins.json Jun 29 02:53:19 volumio volumio[742]: info: Scanning category system_controller Jun 29 02:53:19 volumio volumio[742]: info: Scanning category user_interface Jun 29 02:53:19 volumio volumio[742]: info: Scanning into folder /data/plugins/ Jun 29 02:53:19 volumio volumio[742]: info: Scanning category music_service Jun 29 02:53:19 volumio volumio[742]: info: Plugin folders cleanup completed Jun 29 02:53:19 volumio volumio[742]: info: ------------------------------------------- Jun 29 02:53:19 volumio volumio[742]: info: ----- Core plugins startup ---- Jun 29 02:53:19 volumio volumio[742]: info: ------------------------------------------- Jun 29 02:53:19 volumio volumio[742]: info: Loading plugins from folder /volumio/app/plugins/ Jun 29 02:53:19 volumio volumio[742]: info: Adding plugin upnp to MyMusic Plugins Jun 29 02:53:19 volumio volumio[742]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 29 02:53:19 volumio volumio[742]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 29 02:53:19 volumio volumio[742]: info: Loading plugins from folder /data/plugins/ Jun 29 02:53:19 volumio volumio[742]: info: Loading plugin "system"... Jun 29 02:53:19 volumio volumio[742]: info: Loading plugin "appearance"... Jun 29 02:53:19 volumio systemd[1]: hostapd.service: Service RestartSec=2s expired, scheduling restart. Jun 29 02:53:19 volumio systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 2. Jun 29 02:53:19 volumio systemd[1]: Stopping dnsmasq - A lightweight DHCP and caching DNS server... Jun 29 02:53:19 volumio dnsmasq[776]: exiting on receipt of SIGTERM Jun 29 02:53:19 volumio systemd[1]: dnsmasq.service: Succeeded. Jun 29 02:53:19 volumio systemd[1]: Stopped dnsmasq - A lightweight DHCP and caching DNS server. Jun 29 02:53:19 volumio systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jun 29 02:53:19 volumio systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jun 29 02:53:19 volumio hostapd[807]: Configuration file: /etc/hostapd/hostapd.conf Jun 29 02:53:19 volumio hostapd[807]: Could not read interface wlan0 flags: No such device Jun 29 02:53:19 volumio hostapd[807]: nl80211: Driver does not support authentication/association or connect commands Jun 29 02:53:19 volumio hostapd[807]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jun 29 02:53:19 volumio hostapd[807]: Could not read interface wlan0 flags: No such device Jun 29 02:53:19 volumio hostapd[807]: nl80211 driver initialization failed. Jun 29 02:53:19 volumio hostapd[807]: wlan0: interface state UNINITIALIZED->DISABLED Jun 29 02:53:19 volumio hostapd[807]: wlan0: AP-DISABLED Jun 29 02:53:19 volumio hostapd[807]: wlan0: CTRL-EVENT-TERMINATING Jun 29 02:53:19 volumio hostapd[807]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jun 29 02:53:20 volumio systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jun 29 02:53:20 volumio systemd[1]: hostapd.service: Failed with result 'exit-code'. Jun 29 02:53:20 volumio systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jun 29 02:53:20 volumio systemd[1]: Starting dnsmasq - A lightweight DHCP and caching DNS server... Jun 29 02:53:20 volumio dnsmasq[814]: dnsmasq: syntax check OK. Jun 29 02:53:20 volumio dnsmasq[820]: started, version 2.80 cachesize 150 Jun 29 02:53:20 volumio dnsmasq[820]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect inotify dumpfile Jun 29 02:53:20 volumio dnsmasq[820]: warning: interface wlan0 does not currently exist Jun 29 02:53:20 volumio dnsmasq-dhcp[820]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Jun 29 02:53:20 volumio dnsmasq[820]: reading /etc/resolv.conf Jun 29 02:53:20 volumio dnsmasq[820]: using nameserver 208.67.222.222#53 Jun 29 02:53:20 volumio dnsmasq[820]: using nameserver 208.67.220.220#53 Jun 29 02:53:20 volumio dnsmasq[820]: read /etc/hosts - 5 addresses Jun 29 02:53:20 volumio systemd[1]: Started dnsmasq - A lightweight DHCP and caching DNS server. Jun 29 02:53:21 volumio volumio[742]: info: Loading plugin "network"... Jun 29 02:53:21 volumio volumio[742]: info: Refreshing Cached IP Addresses Jun 29 02:53:21 volumio sudo[827]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 29 02:53:21 volumio sudo[827]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 02:53:21 volumio sudo[827]: pam_unix(sudo:session): session closed for user root Jun 29 02:53:21 volumio volumio[742]: info: Loading plugin "services"... Jun 29 02:53:21 volumio sudo[829]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 29 02:53:21 volumio sudo[829]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 02:53:21 volumio volumio[742]: info: Loading plugin "alsa_controller"... Jun 29 02:53:21 volumio sudo[832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 29 02:53:21 volumio sudo[832]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 02:53:21 volumio sudo[829]: pam_unix(sudo:session): session closed for user root Jun 29 02:53:21 volumio sh[386]: eth0: probing address 192.168.3.102/24 Jun 29 02:53:21 volumio dhcpcd[408]: eth0: probing address 192.168.3.102/24 Jun 29 02:53:21 volumio sudo[832]: pam_unix(sudo:session): session closed for user root Jun 29 02:53:21 volumio dhcpcd[430]: eth0: offered 192.168.3.102 from 192.168.3.1 Jun 29 02:53:21 volumio dhcpcd[430]: eth0: offered 192.168.3.102 from 192.168.3.1 Jun 29 02:53:21 volumio volumio[742]: info: Loading plugin "wizard"... Jun 29 02:53:21 volumio dhcpcd[430]: eth0: probing address 192.168.3.102/24 Jun 29 02:53:21 volumio dhcpcd[430]: eth0: probing address 192.168.3.102/24 Jun 29 02:53:21 volumio volumio[742]: info: Loading plugin "volumio_command_line_client"... Jun 29 02:53:21 volumio volumio[742]: info: Plugin upnp is not enabled Jun 29 02:53:21 volumio volumio[742]: info: Loading plugin "my_music"... Jun 29 02:53:21 volumio volumio[742]: info: Loading plugin "mpd"... Jun 29 02:53:21 volumio volumio[742]: info: Creating MPD Configuration file Jun 29 02:53:21 volumio volumio[742]: info: Plugin upnp_browser is not enabled Jun 29 02:53:21 volumio volumio[742]: info: Loading plugin "networkfs"... Jun 29 02:53:21 volumio sudo[842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 29 02:53:21 volumio sudo[842]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 02:53:21 volumio sudo[842]: pam_unix(sudo:session): session closed for user root Jun 29 02:53:21 volumio sudo[844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 29 02:53:21 volumio sudo[844]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 02:53:21 volumio systemd[1]: Stopping Music Player Daemon... Jun 29 02:53:22 volumio systemd[1]: mpd.service: Succeeded. Jun 29 02:53:22 volumio systemd[1]: Stopped Music Player Daemon. Jun 29 02:53:22 volumio systemd[1]: hostapd.service: Service RestartSec=2s expired, scheduling restart. Jun 29 02:53:22 volumio systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 3. Jun 29 02:53:22 volumio systemd[1]: Stopping dnsmasq - A lightweight DHCP and caching DNS server... Jun 29 02:53:22 volumio systemd[1]: Starting Music Player Daemon... Jun 29 02:53:22 volumio dnsmasq[820]: exiting on receipt of SIGTERM Jun 29 02:53:22 volumio systemd[1]: dnsmasq.service: Succeeded. Jun 29 02:53:22 volumio systemd[1]: Stopped dnsmasq - A lightweight DHCP and caching DNS server. Jun 29 02:53:22 volumio systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jun 29 02:53:22 volumio systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jun 29 02:53:22 volumio hostapd[852]: Configuration file: /etc/hostapd/hostapd.conf Jun 29 02:53:22 volumio hostapd[852]: Could not read interface wlan0 flags: No such device Jun 29 02:53:22 volumio hostapd[852]: nl80211: Driver does not support authentication/association or connect commands Jun 29 02:53:22 volumio hostapd[852]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jun 29 02:53:22 volumio hostapd[852]: Could not read interface wlan0 flags: No such device Jun 29 02:53:22 volumio hostapd[852]: nl80211 driver initialization failed. Jun 29 02:53:22 volumio hostapd[852]: wlan0: interface state UNINITIALIZED->DISABLED Jun 29 02:53:22 volumio hostapd[852]: wlan0: AP-DISABLED Jun 29 02:53:22 volumio hostapd[852]: wlan0: CTRL-EVENT-TERMINATING Jun 29 02:53:22 volumio hostapd[852]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jun 29 02:53:22 volumio systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jun 29 02:53:22 volumio systemd[1]: hostapd.service: Failed with result 'exit-code'. Jun 29 02:53:22 volumio systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jun 29 02:53:22 volumio systemd[1]: Starting dnsmasq - A lightweight DHCP and caching DNS server... Jun 29 02:53:22 volumio dnsmasq[859]: dnsmasq: syntax check OK. Jun 29 02:53:22 volumio volumio[742]: info: Starting Udev Watcher for removable devices Jun 29 02:53:22 volumio dnsmasq[867]: started, version 2.80 cachesize 150 Jun 29 02:53:22 volumio dnsmasq[867]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect inotify dumpfile Jun 29 02:53:22 volumio dnsmasq[867]: warning: interface wlan0 does not currently exist Jun 29 02:53:22 volumio dnsmasq-dhcp[867]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Jun 29 02:53:22 volumio dnsmasq[867]: reading /etc/resolv.conf Jun 29 02:53:22 volumio dnsmasq[867]: using nameserver 208.67.222.222#53 Jun 29 02:53:22 volumio dnsmasq[867]: using nameserver 208.67.220.220#53 Jun 29 02:53:22 volumio dnsmasq[867]: read /etc/hosts - 5 addresses Jun 29 02:53:22 volumio systemd[1]: Started dnsmasq - A lightweight DHCP and caching DNS server. Jun 29 02:53:22 volumio volumio[742]: info: Ignoring mount for partition: boot Jun 29 02:53:22 volumio volumio[742]: info: Ignoring mount for partition: volumio Jun 29 02:53:22 volumio volumio[742]: info: Ignoring mount for partition: volumio_data Jun 29 02:53:22 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 29 02:53:22 volumio volumio[742]: info: Loading plugin "alarm-clock"... Jun 29 02:53:22 volumio volumio[742]: info: Plugin airplay_emulation is not enabled Jun 29 02:53:22 volumio volumio[742]: info: Loading plugin "last_100"... Jun 29 02:53:22 volumio volumio[742]: info: Loading plugin "webradio"... Jun 29 02:53:23 volumio volumio[742]: info: Loading plugin "i2s_dacs"... Jun 29 02:53:23 volumio volumio[742]: info: I2S DAC not set, start Auto-detection Jun 29 02:53:23 volumio volumio[742]: info: Loading plugin "volumiodiscovery"... Jun 29 02:53:23 volumio volumio[742]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 29 02:53:23 volumio volumio[742]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 29 02:53:23 volumio volumio[742]: *** WARNING *** For more information see Jun 29 02:53:23 volumio volumio[742]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 29 02:53:23 volumio node[742]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 29 02:53:23 volumio volumio[742]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 29 02:53:23 volumio volumio[742]: *** WARNING *** For more information see Jun 29 02:53:23 volumio node[742]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 29 02:53:23 volumio node[742]: *** WARNING *** For more information see Jun 29 02:53:23 volumio node[742]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 29 02:53:23 volumio node[742]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 29 02:53:23 volumio node[742]: *** WARNING *** For more information see Jun 29 02:53:23 volumio volumio[742]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 29 02:53:23 volumio volumio[742]: info: Discovery: Started advertising with name: Volumio Jun 29 02:53:23 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 29 02:53:23 volumio volumio[742]: info: Loading plugin "squeezelite_mc"... Jun 29 02:53:23 volumio mpd[873]: Jun 29 02:53 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 29 02:53:23 volumio mpd[873]: Jun 29 02:53 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jun 29 02:53:23 volumio mpd[873]: Jun 29 02:53 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jun 29 02:53:23 volumio systemd[1]: Started Music Player Daemon. Jun 29 02:53:23 volumio sudo[844]: pam_unix(sudo:session): session closed for user root Jun 29 02:53:24 volumio volumio[742]: info: Loading plugin "outputs"... Jun 29 02:53:24 volumio volumio[742]: info: Loading plugin "albumart"... Jun 29 02:53:24 volumio volumio[742]: info: Plugin example_plugin is not enabled Jun 29 02:53:24 volumio volumio[742]: info: Loading plugin "inputs"... Jun 29 02:53:24 volumio volumio[742]: info: Loading plugin "updater_comm"... Jun 29 02:53:24 volumio systemd[1]: hostapd.service: Service RestartSec=2s expired, scheduling restart. Jun 29 02:53:24 volumio systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 4. Jun 29 02:53:24 volumio systemd[1]: Stopping dnsmasq - A lightweight DHCP and caching DNS server... Jun 29 02:53:24 volumio dnsmasq[867]: exiting on receipt of SIGTERM Jun 29 02:53:24 volumio systemd[1]: dnsmasq.service: Succeeded. Jun 29 02:53:24 volumio systemd[1]: Stopped dnsmasq - A lightweight DHCP and caching DNS server. Jun 29 02:53:24 volumio systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jun 29 02:53:24 volumio systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jun 29 02:53:24 volumio hostapd[889]: Configuration file: /etc/hostapd/hostapd.conf Jun 29 02:53:24 volumio volumio[742]: info: Plugin mpdemulation is not enabled Jun 29 02:53:24 volumio volumio[742]: info: Loading plugin "rest_api"... Jun 29 02:53:24 volumio volumio[742]: info: Loading plugin "websocket"... Jun 29 02:53:24 volumio hostapd[889]: Could not read interface wlan0 flags: No such device Jun 29 02:53:24 volumio hostapd[889]: nl80211: Driver does not support authentication/association or connect commands Jun 29 02:53:24 volumio hostapd[889]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jun 29 02:53:24 volumio volumio[742]: info: Plugin RoonBridge is not enabled Jun 29 02:53:24 volumio hostapd[889]: Could not read interface wlan0 flags: No such device Jun 29 02:53:24 volumio hostapd[889]: nl80211 driver initialization failed. Jun 29 02:53:24 volumio hostapd[889]: wlan0: interface state UNINITIALIZED->DISABLED Jun 29 02:53:24 volumio hostapd[889]: wlan0: AP-DISABLED Jun 29 02:53:24 volumio hostapd[889]: wlan0: CTRL-EVENT-TERMINATING Jun 29 02:53:24 volumio hostapd[889]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jun 29 02:53:24 volumio systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jun 29 02:53:24 volumio systemd[1]: hostapd.service: Failed with result 'exit-code'. Jun 29 02:53:24 volumio systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jun 29 02:53:24 volumio volumio[742]: info: Loading i18n strings for locale zh Jun 29 02:53:24 volumio systemd[1]: Starting dnsmasq - A lightweight DHCP and caching DNS server... Jun 29 02:53:24 volumio volumio[742]: Updating browse sources language Jun 29 02:53:24 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 29 02:53:24 volumio dnsmasq[896]: dnsmasq: syntax check OK. Jun 29 02:53:24 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 29 02:53:24 volumio volumio[742]: info: CoreCommandRouter::initPlayerControls Jun 29 02:53:24 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:24 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:24 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:24 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:24 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:24 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:24 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:24 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:24 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 29 02:53:24 volumio volumio[742]: Express server listening on port 3000 Jun 29 02:53:24 volumio volumio[742]: [Metrics] WebUI: 7s 38.62ms Jun 29 02:53:24 volumio dnsmasq[902]: started, version 2.80 cachesize 150 Jun 29 02:53:24 volumio dnsmasq[902]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect inotify dumpfile Jun 29 02:53:24 volumio dnsmasq[902]: warning: interface wlan0 does not currently exist Jun 29 02:53:24 volumio dnsmasq-dhcp[902]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Jun 29 02:53:24 volumio dnsmasq[902]: reading /etc/resolv.conf Jun 29 02:53:24 volumio dnsmasq[902]: using nameserver 208.67.222.222#53 Jun 29 02:53:24 volumio dnsmasq[902]: using nameserver 208.67.220.220#53 Jun 29 02:53:24 volumio dnsmasq[902]: read /etc/hosts - 5 addresses Jun 29 02:53:24 volumio volumio[742]: info: CoreStateMachine::resetVolumioState Jun 29 02:53:24 volumio volumio[742]: info: CoreStateMachine::getcurrentVolume Jun 29 02:53:24 volumio volumio[742]: info: CoreCommandRouter::volumioRetrievevolume Jun 29 02:53:24 volumio volumio[742]: info: CoreStateMachine::pushState Jun 29 02:53:24 volumio volumio[742]: info: CorePlayQueue::getTrack 0 Jun 29 02:53:24 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 29 02:53:24 volumio volumio[742]: info: CoreCommandRouter::volumioPushState Jun 29 02:53:24 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 29 02:53:24 volumio systemd[1]: Started dnsmasq - A lightweight DHCP and caching DNS server. Jun 29 02:53:24 volumio volumio[742]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jun 29 02:53:24 volumio volumio[742]: info: Completed loading Core Plugins Jun 29 02:53:24 volumio volumio[742]: info: Preparing to generate the ALSA configuration file Jun 29 02:53:24 volumio volumio[742]: Forking 3 albumart workers Jun 29 02:53:24 volumio volumio[742]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Hardware Jun 29 02:53:24 volumio volumio[742]: info: MPD Permissions set Jun 29 02:53:24 volumio volumio[742]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jun 29 02:53:24 volumio volumio[742]: wlan0 Interface doesn't support scanning. Jun 29 02:53:24 volumio volumio[742]: info: Cannot use regular scanning, forcing with ap-force Jun 29 02:53:24 volumio sudo[932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jun 29 02:53:24 volumio sudo[932]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 02:53:24 volumio sudo[932]: pam_unix(sudo:session): session closed for user root Jun 29 02:53:24 volumio volumio[742]: command failed: No such device (-19) Jun 29 02:53:24 volumio volumio[742]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jun 29 02:53:24 volumio volumio[742]: command failed: No such device (-19) Jun 29 02:53:24 volumio volumio[742]: info: MPD running with PID873 Jun 29 02:53:24 volumio volumio[742]: ,establishing connection Jun 29 02:53:25 volumio volumio[742]: error: MPD error: The expression evaluated to a falsy value: Jun 29 02:53:25 volumio volumio[742]: assert.ok(self.idling) Jun 29 02:53:25 volumio volumio[742]: error: MPD error: The expression evaluated to a falsy value: Jun 29 02:53:25 volumio volumio[742]: assert.ok(self.idling) Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:25 volumio volumio[742]: info: Reloading queue from file Jun 29 02:53:25 volumio volumio[742]: info: Asound.conf file unchanged, so no further update is needed Jun 29 02:53:25 volumio volumio[742]: info: Output device has changed, restarting MPD Jun 29 02:53:25 volumio volumio[742]: info: ___________ START PLUGINS ___________ Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 29 02:53:25 volumio volumio[742]: info: [1751165605265] CoreMusicLibrary::Adding element Last_100 Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 29 02:53:25 volumio volumio[742]: info: [1751165605276] CoreMusicLibrary::Adding element Webradio Jun 29 02:53:25 volumio sudo[952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 29 02:53:25 volumio sudo[952]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 29 02:53:25 volumio sudo[951]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 29 02:53:25 volumio sudo[951]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 02:53:25 volumio systemd[1]: Stopping Music Player Daemon... Jun 29 02:53:25 volumio sudo[951]: pam_unix(sudo:session): session closed for user root Jun 29 02:53:25 volumio volumio[742]: info: [squeezelite_mc] Starting proxy server... Jun 29 02:53:25 volumio volumio[742]: info: Volumio Calling Home Jun 29 02:53:25 volumio systemd[1]: mpd.service: Succeeded. Jun 29 02:53:25 volumio systemd[1]: Stopped Music Player Daemon. Jun 29 02:53:25 volumio systemd[1]: Starting Music Player Daemon... Jun 29 02:53:25 volumio volumio[742]: info: [squeezelite_mc] Proxy server started on port 38679 Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::volumioRetrievevolume Jun 29 02:53:25 volumio volumio[742]: info: CoreStateMachine::pushState Jun 29 02:53:25 volumio volumio[742]: info: CorePlayQueue::getTrack 0 Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::volumioPushState Jun 29 02:53:25 volumio volumio[742]: info: [squeezelite_mc] Server discovery started Jun 29 02:53:25 volumio volumio[742]: info: [squeezelite_mc] Player finder started Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 29 02:53:25 volumio volumio[742]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 29 02:53:25 volumio volumio[742]: info: [squeezelite_mc] Executing aplay -D hw:0 --nonblock -f MPEG /dev/zero 2>&1 || true Jun 29 02:53:25 volumio volumio[742]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 29 02:53:25 volumio volumio[742]: Error: send ENETUNREACH 255.255.255.255:3483 Jun 29 02:53:25 volumio volumio[742]: at doSend (dgram.js:714:16) Jun 29 02:53:25 volumio volumio[742]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:452:18) Jun 29 02:53:25 volumio volumio[742]: at afterDns (dgram.js:660:5) Jun 29 02:53:25 volumio volumio[742]: at processTicksAndRejections (internal/process/task_queues.js:83:21) { Jun 29 02:53:25 volumio volumio[742]: errno: -101, Jun 29 02:53:25 volumio volumio[742]: code: 'ENETUNREACH', Jun 29 02:53:25 volumio volumio[742]: syscall: 'send', Jun 29 02:53:25 volumio volumio[742]: address: '255.255.255.255', Jun 29 02:53:25 volumio volumio[742]: port: 3483 Jun 29 02:53:25 volumio volumio[742]: } Jun 29 02:53:25 volumio volumio[742]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 29 02:53:25 volumio volumio[742]: Starting albumart workers Jun 29 02:53:25 volumio volumio[742]: Starting albumart workers Jun 29 02:53:25 volumio volumio[742]: Starting albumart workers Jun 29 02:53:26 volumio sh[386]: eth0: leased 192.168.3.102 for 86400 seconds Jun 29 02:53:26 volumio sh[386]: eth0: adding route to 192.168.3.0/24 Jun 29 02:53:26 volumio sh[386]: eth0: adding default route via 192.168.3.1 Jun 29 02:53:26 volumio dhcpcd[408]: eth0: leased 192.168.3.102 for 86400 seconds Jun 29 02:53:26 volumio dhcpcd[408]: eth0: adding route to 192.168.3.0/24 Jun 29 02:53:26 volumio dhcpcd[408]: eth0: adding default route via 192.168.3.1 Jun 29 02:53:26 volumio avahi-daemon[421]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.3.102. Jun 29 02:53:26 volumio avahi-daemon[421]: New relevant interface eth0.IPv4 for mDNS. Jun 29 02:53:26 volumio avahi-daemon[421]: Registering new address record for 192.168.3.102 on eth0.IPv4. Jun 29 02:53:26 volumio dhcpcd[430]: eth0: leased 192.168.3.102 for 86400 seconds Jun 29 02:53:26 volumio dhcpcd[430]: eth0: adding route to 192.168.3.0/24 Jun 29 02:53:26 volumio dhcpcd[430]: eth0: adding default route via 192.168.3.1 Jun 29 02:53:26 volumio dhcpcd[430]: eth0: dhcp_envoption 213: Operation not supported Jun 29 02:53:26 volumio dhcpcd[430]: eth0: leased 192.168.3.102 for 86400 seconds Jun 29 02:53:26 volumio dhcpcd[430]: eth0: adding route to 192.168.3.0/24 Jun 29 02:53:26 volumio dhcpcd[430]: eth0: adding default route via 192.168.3.1 Jun 29 02:53:26 volumio dhcpcd[430]: eth0: dhcp_envoption 213: Operation not supported Jun 29 02:53:26 volumio dhcpcd[430]: eth0: dhcp_envoption 213: Operation not supported Jun 29 02:53:26 volumio dnsmasq[902]: reading /etc/resolv.conf Jun 29 02:53:26 volumio dnsmasq[902]: using nameserver 192.168.3.1#53 Jun 29 02:53:26 volumio dnsmasq[902]: using nameserver 208.67.222.222#53 Jun 29 02:53:26 volumio dnsmasq[902]: using nameserver 208.67.220.220#53 Jun 29 02:53:26 volumio dnsmasq[902]: reading /etc/resolv.conf Jun 29 02:53:26 volumio dnsmasq[902]: using nameserver 192.168.3.1#53 Jun 29 02:53:26 volumio dnsmasq[902]: using nameserver 208.67.222.222#53 Jun 29 02:53:26 volumio dnsmasq[902]: using nameserver 208.67.220.220#53 Jun 29 02:53:26 volumio systemd[1]: hostapd.service: Service RestartSec=2s expired, scheduling restart. Jun 29 02:53:26 volumio systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 5. Jun 29 02:53:26 volumio systemd[1]: Stopping dnsmasq - A lightweight DHCP and caching DNS server... Jun 29 02:53:26 volumio sh[386]: Warning: The unit file, source configuration file or drop-ins of systemd-timesyncd.service changed on disk. Run 'systemctl daemon-reload' to reload units. Jun 29 02:53:26 volumio dnsmasq[902]: exiting on receipt of SIGTERM Jun 29 02:53:26 volumio systemd[1]: dnsmasq.service: Succeeded. Jun 29 02:53:26 volumio systemd[1]: Stopped dnsmasq - A lightweight DHCP and caching DNS server. Jun 29 02:53:26 volumio systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jun 29 02:53:26 volumio systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jun 29 02:53:26 volumio hostapd[1037]: Configuration file: /etc/hostapd/hostapd.conf Jun 29 02:53:26 volumio dhcpcd[430]: Warning: The unit file, source configuration file or drop-ins of systemd-timesyncd.service changed on disk. Run 'systemctl daemon-reload' to reload units. Jun 29 02:53:26 volumio hostapd[1037]: Could not read interface wlan0 flags: No such device Jun 29 02:53:26 volumio hostapd[1037]: nl80211: Driver does not support authentication/association or connect commands Jun 29 02:53:26 volumio hostapd[1037]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jun 29 02:53:26 volumio hostapd[1037]: Could not read interface wlan0 flags: No such device Jun 29 02:53:26 volumio hostapd[1037]: nl80211 driver initialization failed. Jun 29 02:53:26 volumio hostapd[1037]: wlan0: interface state UNINITIALIZED->DISABLED Jun 29 02:53:26 volumio hostapd[1037]: wlan0: AP-DISABLED Jun 29 02:53:26 volumio hostapd[1037]: wlan0: CTRL-EVENT-TERMINATING Jun 29 02:53:26 volumio hostapd[1037]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jun 29 02:53:26 volumio systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jun 29 02:53:26 volumio systemd[1]: hostapd.service: Failed with result 'exit-code'. Jun 29 02:53:26 volumio systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jun 29 02:53:26 volumio systemd[1]: Starting dnsmasq - A lightweight DHCP and caching DNS server... Jun 29 02:53:26 volumio dnsmasq[1065]: dnsmasq: syntax check OK. Jun 29 02:53:26 volumio ntpd[636]: ntpd exiting on signal 15 (Terminated) Jun 29 02:53:26 volumio systemd[1]: Stopping Network Time Service... Jun 29 02:53:26 volumio sudo[1070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-29 02:52 Jun 29 02:53:26 volumio sudo[1070]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 02:53:26 volumio systemd[1]: ntp.service: Succeeded. Jun 29 02:53:26 volumio systemd[1]: Stopped Network Time Service. Jun 29 02:53:27 volumio systemd[1]: Starting Network Time Service... Jun 29 02:53:27 volumio dnsmasq[1085]: started, version 2.80 cachesize 150 Jun 29 02:53:27 volumio dnsmasq[1085]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect inotify dumpfile Jun 29 02:53:27 volumio dnsmasq[1085]: warning: interface wlan0 does not currently exist Jun 29 02:53:27 volumio dnsmasq-dhcp[1085]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Jun 29 02:53:27 volumio dnsmasq[1085]: reading /etc/resolv.conf Jun 29 02:53:27 volumio dnsmasq[1085]: using nameserver 192.168.3.1#53 Jun 29 02:53:27 volumio dnsmasq[1085]: using nameserver 208.67.222.222#53 Jun 29 02:53:27 volumio dnsmasq[1085]: using nameserver 208.67.220.220#53 Jun 29 02:53:27 volumio dnsmasq[1085]: read /etc/hosts - 5 addresses 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="613d705c083fd29de3027cf6e63a923a6020da8e" VOLUMIO_FE_VERSION="575f38b17bfc836dbd47f560a440d36ecd98d5af" VOLUMIO_FE3_VERSION="af818e7eb038d49989134ddd7bf2b2ffaa8cf083" VOLUMIO_BE_VERSION="5936439c04ed803864b9ef314729c659b841752e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 28 Jan 2022 11:02:24 PM CET" VOLUMIO_VERSION="3.212" VOLUMIO_HARDWARE="rock64" VOLUMIO_DEVICENAME="Rock64" VOLUMIO_HASH="d29879c89844222d6122014844c7549a"