-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Sun 2024-05-05 18:53:46 CST. -- May 05 18:53:04 volumio5-4g fake-hwclock[228]: Sun May 5 10:53:04 UTC 2024 May 05 18:53:04 volumio5-4g systemd[1]: Started Load Kernel Modules. May 05 18:53:04 volumio5-4g systemd[1]: Started Restore / save the current clock. May 05 18:53:04 volumio5-4g systemd[1]: Condition check resulted in FUSE Control File System being skipped. May 05 18:53:04 volumio5-4g systemd[1]: Mounting Kernel Configuration File System... May 05 18:53:04 volumio5-4g systemd[1]: Starting Apply Kernel Variables... May 05 18:53:04 volumio5-4g systemd[1]: Mounted Kernel Configuration File System. May 05 18:53:04 volumio5-4g systemd[1]: Started Load/Save Random Seed. May 05 18:53:04 volumio5-4g systemd[1]: dynamicswap.service: Succeeded. May 05 18:53:04 volumio5-4g systemd[1]: Started Apply Kernel Variables. May 05 18:53:04 volumio5-4g systemd[1]: Started udev Coldplug all Devices. May 05 18:53:04 volumio5-4g systemd[1]: Starting Helper to synchronize boot up for ifupdown... May 05 18:53:04 volumio5-4g systemd[1]: Started Create System Users. May 05 18:53:04 volumio5-4g systemd[1]: Starting Create Static Device Nodes in /dev... May 05 18:53:04 volumio5-4g systemd[1]: Started Helper to synchronize boot up for ifupdown. May 05 18:53:04 volumio5-4g systemd[1]: Started Create Static Device Nodes in /dev. May 05 18:53:04 volumio5-4g systemd[1]: Starting udev Kernel Device Manager... May 05 18:53:04 volumio5-4g systemd[1]: Reached target Local File Systems (Pre). May 05 18:53:04 volumio5-4g systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. May 05 18:53:04 volumio5-4g systemd[1]: Mounting /var/log... May 05 18:53:04 volumio5-4g systemd[1]: Mounting /var/spool/cups... May 05 18:53:04 volumio5-4g systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. May 05 18:53:04 volumio5-4g systemd[1]: Mounting /tmp... May 05 18:53:04 volumio5-4g systemd[1]: Mounted /var/log. May 05 18:53:04 volumio5-4g systemd[1]: Mounted /var/spool/cups. May 05 18:53:04 volumio5-4g systemd[1]: Mounted /tmp. May 05 18:53:04 volumio5-4g systemd[1]: Mounting /var/spool/cups/tmp... May 05 18:53:04 volumio5-4g systemd[1]: Starting Flush Journal to Persistent Storage... May 05 18:53:04 volumio5-4g systemd-udevd[251]: Network interface NamePolicy= disabled on kernel command line, ignoring. May 05 18:53:04 volumio5-4g systemd[1]: Mounted /var/spool/cups/tmp. May 05 18:53:04 volumio5-4g systemd-journald[219]: Runtime journal (/run/log/journal/c1d531165394c79721acb5a765d65e88) is 7.5M, max 30.0M, 22.5M free. May 05 18:53:04 volumio5-4g systemd[1]: Started udev Kernel Device Manager. May 05 18:53:04 volumio5-4g systemd[1]: Starting Show Plymouth Boot Screen... May 05 18:53:04 volumio5-4g systemd[1]: Started Flush Journal to Persistent Storage. May 05 18:53:04 volumio5-4g systemd[1]: Received SIGRTMIN+20 from PID 282 (plymouthd). May 05 18:53:04 volumio5-4g systemd[1]: Started Show Plymouth Boot Screen. May 05 18:53:04 volumio5-4g systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. May 05 18:53:04 volumio5-4g systemd[1]: Reached target Paths. May 05 18:53:04 volumio5-4g systemd[1]: Reached target Local Encrypted Volumes. May 05 18:53:04 volumio5-4g systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. May 05 18:53:04 volumio5-4g kernel: input: pwr_button as /devices/platform/pwr_button/input/input5 May 05 18:53:04 volumio5-4g kernel: brcmstb-i2c 107d508200.i2c: @200000hz registered in interrupt mode May 05 18:53:04 volumio5-4g kernel: brcmstb-i2c 107d508280.i2c: @200000hz registered in interrupt mode May 05 18:53:04 volumio5-4g systemd[1]: Found device /dev/ttyAMA10. May 05 18:53:04 volumio5-4g kernel: rpi-gpiomem 107d508500.gpiomem: window base 0x107d508500 size 0x00000040 May 05 18:53:04 volumio5-4g kernel: rpi-gpiomem 107d508500.gpiomem: initialised 1 regions as /dev/gpiomem1 May 05 18:53:04 volumio5-4g kernel: rpi-gpiomem 107d517c00.gpiomem: window base 0x107d517c00 size 0x00000040 May 05 18:53:04 volumio5-4g kernel: rpi-gpiomem 107d517c00.gpiomem: initialised 1 regions as /dev/gpiomem2 May 05 18:53:04 volumio5-4g kernel: rpi-gpiomem 107d504100.gpiomem: window base 0x107d504100 size 0x00000020 May 05 18:53:04 volumio5-4g kernel: rpi-gpiomem 107d504100.gpiomem: initialised 1 regions as /dev/gpiomem3 May 05 18:53:04 volumio5-4g kernel: rpi-gpiomem 107d510700.gpiomem: window base 0x107d510700 size 0x00000020 May 05 18:53:04 volumio5-4g kernel: rpi-gpiomem 107d510700.gpiomem: initialised 1 regions as /dev/gpiomem4 May 05 18:53:04 volumio5-4g kernel: rpi-gpiomem 1f000d0000.gpiomem: window base 0x1f000d0000 size 0x00030000 May 05 18:53:04 volumio5-4g kernel: rpi-gpiomem 1f000d0000.gpiomem: initialised 1 regions as /dev/gpiomem0 May 05 18:53:04 volumio5-4g systemd-udevd[275]: Using default interface naming scheme 'v240'. May 05 18:53:04 volumio5-4g systemd-udevd[275]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 05 18:53:04 volumio5-4g kernel: mc: Linux media interface: v0.10 May 05 18:53:04 volumio5-4g kernel: videodev: Linux video capture interface: v2.00 May 05 18:53:04 volumio5-4g kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 May 05 18:53:04 volumio5-4g kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: bcm2712_iommu_of_xlate: MMU 1000005100.iommu May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: pispbe_probe: HW version: 0x02252700 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: pispbe_probe: BatchStatus: 0x00000000 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: pispbe_probe: Status: 0x00000000 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: Register nodes for group 0 May 05 18:53:04 volumio5-4g kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: input device node registered as /dev/video20 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: tdn_input device node registered as /dev/video21 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: stitch_input device node registered as /dev/video22 May 05 18:53:04 volumio5-4g kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' May 05 18:53:04 volumio5-4g kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' May 05 18:53:04 volumio5-4g kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: hog_output device node registered as /dev/video23 May 05 18:53:04 volumio5-4g kernel: rpivid 1000800000.codec: bcm2712_iommu_of_xlate: MMU 1000005100.iommu May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: output0 device node registered as /dev/video24 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: output1 device node registered as /dev/video25 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: tdn_output device node registered as /dev/video26 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: stitch_output device node registered as /dev/video27 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: config device node registered as /dev/video28 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: Register nodes for group 1 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: input device node registered as /dev/video29 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: tdn_input device node registered as /dev/video30 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: stitch_input device node registered as /dev/video31 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: hog_output device node registered as /dev/video32 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: output0 device node registered as /dev/video33 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: output1 device node registered as /dev/video34 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: tdn_output device node registered as /dev/video35 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: stitch_output device node registered as /dev/video36 May 05 18:53:04 volumio5-4g kernel: pispbe 1000880000.pisp_be: config device node registered as /dev/video37 May 05 18:53:04 volumio5-4g systemd-udevd[257]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 18:53:04 volumio5-4g kernel: rpivid 1000800000.codec: Device registered as /dev/video19 May 05 18:53:04 volumio5-4g kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 May 05 18:53:04 volumio5-4g kernel: [drm] Initialized v3d 1.0.0 20180419 for 1002000000.v3d on minor 0 May 05 18:53:04 volumio5-4g kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 May 05 18:53:04 volumio5-4g kernel: brcmfmac mmc1:0001:1: Direct firmware load for brcm/brcmfmac43455-sdio.raspberrypi,5-model-b.bin failed with error -2 May 05 18:53:04 volumio5-4g kernel: Bluetooth: Core ver 2.22 May 05 18:53:04 volumio5-4g kernel: NET: Registered PF_BLUETOOTH protocol family May 05 18:53:04 volumio5-4g kernel: Bluetooth: HCI device and connection manager initialized May 05 18:53:04 volumio5-4g kernel: Bluetooth: HCI socket layer initialized May 05 18:53:04 volumio5-4g kernel: Bluetooth: L2CAP socket layer initialized May 05 18:53:04 volumio5-4g kernel: Bluetooth: SCO socket layer initialized May 05 18:53:04 volumio5-4g kernel: usbcore: registered new interface driver brcmfmac May 05 18:53:04 volumio5-4g kernel: Bluetooth: HCI UART driver ver 2.3 May 05 18:53:04 volumio5-4g kernel: Bluetooth: HCI UART protocol H4 registered May 05 18:53:04 volumio5-4g kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered May 05 18:53:04 volumio5-4g kernel: Bluetooth: HCI UART protocol Broadcom registered May 05 18:53:04 volumio5-4g kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator May 05 18:53:04 volumio5-4g kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator May 05 18:53:04 volumio5-4g systemd-udevd[272]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 05 18:53:04 volumio5-4g systemd[1]: Found device /dev/mmcblk0p1. May 05 18:53:04 volumio5-4g systemd-udevd[266]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 18:53:04 volumio5-4g systemd-udevd[260]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 18:53:04 volumio5-4g kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov 1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60 May 05 18:53:04 volumio5-4g systemd-udevd[274]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 18:53:04 volumio5-4g systemd-udevd[283]: Using default interface naming scheme 'v240'. May 05 18:53:04 volumio5-4g systemd-udevd[283]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 05 18:53:04 volumio5-4g systemd-udevd[290]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 18:53:04 volumio5-4g systemd-udevd[267]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 18:53:04 volumio5-4g kernel: vc4-drm axi:gpu: bcm2712_iommu_of_xlate: MMU 1000005200.iommu May 05 18:53:04 volumio5-4g kernel: vc4-drm axi:gpu: bound 107c580000.hvs (ops vc4_hvs_ops [vc4]) May 05 18:53:04 volumio5-4g kernel: Registered IR keymap rc-cec May 05 18:53:04 volumio5-4g kernel: rc rc0: vc4-hdmi-0 as /devices/platform/soc/107c701400.hdmi/rc/rc0 May 05 18:53:04 volumio5-4g kernel: input: vc4-hdmi-0 as /devices/platform/soc/107c701400.hdmi/rc/rc0/input6 May 05 18:53:04 volumio5-4g kernel: vc4-drm axi:gpu: bound 107c701400.hdmi (ops vc4_hdmi_ops [vc4]) May 05 18:53:04 volumio5-4g systemd-udevd[259]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 0' failed with exit code 99. May 05 18:53:05 volumio5-4g kernel: Registered IR keymap rc-cec May 05 18:53:05 volumio5-4g kernel: rc rc1: vc4-hdmi-1 as /devices/platform/soc/107c706400.hdmi/rc/rc1 May 05 18:53:05 volumio5-4g kernel: input: vc4-hdmi-1 as /devices/platform/soc/107c706400.hdmi/rc/rc1/input7 May 05 18:53:05 volumio5-4g kernel: vc4-drm axi:gpu: bound 107c706400.hdmi (ops vc4_hdmi_ops [vc4]) May 05 18:53:05 volumio5-4g kernel: vc4-drm axi:gpu: bound 107c500000.mop (ops vc4_txp_ops [vc4]) May 05 18:53:05 volumio5-4g kernel: vc4-drm axi:gpu: bound 107c501000.moplet (ops vc4_txp_ops [vc4]) May 05 18:53:05 volumio5-4g kernel: vc4-drm axi:gpu: bound 107c410000.pixelvalve (ops vc4_crtc_ops [vc4]) May 05 18:53:05 volumio5-4g kernel: vc4-drm axi:gpu: bound 107c411000.pixelvalve (ops vc4_crtc_ops [vc4]) May 05 18:53:05 volumio5-4g kernel: [drm] Initialized vc4 0.0.0 20140616 for axi:gpu on minor 1 May 05 18:53:05 volumio5-4g kernel: vc4-drm axi:gpu: [drm] Cannot find any crtc or sizes May 05 18:53:05 volumio5-4g kernel: vc4-drm axi:gpu: [drm] Cannot find any crtc or sizes May 05 18:53:05 volumio5-4g kernel: vc4-drm axi:gpu: [drm] Cannot find any crtc or sizes May 05 18:53:05 volumio5-4g kernel: Bluetooth: hci0: BCM: chip id 107 May 05 18:53:05 volumio5-4g kernel: Bluetooth: hci0: BCM: features 0x2f May 05 18:53:05 volumio5-4g kernel: Bluetooth: hci0: BCM4345C0 May 05 18:53:05 volumio5-4g kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 May 05 18:53:05 volumio5-4g kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch May 05 18:53:05 volumio5-4g systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. May 05 18:53:05 volumio5-4g systemd-udevd[267]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 18:53:05 volumio5-4g systemd-udevd[275]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 18:53:05 volumio5-4g systemd[1]: Condition check resulted in /sys/subsystem/net/devices/wlan0 being skipped. May 05 18:53:05 volumio5-4g systemd[1]: Created slice system-bthelper.slice. May 05 18:53:05 volumio5-4g systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. May 05 18:53:05 volumio5-4g systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. May 05 18:53:05 volumio5-4g systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. May 05 18:53:05 volumio5-4g systemd[1]: Condition check resulted in Huge Pages File System being skipped. May 05 18:53:05 volumio5-4g systemd[1]: Condition check resulted in FUSE Control File System being skipped. May 05 18:53:05 volumio5-4g systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. May 05 18:53:05 volumio5-4g systemd[1]: Starting File System Check on /dev/mmcblk0p1... May 05 18:53:05 volumio5-4g systemd[1]: Starting Load/Save RF Kill Switch Status... May 05 18:53:05 volumio5-4g systemd[1]: Started File System Check Daemon to report status. May 05 18:53:05 volumio5-4g systemd[1]: Started Load/Save RF Kill Switch Status. May 05 18:53:05 volumio5-4g systemd-fsck[555]: fsck.fat 4.1 (2017-01-24) May 05 18:53:05 volumio5-4g systemd-fsck[555]: /dev/mmcblk0p1: 367 files, 33349/46774 clusters May 05 18:53:05 volumio5-4g systemd[1]: Started File System Check on /dev/mmcblk0p1. May 05 18:53:05 volumio5-4g systemd[1]: Mounting /boot... May 05 18:53:05 volumio5-4g systemd[1]: Mounted /boot. May 05 18:53:05 volumio5-4g systemd[1]: Reached target Local File Systems. May 05 18:53:05 volumio5-4g systemd[1]: Starting Create Volatile Files and Directories... May 05 18:53:05 volumio5-4g systemd[1]: Started ifup for eth0. May 05 18:53:05 volumio5-4g systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... May 05 18:53:05 volumio5-4g systemd[1]: Started ifup for wlan0. May 05 18:53:05 volumio5-4g systemd[1]: Starting Preprocess NFS configuration... May 05 18:53:05 volumio5-4g systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. May 05 18:53:05 volumio5-4g systemd[1]: Starting Raise network interfaces... May 05 18:53:05 volumio5-4g systemd[1]: Received SIGRTMIN+20 from PID 282 (plymouthd). May 05 18:53:05 volumio5-4g systemd[1]: plymouth-read-write.service: Succeeded. May 05 18:53:05 volumio5-4g systemd[1]: Started Tell Plymouth To Write Out Runtime Data. May 05 18:53:05 volumio5-4g systemd[1]: nfs-config.service: Succeeded. May 05 18:53:05 volumio5-4g systemd[1]: Started Preprocess NFS configuration. May 05 18:53:05 volumio5-4g systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. May 05 18:53:05 volumio5-4g systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. May 05 18:53:05 volumio5-4g systemd[1]: Reached target NFS client services. May 05 18:53:05 volumio5-4g systemd[1]: Started Create Volatile Files and Directories. May 05 18:53:05 volumio5-4g systemd[1]: Starting Update UTMP about System Boot/Shutdown... May 05 18:53:05 volumio5-4g systemd[1]: Started Entropy daemon using the HAVEGE algorithm. May 05 18:53:05 volumio5-4g systemd[1]: Condition check resulted in Network Time Synchronization being skipped. May 05 18:53:05 volumio5-4g systemd[1]: Starting RPC bind portmap service... May 05 18:53:05 volumio5-4g systemd[1]: Started Update UTMP about System Boot/Shutdown. May 05 18:53:05 volumio5-4g systemd[1]: Reached target System Initialization. May 05 18:53:05 volumio5-4g systemd[1]: Started Daily apt download activities. May 05 18:53:05 volumio5-4g systemd[1]: Listening on D-Bus System Message Bus Socket. May 05 18:53:05 volumio5-4g systemd[1]: Started Daily apt upgrade and clean activities. May 05 18:53:05 volumio5-4g systemd[1]: Started Daily man-db regeneration. May 05 18:53:05 volumio5-4g systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. May 05 18:53:05 volumio5-4g systemd[1]: Listening on triggerhappy.socket. May 05 18:53:05 volumio5-4g systemd[1]: Reached target Sockets. May 05 18:53:05 volumio5-4g systemd[1]: Started Volumio Splash. May 05 18:53:05 volumio5-4g systemd[1]: Reached target Basic System. May 05 18:53:05 volumio5-4g systemd[1]: Starting Avahi mDNS/DNS-SD Stack... May 05 18:53:05 volumio5-4g systemd[631]: volumiosplash.service: Failed to execute command: No such file or directory May 05 18:53:05 volumio5-4g systemd[631]: volumiosplash.service: Failed at step EXEC spawning /bin/volumiosplash.sh: No such file or directory May 05 18:53:05 volumio5-4g systemd[1]: Started UPnP Renderer front-end to MPD. May 05 18:53:05 volumio5-4g systemd[1]: Started Volumio Log Rotation Service. May 05 18:53:05 volumio5-4g systemd[1]: Starting Login Service... May 05 18:53:05 volumio5-4g systemd[1]: Started Volumio Iptables Module. May 05 18:53:05 volumio5-4g systemd[1]: Starting triggerhappy global hotkey daemon... May 05 18:53:05 volumio5-4g systemd[1]: Started D-Bus System Message Bus. May 05 18:53:05 volumio5-4g kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 05 18:53:05 volumio5-4g systemd[1]: Condition check resulted in Configure Bluetooth Modems connected by UART being skipped. May 05 18:53:05 volumio5-4g systemd[1]: Starting Raspberry Pi bluetooth helper... May 05 18:53:05 volumio5-4g systemd[1]: Started volumio-remote-updater.service. May 05 18:53:05 volumio5-4g systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. May 05 18:53:05 volumio5-4g systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. May 05 18:53:05 volumio5-4g systemd[1]: Started Manage Sound Card State (restore and store). May 05 18:53:05 volumio5-4g systemd[1]: Starting Save/Restore Sound Card State... May 05 18:53:05 volumio5-4g systemd[1]: Starting WPA supplicant... May 05 18:53:05 volumio5-4g systemd[1]: Started Daily Cleanup of Temporary Directories. May 05 18:53:05 volumio5-4g systemd[1]: Reached target Timers. May 05 18:53:05 volumio5-4g systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. May 05 18:53:05 volumio5-4g alsactl[646]: alsactl 1.1.8 daemon started May 05 18:53:05 volumio5-4g systemd[1]: Starting dhcpcd on all interfaces... May 05 18:53:05 volumio5-4g systemd[1]: Starting Wireless Services... May 05 18:53:05 volumio5-4g systemd[1]: haveged.service: Main process exited, code=killed, status=11/SEGV May 05 18:53:05 volumio5-4g systemd[1]: haveged.service: Failed with result 'signal'. May 05 18:53:05 volumio5-4g systemd[1]: volumiosplash.service: Main process exited, code=exited, status=203/EXEC May 05 18:53:05 volumio5-4g systemd[1]: volumiosplash.service: Failed with result 'exit-code'. May 05 18:53:05 volumio5-4g thd[638]: Unable to parse trigger line: May 05 18:53:05 volumio5-4g thd[638]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle May 05 18:53:05 volumio5-4g thd[638]: Unable to parse trigger line: May 05 18:53:05 volumio5-4g thd[638]: Unable to parse trigger line: May 05 18:53:05 volumio5-4g thd[638]: Found socket passed from systemd May 05 18:53:05 volumio5-4g alsactl[647]: No state is present for card sndrpirpidac May 05 18:53:05 volumio5-4g alsactl[647]: Found hardware: "RPi-simple" "" "" "" "" May 05 18:53:05 volumio5-4g alsactl[647]: Hardware is initialized using a generic method May 05 18:53:05 volumio5-4g alsactl[647]: No state is present for card sndrpirpidac May 05 18:53:05 volumio5-4g dhcpcd[650]: Not running dhcpcd because /etc/network/interfaces May 05 18:53:05 volumio5-4g dhcpcd[650]: defines some interfaces that will use a May 05 18:53:05 volumio5-4g dhcpcd[650]: DHCP client or static address May 05 18:53:05 volumio5-4g systemd-logind[636]: New seat seat0. May 05 18:53:05 volumio5-4g systemd-logind[636]: Watching system buttons on /dev/input/event0 (YICHIP 2.4G Receiver) May 05 18:53:05 volumio5-4g systemd-logind[636]: Watching system buttons on /dev/input/event2 (YICHIP 2.4G Receiver System Control) May 05 18:53:05 volumio5-4g systemd-logind[636]: Watching system buttons on /dev/input/event3 (YICHIP 2.4G Receiver Consumer Control) May 05 18:53:05 volumio5-4g systemd-logind[636]: Watching system buttons on /dev/input/event4 (pwr_button) May 05 18:53:05 volumio5-4g systemd-logind[636]: Watching system buttons on /dev/input/event5 (vc4-hdmi-0) May 05 18:53:05 volumio5-4g systemd-logind[636]: Watching system buttons on /dev/input/event6 (vc4-hdmi-1) May 05 18:53:05 volumio5-4g avahi-daemon[633]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). May 05 18:53:05 volumio5-4g avahi-daemon[633]: Successfully dropped root privileges. May 05 18:53:05 volumio5-4g avahi-daemon[633]: avahi-daemon 0.7 starting up. May 05 18:53:05 volumio5-4g kernel: 8021q: 802.1Q VLAN Support v1.8 May 05 18:53:05 volumio5-4g kernel: Bluetooth: hci0: BCM: features 0x2f May 05 18:53:05 volumio5-4g kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+ May 05 18:53:05 volumio5-4g kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342 May 05 18:53:05 volumio5-4g kernel: Bluetooth: hci0: BCM: Using default device address (43:45:c0:00:1f:ac) May 05 18:53:05 volumio5-4g bthelper[644]: Raspberry Pi BDADDR already set May 05 18:53:05 volumio5-4g kernel: macb 1f00100000.ethernet eth0: PHY [1f00100000.ethernet-ffffffff:01] driver [Broadcom BCM54213PE] (irq=POLL) May 05 18:53:05 volumio5-4g kernel: macb 1f00100000.ethernet eth0: configuring for phy/rgmii-id link mode May 05 18:53:05 volumio5-4g sh[562]: eth0: waiting for carrier May 05 18:53:05 volumio5-4g dhcpcd[620]: eth0: waiting for carrier May 05 18:53:05 volumio5-4g kernel: pps pps0: new PPS source ptp0 May 05 18:53:05 volumio5-4g kernel: macb 1f00100000.ethernet: gem-ptp-timer ptp clock registered. May 05 18:53:05 volumio5-4g systemd[1]: Started triggerhappy global hotkey daemon. May 05 18:53:05 volumio5-4g systemd[1]: Started RPC bind portmap service. May 05 18:53:05 volumio5-4g systemd[1]: Started Raspberry Pi bluetooth helper. May 05 18:53:05 volumio5-4g avahi-daemon[633]: Successfully called chroot(). May 05 18:53:05 volumio5-4g avahi-daemon[633]: Successfully dropped remaining capabilities. May 05 18:53:05 volumio5-4g wpa_supplicant[649]: Successfully initialized wpa_supplicant May 05 18:53:05 volumio5-4g systemd[1]: Started Save/Restore Sound Card State. May 05 18:53:05 volumio5-4g systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED May 05 18:53:05 volumio5-4g systemd[1]: dhcpcd.service: Failed with result 'exit-code'. May 05 18:53:05 volumio5-4g systemd[1]: Failed to start dhcpcd on all interfaces. May 05 18:53:05 volumio5-4g avahi-daemon[633]: Loading service file /services/volumio.service. May 05 18:53:05 volumio5-4g systemd[1]: Started Login Service. May 05 18:53:05 volumio5-4g systemd[1]: Started WPA supplicant. May 05 18:53:05 volumio5-4g systemd[1]: Started Avahi mDNS/DNS-SD Stack. May 05 18:53:05 volumio5-4g systemd[1]: Reached target Sound Card. May 05 18:53:05 volumio5-4g sh[564]: wlan0=wlan0 May 05 18:53:05 volumio5-4g systemd[1]: Starting Bluetooth service... May 05 18:53:05 volumio5-4g avahi-daemon[633]: Network interface enumeration completed. May 05 18:53:05 volumio5-4g systemd[1]: Reached target RPC Port Mapper. May 05 18:53:05 volumio5-4g avahi-daemon[633]: Server startup complete. Host name is volumio5-4g.local. Local service cookie is 1866771212. May 05 18:53:05 volumio5-4g systemd[1]: Reached target Remote File Systems (Pre). May 05 18:53:05 volumio5-4g avahi-daemon[633]: Service "Volumio5-4g" (/services/volumio.service) successfully established. May 05 18:53:05 volumio5-4g systemd[1]: Reached target Remote File Systems. May 05 18:53:05 volumio5-4g systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... May 05 18:53:05 volumio5-4g systemd[1]: Started Raise network interfaces. May 05 18:53:05 volumio5-4g systemd[1]: Reached target Network. May 05 18:53:05 volumio5-4g systemd[1]: Starting Permit User Sessions... May 05 18:53:05 volumio5-4g systemd[1]: Reached target Network is Online. May 05 18:53:05 volumio5-4g systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 05 18:53:05 volumio5-4g systemd[1]: Starting Samba NMB Daemon... May 05 18:53:05 volumio5-4g systemd[1]: Starting LSB: Brings up/down network automatically... May 05 18:53:05 volumio5-4g systemd[1]: Starting Network Time Service... May 05 18:53:05 volumio5-4g volumio-remote-updater[645]: Error: No active session May 05 18:53:05 volumio5-4g volumio-remote-updater[645]: [2024-05-05 18:53:05] [info] asio async_connect error: system:111 (Connection refused) May 05 18:53:05 volumio5-4g volumio-remote-updater[645]: [2024-05-05 18:53:05] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 05 18:53:05 volumio5-4g volumio-remote-updater[645]: [2024-05-05 18:53:05] [error] handle_connect error: Underlying Transport Error May 05 18:53:05 volumio5-4g systemd[1]: Starting OpenBSD Secure Shell server... May 05 18:53:05 volumio5-4g systemd[1]: Starting /etc/rc.local Compatibility... May 05 18:53:05 volumio5-4g systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. May 05 18:53:05 volumio5-4g systemd[1]: Started Permit User Sessions. May 05 18:53:05 volumio5-4g systemd[1]: Started /etc/rc.local Compatibility. May 05 18:53:05 volumio5-4g systemd[1]: Starting Terminate Plymouth Boot Screen... May 05 18:53:05 volumio5-4g systemd[1]: Starting Hold until boot process finishes up... May 05 18:53:05 volumio5-4g volumio[634]: Could not open config: /tmp/upmpdcli.conf May 05 18:53:05 volumio5-4g systemd[1]: plymouth-start.service: Succeeded. May 05 18:53:05 volumio5-4g systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE May 05 18:53:05 volumio5-4g systemd[1]: upmpdcli.service: Failed with result 'exit-code'. May 05 18:53:05 volumio5-4g systemd[1]: plymouth-quit.service: Succeeded. May 05 18:53:05 volumio5-4g systemd[1]: Started Terminate Plymouth Boot Screen. May 05 18:53:05 volumio5-4g systemd[1]: plymouth-quit-wait.service: Succeeded. May 05 18:53:05 volumio5-4g systemd[1]: Started Hold until boot process finishes up. May 05 18:53:05 volumio5-4g systemd[1]: Received SIGRTMIN+21 from PID 282 (n/a). May 05 18:53:06 volumio5-4g systemd[1]: iptables.service: Succeeded. May 05 18:53:06 volumio5-4g systemd[1]: Started Serial Getty on ttyAMA10. May 05 18:53:06 volumio5-4g systemd[1]: Reached target Login Prompts. May 05 18:53:06 volumio5-4g ifplugd(eth0)[784]: ifplugd 0.28 initializing. May 05 18:53:06 volumio5-4g ifplugd(eth0)[784]: Using interface eth0/D8:3A:DD:C1:9B:08 with driver (version: 6.1.69-v8+) May 05 18:53:06 volumio5-4g ifplugd(eth0)[784]: Using detection mode: SIOCETHTOOL May 05 18:53:06 volumio5-4g ifplugd(eth0)[784]: Initialization complete, link beat not detected. May 05 18:53:06 volumio5-4g bluetoothd[723]: Bluetooth daemon 5.50 May 05 18:53:06 volumio5-4g bluetoothd[723]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf May 05 18:53:06 volumio5-4g systemd[1]: Started Bluetooth service. May 05 18:53:06 volumio5-4g systemd[1]: Reached target Bluetooth. May 05 18:53:06 volumio5-4g bluetoothd[723]: Starting SDP server May 05 18:53:06 volumio5-4g bluetoothd[723]: Excluding (cli) sap May 05 18:53:06 volumio5-4g ntpd[755]: ntpd 4.2.8p12@1.3728-o (1): Starting May 05 18:53:06 volumio5-4g ntpd[755]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 May 05 18:53:06 volumio5-4g systemd[1]: Started Network Time Service. May 05 18:53:06 volumio5-4g ifplugd[754]: Network Interface Plugging Daemon...start eth0...done. May 05 18:53:06 volumio5-4g ntpd[805]: proto: precision = 1.278 usec (-19) May 05 18:53:06 volumio5-4g ntpd[805]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 05 18:53:06 volumio5-4g systemd[1]: Started LSB: Brings up/down network automatically. May 05 18:53:06 volumio5-4g ntpd[805]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 May 05 18:53:06 volumio5-4g ntpd[805]: Listen and drop on 0 v6wildcard [::]:123 May 05 18:53:06 volumio5-4g ntpd[805]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 05 18:53:06 volumio5-4g ntpd[805]: Listen normally on 2 lo 127.0.0.1:123 May 05 18:53:06 volumio5-4g ntpd[805]: Listening on routing socket on fd #19 for interface updates May 05 18:53:06 volumio5-4g ntpd[805]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 05 18:53:06 volumio5-4g ntpd[805]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 05 18:53:06 volumio5-4g kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 May 05 18:53:06 volumio5-4g kernel: Bluetooth: BNEP filters: protocol multicast May 05 18:53:06 volumio5-4g kernel: Bluetooth: BNEP socket layer initialized May 05 18:53:06 volumio5-4g kernel: Bluetooth: MGMT ver 1.22 May 05 18:53:06 volumio5-4g bluetoothd[723]: Bluetooth management interface 1.22 initialized May 05 18:53:06 volumio5-4g dbus-daemon[639]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=723 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") May 05 18:53:06 volumio5-4g loadcpufreq[743]: Loading cpufreq kernel modules...done (none). May 05 18:53:06 volumio5-4g sshd[806]: Server listening on 0.0.0.0 port 22. May 05 18:53:06 volumio5-4g sshd[806]: Server listening on :: port 22. May 05 18:53:06 volumio5-4g systemd[1]: Started OpenBSD Secure Shell server. May 05 18:53:06 volumio5-4g systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. May 05 18:53:06 volumio5-4g bluetoothd[723]: Failed to set privacy: Rejected (0x0b) May 05 18:53:06 volumio5-4g systemd[1]: Starting LSB: set CPUFreq kernel parameters... May 05 18:53:06 volumio5-4g systemd[1]: Starting Hostname Service... May 05 18:53:06 volumio5-4g cpufrequtils[820]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. May 05 18:53:06 volumio5-4g systemd[1]: Started LSB: set CPUFreq kernel parameters. May 05 18:53:06 volumio5-4g dbus-daemon[639]: [system] Successfully activated service 'org.freedesktop.hostname1' May 05 18:53:06 volumio5-4g systemd[1]: Started Hostname Service. May 05 18:53:06 volumio5-4g alsactl[646]: No state is present for card sndrpirpidac May 05 18:53:06 volumio5-4g alsactl[646]: Found hardware: "RPi-simple" "" "" "" "" May 05 18:53:06 volumio5-4g alsactl[646]: Hardware is initialized using a generic method May 05 18:53:06 volumio5-4g alsactl[646]: No state is present for card sndrpirpidac May 05 18:53:06 volumio5-4g nmbd[763]: [2024/05/05 18:53:06.516802, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) May 05 18:53:06 volumio5-4g nmbd[763]: started asyncdns process 835 May 05 18:53:06 volumio5-4g nmbd[763]: [2024/05/05 18:53:06.517664, 0] ../lib/util/become_daemon.c:149(daemon_status) May 05 18:53:06 volumio5-4g nmbd[763]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... May 05 18:53:06 volumio5-4g nmbd[763]: [2024/05/05 18:53:06.517721, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) May 05 18:53:06 volumio5-4g nmbd[763]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). May 05 18:53:06 volumio5-4g wireless.js[652]: Cleaning previous... May 05 18:53:06 volumio5-4g sudo[843]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 05 18:53:06 volumio5-4g sudo[843]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:06 volumio5-4g sudo[843]: pam_unix(sudo:session): session closed for user root May 05 18:53:06 volumio5-4g sudo[845]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 05 18:53:06 volumio5-4g sudo[845]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:07 volumio5-4g sudo[845]: pam_unix(sudo:session): session closed for user root May 05 18:53:07 volumio5-4g wireless.js[652]: Stopped aP May 05 18:53:07 volumio5-4g ntpd[805]: error resolving pool 0.debian.pool.ntp.org: System error (-11) May 05 18:53:07 volumio5-4g sudo[852]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 05 18:53:07 volumio5-4g sudo[852]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:07 volumio5-4g kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 05 18:53:07 volumio5-4g sudo[852]: pam_unix(sudo:session): session closed for user root May 05 18:53:07 volumio5-4g sudo[854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get May 05 18:53:07 volumio5-4g sudo[854]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:07 volumio5-4g sudo[854]: pam_unix(sudo:session): session closed for user root May 05 18:53:07 volumio5-4g sudo[861]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 05 18:53:07 volumio5-4g sudo[861]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:07 volumio5-4g sudo[861]: pam_unix(sudo:session): session closed for user root May 05 18:53:07 volumio5-4g sudo[863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan May 05 18:53:07 volumio5-4g sudo[863]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:08 volumio5-4g sudo[863]: pam_unix(sudo:session): session closed for user root May 05 18:53:08 volumio5-4g wireless.js[652]: SETTING APPROPRIATE REG DOMAIN: CN May 05 18:53:08 volumio5-4g sudo[868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 05 18:53:08 volumio5-4g sudo[868]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:08 volumio5-4g sudo[868]: pam_unix(sudo:session): session closed for user root May 05 18:53:08 volumio5-4g sudo[870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set CN May 05 18:53:08 volumio5-4g ntpd[805]: error resolving pool 1.debian.pool.ntp.org: System error (-11) May 05 18:53:08 volumio5-4g sudo[870]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:08 volumio5-4g sudo[870]: pam_unix(sudo:session): session closed for user root May 05 18:53:08 volumio5-4g wireless.js[652]: SUCCESSFULLY SET NEW REGDOMAIN: CN May 05 18:53:08 volumio5-4g wireless.js[652]: Start wireless flow May 05 18:53:08 volumio5-4g wireless.js[652]: Stopped hotspot (if there).. May 05 18:53:08 volumio5-4g sudo[875]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 05 18:53:08 volumio5-4g sudo[875]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:08 volumio5-4g sudo[875]: pam_unix(sudo:session): session closed for user root May 05 18:53:08 volumio5-4g sudo[877]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 05 18:53:08 volumio5-4g sudo[877]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:08 volumio5-4g sudo[877]: pam_unix(sudo:session): session closed for user root May 05 18:53:08 volumio5-4g wireless.js[652]: DHCP IP May 05 18:53:08 volumio5-4g wireless.js[652]: Start ap May 05 18:53:08 volumio5-4g wpa_supplicant[879]: Successfully initialized wpa_supplicant May 05 18:53:08 volumio5-4g sudo[880]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd May 05 18:53:08 volumio5-4g sudo[880]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:08 volumio5-4g kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 05 18:53:08 volumio5-4g dhcpcd[881]: dev: loaded udev May 05 18:53:08 volumio5-4g dhcpcd-run-hooks[899]: wlan0: starting wpa_supplicant May 05 18:53:08 volumio5-4g sh[562]: eth0: carrier acquired May 05 18:53:08 volumio5-4g dhcpcd[620]: eth0: carrier acquired May 05 18:53:08 volumio5-4g kernel: macb 1f00100000.ethernet eth0: Link is Up - 1Gbps/Full - flow control tx May 05 18:53:08 volumio5-4g sh[562]: DUID 00:01:00:01:2d:c5:98:d9:2c:cf:67:12:d2:83 May 05 18:53:08 volumio5-4g sh[562]: eth0: IAID dd:c1:9b:08 May 05 18:53:08 volumio5-4g dhcpcd[620]: DUID 00:01:00:01:2d:c5:98:d9:2c:cf:67:12:d2:83 May 05 18:53:08 volumio5-4g dhcpcd[620]: eth0: IAID dd:c1:9b:08 May 05 18:53:08 volumio5-4g dhcpcd[620]: eth0: adding address fe80::b53b:5f66:50eb:adb7 May 05 18:53:08 volumio5-4g sh[562]: eth0: adding address fe80::b53b:5f66:50eb:adb7 May 05 18:53:08 volumio5-4g sh[562]: ipv6_addaddr1: Permission denied May 05 18:53:08 volumio5-4g dhcpcd[620]: ipv6_addaddr1: Permission denied May 05 18:53:08 volumio5-4g sh[562]: eth0: soliciting an IPv6 router May 05 18:53:08 volumio5-4g dhcpcd[620]: eth0: soliciting an IPv6 router May 05 18:53:08 volumio5-4g dhcpcd-run-hooks[905]: wlan0: failed to start wpa_supplicant May 05 18:53:08 volumio5-4g dhcpcd-run-hooks[906]: wlan0: Successfully initialized wpa_supplicant nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Ma May 05 18:53:08 volumio5-4g dhcpcd[881]: wlan0: connected to Access Point `' May 05 18:53:08 volumio5-4g dhcpcd[881]: no interfaces have a carrier May 05 18:53:08 volumio5-4g dhcpcd[881]: forked to background, child pid 916 May 05 18:53:08 volumio5-4g dhcpcd[916]: eth0: waiting for carrier May 05 18:53:08 volumio5-4g dhcpcd[916]: wlan0: waiting for carrier May 05 18:53:08 volumio5-4g dhcpcd[916]: eth0: carrier acquired May 05 18:53:08 volumio5-4g sudo[880]: pam_unix(sudo:session): session closed for user root May 05 18:53:08 volumio5-4g dhcpcd[916]: DUID 00:01:00:01:2d:c5:98:d9:2c:cf:67:12:d2:83 May 05 18:53:08 volumio5-4g dhcpcd[916]: eth0: IAID dd:c1:9b:08 May 05 18:53:08 volumio5-4g dhcpcd[916]: eth0: adding address fe80::b53b:5f66:50eb:adb7 May 05 18:53:08 volumio5-4g dhcpcd[916]: ipv6_addaddr1: Permission denied May 05 18:53:09 volumio5-4g dhcpcd[916]: eth0: soliciting a DHCP lease May 05 18:53:09 volumio5-4g ntpd[805]: error resolving pool 2.debian.pool.ntp.org: System error (-11) May 05 18:53:09 volumio5-4g ifplugd(eth0)[784]: Link beat detected. May 05 18:53:09 volumio5-4g sh[562]: eth0: soliciting a DHCP lease May 05 18:53:09 volumio5-4g dhcpcd[620]: eth0: soliciting a DHCP lease May 05 18:53:09 volumio5-4g ifplugd(eth0)[784]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. May 05 18:53:09 volumio5-4g ifplugd(eth0)[784]: client: ifup: waiting for lock on /run/network/ifstate.eth0 May 05 18:53:09 volumio5-4g dhcpcd[916]: eth0: soliciting an IPv6 router May 05 18:53:09 volumio5-4g wireless.js[652]: trying... May 05 18:53:09 volumio5-4g sudo[926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:09 volumio5-4g sudo[926]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:09 volumio5-4g sudo[926]: pam_unix(sudo:session): session closed for user root May 05 18:53:10 volumio5-4g ntpd[805]: error resolving pool 3.debian.pool.ntp.org: System error (-11) May 05 18:53:10 volumio5-4g systemd[1]: systemd-rfkill.service: Succeeded. May 05 18:53:10 volumio5-4g bthelper[644]: Changing power off succeeded May 05 18:53:10 volumio5-4g wireless.js[652]: trying... May 05 18:53:10 volumio5-4g sudo[930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:10 volumio5-4g sudo[930]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:10 volumio5-4g sudo[930]: pam_unix(sudo:session): session closed for user root May 05 18:53:10 volumio5-4g bthelper[644]: [CHG] Controller D8:3A:DD:C1:9B:0B Class: 0x0000041c May 05 18:53:10 volumio5-4g bthelper[644]: Changing power on succeeded May 05 18:53:10 volumio5-4g volumio-remote-updater[645]: [2024-05-05 18:53:10] [info] asio async_connect error: system:111 (Connection refused) May 05 18:53:10 volumio5-4g volumio-remote-updater[645]: [2024-05-05 18:53:10] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 05 18:53:10 volumio5-4g volumio-remote-updater[645]: [2024-05-05 18:53:10] [error] handle_connect error: Underlying Transport Error May 05 18:53:11 volumio5-4g wireless.js[652]: trying... May 05 18:53:11 volumio5-4g sudo[933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:11 volumio5-4g sudo[933]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:11 volumio5-4g sudo[933]: pam_unix(sudo:session): session closed for user root May 05 18:53:12 volumio5-4g wireless.js[652]: trying... May 05 18:53:12 volumio5-4g sudo[936]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:12 volumio5-4g sudo[936]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:12 volumio5-4g sudo[936]: pam_unix(sudo:session): session closed for user root May 05 18:53:13 volumio5-4g sh[562]: eth0: offered 192.168.3.43 from 192.168.3.1 May 05 18:53:13 volumio5-4g dhcpcd[620]: eth0: offered 192.168.3.43 from 192.168.3.1 May 05 18:53:13 volumio5-4g sh[562]: eth0: probing address 192.168.3.43/24 May 05 18:53:13 volumio5-4g dhcpcd[620]: eth0: probing address 192.168.3.43/24 May 05 18:53:13 volumio5-4g wireless.js[652]: trying... May 05 18:53:13 volumio5-4g sudo[939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:13 volumio5-4g sudo[939]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:13 volumio5-4g sudo[939]: pam_unix(sudo:session): session closed for user root May 05 18:53:14 volumio5-4g dhcpcd[916]: eth0: offered 192.168.3.43 from 192.168.3.1 May 05 18:53:14 volumio5-4g dhcpcd[916]: eth0: probing address 192.168.3.43/24 May 05 18:53:14 volumio5-4g wireless.js[652]: trying... May 05 18:53:14 volumio5-4g sudo[942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:14 volumio5-4g sudo[942]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:14 volumio5-4g sudo[942]: pam_unix(sudo:session): session closed for user root May 05 18:53:15 volumio5-4g wireless.js[652]: trying... May 05 18:53:15 volumio5-4g sudo[945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:15 volumio5-4g sudo[945]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:15 volumio5-4g sudo[945]: pam_unix(sudo:session): session closed for user root May 05 18:53:16 volumio5-4g wireless.js[652]: trying... May 05 18:53:16 volumio5-4g sudo[948]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:16 volumio5-4g sudo[948]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:16 volumio5-4g sudo[948]: pam_unix(sudo:session): session closed for user root May 05 18:53:17 volumio5-4g wireless.js[652]: trying... May 05 18:53:17 volumio5-4g sudo[951]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:17 volumio5-4g sudo[951]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:17 volumio5-4g sudo[951]: pam_unix(sudo:session): session closed for user root May 05 18:53:17 volumio5-4g sh[562]: eth0: leased 192.168.3.43 for 86400 seconds May 05 18:53:17 volumio5-4g sh[562]: eth0: adding route to 192.168.3.0/24 May 05 18:53:17 volumio5-4g sh[562]: eth0: adding default route via 192.168.3.1 May 05 18:53:17 volumio5-4g dhcpcd[620]: eth0: leased 192.168.3.43 for 86400 seconds May 05 18:53:17 volumio5-4g sh[562]: eth0: dhcp_envoption 213: Operation not supported May 05 18:53:17 volumio5-4g dhcpcd[620]: eth0: adding route to 192.168.3.0/24 May 05 18:53:17 volumio5-4g dhcpcd[620]: eth0: adding default route via 192.168.3.1 May 05 18:53:17 volumio5-4g dhcpcd[620]: eth0: dhcp_envoption 213: Operation not supported May 05 18:53:17 volumio5-4g avahi-daemon[633]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.3.43. May 05 18:53:17 volumio5-4g avahi-daemon[633]: New relevant interface eth0.IPv4 for mDNS. May 05 18:53:17 volumio5-4g avahi-daemon[633]: Registering new address record for 192.168.3.43 on eth0.IPv4. May 05 18:53:17 volumio5-4g sh[562]: forked to background, child pid 973 May 05 18:53:17 volumio5-4g dhcpcd[620]: forked to background, child pid 973 May 05 18:53:18 volumio5-4g ifplugd(eth0)[784]: client: ifup: interface eth0 already configured May 05 18:53:18 volumio5-4g sh[562]: eth0=eth0 May 05 18:53:18 volumio5-4g ifplugd(eth0)[784]: Program executed successfully. May 05 18:53:18 volumio5-4g volumio-remote-updater[645]: [2024-05-05 18:53:18] [info] asio async_connect error: system:111 (Connection refused) May 05 18:53:18 volumio5-4g volumio-remote-updater[645]: [2024-05-05 18:53:18] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 05 18:53:18 volumio5-4g volumio-remote-updater[645]: [2024-05-05 18:53:18] [error] handle_connect error: Underlying Transport Error May 05 18:53:18 volumio5-4g wireless.js[652]: trying... May 05 18:53:18 volumio5-4g sudo[1000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:18 volumio5-4g sudo[1000]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:18 volumio5-4g sudo[1000]: pam_unix(sudo:session): session closed for user root May 05 18:53:19 volumio5-4g ntpd[805]: Listen normally on 3 eth0 192.168.3.43:123 May 05 18:53:19 volumio5-4g ntpd[805]: new interface(s) found: waking up resolver May 05 18:53:19 volumio5-4g dhcpcd[916]: eth0: leased 192.168.3.43 for 86400 seconds May 05 18:53:19 volumio5-4g dhcpcd[916]: eth0: adding route to 192.168.3.0/24 May 05 18:53:19 volumio5-4g dhcpcd[916]: eth0: adding default route via 192.168.3.1 May 05 18:53:19 volumio5-4g dhcpcd[916]: eth0: dhcp_envoption 213: Operation not supported May 05 18:53:19 volumio5-4g wireless.js[652]: trying... May 05 18:53:19 volumio5-4g sudo[1023]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:19 volumio5-4g sudo[1023]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:19 volumio5-4g sudo[1023]: pam_unix(sudo:session): session closed for user root May 05 18:53:20 volumio5-4g wireless.js[652]: trying... May 05 18:53:20 volumio5-4g sudo[1026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:20 volumio5-4g sudo[1026]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:20 volumio5-4g sudo[1026]: pam_unix(sudo:session): session closed for user root May 05 18:53:21 volumio5-4g nmbd[763]: [2024/05/05 18:53:21.520538, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 05 18:53:21 volumio5-4g systemd[1]: Started Samba NMB Daemon. May 05 18:53:21 volumio5-4g nmbd[763]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections May 05 18:53:21 volumio5-4g systemd[1]: Starting Samba Winbind Daemon... May 05 18:53:21 volumio5-4g winbindd[1028]: [2024/05/05 18:53:21.633095, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) May 05 18:53:21 volumio5-4g winbindd[1028]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 May 05 18:53:21 volumio5-4g winbindd[1028]: [2024/05/05 18:53:21.647745, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 05 18:53:21 volumio5-4g winbindd[1028]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections May 05 18:53:21 volumio5-4g systemd[1]: Started Samba Winbind Daemon. May 05 18:53:21 volumio5-4g systemd[1]: Starting Samba SMB Daemon... May 05 18:53:21 volumio5-4g wpa_supplicant[904]: wlan0: Failed to initiate sched scan May 05 18:53:21 volumio5-4g wireless.js[652]: trying... May 05 18:53:21 volumio5-4g sudo[1038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:21 volumio5-4g sudo[1038]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:21 volumio5-4g sudo[1038]: pam_unix(sudo:session): session closed for user root May 05 18:53:21 volumio5-4g smbd[1033]: [2024/05/05 18:53:21.828067, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 05 18:53:21 volumio5-4g smbd[1033]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections May 05 18:53:21 volumio5-4g systemd[1]: Started Samba SMB Daemon. May 05 18:53:22 volumio5-4g wireless.js[652]: trying... May 05 18:53:22 volumio5-4g sudo[1045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:22 volumio5-4g sudo[1045]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:22 volumio5-4g sudo[1045]: pam_unix(sudo:session): session closed for user root May 05 18:53:23 volumio5-4g wireless.js[652]: trying... May 05 18:53:23 volumio5-4g sudo[1048]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:23 volumio5-4g sudo[1048]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:23 volumio5-4g sudo[1048]: pam_unix(sudo:session): session closed for user root May 05 18:53:24 volumio5-4g wireless.js[652]: trying... May 05 18:53:24 volumio5-4g sudo[1051]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:24 volumio5-4g sudo[1051]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:24 volumio5-4g sudo[1051]: pam_unix(sudo:session): session closed for user root May 05 18:53:25 volumio5-4g wireless.js[652]: trying... May 05 18:53:25 volumio5-4g sudo[1054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:25 volumio5-4g sudo[1054]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:25 volumio5-4g sudo[1054]: pam_unix(sudo:session): session closed for user root May 05 18:53:26 volumio5-4g wireless.js[652]: trying... May 05 18:53:26 volumio5-4g sudo[1057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:26 volumio5-4g sudo[1057]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:26 volumio5-4g sudo[1057]: pam_unix(sudo:session): session closed for user root May 05 18:53:27 volumio5-4g wpa_supplicant[904]: wlan0: Failed to initiate sched scan May 05 18:53:27 volumio5-4g wireless.js[652]: trying... May 05 18:53:27 volumio5-4g sudo[1060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:27 volumio5-4g sudo[1060]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:27 volumio5-4g sudo[1060]: pam_unix(sudo:session): session closed for user root May 05 18:53:28 volumio5-4g volumio-remote-updater[645]: [2024-05-05 18:53:28] [info] asio async_connect error: system:111 (Connection refused) May 05 18:53:28 volumio5-4g volumio-remote-updater[645]: [2024-05-05 18:53:28] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 05 18:53:28 volumio5-4g volumio-remote-updater[645]: [2024-05-05 18:53:28] [error] handle_connect error: Underlying Transport Error May 05 18:53:28 volumio5-4g wireless.js[652]: trying... May 05 18:53:28 volumio5-4g sudo[1063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 18:53:28 volumio5-4g sudo[1063]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:28 volumio5-4g sudo[1063]: pam_unix(sudo:session): session closed for user root May 05 18:53:29 volumio5-4g wireless.js[652]: Overtime, starting plan B May 05 18:53:29 volumio5-4g kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 05 18:53:29 volumio5-4g systemd[1]: Started Wireless Services. May 05 18:53:29 volumio5-4g systemd[1]: Started Volumio Backend Module. May 05 18:53:29 volumio5-4g systemd[1]: Started Volumio Cpu Tweaker. May 05 18:53:29 volumio5-4g systemd[1]: Reached target Multi-User System. May 05 18:53:29 volumio5-4g systemd[1]: Reached target Graphical Interface. May 05 18:53:29 volumio5-4g systemd[1]: Starting Update UTMP about System Runlevel Changes... May 05 18:53:29 volumio5-4g systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 05 18:53:29 volumio5-4g systemd[1]: Started Update UTMP about System Runlevel Changes. May 05 18:53:29 volumio5-4g systemd[1]: Startup finished in 6.590s (kernel) + 26.416s (userspace) = 33.007s. May 05 18:53:29 volumio5-4g volumio-cpu-tweak[1069]: Setting RT Priority for mpd May 05 18:53:29 volumio5-4g volumio-cpu-tweak[1069]: pid 35's current scheduling policy: SCHED_OTHER May 05 18:53:29 volumio5-4g volumio-cpu-tweak[1069]: pid 35's current scheduling priority: 0 May 05 18:53:29 volumio5-4g volumio-cpu-tweak[1069]: Setting MPD Affinity May 05 18:53:29 volumio5-4g volumio-cpu-tweak[1069]: pid 3's current affinity mask: f May 05 18:53:29 volumio5-4g volumio-cpu-tweak[1069]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input May 05 18:53:29 volumio5-4g volumio-cpu-tweak[1069]: VOLUMIO CPU TWEAK: Setting CPU Governor: conservative May 05 18:53:29 volumio5-4g systemd[1]: volumio_cpu_tweak.service: Succeeded. May 05 18:53:30 volumio5-4g volumio[1068]: info: ------------------------------------------- May 05 18:53:30 volumio5-4g volumio[1068]: info: ----- Volumio3 ---- May 05 18:53:30 volumio5-4g volumio[1068]: info: ------------------------------------------- May 05 18:53:30 volumio5-4g volumio[1068]: info: ----- System startup ---- May 05 18:53:30 volumio5-4g volumio[1068]: info: ------------------------------------------- May 05 18:53:30 volumio5-4g volumio[1068]: info: MYVOLUMIO Environment detected May 05 18:53:30 volumio5-4g volumio[1068]: info: Plugin folders cleanup May 05 18:53:30 volumio5-4g volumio[1068]: info: Scanning into folder /volumio/app/plugins/ May 05 18:53:30 volumio5-4g volumio[1068]: info: Scanning category audio_interface May 05 18:53:30 volumio5-4g volumio[1068]: info: Scanning category miscellanea May 05 18:53:30 volumio5-4g volumio[1068]: info: Scanning category music_service May 05 18:53:30 volumio5-4g volumio[1068]: info: Scanning category plugins.json May 05 18:53:30 volumio5-4g volumio[1068]: info: Scanning category system_controller May 05 18:53:30 volumio5-4g volumio[1068]: info: Scanning category user_interface May 05 18:53:30 volumio5-4g volumio[1068]: info: Scanning into folder /data/plugins/ May 05 18:53:30 volumio5-4g volumio[1068]: info: Scanning category music_service May 05 18:53:30 volumio5-4g volumio[1068]: info: Scanning category system_controller May 05 18:53:30 volumio5-4g volumio[1068]: info: Scanning category user_interface May 05 18:53:30 volumio5-4g volumio[1068]: info: Plugin folders cleanup completed May 05 18:53:30 volumio5-4g volumio[1068]: info: ------------------------------------------- May 05 18:53:30 volumio5-4g volumio[1068]: info: ----- Core plugins startup ---- May 05 18:53:30 volumio5-4g volumio[1068]: info: ------------------------------------------- May 05 18:53:30 volumio5-4g volumio[1068]: info: Loading plugins from folder /volumio/app/plugins/ May 05 18:53:30 volumio5-4g volumio[1068]: info: Adding plugin upnp to MyMusic Plugins May 05 18:53:30 volumio5-4g volumio[1068]: info: Adding plugin airplay_emulation to MyMusic Plugins May 05 18:53:30 volumio5-4g volumio[1068]: info: Adding plugin upnp_browser to MyMusic Plugins May 05 18:53:30 volumio5-4g volumio[1068]: info: Loading plugins from folder /data/plugins/ May 05 18:53:30 volumio5-4g volumio[1068]: info: Loading plugin "system"... May 05 18:53:30 volumio5-4g volumio[1068]: info: Loading plugin "appearance"... May 05 18:53:31 volumio5-4g volumio[1068]: info: Loading plugin "network"... May 05 18:53:31 volumio5-4g volumio[1068]: info: Refreshing Cached IP Addresses May 05 18:53:31 volumio5-4g sudo[1100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 05 18:53:31 volumio5-4g sudo[1100]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:31 volumio5-4g sudo[1102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 05 18:53:31 volumio5-4g sudo[1102]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:31 volumio5-4g volumio[1068]: info: Loading plugin "services"... May 05 18:53:31 volumio5-4g sudo[1100]: pam_unix(sudo:session): session closed for user root May 05 18:53:31 volumio5-4g sudo[1102]: pam_unix(sudo:session): session closed for user root May 05 18:53:31 volumio5-4g volumio[1068]: info: Loading plugin "alsa_controller"... May 05 18:53:31 volumio5-4g sudo[1105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 05 18:53:31 volumio5-4g sudo[1105]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:31 volumio5-4g volumio[1068]: info: Hardware Mixer selected but no Hardware mixer available, detecting default mixer May 05 18:53:31 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 05 18:53:31 volumio5-4g volumio[1068]: info: Device 0 does not have any Mixer Control Available May 05 18:53:31 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 05 18:53:31 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 05 18:53:31 volumio5-4g volumio[1068]: info: Loading plugin "wizard"... May 05 18:53:31 volumio5-4g volumio[1068]: info: Loading plugin "networkfs"... May 05 18:53:31 volumio5-4g volumio[1068]: info: Starting Udev Watcher for removable devices May 05 18:53:31 volumio5-4g sudo[1119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //127.0.0.1/Internal Storage\\music /mnt/NAS/local May 05 18:53:31 volumio5-4g sudo[1119]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:31 volumio5-4g volumio[1068]: info: Mounting Device 626B-EC13 May 05 18:53:31 volumio5-4g sudo[1130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/626B-EC13 -o noatime May 05 18:53:31 volumio5-4g sudo[1130]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:31 volumio5-4g kernel: Key type cifs.spnego registered May 05 18:53:31 volumio5-4g kernel: Key type cifs.idmap registered May 05 18:53:31 volumio5-4g kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. May 05 18:53:31 volumio5-4g kernel: CIFS: Attempting to mount \\127.0.0.1\Internal Storage May 05 18:53:31 volumio5-4g sudo[1119]: pam_unix(sudo:session): session closed for user root May 05 18:53:31 volumio5-4g kernel: fuse: init (API version 7.37) May 05 18:53:31 volumio5-4g sudo[1130]: pam_unix(sudo:session): session closed for user root May 05 18:53:31 volumio5-4g volumio[1068]: info: Ignoring mount for partition: boot May 05 18:53:31 volumio5-4g volumio[1068]: info: Ignoring mount for partition: volumio May 05 18:53:31 volumio5-4g volumio[1068]: info: Ignoring mount for partition: volumio_data May 05 18:53:31 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 05 18:53:31 volumio5-4g volumio[1068]: info: Loading plugin "volumio_command_line_client"... May 05 18:53:31 volumio5-4g volumio[1068]: info: Loading plugin "upnp"... May 05 18:53:31 volumio5-4g volumio[1068]: info: [1714906411782] Starting Upmpd Daemon May 05 18:53:31 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 05 18:53:31 volumio5-4g volumio[1068]: info: Loading plugin "my_music"... May 05 18:53:31 volumio5-4g volumio[1068]: info: Loading plugin "mpd"... May 05 18:53:31 volumio5-4g systemd[1]: Mounting FUSE Control File System... May 05 18:53:31 volumio5-4g systemd[1]: Mounted FUSE Control File System. May 05 18:53:31 volumio5-4g volumio[1068]: info: Loading plugin "upnp_browser"... May 05 18:53:32 volumio5-4g volumio[1068]: info: Loading plugin "alarm-clock"... May 05 18:53:32 volumio5-4g volumio[1068]: info: Loading plugin "airplay_emulation"... May 05 18:53:32 volumio5-4g volumio[1068]: info: Starting Shairport Sync May 05 18:53:32 volumio5-4g volumio[1068]: info: Loading plugin "last_100"... May 05 18:53:32 volumio5-4g volumio[1068]: info: Loading plugin "webradio"... May 05 18:53:32 volumio5-4g volumio[1068]: info: Loading plugin "i2s_dacs"... May 05 18:53:32 volumio5-4g volumio[1068]: info: Loading plugin "volumiodiscovery"... May 05 18:53:32 volumio5-4g volumio[1068]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 05 18:53:32 volumio5-4g node[1068]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 05 18:53:32 volumio5-4g node[1068]: *** WARNING *** Please fix your application to use the native API of Avahi! May 05 18:53:32 volumio5-4g volumio[1068]: *** WARNING *** Please fix your application to use the native API of Avahi! May 05 18:53:32 volumio5-4g volumio[1068]: *** WARNING *** For more information see May 05 18:53:32 volumio5-4g volumio[1068]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 05 18:53:32 volumio5-4g volumio[1068]: *** WARNING *** Please fix your application to use the native API of Avahi! May 05 18:53:32 volumio5-4g volumio[1068]: *** WARNING *** For more information see May 05 18:53:32 volumio5-4g node[1068]: *** WARNING *** For more information see May 05 18:53:32 volumio5-4g node[1068]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 05 18:53:32 volumio5-4g node[1068]: *** WARNING *** Please fix your application to use the native API of Avahi! May 05 18:53:32 volumio5-4g node[1068]: *** WARNING *** For more information see May 05 18:53:32 volumio5-4g volumio[1068]: info: Applying required configuration parameters for plugin volumiodiscovery May 05 18:53:32 volumio5-4g volumio[1068]: info: Discovery: Started advertising with name: Volumio5-4g May 05 18:53:32 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 05 18:53:32 volumio5-4g volumio[1068]: info: Loading plugin "jellyfin"... May 05 18:53:32 volumio5-4g sudo[1105]: pam_unix(sudo:session): session closed for user root May 05 18:53:32 volumio5-4g volumio[1068]: info: Loading plugin "autostart"... May 05 18:53:32 volumio5-4g volumio[1068]: info: Applying required configuration parameters for plugin autostart May 05 18:53:32 volumio5-4g volumio[1068]: info: AutoStart - onVolumioStart - read config.json May 05 18:53:32 volumio5-4g volumio[1068]: info: Loading plugin "peppy_screensaver"... May 05 18:53:32 volumio5-4g volumio[1068]: info: Applying required configuration parameters for plugin peppy_screensaver May 05 18:53:32 volumio5-4g volumio[1068]: info: Loading plugin "outputs"... May 05 18:53:32 volumio5-4g volumio[1068]: info: Loading plugin "albumart"... May 05 18:53:32 volumio5-4g volumio[1068]: info: Plugin example_plugin is not enabled May 05 18:53:32 volumio5-4g volumio[1068]: info: Loading plugin "inputs"... May 05 18:53:32 volumio5-4g volumio[1068]: info: Loading plugin "updater_comm"... May 05 18:53:32 volumio5-4g volumio[1068]: info: Plugin mpdemulation is not enabled May 05 18:53:32 volumio5-4g volumio[1068]: info: Loading plugin "rest_api"... May 05 18:53:32 volumio5-4g volumio[1068]: info: Loading plugin "websocket"... May 05 18:53:32 volumio5-4g volumio[1068]: info: Loading plugin "touch_display"... May 05 18:53:32 volumio5-4g volumio[1068]: Forking 3 albumart workers May 05 18:53:33 volumio5-4g volumio[1068]: info: Applying required configuration parameters for plugin touch_display May 05 18:53:33 volumio5-4g volumio[1068]: info: Loading i18n strings for locale zh May 05 18:53:33 volumio5-4g volumio[1068]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. May 05 18:53:33 volumio5-4g volumio[1068]: Updating browse sources language May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 05 18:53:33 volumio5-4g volumio[1068]: Starting albumart workers May 05 18:53:33 volumio5-4g volumio[1068]: Starting albumart workers May 05 18:53:33 volumio5-4g volumio[1068]: Starting albumart workers May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::initPlayerControls May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 05 18:53:33 volumio5-4g volumio[1068]: Express server listening on port 3000 May 05 18:53:33 volumio5-4g volumio[1068]: [Metrics] WebUI: 2s 926.31ms May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreStateMachine::resetVolumioState May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreStateMachine::getcurrentVolume May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioRetrievevolume May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreStateMachine::pushState May 05 18:53:33 volumio5-4g volumio[1068]: info: CorePlayQueue::getTrack 0 May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioPushState May 05 18:53:33 volumio5-4g volumio[1068]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1 May 05 18:53:33 volumio5-4g volumio[1068]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 05 18:53:33 volumio5-4g volumio[1068]: info: Reloading queue from file May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreStateMachine::setRepeat null single undefined May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreStateMachine::pushState May 05 18:53:33 volumio5-4g volumio[1068]: info: CorePlayQueue::getTrack 0 May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioPushState May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreStateMachine::setRandom null May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreStateMachine::pushState May 05 18:53:33 volumio5-4g volumio[1068]: info: CorePlayQueue::getTrack 0 May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioPushState May 05 18:53:33 volumio5-4g volumio[1068]: info: Setting Device type: Raspberry PI May 05 18:53:33 volumio5-4g volumio[1068]: info: Discovery: adding 1d0de2d3-c195-4be3-ab1d-257be51e1699 May 05 18:53:33 volumio5-4g volumio[1068]: info: Discovery: Found device Volumio5-4g May 05 18:53:33 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioGetState May 05 18:53:33 volumio5-4g volumio[1068]: info: CorePlayQueue::getTrack 0 May 05 18:53:33 volumio5-4g wpa_supplicant[904]: wlan0: Failed to initiate sched scan May 05 18:53:35 volumio5-4g systemd[1]: systemd-fsckd.service: Succeeded. May 05 18:53:35 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 05 18:53:35 volumio5-4g volumio[1068]: info: CoreStateMachine::getcurrentVolume May 05 18:53:35 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioRetrievevolume May 05 18:53:35 volumio5-4g volumio[1068]: info: CoreStateMachine::pushState May 05 18:53:35 volumio5-4g volumio[1068]: info: CorePlayQueue::getTrack 0 May 05 18:53:35 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioPushState May 05 18:53:36 volumio5-4g systemd[1]: systemd-hostnamed.service: Succeeded. May 05 18:53:38 volumio5-4g volumio-remote-updater[645]: [2024-05-05 18:53:38] [connect] Successful connection May 05 18:53:38 volumio5-4g volumio-remote-updater[645]: [2024-05-05 18:53:38] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1714906418 101 May 05 18:53:38 volumio5-4g volumio[1068]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 3 May 05 18:53:39 volumio5-4g wpa_supplicant[904]: wlan0: Failed to initiate sched scan May 05 18:53:41 volumio5-4g sudo[1223]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 05 18:53:41 volumio5-4g sudo[1223]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:41 volumio5-4g sudo[1223]: pam_unix(sudo:session): session closed for user root May 05 18:53:41 volumio5-4g sudo[1225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 05 18:53:41 volumio5-4g sudo[1225]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:41 volumio5-4g sudo[1225]: pam_unix(sudo:session): session closed for user root May 05 18:53:41 volumio5-4g volumio[1068]: verbose: New Socket.io Connection to 192.168.3.43 from 192.168.3.3 UA: Mozilla/5.0 (Linux; Android 14; V2171A; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/87.0.4280.141 Mobile Safari/537.36 VivoBrowser/19.3.1.0 Total Clients: 4 May 05 18:53:41 volumio5-4g sudo[1229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 05 18:53:41 volumio5-4g sudo[1229]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:41 volumio5-4g sudo[1229]: pam_unix(sudo:session): session closed for user root May 05 18:53:41 volumio5-4g sudo[1231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 05 18:53:41 volumio5-4g sudo[1231]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:41 volumio5-4g sudo[1231]: pam_unix(sudo:session): session closed for user root May 05 18:53:41 volumio5-4g volumio[1068]: verbose: New Socket.io Connection to 192.168.3.43 from 192.168.3.3 UA: Mozilla/5.0 (Linux; Android 14; V2171A; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/87.0.4280.141 Mobile Safari/537.36 VivoBrowser/19.3.1.0 Total Clients: 5 May 05 18:53:41 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 05 18:53:41 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 05 18:53:41 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioGetVisibleSources May 05 18:53:41 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 05 18:53:41 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioGetState May 05 18:53:41 volumio5-4g volumio[1068]: info: CorePlayQueue::getTrack 0 May 05 18:53:41 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 05 18:53:41 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 05 18:53:41 volumio5-4g volumio[1068]: info: Received Get System Info May 05 18:53:41 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 05 18:53:41 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 05 18:53:41 volumio5-4g volumio[1068]: info: Discovery: Getting this device information May 05 18:53:41 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioGetState May 05 18:53:41 volumio5-4g volumio[1068]: info: CorePlayQueue::getTrack 0 May 05 18:53:41 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 05 18:53:41 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioGetState May 05 18:53:41 volumio5-4g volumio[1068]: info: CorePlayQueue::getTrack 0 May 05 18:53:41 volumio5-4g volumio[1068]: info: Listing playlists May 05 18:53:41 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 05 18:53:41 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 05 18:53:41 volumio5-4g sudo[1235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 05 18:53:41 volumio5-4g sudo[1235]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:41 volumio5-4g sudo[1235]: pam_unix(sudo:session): session closed for user root May 05 18:53:41 volumio5-4g sudo[1237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 05 18:53:41 volumio5-4g sudo[1237]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:41 volumio5-4g sudo[1237]: pam_unix(sudo:session): session closed for user root May 05 18:53:41 volumio5-4g sudo[1241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 05 18:53:41 volumio5-4g sudo[1241]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 18:53:41 volumio5-4g systemd[1]: Started UPnP Renderer front-end to MPD. May 05 18:53:41 volumio5-4g sudo[1241]: pam_unix(sudo:session): session closed for user root May 05 18:53:41 volumio5-4g volumio[1068]: info: Upmpdcli Daemon Started May 05 18:53:41 volumio5-4g volumio[1068]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 May 05 18:53:42 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioPlay May 05 18:53:42 volumio5-4g volumio[1068]: info: CoreStateMachine::play index undefined May 05 18:53:42 volumio5-4g volumio[1068]: info: CoreStateMachine::setConsumeUpdateService undefined May 05 18:53:42 volumio5-4g volumio[1068]: info: CorePlayQueue::getTrack 0 May 05 18:53:42 volumio5-4g volumio[1068]: info: CoreStateMachine::startPlaybackTimer May 05 18:53:42 volumio5-4g volumio[1068]: info: CorePlayQueue::getTrack 0 May 05 18:53:42 volumio5-4g volumio[1068]: verbose: ControllerMpd::clearAddPlayTracks USB/626B-EC13/呆妹儿、小可 - 最牛派 (慢摇DJ版).flac May 05 18:53:42 volumio5-4g volumio[1068]: verbose: ControllerMpd::sendMpdCommand stop May 05 18:53:43 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 05 18:53:43 volumio5-4g volumio[1068]: info: Received Get System Info May 05 18:53:43 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 05 18:53:43 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 05 18:53:43 volumio5-4g volumio[1068]: info: Discovery: Getting this device information May 05 18:53:43 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioGetState May 05 18:53:43 volumio5-4g volumio[1068]: info: CorePlayQueue::getTrack 0 May 05 18:53:43 volumio5-4g volumio[1068]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 05 18:53:43 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioPlay May 05 18:53:43 volumio5-4g volumio[1068]: info: CoreStateMachine::play index undefined May 05 18:53:43 volumio5-4g volumio[1068]: info: CoreStateMachine::setConsumeUpdateService undefined May 05 18:53:43 volumio5-4g volumio[1068]: info: CorePlayQueue::getTrack 0 May 05 18:53:43 volumio5-4g volumio[1068]: info: CoreStateMachine::startPlaybackTimer May 05 18:53:43 volumio5-4g volumio[1068]: info: CorePlayQueue::getTrack 0 May 05 18:53:43 volumio5-4g volumio[1068]: verbose: ControllerMpd::clearAddPlayTracks USB/626B-EC13/呆妹儿、小可 - 最牛派 (慢摇DJ版).flac May 05 18:53:43 volumio5-4g volumio[1068]: verbose: ControllerMpd::sendMpdCommand stop May 05 18:53:44 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioPlay May 05 18:53:44 volumio5-4g volumio[1068]: info: CoreStateMachine::play index undefined May 05 18:53:44 volumio5-4g volumio[1068]: info: CoreStateMachine::setConsumeUpdateService undefined May 05 18:53:44 volumio5-4g volumio[1068]: info: CorePlayQueue::getTrack 0 May 05 18:53:44 volumio5-4g volumio[1068]: info: CoreStateMachine::startPlaybackTimer May 05 18:53:44 volumio5-4g volumio[1068]: info: CorePlayQueue::getTrack 0 May 05 18:53:44 volumio5-4g volumio[1068]: verbose: ControllerMpd::clearAddPlayTracks USB/626B-EC13/呆妹儿、小可 - 最牛派 (慢摇DJ版).flac May 05 18:53:44 volumio5-4g volumio[1068]: verbose: ControllerMpd::sendMpdCommand stop May 05 18:53:45 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioGetQueue May 05 18:53:45 volumio5-4g volumio[1068]: info: CoreStateMachine::getQueue May 05 18:53:45 volumio5-4g volumio[1068]: info: CorePlayQueue::getQueue May 05 18:53:45 volumio5-4g wpa_supplicant[904]: wlan0: Failed to initiate sched scan May 05 18:53:45 volumio5-4g volumio[1068]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 May 05 18:53:45 volumio5-4g volumio[1068]: info: Preload queue cleared May 05 18:53:45 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioReplaceandPlayItems May 05 18:53:45 volumio5-4g volumio[1068]: info: CoreStateMachine::ClearQueue May 05 18:53:45 volumio5-4g volumio[1068]: info: CoreStateMachine::stop May 05 18:53:45 volumio5-4g volumio[1068]: info: CoreStateMachine::setConsumeUpdateService undefined May 05 18:53:45 volumio5-4g volumio[1068]: info: CorePlayQueue::clearPlayQueue May 05 18:53:45 volumio5-4g volumio[1068]: info: CorePlayQueue::saveQueue May 05 18:53:45 volumio5-4g volumio[1068]: info: CoreCommandRouter::volumioPushQueue May 05 18:53:45 volumio5-4g volumio[1068]: info: CoreStateMachine::addQueueItems May 05 18:53:45 volumio5-4g volumio[1068]: info: CorePlayQueue::addQueueItems May 05 18:53:45 volumio5-4g volumio[1068]: info: Preload queue cleared May 05 18:53:45 volumio5-4g volumio[1068]: info: Adding Item to queue: music-library/USB/626B-EC13/呆妹儿、小可 - 最牛派 (慢摇DJ版).flac May 05 18:53:45 volumio5-4g volumio[1068]: info: Exploding uri music-library/USB/626B-EC13/呆妹儿、小可 - 最牛派 (慢摇DJ版).flac in service mpd May 05 18:53:45 volumio5-4g volumio[1068]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 05 18:53:45 volumio5-4g volumio[1068]: TypeError: Cannot read property 'then' of undefined May 05 18:53:45 volumio5-4g volumio[1068]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2527:19) May 05 18:53:45 volumio5-4g volumio[1068]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2325:21) May 05 18:53:45 volumio5-4g volumio[1068]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1359:16) May 05 18:53:45 volumio5-4g volumio[1068]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) May 05 18:53:45 volumio5-4g volumio[1068]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) May 05 18:53:45 volumio5-4g volumio[1068]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) May 05 18:53:45 volumio5-4g volumio[1068]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) May 05 18:53:45 volumio5-4g volumio[1068]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:501:23) May 05 18:53:45 volumio5-4g volumio[1068]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:477:17) May 05 18:53:45 volumio5-4g volumio[1068]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:118:33) May 05 18:53:45 volumio5-4g volumio[1068]: at Socket.emit (events.js:315:20) May 05 18:53:45 volumio5-4g volumio[1068]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 May 05 18:53:45 volumio5-4g volumio[1068]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 05 18:53:45 volumio5-4g volumio[1068]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 05 18:53:46 volumio5-4g sudo[1253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-05 18:52 May 05 18:53:46 volumio5-4g sudo[1253]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"