-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Sun 2024-05-05 19:01:22 CST. -- May 05 19:00:39 volumio5-4g kernel: hid-generic 0003:3151:3120.0002: input,hiddev96,hidraw1: USB HID v2.00 Mouse [YICHIP 2.4G Receiver] on usb-xhci-hcd.1-1/input1 May 05 19:00:39 volumio5-4g kernel: scsi 0:0:0:0: Direct-Access Mass Storage Device 1.00 PQ: 0 ANSI: 0 CCS May 05 19:00:39 volumio5-4g kernel: sd 0:0:0:0: [sda] 1048578048 512-byte logical blocks: (537 GB/500 GiB) May 05 19:00:39 volumio5-4g kernel: sd 0:0:0:0: [sda] Write Protect is off May 05 19:00:39 volumio5-4g kernel: sd 0:0:0:0: [sda] Mode Sense: 03 00 00 00 May 05 19:00:39 volumio5-4g kernel: sd 0:0:0:0: [sda] No Caching mode page found May 05 19:00:39 volumio5-4g kernel: sd 0:0:0:0: [sda] Assuming drive cache: write through May 05 19:00:39 volumio5-4g kernel: sda: sda1 May 05 19:00:39 volumio5-4g kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk May 05 19:00:39 volumio5-4g initramfs: Checking for USB updates May 05 19:00:39 volumio5-4g kernel: F2FS-fs (sda1): Magic Mismatch, valid(0xf2f52010) - read(0x41b05066) May 05 19:00:39 volumio5-4g kernel: F2FS-fs (sda1): Can't find valid F2FS filesystem in 1th superblock May 05 19:00:39 volumio5-4g kernel: F2FS-fs (sda1): Magic Mismatch, valid(0xf2f52010) - read(0x0) May 05 19:00:39 volumio5-4g kernel: F2FS-fs (sda1): Can't find valid F2FS filesystem in 2th superblock May 05 19:00:39 volumio5-4g kernel: loop0: detected capacity change from 0 to 967536 May 05 19:00:39 volumio5-4g kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. May 05 19:00:39 volumio5-4g kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. May 05 19:00:39 volumio5-4g kernel: EXT4-fs (mmcblk0p3): 2 orphan inodes deleted May 05 19:00:39 volumio5-4g kernel: EXT4-fs (mmcblk0p3): recovery complete May 05 19:00:39 volumio5-4g kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Quota mode: none. May 05 19:00:39 volumio5-4g initramfs: With Option: May 05 19:00:39 volumio5-4g initramfs: VOLUMIO_VERSION="3.631" May 05 19:00:39 volumio5-4g initramfs: Finish initramfs, continue booting Volumio May 05 19:00:39 volumio5-4g systemd[1]: System time before build time, advancing clock. May 05 19:00:39 volumio5-4g kernel: NET: Registered PF_INET6 protocol family May 05 19:00:39 volumio5-4g kernel: Segment Routing with IPv6 May 05 19:00:39 volumio5-4g kernel: In-situ OAM (IOAM) with IPv6 May 05 19:00:39 volumio5-4g 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) May 05 19:00:39 volumio5-4g systemd[1]: Detected architecture arm64. May 05 19:00:39 volumio5-4g systemd[1]: Set hostname to . May 05 19:00:39 volumio5-4g kernel: uart-pl011 107d001000.serial: no DMA platform data May 05 19:00:39 volumio5-4g systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 05 19:00:39 volumio5-4g systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. May 05 19:00:39 volumio5-4g systemd[1]: Created slice system-serial\x2dgetty.slice. May 05 19:00:39 volumio5-4g systemd[1]: Listening on initctl Compatibility Named Pipe. May 05 19:00:39 volumio5-4g systemd[1]: Listening on fsck to fsckd communication Socket. May 05 19:00:39 volumio5-4g systemd[1]: Started Forward Password Requests to Wall Directory Watch. May 05 19:00:39 volumio5-4g systemd[1]: Listening on RPCbind Server Activation Socket. May 05 19:00:39 volumio5-4g kernel: i2c_dev: i2c /dev entries driver May 05 19:00:39 volumio5-4g systemd-journald[227]: Journal started May 05 19:00:39 volumio5-4g systemd-journald[227]: Runtime journal (/run/log/journal/c1d531165394c79721acb5a765d65e88) is 7.5M, max 30.0M, 22.5M free. Feb 14 18:11:58 volumio5-4g systemd-modules-load[218]: Inserted module 'i2c_dev' May 05 19:00:39 volumio5-4g fake-hwclock[219]: Sun May 5 11:00:39 UTC 2024 May 05 19:00:39 volumio5-4g systemd[1]: Started Restore / save the current clock. May 05 19:00:39 volumio5-4g systemd[1]: Started Apply Kernel Variables. May 05 19:00:39 volumio5-4g systemd[1]: Started Load/Save Random Seed. May 05 19:00:39 volumio5-4g systemd[1]: dynamicswap.service: Succeeded. May 05 19:00:39 volumio5-4g systemd[1]: Started Create System Users. May 05 19:00:39 volumio5-4g systemd[1]: Starting Create Static Device Nodes in /dev... May 05 19:00:39 volumio5-4g systemd[1]: Started Create Static Device Nodes in /dev. May 05 19:00:39 volumio5-4g systemd[1]: Starting udev Kernel Device Manager... May 05 19:00:39 volumio5-4g systemd[1]: Reached target Local File Systems (Pre). May 05 19:00:39 volumio5-4g systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. May 05 19:00:39 volumio5-4g systemd[1]: Mounting /tmp... May 05 19:00:39 volumio5-4g systemd[1]: Mounting /var/spool/cups... May 05 19:00:39 volumio5-4g systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. May 05 19:00:39 volumio5-4g systemd[1]: Mounting /var/log... May 05 19:00:39 volumio5-4g systemd[1]: Mounted /tmp. May 05 19:00:39 volumio5-4g systemd[1]: Mounted /var/spool/cups. May 05 19:00:39 volumio5-4g systemd[1]: Mounting /var/spool/cups/tmp... May 05 19:00:39 volumio5-4g systemd[1]: Mounted /var/spool/cups/tmp. May 05 19:00:39 volumio5-4g systemd[1]: Mounted /var/log. May 05 19:00:39 volumio5-4g systemd[1]: Started udev Coldplug all Devices. May 05 19:00:39 volumio5-4g systemd-udevd[246]: Network interface NamePolicy= disabled on kernel command line, ignoring. May 05 19:00:39 volumio5-4g systemd[1]: Starting Helper to synchronize boot up for ifupdown... May 05 19:00:39 volumio5-4g systemd[1]: Starting Flush Journal to Persistent Storage... May 05 19:00:39 volumio5-4g systemd[1]: Started Helper to synchronize boot up for ifupdown. May 05 19:00:39 volumio5-4g systemd-journald[227]: Runtime journal (/run/log/journal/c1d531165394c79721acb5a765d65e88) is 7.5M, max 30.0M, 22.5M free. May 05 19:00:39 volumio5-4g systemd[1]: Started udev Kernel Device Manager. May 05 19:00:39 volumio5-4g systemd[1]: Starting Show Plymouth Boot Screen... May 05 19:00:39 volumio5-4g systemd[1]: Started Flush Journal to Persistent Storage. May 05 19:00:39 volumio5-4g systemd[1]: Received SIGRTMIN+20 from PID 276 (plymouthd). May 05 19:00:39 volumio5-4g systemd[1]: Started Show Plymouth Boot Screen. May 05 19:00:39 volumio5-4g systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. May 05 19:00:39 volumio5-4g systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. May 05 19:00:39 volumio5-4g systemd[1]: Reached target Paths. May 05 19:00:39 volumio5-4g systemd[1]: Reached target Local Encrypted Volumes. May 05 19:00:39 volumio5-4g kernel: mc: Linux media interface: v0.10 May 05 19:00:39 volumio5-4g systemd-udevd[261]: Using default interface naming scheme 'v240'. May 05 19:00:39 volumio5-4g systemd-udevd[261]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 05 19:00:39 volumio5-4g kernel: rpi-gpiomem 107d508500.gpiomem: window base 0x107d508500 size 0x00000040 May 05 19:00:39 volumio5-4g kernel: videodev: Linux video capture interface: v2.00 May 05 19:00:39 volumio5-4g kernel: rpi-gpiomem 107d508500.gpiomem: initialised 1 regions as /dev/gpiomem1 May 05 19:00:39 volumio5-4g kernel: rpi-gpiomem 107d517c00.gpiomem: window base 0x107d517c00 size 0x00000040 May 05 19:00:39 volumio5-4g kernel: rpi-gpiomem 107d517c00.gpiomem: initialised 1 regions as /dev/gpiomem2 May 05 19:00:39 volumio5-4g kernel: rpi-gpiomem 107d504100.gpiomem: window base 0x107d504100 size 0x00000020 May 05 19:00:39 volumio5-4g kernel: rpi-gpiomem 107d504100.gpiomem: initialised 1 regions as /dev/gpiomem3 May 05 19:00:39 volumio5-4g kernel: rpi-gpiomem 107d510700.gpiomem: window base 0x107d510700 size 0x00000020 May 05 19:00:39 volumio5-4g kernel: rpi-gpiomem 107d510700.gpiomem: initialised 1 regions as /dev/gpiomem4 May 05 19:00:39 volumio5-4g kernel: rpi-gpiomem 1f000d0000.gpiomem: window base 0x1f000d0000 size 0x00030000 May 05 19:00:39 volumio5-4g kernel: rpi-gpiomem 1f000d0000.gpiomem: initialised 1 regions as /dev/gpiomem0 May 05 19:00:39 volumio5-4g kernel: input: pwr_button as /devices/platform/pwr_button/input/input5 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: bcm2712_iommu_of_xlate: MMU 1000005100.iommu May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: pispbe_probe: HW version: 0x02252700 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: pispbe_probe: BatchStatus: 0x00000000 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: pispbe_probe: Status: 0x00000000 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: Register nodes for group 0 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: input device node registered as /dev/video20 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: tdn_input device node registered as /dev/video21 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: stitch_input device node registered as /dev/video22 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: hog_output device node registered as /dev/video23 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: output0 device node registered as /dev/video24 May 05 19:00:39 volumio5-4g systemd[1]: Found device /dev/ttyAMA10. May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: output1 device node registered as /dev/video25 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: tdn_output device node registered as /dev/video26 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: stitch_output device node registered as /dev/video27 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: config device node registered as /dev/video28 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: Register nodes for group 1 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: input device node registered as /dev/video29 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: tdn_input device node registered as /dev/video30 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: stitch_input device node registered as /dev/video31 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: hog_output device node registered as /dev/video32 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: output0 device node registered as /dev/video33 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: output1 device node registered as /dev/video34 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: tdn_output device node registered as /dev/video35 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: stitch_output device node registered as /dev/video36 May 05 19:00:39 volumio5-4g kernel: pispbe 1000880000.pisp_be: config device node registered as /dev/video37 May 05 19:00:39 volumio5-4g kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. May 05 19:00:39 volumio5-4g kernel: rpivid 1000800000.codec: bcm2712_iommu_of_xlate: MMU 1000005100.iommu May 05 19:00:39 volumio5-4g kernel: rpivid 1000800000.codec: Device registered as /dev/video19 May 05 19:00:39 volumio5-4g kernel: brcmstb-i2c 107d508200.i2c: @200000hz registered in interrupt mode May 05 19:00:39 volumio5-4g kernel: brcmstb-i2c 107d508280.i2c: @200000hz registered in interrupt mode May 05 19:00:39 volumio5-4g kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database May 05 19:00:39 volumio5-4g kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' May 05 19:00:39 volumio5-4g kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' May 05 19:00:39 volumio5-4g kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' May 05 19:00:39 volumio5-4g kernel: [drm] Initialized v3d 1.0.0 20180419 for 1002000000.v3d on minor 0 May 05 19:00:39 volumio5-4g systemd[1]: Found device /dev/mmcblk0p1. May 05 19:00:39 volumio5-4g kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 May 05 19:00:39 volumio5-4g kernel: Bluetooth: Core ver 2.22 May 05 19:00:39 volumio5-4g kernel: NET: Registered PF_BLUETOOTH protocol family May 05 19:00:39 volumio5-4g kernel: Bluetooth: HCI device and connection manager initialized May 05 19:00:39 volumio5-4g kernel: Bluetooth: HCI socket layer initialized May 05 19:00:39 volumio5-4g kernel: Bluetooth: L2CAP socket layer initialized May 05 19:00:39 volumio5-4g kernel: Bluetooth: SCO socket layer initialized May 05 19:00:39 volumio5-4g systemd-udevd[256]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 19:00:39 volumio5-4g systemd[1]: Starting File System Check on /dev/mmcblk0p1... May 05 19:00:39 volumio5-4g systemd[1]: Found device /sys/subsystem/net/devices/eth0. May 05 19:00:39 volumio5-4g kernel: Bluetooth: HCI UART driver ver 2.3 May 05 19:00:39 volumio5-4g kernel: Bluetooth: HCI UART protocol H4 registered May 05 19:00:39 volumio5-4g kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered May 05 19:00:39 volumio5-4g kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator May 05 19:00:39 volumio5-4g kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator May 05 19:00:39 volumio5-4g kernel: Bluetooth: HCI UART protocol Broadcom registered May 05 19:00:39 volumio5-4g kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 May 05 19:00:39 volumio5-4g kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 May 05 19:00:39 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 19:00:39 volumio5-4g kernel: usbcore: registered new interface driver brcmfmac May 05 19:00:39 volumio5-4g systemd[1]: Started File System Check Daemon to report status. May 05 19:00:39 volumio5-4g systemd-fsck[388]: fsck.fat 4.1 (2017-01-24) May 05 19:00:39 volumio5-4g systemd-fsck[388]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. May 05 19:00:39 volumio5-4g systemd-fsck[388]: Automatically removing dirty bit. May 05 19:00:39 volumio5-4g systemd-fsck[388]: Performing changes. May 05 19:00:39 volumio5-4g systemd-fsck[388]: /dev/mmcblk0p1: 367 files, 33349/46774 clusters May 05 19:00:39 volumio5-4g systemd-udevd[285]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 19:00:39 volumio5-4g systemd[1]: Started File System Check on /dev/mmcblk0p1. May 05 19:00:39 volumio5-4g systemd[1]: Mounting /boot... May 05 19:00:39 volumio5-4g systemd-udevd[275]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 19:00:39 volumio5-4g systemd[1]: Mounted /boot. May 05 19:00:39 volumio5-4g systemd-udevd[279]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 19:00:39 volumio5-4g systemd-udevd[286]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 05 19:00:39 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 19:00:39 volumio5-4g systemd-udevd[264]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 19:00:39 volumio5-4g systemd-udevd[284]: Using default interface naming scheme 'v240'. May 05 19:00:39 volumio5-4g systemd-udevd[284]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 05 19:00:40 volumio5-4g kernel: vc4-drm axi:gpu: bcm2712_iommu_of_xlate: MMU 1000005200.iommu May 05 19:00:40 volumio5-4g kernel: vc4-drm axi:gpu: bound 107c580000.hvs (ops vc4_hvs_ops [vc4]) May 05 19:00:40 volumio5-4g kernel: Registered IR keymap rc-cec May 05 19:00:40 volumio5-4g kernel: rc rc0: vc4-hdmi-0 as /devices/platform/soc/107c701400.hdmi/rc/rc0 May 05 19:00:40 volumio5-4g kernel: input: vc4-hdmi-0 as /devices/platform/soc/107c701400.hdmi/rc/rc0/input6 May 05 19:00:40 volumio5-4g systemd-udevd[285]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 19:00:40 volumio5-4g kernel: vc4-drm axi:gpu: bound 107c701400.hdmi (ops vc4_hdmi_ops [vc4]) May 05 19:00:40 volumio5-4g kernel: Registered IR keymap rc-cec May 05 19:00:40 volumio5-4g kernel: rc rc1: vc4-hdmi-1 as /devices/platform/soc/107c706400.hdmi/rc/rc1 May 05 19:00:40 volumio5-4g kernel: input: vc4-hdmi-1 as /devices/platform/soc/107c706400.hdmi/rc/rc1/input7 May 05 19:00:40 volumio5-4g kernel: vc4-drm axi:gpu: bound 107c706400.hdmi (ops vc4_hdmi_ops [vc4]) May 05 19:00:40 volumio5-4g kernel: vc4-drm axi:gpu: bound 107c500000.mop (ops vc4_txp_ops [vc4]) May 05 19:00:40 volumio5-4g kernel: vc4-drm axi:gpu: bound 107c501000.moplet (ops vc4_txp_ops [vc4]) May 05 19:00:40 volumio5-4g kernel: vc4-drm axi:gpu: bound 107c410000.pixelvalve (ops vc4_crtc_ops [vc4]) May 05 19:00:40 volumio5-4g kernel: vc4-drm axi:gpu: bound 107c411000.pixelvalve (ops vc4_crtc_ops [vc4]) May 05 19:00:40 volumio5-4g kernel: [drm] Initialized vc4 0.0.0 20140616 for axi:gpu on minor 1 May 05 19:00:40 volumio5-4g kernel: vc4-drm axi:gpu: [drm] Cannot find any crtc or sizes May 05 19:00:40 volumio5-4g kernel: vc4-drm axi:gpu: [drm] Cannot find any crtc or sizes May 05 19:00:40 volumio5-4g kernel: vc4-drm axi:gpu: [drm] Cannot find any crtc or sizes May 05 19:00:40 volumio5-4g kernel: Bluetooth: hci0: BCM: chip id 107 May 05 19:00:40 volumio5-4g kernel: Bluetooth: hci0: BCM: features 0x2f May 05 19:00:40 volumio5-4g kernel: Bluetooth: hci0: BCM4345C0 May 05 19:00:40 volumio5-4g kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 May 05 19:00:40 volumio5-4g kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch May 05 19:00:40 volumio5-4g systemd-udevd[262]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 19:00:40 volumio5-4g systemd-udevd[285]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. May 05 19:00:40 volumio5-4g systemd[1]: Created slice system-bthelper.slice. May 05 19:00:40 volumio5-4g systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. May 05 19:00:40 volumio5-4g systemd[1]: Condition check resulted in FUSE Control File System being skipped. May 05 19:00:40 volumio5-4g systemd[1]: Condition check resulted in Huge Pages File System being skipped. May 05 19:00:40 volumio5-4g systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. May 05 19:00:40 volumio5-4g systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. May 05 19:00:40 volumio5-4g systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. May 05 19:00:40 volumio5-4g systemd[1]: Reached target Local File Systems. May 05 19:00:40 volumio5-4g systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. May 05 19:00:40 volumio5-4g systemd[1]: Starting Create Volatile Files and Directories... May 05 19:00:40 volumio5-4g systemd[1]: Starting Raise network interfaces... May 05 19:00:40 volumio5-4g systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... May 05 19:00:40 volumio5-4g systemd[1]: Starting Preprocess NFS configuration... May 05 19:00:40 volumio5-4g systemd[1]: Started ifup for eth0. May 05 19:00:40 volumio5-4g systemd[1]: Found device /sys/subsystem/net/devices/wlan0. May 05 19:00:40 volumio5-4g systemd[1]: plymouth-read-write.service: Succeeded. May 05 19:00:40 volumio5-4g systemd[1]: Started Tell Plymouth To Write Out Runtime Data. May 05 19:00:40 volumio5-4g systemd[1]: nfs-config.service: Succeeded. May 05 19:00:40 volumio5-4g systemd[1]: Started Preprocess NFS configuration. May 05 19:00:40 volumio5-4g systemd[1]: Received SIGRTMIN+20 from PID 276 (plymouthd). May 05 19:00:40 volumio5-4g systemd[1]: Starting Load/Save RF Kill Switch Status... May 05 19:00:40 volumio5-4g systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. May 05 19:00:40 volumio5-4g systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. May 05 19:00:40 volumio5-4g systemd[1]: Reached target NFS client services. May 05 19:00:40 volumio5-4g systemd[1]: Started ifup for wlan0. May 05 19:00:40 volumio5-4g systemd[1]: Started Create Volatile Files and Directories. May 05 19:00:40 volumio5-4g systemd[1]: Condition check resulted in Network Time Synchronization being skipped. May 05 19:00:40 volumio5-4g systemd[1]: Starting Update UTMP about System Boot/Shutdown... May 05 19:00:40 volumio5-4g systemd[1]: Started Entropy daemon using the HAVEGE algorithm. May 05 19:00:40 volumio5-4g systemd[1]: Starting RPC bind portmap service... May 05 19:00:40 volumio5-4g systemd[1]: Started Load/Save RF Kill Switch Status. May 05 19:00:40 volumio5-4g systemd[1]: Started Update UTMP about System Boot/Shutdown. May 05 19:00:40 volumio5-4g systemd[1]: Reached target System Initialization. May 05 19:00:40 volumio5-4g systemd[1]: Listening on triggerhappy.socket. May 05 19:00:40 volumio5-4g systemd[1]: Started Daily Cleanup of Temporary Directories. May 05 19:00:40 volumio5-4g systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. May 05 19:00:40 volumio5-4g systemd[1]: Listening on D-Bus System Message Bus Socket. May 05 19:00:40 volumio5-4g systemd[1]: Reached target Sockets. May 05 19:00:40 volumio5-4g systemd[1]: Started Daily man-db regeneration. May 05 19:00:40 volumio5-4g systemd[1]: Started Volumio Splash. May 05 19:00:40 volumio5-4g systemd[1]: Reached target Basic System. May 05 19:00:40 volumio5-4g systemd[628]: volumiosplash.service: Failed to execute command: No such file or directory May 05 19:00:40 volumio5-4g systemd[628]: volumiosplash.service: Failed at step EXEC spawning /bin/volumiosplash.sh: No such file or directory May 05 19:00:40 volumio5-4g systemd[1]: Starting Avahi mDNS/DNS-SD Stack... May 05 19:00:40 volumio5-4g systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. May 05 19:00:40 volumio5-4g systemd[1]: Starting Wireless Services... May 05 19:00:40 volumio5-4g systemd[1]: Condition check resulted in Configure Bluetooth Modems connected by UART being skipped. May 05 19:00:40 volumio5-4g systemd[1]: Started Manage Sound Card State (restore and store). May 05 19:00:40 volumio5-4g alsactl[632]: alsactl 1.1.8 daemon started May 05 19:00:40 volumio5-4g systemd[1]: Started UPnP Renderer front-end to MPD. May 05 19:00:40 volumio5-4g systemd[1]: Starting dhcpcd on all interfaces... May 05 19:00:40 volumio5-4g systemd[1]: Starting Login Service... May 05 19:00:40 volumio5-4g systemd[1]: Starting triggerhappy global hotkey daemon... May 05 19:00:40 volumio5-4g systemd[1]: Started Volumio Log Rotation Service. May 05 19:00:40 volumio5-4g systemd[1]: Started volumio-remote-updater.service. May 05 19:00:40 volumio5-4g systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. May 05 19:00:40 volumio5-4g systemd[1]: Starting Raspberry Pi bluetooth helper... May 05 19:00:40 volumio5-4g systemd[1]: Starting Save/Restore Sound Card State... May 05 19:00:40 volumio5-4g kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 05 19:00:40 volumio5-4g dhcpcd[636]: Not running dhcpcd because /etc/network/interfaces May 05 19:00:40 volumio5-4g dhcpcd[636]: defines some interfaces that will use a May 05 19:00:40 volumio5-4g dhcpcd[636]: DHCP client or static address May 05 19:00:40 volumio5-4g systemd[1]: Started Volumio Iptables Module. May 05 19:00:40 volumio5-4g systemd[1]: Started D-Bus System Message Bus. May 05 19:00:40 volumio5-4g systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. May 05 19:00:40 volumio5-4g systemd[1]: Started Daily apt download activities. May 05 19:00:40 volumio5-4g systemd[1]: Started Daily apt upgrade and clean activities. May 05 19:00:40 volumio5-4g systemd[1]: Reached target Timers. May 05 19:00:40 volumio5-4g systemd[1]: Starting WPA supplicant... May 05 19:00:40 volumio5-4g systemd[1]: haveged.service: Main process exited, code=killed, status=11/SEGV May 05 19:00:40 volumio5-4g systemd[1]: haveged.service: Failed with result 'signal'. May 05 19:00:40 volumio5-4g systemd[1]: volumiosplash.service: Main process exited, code=exited, status=203/EXEC May 05 19:00:40 volumio5-4g systemd[1]: volumiosplash.service: Failed with result 'exit-code'. May 05 19:00:40 volumio5-4g systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED May 05 19:00:40 volumio5-4g systemd[1]: dhcpcd.service: Failed with result 'exit-code'. May 05 19:00:40 volumio5-4g systemd[1]: Failed to start dhcpcd on all interfaces. May 05 19:00:40 volumio5-4g thd[641]: Unable to parse trigger line: May 05 19:00:40 volumio5-4g thd[641]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle May 05 19:00:40 volumio5-4g thd[641]: Unable to parse trigger line: May 05 19:00:40 volumio5-4g thd[641]: Found socket passed from systemd May 05 19:00:40 volumio5-4g systemd-logind[639]: New seat seat0. May 05 19:00:40 volumio5-4g systemd-logind[639]: Watching system buttons on /dev/input/event0 (YICHIP 2.4G Receiver) May 05 19:00:40 volumio5-4g systemd-logind[639]: Watching system buttons on /dev/input/event2 (YICHIP 2.4G Receiver System Control) May 05 19:00:40 volumio5-4g systemd-logind[639]: Watching system buttons on /dev/input/event3 (YICHIP 2.4G Receiver Consumer Control) May 05 19:00:40 volumio5-4g systemd-logind[639]: Watching system buttons on /dev/input/event4 (pwr_button) May 05 19:00:40 volumio5-4g systemd-logind[639]: Watching system buttons on /dev/input/event5 (vc4-hdmi-0) May 05 19:00:40 volumio5-4g systemd-logind[639]: Watching system buttons on /dev/input/event6 (vc4-hdmi-1) May 05 19:00:40 volumio5-4g avahi-daemon[630]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). May 05 19:00:40 volumio5-4g avahi-daemon[630]: Successfully dropped root privileges. May 05 19:00:40 volumio5-4g avahi-daemon[630]: avahi-daemon 0.7 starting up. May 05 19:00:40 volumio5-4g kernel: 8021q: 802.1Q VLAN Support v1.8 May 05 19:00:40 volumio5-4g avahi-daemon[630]: Successfully called chroot(). May 05 19:00:40 volumio5-4g avahi-daemon[630]: Successfully dropped remaining capabilities. May 05 19:00:40 volumio5-4g wpa_supplicant[654]: Successfully initialized wpa_supplicant May 05 19:00:40 volumio5-4g avahi-daemon[630]: Loading service file /services/volumio.service. May 05 19:00:40 volumio5-4g kernel: macb 1f00100000.ethernet eth0: PHY [1f00100000.ethernet-ffffffff:01] driver [Broadcom BCM54213PE] (irq=POLL) May 05 19:00:40 volumio5-4g kernel: macb 1f00100000.ethernet eth0: configuring for phy/rgmii-id link mode May 05 19:00:40 volumio5-4g kernel: pps pps0: new PPS source ptp0 May 05 19:00:40 volumio5-4g sh[566]: eth0: waiting for carrier May 05 19:00:40 volumio5-4g dhcpcd[615]: eth0: waiting for carrier May 05 19:00:40 volumio5-4g avahi-daemon[630]: Network interface enumeration completed. May 05 19:00:40 volumio5-4g kernel: macb 1f00100000.ethernet: gem-ptp-timer ptp clock registered. May 05 19:00:40 volumio5-4g avahi-daemon[630]: Server startup complete. Host name is volumio5-4g.local. Local service cookie is 3039878088. May 05 19:00:40 volumio5-4g avahi-daemon[630]: Service "Volumio5-4g" (/services/volumio.service) successfully established. May 05 19:00:40 volumio5-4g systemd[1]: Started RPC bind portmap service. May 05 19:00:40 volumio5-4g systemd[1]: Started triggerhappy global hotkey daemon. May 05 19:00:40 volumio5-4g systemd[1]: Started Save/Restore Sound Card State. May 05 19:00:40 volumio5-4g kernel: Bluetooth: hci0: BCM: features 0x2f May 05 19:00:40 volumio5-4g kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+ May 05 19:00:40 volumio5-4g kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342 May 05 19:00:40 volumio5-4g kernel: Bluetooth: hci0: BCM: Using default device address (43:45:c0:00:1f:ac) May 05 19:00:40 volumio5-4g systemd[1]: Reached target Sound Card. May 05 19:00:40 volumio5-4g dbus-daemon[653]: [system] Successfully activated service 'org.freedesktop.systemd1' May 05 19:00:40 volumio5-4g systemd[1]: Reached target RPC Port Mapper. May 05 19:00:40 volumio5-4g systemd[1]: Reached target Remote File Systems (Pre). May 05 19:00:40 volumio5-4g systemd[1]: Reached target Remote File Systems. May 05 19:00:40 volumio5-4g sh[585]: wlan0=wlan0 May 05 19:00:40 volumio5-4g systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... May 05 19:00:40 volumio5-4g systemd[1]: Started WPA supplicant. May 05 19:00:40 volumio5-4g systemd[1]: Started Avahi mDNS/DNS-SD Stack. May 05 19:00:40 volumio5-4g systemd[1]: Started Login Service. May 05 19:00:40 volumio5-4g bthelper[646]: Raspberry Pi BDADDR already set May 05 19:00:40 volumio5-4g systemd[1]: Started Raspberry Pi bluetooth helper. May 05 19:00:40 volumio5-4g systemd[1]: Starting Bluetooth service... May 05 19:00:40 volumio5-4g systemd[1]: Started Raise network interfaces. May 05 19:00:40 volumio5-4g systemd[1]: Reached target Network. May 05 19:00:40 volumio5-4g volumio-remote-updater[645]: Error: No active session May 05 19:00:40 volumio5-4g volumio-remote-updater[645]: [2024-05-05 19:00:40] [info] asio async_connect error: system:111 (Connection refused) May 05 19:00:40 volumio5-4g volumio-remote-updater[645]: [2024-05-05 19:00:40] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 05 19:00:40 volumio5-4g volumio-remote-updater[645]: [2024-05-05 19:00:40] [error] handle_connect error: Underlying Transport Error May 05 19:00:40 volumio5-4g systemd[1]: Starting OpenBSD Secure Shell server... May 05 19:00:40 volumio5-4g systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. May 05 19:00:40 volumio5-4g systemd[1]: Starting Network Time Service... May 05 19:00:40 volumio5-4g systemd[1]: Reached target Network is Online. May 05 19:00:40 volumio5-4g systemd[1]: Starting LSB: Brings up/down network automatically... May 05 19:00:40 volumio5-4g systemd[1]: Starting Samba NMB Daemon... May 05 19:00:40 volumio5-4g systemd[1]: Starting /etc/rc.local Compatibility... May 05 19:00:40 volumio5-4g systemd[1]: Starting Permit User Sessions... May 05 19:00:40 volumio5-4g systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 05 19:00:40 volumio5-4g volumio[635]: Could not open config: /tmp/upmpdcli.conf May 05 19:00:40 volumio5-4g systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE May 05 19:00:40 volumio5-4g systemd[1]: upmpdcli.service: Failed with result 'exit-code'. May 05 19:00:40 volumio5-4g systemd[1]: Started /etc/rc.local Compatibility. May 05 19:00:40 volumio5-4g systemd[1]: Started Permit User Sessions. May 05 19:00:41 volumio5-4g systemd[1]: Starting Hold until boot process finishes up... May 05 19:00:41 volumio5-4g systemd[1]: Starting Terminate Plymouth Boot Screen... May 05 19:00:41 volumio5-4g systemd[1]: iptables.service: Succeeded. May 05 19:00:41 volumio5-4g loadcpufreq[710]: Loading cpufreq kernel modules...error: unexpectedly disconnected from boot status daemon May 05 19:00:41 volumio5-4g systemd[1]: plymouth-start.service: Succeeded. May 05 19:00:41 volumio5-4g systemd[1]: plymouth-quit-wait.service: Succeeded. May 05 19:00:41 volumio5-4g systemd[1]: Started Hold until boot process finishes up. May 05 19:00:41 volumio5-4g systemd[1]: plymouth-quit.service: Succeeded. May 05 19:00:41 volumio5-4g systemd[1]: Started Terminate Plymouth Boot Screen. May 05 19:00:41 volumio5-4g systemd[1]: Received SIGRTMIN+21 from PID 276 (n/a). May 05 19:00:41 volumio5-4g bluetoothd[745]: Bluetooth daemon 5.50 May 05 19:00:41 volumio5-4g bluetoothd[745]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf May 05 19:00:41 volumio5-4g systemd[1]: Started Serial Getty on ttyAMA10. May 05 19:00:41 volumio5-4g systemd[1]: Reached target Login Prompts. May 05 19:00:41 volumio5-4g systemd[1]: Started Bluetooth service. May 05 19:00:41 volumio5-4g systemd[1]: Reached target Bluetooth. May 05 19:00:41 volumio5-4g ifplugd(eth0)[801]: ifplugd 0.28 initializing. May 05 19:00:41 volumio5-4g ifplugd(eth0)[801]: Using interface eth0/D8:3A:DD:C1:9B:08 with driver (version: 6.1.69-v8+) May 05 19:00:41 volumio5-4g ifplugd(eth0)[801]: Using detection mode: SIOCETHTOOL May 05 19:00:41 volumio5-4g bluetoothd[745]: Starting SDP server May 05 19:00:41 volumio5-4g ifplugd(eth0)[801]: Initialization complete, link beat not detected. May 05 19:00:41 volumio5-4g bluetoothd[745]: Excluding (cli) sap May 05 19:00:41 volumio5-4g ntpd[754]: ntpd 4.2.8p12@1.3728-o (1): Starting May 05 19:00:41 volumio5-4g ntpd[754]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 May 05 19:00:41 volumio5-4g systemd[1]: Started Network Time Service. May 05 19:00:41 volumio5-4g ntpd[810]: proto: precision = 1.296 usec (-19) May 05 19:00:41 volumio5-4g loadcpufreq[710]: done (none). May 05 19:00:41 volumio5-4g systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. May 05 19:00:41 volumio5-4g ntpd[810]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 05 19:00:41 volumio5-4g systemd[1]: Starting LSB: set CPUFreq kernel parameters... May 05 19:00:41 volumio5-4g ntpd[810]: 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 19:00:41 volumio5-4g ntpd[810]: Listen and drop on 0 v6wildcard [::]:123 May 05 19:00:41 volumio5-4g ntpd[810]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 05 19:00:41 volumio5-4g ntpd[810]: Listen normally on 2 lo 127.0.0.1:123 May 05 19:00:41 volumio5-4g ntpd[810]: Listening on routing socket on fd #19 for interface updates May 05 19:00:41 volumio5-4g ntpd[810]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 05 19:00:41 volumio5-4g ntpd[810]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 05 19:00:41 volumio5-4g dbus-daemon[653]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=745 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") May 05 19:00:41 volumio5-4g bluetoothd[745]: Bluetooth management interface 1.22 initialized May 05 19:00:41 volumio5-4g kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 May 05 19:00:41 volumio5-4g kernel: Bluetooth: BNEP filters: protocol multicast May 05 19:00:41 volumio5-4g kernel: Bluetooth: BNEP socket layer initialized May 05 19:00:41 volumio5-4g kernel: Bluetooth: MGMT ver 1.22 May 05 19:00:41 volumio5-4g ifplugd[755]: Network Interface Plugging Daemon...start eth0...done. May 05 19:00:41 volumio5-4g sshd[826]: Server listening on 0.0.0.0 port 22. May 05 19:00:41 volumio5-4g sshd[826]: Server listening on :: port 22. May 05 19:00:41 volumio5-4g cpufrequtils[816]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. May 05 19:00:41 volumio5-4g systemd[1]: Started OpenBSD Secure Shell server. May 05 19:00:41 volumio5-4g systemd[1]: Started LSB: Brings up/down network automatically. May 05 19:00:41 volumio5-4g systemd[1]: Started LSB: set CPUFreq kernel parameters. May 05 19:00:41 volumio5-4g systemd[1]: Starting Hostname Service... May 05 19:00:41 volumio5-4g bluetoothd[745]: Failed to set privacy: Rejected (0x0b) May 05 19:00:41 volumio5-4g dbus-daemon[653]: [system] Successfully activated service 'org.freedesktop.hostname1' May 05 19:00:41 volumio5-4g systemd[1]: Started Hostname Service. May 05 19:00:41 volumio5-4g nmbd[761]: [2024/05/05 19:00:41.420314, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) May 05 19:00:41 volumio5-4g nmbd[761]: started asyncdns process 838 May 05 19:00:41 volumio5-4g nmbd[761]: [2024/05/05 19:00:41.421911, 0] ../lib/util/become_daemon.c:149(daemon_status) May 05 19:00:41 volumio5-4g nmbd[761]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... May 05 19:00:41 volumio5-4g nmbd[761]: [2024/05/05 19:00:41.422158, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) May 05 19:00:41 volumio5-4g nmbd[761]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). May 05 19:00:41 volumio5-4g wireless.js[631]: Cleaning previous... May 05 19:00:41 volumio5-4g sudo[846]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 05 19:00:41 volumio5-4g sudo[846]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:41 volumio5-4g sudo[846]: pam_unix(sudo:session): session closed for user root May 05 19:00:41 volumio5-4g sudo[848]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 05 19:00:41 volumio5-4g sudo[848]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:42 volumio5-4g sudo[848]: pam_unix(sudo:session): session closed for user root May 05 19:00:42 volumio5-4g ntpd[810]: error resolving pool 0.debian.pool.ntp.org: System error (-11) May 05 19:00:42 volumio5-4g wireless.js[631]: Stopped aP May 05 19:00:42 volumio5-4g sudo[855]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 05 19:00:42 volumio5-4g sudo[855]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:42 volumio5-4g sudo[855]: pam_unix(sudo:session): session closed for user root May 05 19:00:42 volumio5-4g kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 05 19:00:42 volumio5-4g sudo[857]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get May 05 19:00:42 volumio5-4g sudo[857]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:42 volumio5-4g sudo[857]: pam_unix(sudo:session): session closed for user root May 05 19:00:42 volumio5-4g sudo[864]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 05 19:00:42 volumio5-4g sudo[864]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:42 volumio5-4g sudo[864]: pam_unix(sudo:session): session closed for user root May 05 19:00:42 volumio5-4g sudo[866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan May 05 19:00:42 volumio5-4g sudo[866]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:43 volumio5-4g ntpd[810]: error resolving pool 1.debian.pool.ntp.org: System error (-11) May 05 19:00:43 volumio5-4g sudo[866]: pam_unix(sudo:session): session closed for user root May 05 19:00:43 volumio5-4g wireless.js[631]: SETTING APPROPRIATE REG DOMAIN: CN May 05 19:00:43 volumio5-4g sudo[871]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 05 19:00:43 volumio5-4g sudo[871]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:43 volumio5-4g sudo[871]: pam_unix(sudo:session): session closed for user root May 05 19:00:43 volumio5-4g sudo[873]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set CN May 05 19:00:43 volumio5-4g sudo[873]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:43 volumio5-4g sudo[873]: pam_unix(sudo:session): session closed for user root May 05 19:00:43 volumio5-4g wireless.js[631]: SUCCESSFULLY SET NEW REGDOMAIN: CN May 05 19:00:43 volumio5-4g wireless.js[631]: Start wireless flow May 05 19:00:43 volumio5-4g wireless.js[631]: Stopped hotspot (if there).. May 05 19:00:43 volumio5-4g sudo[878]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 05 19:00:43 volumio5-4g sudo[878]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:43 volumio5-4g sudo[878]: pam_unix(sudo:session): session closed for user root May 05 19:00:43 volumio5-4g sudo[880]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 05 19:00:43 volumio5-4g sudo[880]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:43 volumio5-4g sudo[880]: pam_unix(sudo:session): session closed for user root May 05 19:00:43 volumio5-4g wireless.js[631]: DHCP IP May 05 19:00:43 volumio5-4g wireless.js[631]: Start ap May 05 19:00:43 volumio5-4g wpa_supplicant[882]: Successfully initialized wpa_supplicant May 05 19:00:43 volumio5-4g wpa_supplicant[882]: Line 4: too long ssid (len=43 max_len=32) May 05 19:00:43 volumio5-4g wpa_supplicant[882]: Line 4: failed to parse ssid '"HUAWEI-\xE5\x91\xA8\xE9\x9F\xB3wifi6_Wi-Fi5"'. May 05 19:00:43 volumio5-4g wpa_supplicant[882]: Line 7: failed to parse network block. May 05 19:00:43 volumio5-4g wpa_supplicant[882]: Failed to read or parse configuration '/etc/wpa_supplicant/wpa_supplicant.conf'. May 05 19:00:43 volumio5-4g sudo[883]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd May 05 19:00:43 volumio5-4g sudo[883]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:43 volumio5-4g dhcpcd[884]: dev: loaded udev May 05 19:00:43 volumio5-4g dhcpcd-run-hooks[902]: wlan0: starting wpa_supplicant May 05 19:00:43 volumio5-4g dhcpcd-run-hooks[904]: wlan0: failed to start wpa_supplicant May 05 19:00:43 volumio5-4g dhcpcd-run-hooks[905]: wlan0: Successfully initialized wpa_supplicant Line 4: too long ssid (len=43 max_len=32) Line 4: failed to parse ssid '"HUAWEI-\xE5\x91\xA8\xE9\x9F\xB3wifi6_Wi-Fi5"'. Line 7: failed to parse network block. Failed to read or parse configuration '/etc/wpa_supplicant/wpa_supplicant.conf'. May 05 19:00:43 volumio5-4g dhcpcd[884]: wlan0: connected to Access Point `' May 05 19:00:43 volumio5-4g dhcpcd[884]: no interfaces have a carrier May 05 19:00:43 volumio5-4g dhcpcd[884]: forked to background, child pid 915 May 05 19:00:43 volumio5-4g dhcpcd[915]: eth0: waiting for carrier May 05 19:00:43 volumio5-4g sudo[883]: pam_unix(sudo:session): session closed for user root May 05 19:00:43 volumio5-4g dhcpcd[915]: wlan0: waiting for carrier May 05 19:00:43 volumio5-4g kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 05 19:00:43 volumio5-4g dhcpcd[915]: eth0: carrier acquired May 05 19:00:43 volumio5-4g dhcpcd[615]: eth0: carrier acquired May 05 19:00:43 volumio5-4g sh[566]: eth0: carrier acquired May 05 19:00:43 volumio5-4g kernel: macb 1f00100000.ethernet eth0: Link is Up - 1Gbps/Full - flow control tx May 05 19:00:43 volumio5-4g sh[566]: DUID 00:01:00:01:2d:c5:98:d9:2c:cf:67:12:d2:83 May 05 19:00:43 volumio5-4g sh[566]: eth0: IAID dd:c1:9b:08 May 05 19:00:43 volumio5-4g dhcpcd[915]: DUID 00:01:00:01:2d:c5:98:d9:2c:cf:67:12:d2:83 May 05 19:00:43 volumio5-4g dhcpcd[615]: DUID 00:01:00:01:2d:c5:98:d9:2c:cf:67:12:d2:83 May 05 19:00:43 volumio5-4g dhcpcd[915]: eth0: IAID dd:c1:9b:08 May 05 19:00:43 volumio5-4g dhcpcd[615]: eth0: IAID dd:c1:9b:08 May 05 19:00:43 volumio5-4g sh[566]: eth0: adding address fe80::b53b:5f66:50eb:adb7 May 05 19:00:43 volumio5-4g sh[566]: ipv6_addaddr1: Permission denied May 05 19:00:43 volumio5-4g dhcpcd[615]: eth0: adding address fe80::b53b:5f66:50eb:adb7 May 05 19:00:43 volumio5-4g dhcpcd[915]: eth0: adding address fe80::b53b:5f66:50eb:adb7 May 05 19:00:43 volumio5-4g dhcpcd[615]: ipv6_addaddr1: Permission denied May 05 19:00:43 volumio5-4g dhcpcd[915]: ipv6_addaddr1: Permission denied May 05 19:00:44 volumio5-4g ntpd[810]: error resolving pool 2.debian.pool.ntp.org: System error (-11) May 05 19:00:44 volumio5-4g sh[566]: eth0: soliciting an IPv6 router May 05 19:00:44 volumio5-4g dhcpcd[615]: eth0: soliciting an IPv6 router May 05 19:00:44 volumio5-4g dhcpcd[915]: eth0: rebinding lease of 192.168.3.43 May 05 19:00:44 volumio5-4g dhcpcd[915]: eth0: soliciting an IPv6 router May 05 19:00:44 volumio5-4g sh[566]: eth0: rebinding lease of 192.168.3.43 May 05 19:00:44 volumio5-4g dhcpcd[615]: eth0: rebinding lease of 192.168.3.43 May 05 19:00:44 volumio5-4g ifplugd(eth0)[801]: Link beat detected. May 05 19:00:44 volumio5-4g wireless.js[631]: trying... May 05 19:00:44 volumio5-4g sudo[919]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:00:44 volumio5-4g sudo[919]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:44 volumio5-4g sudo[919]: pam_unix(sudo:session): session closed for user root May 05 19:00:44 volumio5-4g ifplugd(eth0)[801]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. May 05 19:00:44 volumio5-4g ifplugd(eth0)[801]: client: ifup: waiting for lock on /run/network/ifstate.eth0 May 05 19:00:45 volumio5-4g ntpd[810]: error resolving pool 3.debian.pool.ntp.org: System error (-11) May 05 19:00:45 volumio5-4g systemd[1]: systemd-rfkill.service: Succeeded. May 05 19:00:45 volumio5-4g wireless.js[631]: trying... May 05 19:00:45 volumio5-4g sudo[927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:00:45 volumio5-4g sudo[927]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:45 volumio5-4g sudo[927]: pam_unix(sudo:session): session closed for user root May 05 19:00:45 volumio5-4g bthelper[646]: Changing power off succeeded May 05 19:00:45 volumio5-4g volumio-remote-updater[645]: [2024-05-05 19:00:45] [info] asio async_connect error: system:111 (Connection refused) May 05 19:00:45 volumio5-4g volumio-remote-updater[645]: [2024-05-05 19:00:45] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 05 19:00:45 volumio5-4g volumio-remote-updater[645]: [2024-05-05 19:00:45] [error] handle_connect error: Underlying Transport Error May 05 19:00:46 volumio5-4g bthelper[646]: [CHG] Controller D8:3A:DD:C1:9B:0B Class: 0x0000041c May 05 19:00:46 volumio5-4g bthelper[646]: Changing power on succeeded May 05 19:00:46 volumio5-4g wireless.js[631]: trying... May 05 19:00:46 volumio5-4g sudo[931]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:00:46 volumio5-4g sudo[931]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:46 volumio5-4g sudo[931]: pam_unix(sudo:session): session closed for user root May 05 19:00:47 volumio5-4g wireless.js[631]: trying... May 05 19:00:47 volumio5-4g sudo[934]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:00:47 volumio5-4g sudo[934]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:47 volumio5-4g sudo[934]: pam_unix(sudo:session): session closed for user root May 05 19:00:48 volumio5-4g dhcpcd[915]: eth0: probing address 192.168.3.43/24 May 05 19:00:48 volumio5-4g wireless.js[631]: trying... May 05 19:00:48 volumio5-4g sudo[937]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:00:48 volumio5-4g sudo[937]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:48 volumio5-4g sudo[937]: pam_unix(sudo:session): session closed for user root May 05 19:00:49 volumio5-4g sh[566]: eth0: probing address 192.168.3.43/24 May 05 19:00:49 volumio5-4g dhcpcd[615]: eth0: probing address 192.168.3.43/24 May 05 19:00:49 volumio5-4g wireless.js[631]: trying... May 05 19:00:49 volumio5-4g sudo[940]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:00:49 volumio5-4g sudo[940]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:49 volumio5-4g sudo[940]: pam_unix(sudo:session): session closed for user root May 05 19:00:50 volumio5-4g wireless.js[631]: trying... May 05 19:00:50 volumio5-4g sudo[943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:00:50 volumio5-4g sudo[943]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:50 volumio5-4g sudo[943]: pam_unix(sudo:session): session closed for user root May 05 19:00:51 volumio5-4g wireless.js[631]: trying... May 05 19:00:51 volumio5-4g sudo[946]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:00:51 volumio5-4g sudo[946]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:51 volumio5-4g sudo[946]: pam_unix(sudo:session): session closed for user root May 05 19:00:52 volumio5-4g wireless.js[631]: trying... May 05 19:00:52 volumio5-4g sudo[949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:00:52 volumio5-4g sudo[949]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:52 volumio5-4g sudo[949]: pam_unix(sudo:session): session closed for user root May 05 19:00:53 volumio5-4g volumio-remote-updater[645]: [2024-05-05 19:00:53] [info] asio async_connect error: system:111 (Connection refused) May 05 19:00:53 volumio5-4g volumio-remote-updater[645]: [2024-05-05 19:00:53] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 05 19:00:53 volumio5-4g volumio-remote-updater[645]: [2024-05-05 19:00:53] [error] handle_connect error: Underlying Transport Error May 05 19:00:53 volumio5-4g wireless.js[631]: trying... May 05 19:00:53 volumio5-4g sudo[952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:00:53 volumio5-4g sudo[952]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:53 volumio5-4g sudo[952]: pam_unix(sudo:session): session closed for user root May 05 19:00:53 volumio5-4g dhcpcd[915]: eth0: leased 192.168.3.43 for 86400 seconds May 05 19:00:53 volumio5-4g dhcpcd[915]: eth0: adding route to 192.168.3.0/24 May 05 19:00:53 volumio5-4g avahi-daemon[630]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.3.43. May 05 19:00:53 volumio5-4g dhcpcd[915]: eth0: adding default route via 192.168.3.1 May 05 19:00:53 volumio5-4g avahi-daemon[630]: New relevant interface eth0.IPv4 for mDNS. May 05 19:00:53 volumio5-4g avahi-daemon[630]: Registering new address record for 192.168.3.43 on eth0.IPv4. May 05 19:00:54 volumio5-4g sh[566]: eth0: leased 192.168.3.43 for 86400 seconds May 05 19:00:54 volumio5-4g sh[566]: eth0: adding route to 192.168.3.0/24 May 05 19:00:54 volumio5-4g sh[566]: eth0: adding default route via 192.168.3.1 May 05 19:00:54 volumio5-4g sh[566]: eth0: dhcp_envoption 213: Operation not supported May 05 19:00:54 volumio5-4g dhcpcd[615]: eth0: leased 192.168.3.43 for 86400 seconds May 05 19:00:54 volumio5-4g dhcpcd[615]: eth0: adding route to 192.168.3.0/24 May 05 19:00:54 volumio5-4g dhcpcd[615]: eth0: adding default route via 192.168.3.1 May 05 19:00:54 volumio5-4g dhcpcd[615]: eth0: dhcp_envoption 213: Operation not supported May 05 19:00:54 volumio5-4g sh[566]: forked to background, child pid 994 May 05 19:00:54 volumio5-4g dhcpcd[615]: forked to background, child pid 994 May 05 19:00:54 volumio5-4g ifplugd(eth0)[801]: client: ifup: interface eth0 already configured May 05 19:00:54 volumio5-4g sh[566]: eth0=eth0 May 05 19:00:54 volumio5-4g ifplugd(eth0)[801]: Program executed successfully. May 05 19:00:54 volumio5-4g wireless.js[631]: trying... May 05 19:00:54 volumio5-4g sudo[1021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:00:54 volumio5-4g sudo[1021]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:54 volumio5-4g sudo[1021]: pam_unix(sudo:session): session closed for user root May 05 19:00:55 volumio5-4g wireless.js[631]: trying... May 05 19:00:55 volumio5-4g sudo[1024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:00:55 volumio5-4g sudo[1024]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:55 volumio5-4g sudo[1024]: pam_unix(sudo:session): session closed for user root May 05 19:00:56 volumio5-4g ntpd[810]: Listen normally on 3 eth0 192.168.3.43:123 May 05 19:00:56 volumio5-4g ntpd[810]: new interface(s) found: waking up resolver May 05 19:00:56 volumio5-4g nmbd[761]: [2024/05/05 19:00:56.424324, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 05 19:00:56 volumio5-4g nmbd[761]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections May 05 19:00:56 volumio5-4g systemd[1]: Started Samba NMB Daemon. May 05 19:00:56 volumio5-4g systemd[1]: Starting Samba Winbind Daemon... May 05 19:00:56 volumio5-4g winbindd[1026]: [2024/05/05 19:00:56.539160, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) May 05 19:00:56 volumio5-4g winbindd[1026]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 May 05 19:00:56 volumio5-4g winbindd[1026]: [2024/05/05 19:00:56.553967, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 05 19:00:56 volumio5-4g winbindd[1026]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections May 05 19:00:56 volumio5-4g systemd[1]: Started Samba Winbind Daemon. May 05 19:00:56 volumio5-4g systemd[1]: Starting Samba SMB Daemon... May 05 19:00:56 volumio5-4g winbindd[1026]: [2024/05/05 19:00:56.700207, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) May 05 19:00:56 volumio5-4g winbindd[1026]: res_names->count = 3, expected 4 May 05 19:00:56 volumio5-4g wireless.js[631]: trying... May 05 19:00:56 volumio5-4g sudo[1038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:00:56 volumio5-4g smbd[1031]: [2024/05/05 19:00:56.712033, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 05 19:00:56 volumio5-4g systemd[1]: Started Samba SMB Daemon. May 05 19:00:56 volumio5-4g smbd[1031]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections May 05 19:00:56 volumio5-4g sudo[1038]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:56 volumio5-4g sudo[1038]: pam_unix(sudo:session): session closed for user root May 05 19:00:57 volumio5-4g wireless.js[631]: trying... May 05 19:00:57 volumio5-4g sudo[1043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:00:57 volumio5-4g sudo[1043]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:57 volumio5-4g sudo[1043]: pam_unix(sudo:session): session closed for user root May 05 19:00:58 volumio5-4g wireless.js[631]: trying... May 05 19:00:58 volumio5-4g sudo[1046]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:00:58 volumio5-4g sudo[1046]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:58 volumio5-4g sudo[1046]: pam_unix(sudo:session): session closed for user root May 05 19:00:59 volumio5-4g wireless.js[631]: trying... May 05 19:00:59 volumio5-4g sudo[1049]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:00:59 volumio5-4g sudo[1049]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:00:59 volumio5-4g sudo[1049]: pam_unix(sudo:session): session closed for user root May 05 19:01:00 volumio5-4g wireless.js[631]: trying... May 05 19:01:00 volumio5-4g sudo[1052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:01:00 volumio5-4g sudo[1052]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:01:00 volumio5-4g sudo[1052]: pam_unix(sudo:session): session closed for user root May 05 19:01:01 volumio5-4g wireless.js[631]: trying... May 05 19:01:01 volumio5-4g sudo[1055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:01:01 volumio5-4g sudo[1055]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:01:01 volumio5-4g sudo[1055]: pam_unix(sudo:session): session closed for user root May 05 19:01:02 volumio5-4g wireless.js[631]: trying... May 05 19:01:02 volumio5-4g sudo[1058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:01:02 volumio5-4g sudo[1058]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:01:02 volumio5-4g sudo[1058]: pam_unix(sudo:session): session closed for user root May 05 19:01:03 volumio5-4g volumio-remote-updater[645]: [2024-05-05 19:01:03] [info] asio async_connect error: system:111 (Connection refused) May 05 19:01:03 volumio5-4g volumio-remote-updater[645]: [2024-05-05 19:01:03] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 05 19:01:03 volumio5-4g volumio-remote-updater[645]: [2024-05-05 19:01:03] [error] handle_connect error: Underlying Transport Error May 05 19:01:03 volumio5-4g wireless.js[631]: trying... May 05 19:01:03 volumio5-4g sudo[1061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 05 19:01:03 volumio5-4g sudo[1061]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:01:03 volumio5-4g sudo[1061]: pam_unix(sudo:session): session closed for user root May 05 19:01:04 volumio5-4g wireless.js[631]: Overtime, starting plan B May 05 19:01:04 volumio5-4g kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 05 19:01:04 volumio5-4g systemd[1]: Started Wireless Services. May 05 19:01:04 volumio5-4g systemd[1]: Started Volumio Backend Module. May 05 19:01:04 volumio5-4g systemd[1]: Started Volumio Cpu Tweaker. May 05 19:01:04 volumio5-4g systemd[1]: Reached target Multi-User System. May 05 19:01:04 volumio5-4g systemd[1]: Reached target Graphical Interface. May 05 19:01:04 volumio5-4g systemd[1]: Starting Update UTMP about System Runlevel Changes... May 05 19:01:04 volumio5-4g systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 05 19:01:04 volumio5-4g systemd[1]: Started Update UTMP about System Runlevel Changes. May 05 19:01:04 volumio5-4g systemd[1]: Startup finished in 6.408s (kernel) + 26.315s (userspace) = 32.724s. May 05 19:01:04 volumio5-4g volumio-cpu-tweak[1067]: Setting RT Priority for mpd May 05 19:01:04 volumio5-4g volumio-cpu-tweak[1067]: pid 35's current scheduling policy: SCHED_OTHER May 05 19:01:04 volumio5-4g volumio-cpu-tweak[1067]: pid 35's current scheduling priority: 0 May 05 19:01:04 volumio5-4g volumio-cpu-tweak[1067]: Setting MPD Affinity May 05 19:01:04 volumio5-4g volumio-cpu-tweak[1067]: pid 3's current affinity mask: f May 05 19:01:04 volumio5-4g volumio-cpu-tweak[1067]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input May 05 19:01:04 volumio5-4g volumio-cpu-tweak[1067]: VOLUMIO CPU TWEAK: Setting CPU Governor: conservative May 05 19:01:04 volumio5-4g systemd[1]: volumio_cpu_tweak.service: Succeeded. May 05 19:01:05 volumio5-4g volumio[1066]: info: ------------------------------------------- May 05 19:01:05 volumio5-4g volumio[1066]: info: ----- Volumio3 ---- May 05 19:01:05 volumio5-4g volumio[1066]: info: ------------------------------------------- May 05 19:01:05 volumio5-4g volumio[1066]: info: ----- System startup ---- May 05 19:01:05 volumio5-4g volumio[1066]: info: ------------------------------------------- May 05 19:01:05 volumio5-4g volumio[1066]: info: MYVOLUMIO Environment detected May 05 19:01:05 volumio5-4g volumio[1066]: info: Plugin folders cleanup May 05 19:01:05 volumio5-4g volumio[1066]: info: Scanning into folder /volumio/app/plugins/ May 05 19:01:05 volumio5-4g volumio[1066]: info: Scanning category audio_interface May 05 19:01:05 volumio5-4g volumio[1066]: info: Scanning category miscellanea May 05 19:01:05 volumio5-4g volumio[1066]: info: Scanning category music_service May 05 19:01:05 volumio5-4g volumio[1066]: info: Scanning category plugins.json May 05 19:01:05 volumio5-4g volumio[1066]: info: Scanning category system_controller May 05 19:01:05 volumio5-4g volumio[1066]: info: Scanning category user_interface May 05 19:01:05 volumio5-4g volumio[1066]: info: Scanning into folder /data/plugins/ May 05 19:01:05 volumio5-4g volumio[1066]: info: Scanning category music_service May 05 19:01:05 volumio5-4g volumio[1066]: info: Scanning category system_controller May 05 19:01:05 volumio5-4g volumio[1066]: info: Scanning category user_interface May 05 19:01:05 volumio5-4g volumio[1066]: info: Plugin folders cleanup completed May 05 19:01:05 volumio5-4g volumio[1066]: info: ------------------------------------------- May 05 19:01:05 volumio5-4g volumio[1066]: info: ----- Core plugins startup ---- May 05 19:01:05 volumio5-4g volumio[1066]: info: ------------------------------------------- May 05 19:01:05 volumio5-4g volumio[1066]: info: Loading plugins from folder /volumio/app/plugins/ May 05 19:01:05 volumio5-4g volumio[1066]: info: Adding plugin upnp to MyMusic Plugins May 05 19:01:05 volumio5-4g volumio[1066]: info: Adding plugin airplay_emulation to MyMusic Plugins May 05 19:01:05 volumio5-4g volumio[1066]: info: Adding plugin upnp_browser to MyMusic Plugins May 05 19:01:05 volumio5-4g volumio[1066]: info: Loading plugins from folder /data/plugins/ May 05 19:01:05 volumio5-4g volumio[1066]: info: Loading plugin "system"... May 05 19:01:05 volumio5-4g volumio[1066]: info: Loading plugin "appearance"... May 05 19:01:06 volumio5-4g volumio[1066]: info: Loading plugin "network"... May 05 19:01:06 volumio5-4g volumio[1066]: info: Refreshing Cached IP Addresses May 05 19:01:06 volumio5-4g sudo[1098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 05 19:01:06 volumio5-4g sudo[1098]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:01:06 volumio5-4g volumio[1066]: info: Loading plugin "services"... May 05 19:01:06 volumio5-4g sudo[1100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 05 19:01:06 volumio5-4g sudo[1100]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:01:06 volumio5-4g sudo[1098]: pam_unix(sudo:session): session closed for user root May 05 19:01:06 volumio5-4g volumio[1066]: info: Loading plugin "alsa_controller"... May 05 19:01:06 volumio5-4g sudo[1100]: pam_unix(sudo:session): session closed for user root May 05 19:01:06 volumio5-4g sudo[1102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 05 19:01:06 volumio5-4g sudo[1102]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:01:06 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 05 19:01:06 volumio5-4g volumio[1066]: info: Loading plugin "wizard"... May 05 19:01:06 volumio5-4g volumio[1066]: info: Loading plugin "networkfs"... May 05 19:01:06 volumio5-4g volumio[1066]: info: Starting Udev Watcher for removable devices May 05 19:01:06 volumio5-4g sudo[1109]: 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 19:01:06 volumio5-4g sudo[1109]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:01:06 volumio5-4g volumio[1066]: info: Mounting Device 626B-EC13 May 05 19:01:06 volumio5-4g sudo[1120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/626B-EC13 -o noatime May 05 19:01:06 volumio5-4g sudo[1120]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:01:06 volumio5-4g kernel: Key type cifs.spnego registered May 05 19:01:06 volumio5-4g kernel: Key type cifs.idmap registered May 05 19:01:06 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 19:01:06 volumio5-4g kernel: CIFS: Attempting to mount \\127.0.0.1\Internal Storage May 05 19:01:06 volumio5-4g sudo[1109]: pam_unix(sudo:session): session closed for user root May 05 19:01:06 volumio5-4g mount.exfat[1142]: volume was not unmounted cleanly May 05 19:01:06 volumio5-4g kernel: fuse: init (API version 7.37) May 05 19:01:06 volumio5-4g sudo[1120]: pam_unix(sudo:session): session closed for user root May 05 19:01:06 volumio5-4g volumio[1066]: WARN: volume was not unmounted cleanly. May 05 19:01:06 volumio5-4g volumio[1066]: info: Ignoring mount for partition: boot May 05 19:01:06 volumio5-4g volumio[1066]: info: Ignoring mount for partition: volumio May 05 19:01:06 volumio5-4g volumio[1066]: info: Ignoring mount for partition: volumio_data May 05 19:01:06 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 05 19:01:06 volumio5-4g volumio[1066]: info: Loading plugin "volumio_command_line_client"... May 05 19:01:06 volumio5-4g volumio[1066]: info: Loading plugin "upnp"... May 05 19:01:06 volumio5-4g volumio[1066]: info: [1714906866697] Starting Upmpd Daemon May 05 19:01:06 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 05 19:01:06 volumio5-4g volumio[1066]: info: Loading plugin "my_music"... May 05 19:01:06 volumio5-4g volumio[1066]: info: Loading plugin "mpd"... May 05 19:01:06 volumio5-4g systemd[1]: Mounting FUSE Control File System... May 05 19:01:06 volumio5-4g systemd[1]: Mounted FUSE Control File System. May 05 19:01:06 volumio5-4g volumio[1066]: info: Plugin upnp_browser is not enabled May 05 19:01:06 volumio5-4g volumio[1066]: info: Loading plugin "alarm-clock"... May 05 19:01:06 volumio5-4g volumio[1066]: info: Loading plugin "airplay_emulation"... May 05 19:01:06 volumio5-4g volumio[1066]: info: Starting Shairport Sync May 05 19:01:06 volumio5-4g volumio[1066]: info: Loading plugin "last_100"... May 05 19:01:06 volumio5-4g volumio[1066]: info: Loading plugin "webradio"... May 05 19:01:06 volumio5-4g volumio[1066]: info: Loading plugin "i2s_dacs"... May 05 19:01:06 volumio5-4g volumio[1066]: info: Loading plugin "volumiodiscovery"... May 05 19:01:06 volumio5-4g volumio[1066]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 05 19:01:06 volumio5-4g node[1066]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 05 19:01:06 volumio5-4g node[1066]: *** WARNING *** Please fix your application to use the native API of Avahi! May 05 19:01:06 volumio5-4g volumio[1066]: *** WARNING *** Please fix your application to use the native API of Avahi! May 05 19:01:06 volumio5-4g volumio[1066]: *** WARNING *** For more information see May 05 19:01:06 volumio5-4g volumio[1066]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 05 19:01:06 volumio5-4g volumio[1066]: *** WARNING *** Please fix your application to use the native API of Avahi! May 05 19:01:06 volumio5-4g volumio[1066]: *** WARNING *** For more information see May 05 19:01:06 volumio5-4g node[1066]: *** WARNING *** For more information see May 05 19:01:06 volumio5-4g node[1066]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 05 19:01:06 volumio5-4g node[1066]: *** WARNING *** Please fix your application to use the native API of Avahi! May 05 19:01:06 volumio5-4g node[1066]: *** WARNING *** For more information see May 05 19:01:06 volumio5-4g volumio[1066]: info: Applying required configuration parameters for plugin volumiodiscovery May 05 19:01:06 volumio5-4g volumio[1066]: info: Discovery: Started advertising with name: Volumio5-4g May 05 19:01:06 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 05 19:01:06 volumio5-4g volumio[1066]: info: Loading plugin "jellyfin"... May 05 19:01:07 volumio5-4g sudo[1102]: pam_unix(sudo:session): session closed for user root May 05 19:01:07 volumio5-4g volumio[1066]: info: Loading plugin "autostart"... May 05 19:01:07 volumio5-4g volumio[1066]: info: Applying required configuration parameters for plugin autostart May 05 19:01:07 volumio5-4g volumio[1066]: info: AutoStart - onVolumioStart - read config.json May 05 19:01:07 volumio5-4g volumio[1066]: info: Loading plugin "peppy_screensaver"... May 05 19:01:07 volumio5-4g volumio[1066]: info: Applying required configuration parameters for plugin peppy_screensaver May 05 19:01:07 volumio5-4g volumio[1066]: info: Loading plugin "outputs"... May 05 19:01:07 volumio5-4g volumio[1066]: info: Loading plugin "albumart"... May 05 19:01:07 volumio5-4g volumio[1066]: info: Plugin example_plugin is not enabled May 05 19:01:07 volumio5-4g volumio[1066]: info: Loading plugin "inputs"... May 05 19:01:07 volumio5-4g volumio[1066]: info: Loading plugin "updater_comm"... May 05 19:01:07 volumio5-4g volumio[1066]: info: Plugin mpdemulation is not enabled May 05 19:01:07 volumio5-4g volumio[1066]: info: Loading plugin "rest_api"... May 05 19:01:07 volumio5-4g volumio[1066]: info: Loading plugin "websocket"... May 05 19:01:07 volumio5-4g volumio[1066]: info: Loading plugin "touch_display"... May 05 19:01:07 volumio5-4g volumio[1066]: Forking 3 albumart workers May 05 19:01:07 volumio5-4g volumio[1066]: info: Applying required configuration parameters for plugin touch_display May 05 19:01:08 volumio5-4g volumio[1066]: info: Loading i18n strings for locale zh May 05 19:01:08 volumio5-4g volumio[1066]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. May 05 19:01:08 volumio5-4g volumio[1066]: Updating browse sources language May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 05 19:01:08 volumio5-4g volumio[1066]: Starting albumart workers May 05 19:01:08 volumio5-4g volumio[1066]: Starting albumart workers May 05 19:01:08 volumio5-4g volumio[1066]: Starting albumart workers May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::initPlayerControls May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 05 19:01:08 volumio5-4g volumio[1066]: Express server listening on port 3000 May 05 19:01:08 volumio5-4g volumio[1066]: [Metrics] WebUI: 2s 887.22ms May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreStateMachine::resetVolumioState May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreStateMachine::getcurrentVolume May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::volumioRetrievevolume May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreStateMachine::pushState May 05 19:01:08 volumio5-4g volumio[1066]: info: CorePlayQueue::getTrack 0 May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::volumioPushState May 05 19:01:08 volumio5-4g volumio[1066]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1 May 05 19:01:08 volumio5-4g volumio[1066]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 05 19:01:08 volumio5-4g volumio[1066]: info: Reloading queue from file May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreStateMachine::setRepeat null single undefined May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreStateMachine::pushState May 05 19:01:08 volumio5-4g volumio[1066]: info: CorePlayQueue::getTrack 0 May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::volumioPushState May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreStateMachine::setRandom null May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreStateMachine::pushState May 05 19:01:08 volumio5-4g volumio[1066]: info: CorePlayQueue::getTrack 0 May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::volumioPushState May 05 19:01:08 volumio5-4g volumio[1066]: info: Setting Device type: Raspberry PI May 05 19:01:08 volumio5-4g volumio[1066]: info: Discovery: adding 1d0de2d3-c195-4be3-ab1d-257be51e1699 May 05 19:01:08 volumio5-4g volumio[1066]: info: Discovery: Found device Volumio5-4g May 05 19:01:08 volumio5-4g volumio[1066]: info: CoreCommandRouter::volumioGetState May 05 19:01:08 volumio5-4g volumio[1066]: info: CorePlayQueue::getTrack 0 May 05 19:01:09 volumio5-4g systemd[1]: systemd-fsckd.service: Succeeded. May 05 19:01:11 volumio5-4g systemd[1]: systemd-hostnamed.service: Succeeded. May 05 19:01:13 volumio5-4g volumio-remote-updater[645]: [2024-05-05 19:01:13] [connect] Successful connection May 05 19:01:13 volumio5-4g volumio-remote-updater[645]: [2024-05-05 19:01:13] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1714906873 101 May 05 19:01:13 volumio5-4g volumio[1066]: 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 19:01:14 volumio5-4g sudo[1213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 05 19:01:14 volumio5-4g sudo[1213]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:01:14 volumio5-4g sudo[1213]: pam_unix(sudo:session): session closed for user root May 05 19:01:14 volumio5-4g sudo[1215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 05 19:01:14 volumio5-4g sudo[1215]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:01:14 volumio5-4g sudo[1215]: pam_unix(sudo:session): session closed for user root May 05 19:01:14 volumio5-4g volumio[1066]: 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 19:01:15 volumio5-4g sudo[1219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 05 19:01:15 volumio5-4g sudo[1219]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:01:15 volumio5-4g sudo[1219]: pam_unix(sudo:session): session closed for user root May 05 19:01:15 volumio5-4g sudo[1221]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 05 19:01:15 volumio5-4g sudo[1221]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:01:15 volumio5-4g sudo[1221]: pam_unix(sudo:session): session closed for user root May 05 19:01:15 volumio5-4g volumio[1066]: 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 19:01:15 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 05 19:01:15 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 05 19:01:15 volumio5-4g volumio[1066]: info: CoreCommandRouter::volumioGetVisibleSources May 05 19:01:15 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 05 19:01:15 volumio5-4g volumio[1066]: info: CoreCommandRouter::volumioGetState May 05 19:01:15 volumio5-4g volumio[1066]: info: CorePlayQueue::getTrack 0 May 05 19:01:15 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 05 19:01:15 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 05 19:01:15 volumio5-4g volumio[1066]: info: Received Get System Info May 05 19:01:15 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 05 19:01:15 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 05 19:01:15 volumio5-4g volumio[1066]: info: Discovery: Getting this device information May 05 19:01:15 volumio5-4g volumio[1066]: info: CoreCommandRouter::volumioGetState May 05 19:01:15 volumio5-4g volumio[1066]: info: CorePlayQueue::getTrack 0 May 05 19:01:15 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 05 19:01:15 volumio5-4g volumio[1066]: info: CoreCommandRouter::volumioGetState May 05 19:01:15 volumio5-4g volumio[1066]: info: CorePlayQueue::getTrack 0 May 05 19:01:15 volumio5-4g volumio[1066]: info: Listing playlists May 05 19:01:15 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 05 19:01:15 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 05 19:01:16 volumio5-4g sudo[1225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 05 19:01:16 volumio5-4g sudo[1225]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:01:16 volumio5-4g sudo[1225]: pam_unix(sudo:session): session closed for user root May 05 19:01:16 volumio5-4g sudo[1227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 05 19:01:16 volumio5-4g sudo[1227]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:01:16 volumio5-4g sudo[1227]: pam_unix(sudo:session): session closed for user root May 05 19:01:16 volumio5-4g sudo[1231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 05 19:01:16 volumio5-4g sudo[1231]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 19:01:16 volumio5-4g systemd[1]: Started UPnP Renderer front-end to MPD. May 05 19:01:16 volumio5-4g sudo[1231]: pam_unix(sudo:session): session closed for user root May 05 19:01:16 volumio5-4g volumio[1066]: info: Upmpdcli Daemon Started May 05 19:01:16 volumio5-4g volumio[1066]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 May 05 19:01:16 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 05 19:01:16 volumio5-4g volumio[1066]: info: Received Get System Info May 05 19:01:16 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 05 19:01:16 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 05 19:01:16 volumio5-4g volumio[1066]: info: Discovery: Getting this device information May 05 19:01:16 volumio5-4g volumio[1066]: info: CoreCommandRouter::volumioGetState May 05 19:01:16 volumio5-4g volumio[1066]: info: CorePlayQueue::getTrack 0 May 05 19:01:16 volumio5-4g volumio[1066]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 05 19:01:17 volumio5-4g volumio[1066]: info: CoreCommandRouter::volumioPlay May 05 19:01:17 volumio5-4g volumio[1066]: info: CoreStateMachine::play index undefined May 05 19:01:17 volumio5-4g volumio[1066]: info: CoreStateMachine::setConsumeUpdateService undefined May 05 19:01:17 volumio5-4g volumio[1066]: info: CorePlayQueue::getTrack 0 May 05 19:01:17 volumio5-4g volumio[1066]: info: CoreStateMachine::startPlaybackTimer May 05 19:01:17 volumio5-4g volumio[1066]: info: CorePlayQueue::getTrack 0 May 05 19:01:17 volumio5-4g volumio[1066]: verbose: ControllerMpd::clearAddPlayTracks USB/626B-EC13/呆妹儿、小可 - 最牛派 (慢摇DJ版).flac May 05 19:01:17 volumio5-4g volumio[1066]: verbose: ControllerMpd::sendMpdCommand stop May 05 19:01:19 volumio5-4g volumio[1066]: info: CoreCommandRouter::volumioPlay May 05 19:01:19 volumio5-4g volumio[1066]: info: CoreStateMachine::play index undefined May 05 19:01:19 volumio5-4g volumio[1066]: info: CoreStateMachine::setConsumeUpdateService undefined May 05 19:01:19 volumio5-4g volumio[1066]: info: CorePlayQueue::getTrack 0 May 05 19:01:19 volumio5-4g volumio[1066]: info: CoreStateMachine::startPlaybackTimer May 05 19:01:19 volumio5-4g volumio[1066]: info: CorePlayQueue::getTrack 0 May 05 19:01:19 volumio5-4g volumio[1066]: verbose: ControllerMpd::clearAddPlayTracks USB/626B-EC13/呆妹儿、小可 - 最牛派 (慢摇DJ版).flac May 05 19:01:19 volumio5-4g volumio[1066]: verbose: ControllerMpd::sendMpdCommand stop May 05 19:01:20 volumio5-4g volumio[1066]: info: CoreCommandRouter::volumioPlay May 05 19:01:20 volumio5-4g volumio[1066]: info: CoreStateMachine::play index undefined May 05 19:01:20 volumio5-4g volumio[1066]: info: CoreStateMachine::setConsumeUpdateService undefined May 05 19:01:20 volumio5-4g volumio[1066]: info: CorePlayQueue::getTrack 0 May 05 19:01:20 volumio5-4g volumio[1066]: info: CoreStateMachine::startPlaybackTimer May 05 19:01:20 volumio5-4g volumio[1066]: info: CorePlayQueue::getTrack 0 May 05 19:01:20 volumio5-4g volumio[1066]: verbose: ControllerMpd::clearAddPlayTracks USB/626B-EC13/呆妹儿、小可 - 最牛派 (慢摇DJ版).flac May 05 19:01:20 volumio5-4g volumio[1066]: verbose: ControllerMpd::sendMpdCommand stop May 05 19:01:20 volumio5-4g volumio[1066]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 May 05 19:01:21 volumio5-4g volumio[1066]: info: CoreCommandRouter::volumioGetQueue May 05 19:01:21 volumio5-4g volumio[1066]: info: CoreStateMachine::getQueue May 05 19:01:21 volumio5-4g volumio[1066]: info: CorePlayQueue::getQueue May 05 19:01:22 volumio5-4g volumio[1066]: info: Preload queue cleared May 05 19:01:22 volumio5-4g volumio[1066]: info: CoreCommandRouter::volumioReplaceandPlayItems May 05 19:01:22 volumio5-4g volumio[1066]: info: CoreStateMachine::ClearQueue May 05 19:01:22 volumio5-4g volumio[1066]: info: CoreStateMachine::stop May 05 19:01:22 volumio5-4g volumio[1066]: info: CoreStateMachine::setConsumeUpdateService undefined May 05 19:01:22 volumio5-4g volumio[1066]: info: CorePlayQueue::clearPlayQueue May 05 19:01:22 volumio5-4g volumio[1066]: info: CorePlayQueue::saveQueue May 05 19:01:22 volumio5-4g volumio[1066]: info: CoreCommandRouter::volumioPushQueue May 05 19:01:22 volumio5-4g volumio[1066]: info: CoreStateMachine::addQueueItems May 05 19:01:22 volumio5-4g volumio[1066]: info: CorePlayQueue::addQueueItems May 05 19:01:22 volumio5-4g volumio[1066]: info: Preload queue cleared May 05 19:01:22 volumio5-4g volumio[1066]: info: Adding Item to queue: music-library/USB/626B-EC13/呆妹儿、小可 - 最牛派 (慢摇DJ版).flac May 05 19:01:22 volumio5-4g volumio[1066]: info: Exploding uri music-library/USB/626B-EC13/呆妹儿、小可 - 最牛派 (慢摇DJ版).flac in service mpd May 05 19:01:22 volumio5-4g volumio[1066]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 05 19:01:22 volumio5-4g volumio[1066]: TypeError: Cannot read property 'then' of undefined May 05 19:01:22 volumio5-4g volumio[1066]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2527:19) May 05 19:01:22 volumio5-4g volumio[1066]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2325:21) May 05 19:01:22 volumio5-4g volumio[1066]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1359:16) May 05 19:01:22 volumio5-4g volumio[1066]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) May 05 19:01:22 volumio5-4g volumio[1066]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) May 05 19:01:22 volumio5-4g volumio[1066]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) May 05 19:01:22 volumio5-4g volumio[1066]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) May 05 19:01:22 volumio5-4g volumio[1066]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:501:23) May 05 19:01:22 volumio5-4g volumio[1066]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:477:17) May 05 19:01:22 volumio5-4g volumio[1066]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:118:33) May 05 19:01:22 volumio5-4g volumio[1066]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 05 19:01:22 volumio5-4g sudo[1243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-05 19:00 May 05 19:01:22 volumio5-4g sudo[1243]: 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"