-- Logs begin at Thu 2019-02-14 17:11:58 +07, end at Tue 2024-08-20 13:56:30 +07. -- Aug 20 13:55:48 volumio fake-hwclock[402]: Tue Aug 20 06:55:48 UTC 2024 Aug 20 13:55:48 volumio systemd[1]: Started Restore / save the current clock. Aug 20 13:55:48 volumio systemd[1]: Started Apply Kernel Variables. Aug 20 13:55:48 volumio systemd[1]: Mounted Kernel Configuration File System. Aug 20 13:55:48 volumio systemd[1]: Mounted FUSE Control File System. Aug 20 13:55:48 volumio systemd[1]: Started Load/Save Random Seed. Aug 20 13:55:48 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 20 13:55:48 volumio systemd[1]: Started Create System Users. Aug 20 13:55:48 volumio systemd[1]: Starting Create Static Device Nodes in /dev... Aug 20 13:55:48 volumio systemd[1]: Started udev Coldplug all Devices. Aug 20 13:55:48 volumio systemd[1]: Starting Helper to synchronize boot up for ifupdown... Aug 20 13:55:48 volumio systemd[1]: Started Create Static Device Nodes in /dev. Aug 20 13:55:48 volumio systemd[1]: Reached target Local File Systems (Pre). Aug 20 13:55:48 volumio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Aug 20 13:55:48 volumio systemd[1]: Mounting /var/log... Aug 20 13:55:48 volumio systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Aug 20 13:55:48 volumio systemd[1]: Mounting /tmp... Aug 20 13:55:48 volumio systemd[1]: Mounting /var/spool/cups... Aug 20 13:55:48 volumio systemd[1]: Starting udev Kernel Device Manager... Aug 20 13:55:48 volumio systemd[1]: Mounted /var/log. Aug 20 13:55:48 volumio systemd[1]: Mounted /tmp. Aug 20 13:55:48 volumio systemd[1]: Mounted /var/spool/cups. Aug 20 13:55:48 volumio systemd[1]: Mounting /var/spool/cups/tmp... Aug 20 13:55:48 volumio systemd[1]: Starting Flush Journal to Persistent Storage... Aug 20 13:55:48 volumio systemd[1]: Mounted /var/spool/cups/tmp. Aug 20 13:55:48 volumio systemd-udevd[435]: Network interface NamePolicy= disabled on kernel command line, ignoring. Aug 20 13:55:48 volumio systemd-journald[400]: Runtime journal (/run/log/journal/d5012141e8efab18115b4334669e938a) is 7.5M, max 30.0M, 22.5M free. Aug 20 13:55:48 volumio systemd[1]: Started Flush Journal to Persistent Storage. Aug 20 13:55:48 volumio systemd[1]: Started udev Kernel Device Manager. Aug 20 13:55:48 volumio systemd[1]: Starting Show Plymouth Boot Screen... Aug 20 13:55:48 volumio systemd[1]: plymouth-start.service: Succeeded. Aug 20 13:55:48 volumio systemd[1]: Started Show Plymouth Boot Screen. Aug 20 13:55:48 volumio systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Aug 20 13:55:48 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Aug 20 13:55:48 volumio systemd[1]: Reached target Local Encrypted Volumes. Aug 20 13:55:48 volumio systemd[1]: Reached target Paths. Aug 20 13:55:48 volumio systemd-udevd[445]: Using default interface naming scheme 'v240'. Aug 20 13:55:48 volumio systemd-udevd[445]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 20 13:55:48 volumio kernel: rpi-gpiomem 107d508500.gpiomem: window base 0x107d508500 size 0x00000040 Aug 20 13:55:48 volumio kernel: rpi-gpiomem 107d508500.gpiomem: initialised 1 regions as /dev/gpiomem1 Aug 20 13:55:48 volumio kernel: rpi-gpiomem 107d517c00.gpiomem: window base 0x107d517c00 size 0x00000040 Aug 20 13:55:48 volumio kernel: rpi-gpiomem 107d517c00.gpiomem: initialised 1 regions as /dev/gpiomem2 Aug 20 13:55:48 volumio kernel: rpi-gpiomem 107d504100.gpiomem: window base 0x107d504100 size 0x00000020 Aug 20 13:55:48 volumio kernel: rpi-gpiomem 107d504100.gpiomem: initialised 1 regions as /dev/gpiomem3 Aug 20 13:55:48 volumio kernel: rpi-gpiomem 107d510700.gpiomem: window base 0x107d510700 size 0x00000020 Aug 20 13:55:48 volumio kernel: rpi-gpiomem 107d510700.gpiomem: initialised 1 regions as /dev/gpiomem4 Aug 20 13:55:48 volumio kernel: rpi-gpiomem 1f000d0000.gpiomem: window base 0x1f000d0000 size 0x00030000 Aug 20 13:55:48 volumio kernel: rpi-gpiomem 1f000d0000.gpiomem: initialised 1 regions as /dev/gpiomem0 Aug 20 13:55:48 volumio kernel: input: pwr_button as /devices/platform/pwr_button/input/input0 Aug 20 13:55:48 volumio kernel: brcmstb-i2c 107d508200.i2c: @200000hz registered in interrupt mode Aug 20 13:55:48 volumio kernel: brcmstb-i2c 107d508280.i2c: @200000hz registered in interrupt mode Aug 20 13:55:48 volumio systemd[1]: Found device /dev/ttyAMA10. Aug 20 13:55:48 volumio kernel: mc: Linux media interface: v0.10 Aug 20 13:55:48 volumio kernel: videodev: Linux video capture interface: v2.00 Aug 20 13:55:48 volumio systemd[1]: Found device /sys/subsystem/net/devices/eth0. Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: bcm2712_iommu_of_xlate: MMU 1000005100.iommu Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: pispbe_probe: HW version: 0x02252700 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: pispbe_probe: BatchStatus: 0x00000000 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: pispbe_probe: Status: 0x00000000 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: Register nodes for group 0 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: input device node registered as /dev/video20 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: tdn_input device node registered as /dev/video21 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: stitch_input device node registered as /dev/video22 Aug 20 13:55:48 volumio kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. Aug 20 13:55:48 volumio kernel: rpivid 1000800000.codec: bcm2712_iommu_of_xlate: MMU 1000005100.iommu Aug 20 13:55:48 volumio kernel: rpivid 1000800000.codec: Device registered as /dev/video19 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: hog_output device node registered as /dev/video23 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: output0 device node registered as /dev/video24 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: output1 device node registered as /dev/video25 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: tdn_output device node registered as /dev/video26 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: stitch_output device node registered as /dev/video27 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: config device node registered as /dev/video28 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: Register nodes for group 1 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: input device node registered as /dev/video29 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: tdn_input device node registered as /dev/video30 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: stitch_input device node registered as /dev/video31 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: hog_output device node registered as /dev/video32 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: output0 device node registered as /dev/video33 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: output1 device node registered as /dev/video34 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: tdn_output device node registered as /dev/video35 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: stitch_output device node registered as /dev/video36 Aug 20 13:55:48 volumio kernel: pispbe 1000880000.pisp_be: config device node registered as /dev/video37 Aug 20 13:55:48 volumio kernel: vc4-drm axi:gpu: bcm2712_iommu_of_xlate: MMU 1000005200.iommu Aug 20 13:55:48 volumio kernel: vc4-drm axi:gpu: bound 107c580000.hvs (ops vc4_hvs_ops [vc4]) Aug 20 13:55:48 volumio kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Aug 20 13:55:48 volumio kernel: snd-rpi-i-sabre-q2m soc:sound: snd_soc_register_card() failed: -517 Aug 20 13:55:48 volumio kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Aug 20 13:55:48 volumio kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Aug 20 13:55:48 volumio kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Aug 20 13:55:48 volumio systemd-udevd[444]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 20 13:55:48 volumio kernel: Registered IR keymap rc-cec Aug 20 13:55:48 volumio kernel: Bluetooth: Core ver 2.22 Aug 20 13:55:48 volumio kernel: NET: Registered PF_BLUETOOTH protocol family Aug 20 13:55:48 volumio kernel: Bluetooth: HCI device and connection manager initialized Aug 20 13:55:48 volumio kernel: Bluetooth: HCI socket layer initialized Aug 20 13:55:48 volumio kernel: Bluetooth: L2CAP socket layer initialized Aug 20 13:55:48 volumio kernel: Bluetooth: SCO socket layer initialized Aug 20 13:55:48 volumio kernel: rc rc0: vc4-hdmi-0 as /devices/platform/soc/107c701400.hdmi/rc/rc0 Aug 20 13:55:48 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Aug 20 13:55:48 volumio kernel: input: vc4-hdmi-0 as /devices/platform/soc/107c701400.hdmi/rc/rc0/input1 Aug 20 13:55:48 volumio kernel: snd-rpi-i-sabre-q2m soc:sound: snd_soc_register_card() failed: -517 Aug 20 13:55:48 volumio kernel: Bluetooth: HCI UART driver ver 2.3 Aug 20 13:55:48 volumio kernel: Bluetooth: HCI UART protocol H4 registered Aug 20 13:55:48 volumio kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Aug 20 13:55:48 volumio kernel: Bluetooth: HCI UART protocol Broadcom registered Aug 20 13:55:48 volumio kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Aug 20 13:55:48 volumio kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Aug 20 13:55:48 volumio kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Aug 20 13:55:48 volumio kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Aug 20 13:55:48 volumio kernel: brcmfmac mmc1:0001:1: Direct firmware load for brcm/brcmfmac43455-sdio.raspberrypi,5-model-b.bin failed with error -2 Aug 20 13:55:48 volumio systemd[1]: Found device /dev/disk/by-uuid/6B37-2179. Aug 20 13:55:48 volumio systemd[1]: Starting File System Check on /dev/disk/by-uuid/6B37-2179... Aug 20 13:55:48 volumio kernel: snd-rpi-i-sabre-q2m soc:sound: snd_soc_register_card() failed: -517 Aug 20 13:55:48 volumio kernel: vc4-drm axi:gpu: bound 107c701400.hdmi (ops vc4_hdmi_ops [vc4]) Aug 20 13:55:48 volumio kernel: Registered IR keymap rc-cec Aug 20 13:55:48 volumio kernel: rc rc1: vc4-hdmi-1 as /devices/platform/soc/107c706400.hdmi/rc/rc1 Aug 20 13:55:48 volumio kernel: input: vc4-hdmi-1 as /devices/platform/soc/107c706400.hdmi/rc/rc1/input2 Aug 20 13:55:48 volumio kernel: vc4-drm axi:gpu: bound 107c706400.hdmi (ops vc4_hdmi_ops [vc4]) Aug 20 13:55:48 volumio kernel: vc4-drm axi:gpu: bound 107c500000.mop (ops vc4_txp_ops [vc4]) Aug 20 13:55:48 volumio kernel: vc4-drm axi:gpu: bound 107c501000.moplet (ops vc4_txp_ops [vc4]) Aug 20 13:55:48 volumio kernel: vc4-drm axi:gpu: bound 107c410000.pixelvalve (ops vc4_crtc_ops [vc4]) Aug 20 13:55:48 volumio kernel: vc4-drm axi:gpu: bound 107c411000.pixelvalve (ops vc4_crtc_ops [vc4]) Aug 20 13:55:48 volumio kernel: [drm] Initialized vc4 0.0.0 20140616 for axi:gpu on minor 1 Aug 20 13:55:48 volumio kernel: snd-rpi-i-sabre-q2m soc:sound: snd_soc_register_card() failed: -517 Aug 20 13:55:48 volumio systemd[1]: Started File System Check Daemon to report status. Aug 20 13:55:48 volumio systemd-fsck[659]: fsck.fat 4.1 (2017-01-24) Aug 20 13:55:48 volumio systemd-fsck[659]: /dev/mmcblk0p1: 374 files, 33703/46774 clusters Aug 20 13:55:48 volumio systemd[1]: Started File System Check on /dev/disk/by-uuid/6B37-2179. Aug 20 13:55:49 volumio 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 Aug 20 13:55:49 volumio systemd[1]: Mounting /boot... Aug 20 13:55:49 volumio systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Aug 20 13:55:49 volumio kernel: usbcore: registered new interface driver brcmfmac Aug 20 13:55:49 volumio kernel: snd-rpi-i-sabre-q2m soc:sound: snd_soc_register_card() failed: -517 Aug 20 13:55:49 volumio systemd[1]: Mounted /boot. Aug 20 13:55:49 volumio kernel: snd-rpi-i-sabre-q2m soc:sound: snd_soc_register_card() failed: -517 Aug 20 13:55:49 volumio systemd-udevd[456]: Using default interface naming scheme 'v240'. Aug 20 13:55:49 volumio systemd-udevd[456]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 20 13:55:49 volumio kernel: Console: switching to colour frame buffer device 480x135 Aug 20 13:55:49 volumio kernel: snd-rpi-i-sabre-q2m soc:sound: snd_soc_register_card() failed: -517 Aug 20 13:55:49 volumio kernel: vc4-drm axi:gpu: [drm] fb0: vc4drmfb frame buffer device Aug 20 13:55:49 volumio kernel: ieee80211 phy0: brcmf_cfg80211_reg_notifier: Firmware rejected country setting Aug 20 13:55:49 volumio kernel: Bluetooth: hci0: BCM: chip id 107 Aug 20 13:55:49 volumio kernel: Bluetooth: hci0: BCM: features 0x2f Aug 20 13:55:49 volumio kernel: Bluetooth: hci0: BCM4345C0 Aug 20 13:55:49 volumio kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 Aug 20 13:55:49 volumio kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch Aug 20 13:55:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000001] -121 Aug 20 13:55:49 volumio kernel: snd-rpi-i-sabre-q2m soc:sound: Audiophonics Device ID : FFFFFF87 Aug 20 13:55:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000002] -121 Aug 20 13:55:49 volumio kernel: snd-rpi-i-sabre-q2m soc:sound: Audiophonics API revision : FFFFFF87 Aug 20 13:55:49 volumio systemd-udevd[448]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Aug 20 13:55:49 volumio systemd-udevd[464]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Aug 20 13:55:49 volumio systemd-udevd[447]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Aug 20 13:55:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Aug 20 13:55:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 13:55:49 volumio systemd[1]: Created slice system-bthelper.slice. Aug 20 13:55:49 volumio systemd[1]: Starting Load/Save RF Kill Switch Status... Aug 20 13:55:49 volumio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Aug 20 13:55:49 volumio systemd[1]: Starting Show Plymouth Boot Screen... Aug 20 13:55:49 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Aug 20 13:55:49 volumio systemd[1]: Condition check resulted in Huge Pages File System being skipped. Aug 20 13:55:49 volumio systemd[1]: Reached target Local File Systems. Aug 20 13:55:49 volumio systemd[1]: Starting Create Volatile Files and Directories... Aug 20 13:55:49 volumio systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Aug 20 13:55:49 volumio systemd[1]: Starting Preprocess NFS configuration... Aug 20 13:55:49 volumio systemd[1]: Started ifup for eth0. Aug 20 13:55:49 volumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Aug 20 13:55:49 volumio systemd[1]: Started Load/Save RF Kill Switch Status. Aug 20 13:55:49 volumio systemd[1]: nfs-config.service: Succeeded. Aug 20 13:55:49 volumio systemd[1]: Started Preprocess NFS configuration. Aug 20 13:55:49 volumio systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Aug 20 13:55:49 volumio systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Aug 20 13:55:49 volumio systemd[1]: Reached target NFS client services. Aug 20 13:55:49 volumio systemd[1]: Received SIGRTMIN+20 from PID 281 (plymouthd). Aug 20 13:55:49 volumio systemd[1]: plymouth-read-write.service: Succeeded. Aug 20 13:55:49 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Aug 20 13:55:49 volumio systemd[1]: Started Create Volatile Files and Directories. Aug 20 13:55:49 volumio systemd[1]: plymouth-start.service: Succeeded. Aug 20 13:55:49 volumio systemd[1]: Started Show Plymouth Boot Screen. Aug 20 13:55:49 volumio systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Aug 20 13:55:49 volumio systemd[1]: Started ifup for wlan0. Aug 20 13:55:49 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Aug 20 13:55:49 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown... Aug 20 13:55:49 volumio systemd[1]: Starting RPC bind portmap service... Aug 20 13:55:49 volumio systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Aug 20 13:55:49 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Aug 20 13:55:49 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown. Aug 20 13:55:49 volumio systemd[1]: Reached target System Initialization. Aug 20 13:55:49 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Aug 20 13:55:49 volumio systemd[1]: Started Daily apt download activities. Aug 20 13:55:49 volumio systemd[1]: Listening on triggerhappy.socket. Aug 20 13:55:49 volumio systemd[1]: Started Daily apt upgrade and clean activities. Aug 20 13:55:49 volumio systemd[1]: Listening on D-Bus System Message Bus Socket. Aug 20 13:55:49 volumio systemd[1]: Reached target Sockets. Aug 20 13:55:49 volumio systemd[1]: Reached target Basic System. Aug 20 13:55:49 volumio systemd[1]: Started Volumio Iptables Module. Aug 20 13:55:49 volumio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Aug 20 13:55:49 volumio systemd[1]: Started Volumio Log Rotation Service. Aug 20 13:55:49 volumio systemd[1]: Started Manage Sound Card State (restore and store). Aug 20 13:55:49 volumio alsactl[804]: alsactl 1.1.8 daemon started Aug 20 13:55:49 volumio systemd[1]: Starting Save/Restore Sound Card State... Aug 20 13:55:49 volumio systemd[1]: Starting Wireless Services... Aug 20 13:55:49 volumio systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Aug 20 13:55:49 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Aug 20 13:55:49 volumio systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Aug 20 13:55:49 volumio systemd[1]: Starting dhcpcd on all interfaces... Aug 20 13:55:49 volumio systemd[1]: Started volumio-remote-updater.service. Aug 20 13:55:49 volumio systemd[1]: Starting Login Service... Aug 20 13:55:49 volumio systemd[1]: Started D-Bus System Message Bus. Aug 20 13:55:49 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Aug 20 13:55:49 volumio alsactl[804]: /usr/sbin/alsactl: set_control:1461Cannot write control '2:0:0:Digital Playback Volume:0' : Remote I/O error Aug 20 13:55:49 volumio alsactl[804]: /usr/sbin/alsactl: set_control:1461Cannot write control '2:0:0:Digital Playback Switch:0' : Remote I/O error Aug 20 13:55:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Aug 20 13:55:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 13:55:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Aug 20 13:55:49 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 13:55:49 volumio alsactl[805]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Digital Playback Volume:0' : Remote I/O error Aug 20 13:55:49 volumio alsactl[805]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Digital Playback Switch:0' : Remote I/O error Aug 20 13:55:49 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Aug 20 13:55:49 volumio systemd[1]: Starting triggerhappy global hotkey daemon... Aug 20 13:55:49 volumio systemd[1]: Condition check resulted in Configure Bluetooth Modems connected by UART being skipped. Aug 20 13:55:49 volumio systemd[1]: Starting Raspberry Pi bluetooth helper... Aug 20 13:55:49 volumio systemd[1]: Starting WPA supplicant... Aug 20 13:55:49 volumio kernel: macb 1f00100000.ethernet eth0: PHY [1f00100000.ethernet-ffffffff:01] driver [Broadcom BCM54213PE] (irq=POLL) Aug 20 13:55:49 volumio kernel: macb 1f00100000.ethernet eth0: configuring for phy/rgmii-id link mode Aug 20 13:55:49 volumio systemd[1]: Started Daily man-db regeneration. Aug 20 13:55:49 volumio systemd[1]: Started Daily Cleanup of Temporary Directories. Aug 20 13:55:49 volumio systemd[1]: Reached target Timers. Aug 20 13:55:49 volumio systemd[1]: haveged.service: Main process exited, code=killed, status=11/SEGV Aug 20 13:55:49 volumio systemd[1]: haveged.service: Failed with result 'signal'. Aug 20 13:55:49 volumio systemd[1]: Started RPC bind portmap service. Aug 20 13:55:49 volumio kernel: pps pps0: new PPS source ptp0 Aug 20 13:55:49 volumio kernel: macb 1f00100000.ethernet: gem-ptp-timer ptp clock registered. Aug 20 13:55:49 volumio systemd[1]: Started Save/Restore Sound Card State. Aug 20 13:55:49 volumio systemd[1]: Reached target Sound Card. Aug 20 13:55:49 volumio systemd[1]: Reached target RPC Port Mapper. Aug 20 13:55:49 volumio systemd[1]: Reached target Remote File Systems (Pre). Aug 20 13:55:49 volumio systemd[1]: Reached target Remote File Systems. Aug 20 13:55:49 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Aug 20 13:55:49 volumio thd[816]: Unable to parse trigger line: Aug 20 13:55:49 volumio thd[816]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Aug 20 13:55:49 volumio thd[816]: Unable to parse trigger line: Aug 20 13:55:49 volumio thd[816]: Found socket passed from systemd Aug 20 13:55:49 volumio systemd-logind[810]: New seat seat0. Aug 20 13:55:49 volumio systemd-logind[810]: Watching system buttons on /dev/input/event0 (pwr_button) Aug 20 13:55:49 volumio systemd-logind[810]: Watching system buttons on /dev/input/event1 (vc4-hdmi-0) Aug 20 13:55:49 volumio systemd-logind[810]: Watching system buttons on /dev/input/event2 (vc4-hdmi-1) Aug 20 13:55:49 volumio dhcpcd[808]: dev: loaded udev Aug 20 13:55:49 volumio avahi-daemon[815]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Aug 20 13:55:49 volumio avahi-daemon[815]: Successfully dropped root privileges. Aug 20 13:55:49 volumio avahi-daemon[815]: avahi-daemon 0.7 starting up. Aug 20 13:55:49 volumio kernel: Bluetooth: hci0: BCM: features 0x2f Aug 20 13:55:49 volumio kernel: 8021q: 802.1Q VLAN Support v1.8 Aug 20 13:55:49 volumio kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+ Aug 20 13:55:49 volumio kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342 Aug 20 13:55:49 volumio kernel: Bluetooth: hci0: BCM: Using default device address (43:45:c0:00:1f:ac) Aug 20 13:55:49 volumio dhcpcd[808]: `undefined' is not a valid IP address Aug 20 13:55:49 volumio dhcpcd[808]: `undefined' is not a valid IP address Aug 20 13:55:49 volumio dhcpcd[808]: forked to background, child pid 877 Aug 20 13:55:49 volumio avahi-daemon[815]: Successfully called chroot(). Aug 20 13:55:49 volumio avahi-daemon[815]: Successfully dropped remaining capabilities. Aug 20 13:55:49 volumio systemd[1]: Started Login Service. Aug 20 13:55:49 volumio wpa_supplicant[818]: Successfully initialized wpa_supplicant Aug 20 13:55:49 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Aug 20 13:55:49 volumio systemd[1]: Started triggerhappy global hotkey daemon. Aug 20 13:55:49 volumio systemd[1]: Started dhcpcd on all interfaces. Aug 20 13:55:49 volumio avahi-daemon[815]: No service file found in /etc/avahi/services. Aug 20 13:55:49 volumio avahi-daemon[815]: Network interface enumeration completed. Aug 20 13:55:49 volumio avahi-daemon[815]: Server startup complete. Host name is volumio.local. Local service cookie is 4277737820. Aug 20 13:55:49 volumio bthelper[817]: Raspberry Pi BDADDR already set Aug 20 13:55:49 volumio sh[757]: eth0=eth0 Aug 20 13:55:49 volumio sh[773]: wlan0=wlan0 Aug 20 13:55:49 volumio systemd[1]: Started Raspberry Pi bluetooth helper. Aug 20 13:55:49 volumio systemd[1]: Started WPA supplicant. Aug 20 13:55:50 volumio systemd[1]: Starting Bluetooth service... Aug 20 13:55:50 volumio volumio-remote-updater[809]: Error: No active session Aug 20 13:55:50 volumio volumio-remote-updater[809]: [2024-08-20 13:55:50] [info] asio async_connect error: system:111 (Connection refused) Aug 20 13:55:50 volumio volumio-remote-updater[809]: [2024-08-20 13:55:50] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 20 13:55:50 volumio volumio-remote-updater[809]: [2024-08-20 13:55:50] [error] handle_connect error: Underlying Transport Error Aug 20 13:55:50 volumio volumio[807]: Could not open config: /tmp/upmpdcli.conf Aug 20 13:55:50 volumio loadcpufreq[824]: Loading cpufreq kernel modules...done (none). Aug 20 13:55:50 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Aug 20 13:55:50 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Aug 20 13:55:50 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Aug 20 13:55:50 volumio dhcpcd-run-hooks[951]: wlan0: ctrl_interface not defined in /etc/wpa_supplicant/wpa_supplicant.conf Aug 20 13:55:50 volumio bluetoothd[898]: Bluetooth daemon 5.50 Aug 20 13:55:50 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Aug 20 13:55:50 volumio dhcpcd-run-hooks[954]: wlan0: not interacting with wpa_supplicant(8) Aug 20 13:55:50 volumio dhcpcd[877]: wlan0: connected to Access Point `' Aug 20 13:55:50 volumio dhcpcd[877]: eth0: waiting for carrier Aug 20 13:55:50 volumio dhcpcd[877]: wlan0: waiting for carrier Aug 20 13:55:50 volumio bluetoothd[898]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Aug 20 13:55:50 volumio systemd[1]: iptables.service: Succeeded. Aug 20 13:55:50 volumio systemd[1]: Started Bluetooth service. Aug 20 13:55:50 volumio systemd[1]: Reached target Bluetooth. Aug 20 13:55:50 volumio bluetoothd[898]: Starting SDP server Aug 20 13:55:50 volumio bluetoothd[898]: Excluding (cli) sap Aug 20 13:55:50 volumio systemd[1]: Started Helper to synchronize boot up for ifupdown. Aug 20 13:55:50 volumio bluetoothd[898]: Bluetooth management interface 1.22 initialized Aug 20 13:55:50 volumio dbus-daemon[811]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=898 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Aug 20 13:55:50 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Aug 20 13:55:50 volumio kernel: Bluetooth: BNEP filters: protocol multicast Aug 20 13:55:50 volumio kernel: Bluetooth: BNEP socket layer initialized Aug 20 13:55:50 volumio kernel: Bluetooth: MGMT ver 1.22 Aug 20 13:55:50 volumio systemd[1]: Starting Raise network interfaces... Aug 20 13:55:50 volumio cpufrequtils[953]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Aug 20 13:55:50 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Aug 20 13:55:50 volumio systemd[1]: Starting Hostname Service... Aug 20 13:55:50 volumio dbus-daemon[811]: [system] Successfully activated service 'org.freedesktop.hostname1' Aug 20 13:55:50 volumio systemd[1]: Started Hostname Service. Aug 20 13:55:50 volumio systemd[1]: Started Raise network interfaces. Aug 20 13:55:50 volumio systemd[1]: Reached target Network. Aug 20 13:55:50 volumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Aug 20 13:55:50 volumio systemd[1]: Starting Network Time Service... Aug 20 13:55:50 volumio systemd[1]: Starting Permit User Sessions... Aug 20 13:55:50 volumio systemd[1]: Reached target Network is Online. Aug 20 13:55:50 volumio systemd[1]: Starting Samba NMB Daemon... Aug 20 13:55:50 volumio bluetoothd[898]: Failed to set privacy: Rejected (0x0b) Aug 20 13:55:50 volumio systemd[1]: Starting LSB: Brings up/down network automatically... Aug 20 13:55:50 volumio systemd[1]: Starting /etc/rc.local Compatibility... Aug 20 13:55:50 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 20 13:55:50 volumio systemd[1]: Started /etc/rc.local Compatibility. Aug 20 13:55:50 volumio systemd[1]: Started Permit User Sessions. Aug 20 13:55:50 volumio systemd[1]: Starting Hold until boot process finishes up... Aug 20 13:55:50 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... Aug 20 13:55:50 volumio systemd[1]: Received SIGRTMIN+21 from PID 281 (plymouthd). Aug 20 13:55:50 volumio systemd[1]: plymouth-quit-wait.service: Succeeded. Aug 20 13:55:50 volumio systemd[1]: Started Hold until boot process finishes up. Aug 20 13:55:50 volumio systemd[1]: plymouth-quit.service: Succeeded. Aug 20 13:55:50 volumio systemd[1]: Started Terminate Plymouth Boot Screen. Aug 20 13:55:50 volumio systemd[1]: Received SIGRTMIN+21 from PID 281 (n/a). Aug 20 13:55:50 volumio ntpd[1039]: ntpd 4.2.8p12@1.3728-o (1): Starting Aug 20 13:55:50 volumio ntpd[1039]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Aug 20 13:55:50 volumio ifplugd(eth0)[1068]: ifplugd 0.28 initializing. Aug 20 13:55:50 volumio ifplugd(eth0)[1068]: Using interface eth0/2C:CF:67:17:93:2B with driver (version: 6.1.69-v8+) Aug 20 13:55:50 volumio systemd[1]: Started Serial Getty on ttyAMA10. Aug 20 13:55:50 volumio ifplugd(eth0)[1068]: Using detection mode: SIOCETHTOOL Aug 20 13:55:50 volumio ifplugd(eth0)[1068]: Initialization complete, link beat not detected. Aug 20 13:55:50 volumio ntpd[1064]: proto: precision = 0.851 usec (-20) Aug 20 13:55:50 volumio systemd[1]: Reached target Login Prompts. Aug 20 13:55:50 volumio ntpd[1064]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Aug 20 13:55:50 volumio ntpd[1064]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Aug 20 13:55:50 volumio systemd[1]: Started Network Time Service. Aug 20 13:55:50 volumio ntpd[1064]: Listen and drop on 0 v6wildcard [::]:123 Aug 20 13:55:50 volumio ntpd[1064]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Aug 20 13:55:50 volumio ntpd[1064]: Listen normally on 2 lo 127.0.0.1:123 Aug 20 13:55:50 volumio ntpd[1064]: Listening on routing socket on fd #19 for interface updates Aug 20 13:55:50 volumio ntpd[1064]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 20 13:55:50 volumio ntpd[1064]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 20 13:55:50 volumio ifplugd[1043]: Network Interface Plugging Daemon...start eth0...done. Aug 20 13:55:50 volumio systemd[1]: Started LSB: Brings up/down network automatically. Aug 20 13:55:50 volumio nmbd[1050]: [2024/08/20 13:55:50.588010, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Aug 20 13:55:50 volumio nmbd[1050]: started asyncdns process 1077 Aug 20 13:55:50 volumio nmbd[1050]: [2024/08/20 13:55:50.588751, 0] ../lib/util/become_daemon.c:149(daemon_status) Aug 20 13:55:50 volumio nmbd[1050]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Aug 20 13:55:50 volumio nmbd[1050]: [2024/08/20 13:55:50.588791, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Aug 20 13:55:50 volumio nmbd[1050]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Aug 20 13:55:50 volumio wireless.js[806]: Cleaning previous... Aug 20 13:55:50 volumio sudo[1081]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Aug 20 13:55:50 volumio sudo[1081]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:50 volumio sudo[1081]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:50 volumio sudo[1083]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Aug 20 13:55:50 volumio sudo[1083]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:51 volumio sudo[1083]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:51 volumio wireless.js[806]: Stopped aP Aug 20 13:55:51 volumio wireless.js[806]: Wireless Networking DISABLED, not starting wireless flow Aug 20 13:55:51 volumio systemd[1]: wireless.service: Succeeded. Aug 20 13:55:51 volumio systemd[1]: Started Wireless Services. Aug 20 13:55:51 volumio systemd[1]: Started Volumio Backend Module. Aug 20 13:55:51 volumio systemd[1]: Started Volumio Cpu Tweaker. Aug 20 13:55:51 volumio volumio-cpu-tweak[1092]: Setting RT Priority for mpd Aug 20 13:55:51 volumio volumio-cpu-tweak[1092]: pid 35's current scheduling policy: SCHED_OTHER Aug 20 13:55:51 volumio volumio-cpu-tweak[1092]: pid 35's current scheduling priority: 0 Aug 20 13:55:51 volumio volumio-cpu-tweak[1092]: Setting MPD Affinity Aug 20 13:55:51 volumio volumio-cpu-tweak[1092]: pid 3's current affinity mask: f Aug 20 13:55:51 volumio volumio-cpu-tweak[1092]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Aug 20 13:55:51 volumio volumio-cpu-tweak[1092]: VOLUMIO CPU TWEAK: Setting CPU Governor: conservative Aug 20 13:55:51 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Aug 20 13:55:51 volumio ntpd[1064]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Aug 20 13:55:51 volumio volumio[1091]: info: ------------------------------------------- Aug 20 13:55:51 volumio volumio[1091]: info: ----- Volumio3 ---- Aug 20 13:55:51 volumio volumio[1091]: info: ------------------------------------------- Aug 20 13:55:51 volumio volumio[1091]: info: ----- System startup ---- Aug 20 13:55:51 volumio volumio[1091]: info: ------------------------------------------- Aug 20 13:55:52 volumio volumio[1091]: info: MYVOLUMIO Environment detected Aug 20 13:55:52 volumio volumio[1091]: info: Plugin folders cleanup Aug 20 13:55:52 volumio volumio[1091]: info: Scanning into folder /volumio/app/plugins/ Aug 20 13:55:52 volumio volumio[1091]: info: Scanning category audio_interface Aug 20 13:55:52 volumio volumio[1091]: info: Scanning category miscellanea Aug 20 13:55:52 volumio volumio[1091]: info: Scanning category music_service Aug 20 13:55:52 volumio volumio[1091]: info: Scanning category plugins.json Aug 20 13:55:52 volumio volumio[1091]: info: Scanning category system_controller Aug 20 13:55:52 volumio volumio[1091]: info: Scanning category user_interface Aug 20 13:55:52 volumio volumio[1091]: info: Scanning into folder /data/plugins/ Aug 20 13:55:52 volumio volumio[1091]: info: Scanning category audio_interface Aug 20 13:55:52 volumio volumio[1091]: info: Scanning category music_service Aug 20 13:55:52 volumio volumio[1091]: info: Scanning category user_interface Aug 20 13:55:52 volumio volumio[1091]: info: Plugin folders cleanup completed Aug 20 13:55:52 volumio volumio[1091]: info: ------------------------------------------- Aug 20 13:55:52 volumio volumio[1091]: info: ----- Core plugins startup ---- Aug 20 13:55:52 volumio volumio[1091]: info: ------------------------------------------- Aug 20 13:55:52 volumio volumio[1091]: info: Loading plugins from folder /volumio/app/plugins/ Aug 20 13:55:52 volumio volumio[1091]: info: Adding plugin upnp to MyMusic Plugins Aug 20 13:55:52 volumio volumio[1091]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 20 13:55:52 volumio volumio[1091]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 20 13:55:52 volumio volumio[1091]: info: Loading plugins from folder /data/plugins/ Aug 20 13:55:52 volumio volumio[1091]: info: Loading plugin "system"... Aug 20 13:55:52 volumio volumio[1091]: info: Loading plugin "appearance"... Aug 20 13:55:52 volumio ntpd[1064]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Aug 20 13:55:52 volumio volumio[1091]: info: Loading plugin "network"... Aug 20 13:55:52 volumio volumio[1091]: info: Refreshing Cached IP Addresses Aug 20 13:55:52 volumio volumio[1091]: info: Loading plugin "services"... Aug 20 13:55:52 volumio sudo[1122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 20 13:55:52 volumio volumio[1091]: info: Loading plugin "alsa_controller"... Aug 20 13:55:52 volumio sudo[1122]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:52 volumio sudo[1124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 20 13:55:52 volumio sudo[1124]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:52 volumio sudo[1122]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:52 volumio sudo[1124]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:52 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 20 13:55:52 volumio volumio[1091]: info: Loading plugin "wizard"... Aug 20 13:55:52 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 13:55:52 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Aug 20 13:55:52 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 13:55:52 volumio volumio[1091]: info: Loading plugin "networkfs"... Aug 20 13:55:52 volumio volumio[1091]: info: Starting Udev Watcher for removable devices Aug 20 13:55:52 volumio sudo[1132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.100/\\\\C:\\Users\\nccus\\OneDrive\\Music /mnt/NAS/HACUONG Aug 20 13:55:52 volumio sudo[1132]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:52 volumio volumio[1091]: info: Mounting Device New_Volume Aug 20 13:55:52 volumio sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/New_Volume -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 20 13:55:52 volumio sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:52 volumio kernel: Key type cifs.spnego registered Aug 20 13:55:52 volumio kernel: Key type cifs.idmap registered Aug 20 13:55:52 volumio sudo[1132]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:52 volumio 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. Aug 20 13:55:52 volumio kernel: CIFS: Attempting to mount \\192.168.1.100\ Aug 20 13:55:52 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Aug 20 13:55:52 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Aug 20 13:55:53 volumio ntfs-3g[1152]: Version 2017.3.23AR.3 integrated FUSE 28 Aug 20 13:55:53 volumio ntfs-3g[1152]: Mounted /dev/sda1 (Read-Write, label "New Volume", NTFS 3.1) Aug 20 13:55:53 volumio ntfs-3g[1152]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 20 13:55:53 volumio ntfs-3g[1152]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Aug 20 13:55:53 volumio ntfs-3g[1152]: Global ownership and permissions enforced, configuration type 7 Aug 20 13:55:53 volumio sudo[1143]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:53 volumio volumio[1091]: info: Ignoring mount for partition: boot Aug 20 13:55:53 volumio volumio[1091]: info: Ignoring mount for partition: volumio Aug 20 13:55:53 volumio volumio[1091]: info: Ignoring mount for partition: volumio_data Aug 20 13:55:53 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 20 13:55:53 volumio volumio[1091]: info: Loading plugin "volumio_command_line_client"... Aug 20 13:55:53 volumio volumio[1091]: info: Loading plugin "upnp"... Aug 20 13:55:53 volumio volumio[1091]: info: [1724136953336] Starting Upmpd Daemon Aug 20 13:55:53 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 20 13:55:53 volumio volumio[1091]: info: Loading plugin "my_music"... Aug 20 13:55:53 volumio volumio[1091]: info: Loading plugin "mpd"... Aug 20 13:55:53 volumio ntpd[1064]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Aug 20 13:55:53 volumio volumio[1091]: info: Loading plugin "upnp_browser"... Aug 20 13:55:53 volumio volumio[1091]: info: Loading plugin "alarm-clock"... Aug 20 13:55:53 volumio volumio[1091]: info: Loading plugin "airplay_emulation"... Aug 20 13:55:53 volumio volumio[1091]: info: Starting Shairport Sync Aug 20 13:55:53 volumio volumio[1091]: info: Loading plugin "last_100"... Aug 20 13:55:53 volumio volumio[1091]: info: Loading plugin "webradio"... Aug 20 13:55:53 volumio volumio[1091]: info: Loading plugin "i2s_dacs"... Aug 20 13:55:53 volumio volumio[1091]: info: Loading plugin "volumiodiscovery"... Aug 20 13:55:53 volumio volumio[1091]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 20 13:55:53 volumio node[1091]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 20 13:55:53 volumio node[1091]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 20 13:55:53 volumio volumio[1091]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 20 13:55:53 volumio volumio[1091]: *** WARNING *** For more information see Aug 20 13:55:53 volumio volumio[1091]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 20 13:55:53 volumio volumio[1091]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 20 13:55:53 volumio volumio[1091]: *** WARNING *** For more information see Aug 20 13:55:53 volumio node[1091]: *** WARNING *** For more information see Aug 20 13:55:53 volumio node[1091]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 20 13:55:53 volumio node[1091]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 20 13:55:53 volumio node[1091]: *** WARNING *** For more information see Aug 20 13:55:53 volumio volumio[1091]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 20 13:55:53 volumio volumio[1091]: info: Discovery: Started advertising with name: Volumio Aug 20 13:55:53 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 20 13:55:53 volumio volumio[1091]: info: Loading plugin "outputs"... Aug 20 13:55:53 volumio volumio[1091]: info: Loading plugin "albumart"... Aug 20 13:55:53 volumio volumio[1091]: info: Plugin example_plugin is not enabled Aug 20 13:55:53 volumio volumio[1091]: info: Loading plugin "inputs"... Aug 20 13:55:53 volumio volumio[1091]: info: Loading plugin "updater_comm"... Aug 20 13:55:53 volumio dhcpcd[877]: eth0: carrier acquired Aug 20 13:55:53 volumio kernel: macb 1f00100000.ethernet eth0: Link is Up - 1Gbps/Full - flow control tx Aug 20 13:55:53 volumio dhcpcd[877]: DUID 00:01:00:01:2e:4e:f2:20:2c:cf:67:17:93:2b Aug 20 13:55:53 volumio dhcpcd[877]: eth0: IAID 67:17:93:2b Aug 20 13:55:53 volumio dhcpcd[877]: eth0: adding address fe80::2ecf:67ff:fe17:932b Aug 20 13:55:53 volumio dhcpcd[877]: ipv6_addaddr1: Permission denied Aug 20 13:55:53 volumio dhcpcd[877]: eth0: probing address 192.168.1.98/24 Aug 20 13:55:53 volumio volumio[1091]: info: Plugin mpdemulation is not enabled Aug 20 13:55:53 volumio volumio[1091]: info: Loading plugin "rest_api"... Aug 20 13:55:53 volumio volumio[1091]: Forking 3 albumart workers Aug 20 13:55:53 volumio volumio[1091]: info: Loading plugin "websocket"... Aug 20 13:55:53 volumio volumio[1091]: info: Starting Socket.io Server version 2.3.0 Aug 20 13:55:53 volumio volumio[1091]: info: Loading plugin "fusiondsp"... Aug 20 13:55:53 volumio volumio[1091]: info: Applying required configuration parameters for plugin fusiondsp Aug 20 13:55:53 volumio volumio[1091]: Starting albumart workers Aug 20 13:55:53 volumio volumio[1091]: Starting albumart workers Aug 20 13:55:54 volumio dhcpcd[877]: eth0: soliciting an IPv6 router Aug 20 13:55:54 volumio volumio[1091]: info: Loading plugin "RoonBridge"... Aug 20 13:55:54 volumio volumio[1091]: Starting albumart workers Aug 20 13:55:54 volumio volumio[1091]: info: Applying required configuration parameters for plugin RoonBridge Aug 20 13:55:54 volumio volumio[1091]: info: Loading plugin "minidlna"... Aug 20 13:55:54 volumio volumio[1091]: info: Applying required configuration parameters for plugin minidlna Aug 20 13:55:54 volumio volumio[1091]: info: Loading plugin "touch_display"... Aug 20 13:55:54 volumio volumio[1091]: info: Applying required configuration parameters for plugin touch_display Aug 20 13:55:54 volumio ntpd[1064]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Aug 20 13:55:54 volumio volumio[1091]: info: Loading i18n strings for locale vi Aug 20 13:55:54 volumio volumio[1091]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Aug 20 13:55:54 volumio volumio[1091]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Aug 20 13:55:54 volumio volumio[1091]: Updating browse sources language Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 13:55:54 volumio systemd[1]: systemd-rfkill.service: Succeeded. Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::initPlayerControls Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: Express server listening on port 3000 Aug 20 13:55:54 volumio volumio[1091]: [Metrics] WebUI: 2s 773.72ms Aug 20 13:55:54 volumio ifplugd(eth0)[1068]: Link beat detected. Aug 20 13:55:54 volumio volumio[1091]: info: CoreStateMachine::resetVolumioState Aug 20 13:55:54 volumio volumio[1091]: info: CoreStateMachine::getcurrentVolume Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::volumioRetrievevolume Aug 20 13:55:54 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 13:55:54 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Aug 20 13:55:54 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 13:55:54 volumio volumio[1091]: info: Cannot mount NAS HACUONG at system boot, trial number 1 ,retrying in 5 seconds Aug 20 13:55:54 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 13:55:54 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Aug 20 13:55:54 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 13:55:54 volumio volumio[1091]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Aug 20 13:55:54 volumio volumio[1091]: MPD error: Cannot assign requested address Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: Reloading queue from file Aug 20 13:55:54 volumio volumio[1091]: info: VolumeController:: Volume=76 Mute =true Aug 20 13:55:54 volumio volumio[1091]: info: CoreStateMachine::pushState Aug 20 13:55:54 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Aug 20 13:55:54 volumio volumio[1091]: info: CoreStateMachine::updateTrackBlock Aug 20 13:55:54 volumio volumio[1091]: info: CorePlayQueue::getTrackBlock Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::volumioRetrievevolume Aug 20 13:55:54 volumio volumio[1091]: info: CoreStateMachine::setRepeat null single undefined Aug 20 13:55:54 volumio volumio[1091]: info: CoreStateMachine::pushState Aug 20 13:55:54 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Aug 20 13:55:54 volumio volumio[1091]: info: CoreStateMachine::setRandom null Aug 20 13:55:54 volumio volumio[1091]: info: CoreStateMachine::pushState Aug 20 13:55:54 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Aug 20 13:55:54 volumio volumio[1091]: info: Setting Device type: Raspberry PI Aug 20 13:55:54 volumio volumio[1091]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Aug 20 13:55:54 volumio volumio[1091]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d04170 Aug 20 13:55:54 volumio volumio[1091]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Aug 20 13:55:54 volumio volumio[1091]: info: Completed loading Core Plugins Aug 20 13:55:54 volumio volumio[1091]: info: Preparing to generate the ALSA configuration file Aug 20 13:55:54 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 13:55:54 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Aug 20 13:55:54 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 13:55:54 volumio volumio[1091]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 20 13:55:54 volumio volumio[1091]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 20 13:55:54 volumio volumio[1091]: info: Reading ALSA contributions from plugins. Aug 20 13:55:54 volumio ifplugd(eth0)[1068]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Aug 20 13:55:54 volumio ifplugd(eth0)[1068]: client: ifup: interface eth0 already configured Aug 20 13:55:54 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 13:55:54 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Aug 20 13:55:54 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at soc_component_read_no_lock on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 13:55:54 volumio volumio[1091]: info: VolumeController:: Volume=76 Mute =true Aug 20 13:55:54 volumio volumio[1091]: info: CoreStateMachine::pushState Aug 20 13:55:54 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Aug 20 13:55:54 volumio volumio[1091]: info: Asound.conf file unchanged, so no further update is needed Aug 20 13:55:54 volumio volumio[1091]: info: Output device has changed, restarting MPD Aug 20 13:55:54 volumio volumio[1091]: info: Output device has changed, restarting Shairport Sync Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:55:54 volumio sudo[1229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 20 13:55:54 volumio sudo[1229]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:54 volumio sudo[1229]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:54 volumio sudo[1231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 20 13:55:54 volumio sudo[1231]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:54 volumio volumio[1091]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 20 13:55:54 volumio volumio[1091]: info: ___________ START PLUGINS ___________ Aug 20 13:55:54 volumio volumio[1091]: info: ControllerMpd::onStart: Initializing MPD Aug 20 13:55:54 volumio volumio[1091]: info: Creating MPD Configuration file Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 20 13:55:54 volumio volumio[1091]: info: [1724136954640] CoreMusicLibrary::Adding element Máy chủ Media Aug 20 13:55:54 volumio sudo[1239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 20 13:55:54 volumio sudo[1239]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:55:54 volumio sudo[1239]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:54 volumio sudo[1241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 20 13:55:54 volumio sudo[1241]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:54 volumio systemd[1]: Listening on mpd.socket. Aug 20 13:55:54 volumio systemd[1]: Starting Music Player Daemon... Aug 20 13:55:54 volumio volumio[1091]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:55:54 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 20 13:55:54 volumio systemd[1]: mpd.service: Succeeded. Aug 20 13:55:54 volumio systemd[1]: Stopped Music Player Daemon. Aug 20 13:55:54 volumio systemd[1]: Starting Music Player Daemon... Aug 20 13:55:54 volumio volumio[1091]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 20 13:55:54 volumio volumio[1091]: info: [1724136954680] CoreMusicLibrary::Adding element Last_100 Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 20 13:55:54 volumio volumio[1091]: info: [1724136954681] CoreMusicLibrary::Adding element Webradio Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 20 13:55:54 volumio volumio[1091]: info: Initializing BBC Radios Aug 20 13:55:54 volumio ifplugd(eth0)[1068]: Program executed successfully. Aug 20 13:55:54 volumio sudo[1248]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 20 13:55:54 volumio sudo[1248]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:54 volumio sudo[1248]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 20 13:55:54 volumio sudo[1248]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: Loading i18n strings for locale vi Aug 20 13:55:54 volumio volumio[1091]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Aug 20 13:55:54 volumio volumio[1091]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: FusionDsp - mixtype--------------------- Hardware Aug 20 13:55:54 volumio volumio[1091]: info: Loading i18n strings for locale vi Aug 20 13:55:54 volumio volumio[1091]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Aug 20 13:55:54 volumio volumio[1091]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Aug 20 13:55:54 volumio sudo[1265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Aug 20 13:55:54 volumio sudo[1265]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:54 volumio volumio[1091]: info: Loading i18n strings for locale vi Aug 20 13:55:54 volumio volumio[1091]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Aug 20 13:55:54 volumio volumio[1091]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 20 13:55:54 volumio volumio[1091]: info: Volumio Calling Home Aug 20 13:55:54 volumio volumio[1091]: info: Preparing to generate the ALSA configuration file Aug 20 13:55:54 volumio sudo[1273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Aug 20 13:55:54 volumio sudo[1273]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:54 volumio systemd[1]: Started RoonBridge. Aug 20 13:55:54 volumio sudo[1277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Aug 20 13:55:54 volumio sudo[1277]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:54 volumio sudo[1265]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:54 volumio sudo[1280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Aug 20 13:55:54 volumio sudo[1280]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:54 volumio volumio[1091]: Unhandled rejection Error: No sockets available, cannot start. Aug 20 13:55:54 volumio volumio[1091]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Aug 20 13:55:54 volumio volumio[1091]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Aug 20 13:55:54 volumio volumio[1091]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Aug 20 13:55:54 volumio volumio[1091]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Aug 20 13:55:54 volumio volumio[1091]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Aug 20 13:55:54 volumio volumio[1091]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Aug 20 13:55:54 volumio volumio[1091]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Aug 20 13:55:54 volumio volumio[1091]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Aug 20 13:55:54 volumio volumio[1091]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Aug 20 13:55:54 volumio volumio[1091]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Aug 20 13:55:54 volumio volumio[1091]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Aug 20 13:55:54 volumio volumio[1091]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Aug 20 13:55:54 volumio volumio[1091]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Aug 20 13:55:54 volumio volumio[1091]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Aug 20 13:55:54 volumio volumio[1091]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Aug 20 13:55:54 volumio volumio[1091]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Aug 20 13:55:54 volumio volumio[1091]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 20 13:55:54 volumio volumio[1091]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 20 13:55:54 volumio volumio[1091]: info: Reading ALSA contributions from plugins. Aug 20 13:55:54 volumio volumio[1091]: info: touch_display: No backlight interface detected. Aug 20 13:55:54 volumio volumio[1091]: info: MPD Permissions set Aug 20 13:55:54 volumio volumio[1091]: info: MPD Permissions set Aug 20 13:55:54 volumio volumio[1091]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Aug 20 13:55:54 volumio systemd[1]: Reloading. Aug 20 13:55:54 volumio volumio[1091]: info: Starting Shairport Sync Aug 20 13:55:54 volumio sudo[1298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Aug 20 13:55:54 volumio sudo[1298]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:54 volumio volumio[1091]: info: Starting Shairport Sync Aug 20 13:55:54 volumio volumio[1091]: info: Starting Shairport Sync Aug 20 13:55:54 volumio sudo[1301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Aug 20 13:55:54 volumio sudo[1301]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:54 volumio sudo[1304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:55:54 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:55:54 volumio sudo[1304]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:54 volumio volumio[1091]: info: Asound.conf file unchanged, so no further update is needed Aug 20 13:55:54 volumio volumio[1091]: info: Output device has changed, restarting MPD Aug 20 13:55:54 volumio sudo[1324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 20 13:55:54 volumio sudo[1324]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:54 volumio sudo[1301]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:54 volumio sudo[1298]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:54 volumio sudo[1320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 20 13:55:54 volumio sudo[1320]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:54 volumio volumio[1091]: info: Output device has changed, restarting Shairport Sync Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:54 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:55:54 volumio bthelper[817]: Changing power off succeeded Aug 20 13:55:54 volumio sudo[1326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 20 13:55:54 volumio sudo[1326]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:54 volumio sudo[1326]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:54 volumio sudo[1330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 20 13:55:54 volumio sudo[1330]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:54 volumio volumio[1091]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 20 13:55:55 volumio volumio[1091]: info: MPD Permissions set Aug 20 13:55:55 volumio volumio[1091]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Aug 20 13:55:55 volumio volumio[1091]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Aug 20 13:55:55 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:55 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:55 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:55 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:55 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:55 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:55 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:55 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:55 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:55:55 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:55 volumio volumio[1091]: info: Starting Shairport Sync Aug 20 13:55:55 volumio sudo[1341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 20 13:55:55 volumio sudo[1341]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:55 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 20 13:55:55 volumio volumio-remote-updater[809]: [2024-08-20 13:55:55] [connect] Successful connection Aug 20 13:55:55 volumio volumio-remote-updater[809]: [2024-08-20 13:55:55] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1724136955 101 Aug 20 13:55:55 volumio volumio[1091]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 3 Aug 20 13:55:55 volumio bthelper[817]: [CHG] Controller 2C:CF:67:17:93:2D Class: 0x0000041c Aug 20 13:55:55 volumio bthelper[817]: Changing power on succeeded Aug 20 13:55:55 volumio systemd[1]: serial-getty@ttyAMA10.service: Current command vanished from the unit file, execution of the command list won't be resumed. Aug 20 13:55:55 volumio sudo[1280]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:55 volumio volumio[1091]: info: touch_display: systemctl daemon-reload succeeded. Aug 20 13:55:55 volumio sudo[1273]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:55 volumio systemd[1]: Reloading. Aug 20 13:55:55 volumio volumio[1091]: info: touch_display: systemctl stop getty@tty1.service succeeded. Aug 20 13:55:55 volumio sudo[1345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Aug 20 13:55:55 volumio sudo[1345]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:55 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 20 13:55:55 volumio RoonBridge[1271]: 00:00:00.004 Warn: get lock file path: /tmp/.rnbgem0- Aug 20 13:55:55 volumio volumio[1091]: info: minidlna: Found miniDLNA version 1.2.1 Aug 20 13:55:55 volumio volumio[1091]: info: minidlna: Starting minidlna.service Aug 20 13:55:55 volumio sudo[1361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Aug 20 13:55:55 volumio sudo[1361]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:55 volumio sudo[1277]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:55 volumio volumio[1091]: info: touch_display: systemctl disable getty@tty1.service succeeded. Aug 20 13:55:55 volumio RoonBridge[1271]: 00:00:00.173 Trace: [childprocess] using unix child process Aug 20 13:55:55 volumio systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server. Aug 20 13:55:55 volumio systemd[1]: Started Volumio Kiosk. Aug 20 13:55:55 volumio sudo[1345]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:55 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 20 13:55:55 volumio volumio[1091]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Aug 20 13:55:55 volumio volumio[1091]: info: touch_display: Volumio Kiosk started. Aug 20 13:55:55 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 20 13:55:55 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 20 13:55:55 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 20 13:55:55 volumio systemd[1]: mpd.service: Succeeded. Aug 20 13:55:55 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:55:55 volumio systemd[1]: Stopped Music Player Daemon. Aug 20 13:55:55 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:55:55 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:55:55 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:55:55 volumio sudo[1361]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:55 volumio systemd[1]: Starting Music Player Daemon... Aug 20 13:55:55 volumio volumio[1091]: info: minidlna: systemctl start minidlna.service succeeded. Aug 20 13:55:55 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 20 13:55:55 volumio RoonBridge[1271]: 00:00:00.219 Debug: PathForResource, filename: ../.update Aug 20 13:55:55 volumio sudo[1304]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:55 volumio sudo[1324]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:55 volumio sudo[1341]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:55 volumio volumio[1091]: info: Shairport-Sync Started Aug 20 13:55:55 volumio volumio[1091]: Error adding Membership: Error: addMembership EINVAL Aug 20 13:55:55 volumio volumio[1091]: info: Shairport-Sync Started Aug 20 13:55:55 volumio volumio[1091]: info: Shairport-Sync Started Aug 20 13:55:55 volumio sudo[1320]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:55 volumio volumio[1091]: info: Shairport-Sync Started Aug 20 13:55:55 volumio volumio[1091]: info: touch_display: X display number found: Aug 20 13:55:55 volumio sudo[1373]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 20 13:55:55 volumio sudo[1373]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:55 volumio sudo[1373]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 20 13:55:55 volumio sudo[1373]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:55 volumio RoonBridge[1271]: 00:00:00.269 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/../.update Aug 20 13:55:55 volumio RoonBridge[1271]: 00:00:00.272 Debug: PathForResource, filename: RAATServer Aug 20 13:55:55 volumio RoonBridge[1271]: 00:00:00.272 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Aug 20 13:55:55 volumio RoonBridge[1271]: 00:00:00.272 Debug: PathForResource, filename: RoonBridgeHelper Aug 20 13:55:55 volumio RoonBridge[1271]: 00:00:00.272 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Aug 20 13:55:55 volumio RoonBridge[1271]: Initializing Aug 20 13:55:55 volumio RoonBridge[1271]: 00:00:00.293 Info: Starting /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Aug 20 13:55:55 volumio startx[1364]: X.Org X Server 1.20.4 Aug 20 13:55:55 volumio startx[1364]: X Protocol Version 11, Revision 0 Aug 20 13:55:55 volumio startx[1364]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Aug 20 13:55:55 volumio startx[1364]: Current Operating System: Linux volumio 6.1.69-v8+ #1710 SMP PREEMPT Thu Dec 21 13:21:40 GMT 2023 aarch64 Aug 20 13:55:55 volumio startx[1364]: Kernel command line: reboot=w coherent_pool=1M 8250.nr_uarts=1 pci=pcie_bus_safe snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 smsc95xx.macaddr=2C:CF:67:17:93:2B vc_mem.mem_base=0x3fc00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyAMA10,115200 console=tty1 imgpart=UUID=7462f9ec-50f6-4f55-9f22-79cca1bee42a imgfile=/volumio_current.sqsh bootpart=UUID=6B37-2179 datapart=UUID=1edb70c0-e4ed-4e52-a224-cb4221f6e8fd uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Aug 20 13:55:55 volumio startx[1364]: Build Date: 04 April 2023 07:50:56AM Aug 20 13:55:55 volumio startx[1364]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Aug 20 13:55:55 volumio startx[1364]: Current version of pixman: 0.36.0 Aug 20 13:55:55 volumio startx[1364]: Before reporting problems, check http://wiki.x.org Aug 20 13:55:55 volumio startx[1364]: to make sure that you have the latest version. Aug 20 13:55:55 volumio startx[1364]: Markers: (--) probed, (**) from config file, (==) default setting, Aug 20 13:55:55 volumio startx[1364]: (++) from command line, (!!) notice, (II) informational, Aug 20 13:55:55 volumio startx[1364]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Aug 20 13:55:55 volumio startx[1364]: (==) Log file: "/var/log/Xorg.0.log", Time: Tue Aug 20 13:55:55 2024 Aug 20 13:55:55 volumio startx[1364]: (==) Using config directory: "/etc/X11/xorg.conf.d" Aug 20 13:55:55 volumio startx[1364]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Aug 20 13:55:55 volumio RoonBridge[1271]: 00:00:00.316 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Aug 20 13:55:55 volumio volumio[1091]: info: touch_display: X display number found: 0 Aug 20 13:55:55 volumio RoonBridge[1271]: Not Running (.o) Aug 20 13:55:55 volumio volumio[1091]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Aug 20 13:55:55 volumio volumio[1091]: info: touch_display: X display number found: 0 Aug 20 13:55:55 volumio RoonBridge[1271]: Running Aug 20 13:55:56 volumio RoonBridge[1271]: 00:00:00.009 Warn: get lock file path: /tmp/.rnbhgem0- Aug 20 13:55:56 volumio mpd[1394]: Aug 20 13:55 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 20 13:55:56 volumio systemd[1]: Started Music Player Daemon. Aug 20 13:55:56 volumio sudo[1241]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:56 volumio sudo[1330]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:56 volumio sudo[1231]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:56 volumio volumio[1091]: info: Completed starting Core Plugins Aug 20 13:55:56 volumio volumio[1091]: info: ------------------------------------------- Aug 20 13:55:56 volumio volumio[1091]: info: ----- MyVolumio plugins startup ---- Aug 20 13:55:56 volumio volumio[1091]: info: ------------------------------------------- Aug 20 13:55:56 volumio volumio[1091]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 20 13:55:56 volumio volumio[1091]: info: MPD running with PID1394 Aug 20 13:55:56 volumio volumio[1091]: ,establishing connection Aug 20 13:55:56 volumio volumio[1091]: error: MPD error: The expression evaluated to a falsy value: Aug 20 13:55:56 volumio volumio[1091]: assert.ok(self.idling) Aug 20 13:55:56 volumio volumio[1091]: error: The expression evaluated to a falsy value: Aug 20 13:55:56 volumio volumio[1091]: assert.ok(self.idling) Aug 20 13:55:56 volumio volumio[1091]: error: MPD error: The expression evaluated to a falsy value: Aug 20 13:55:56 volumio volumio[1091]: assert.ok(self.idling) Aug 20 13:55:56 volumio volumio[1091]: error: The expression evaluated to a falsy value: Aug 20 13:55:56 volumio volumio[1091]: assert.ok(self.idling) Aug 20 13:55:56 volumio volumio[1091]: error: MPD error: The expression evaluated to a falsy value: Aug 20 13:55:56 volumio volumio[1091]: assert.ok(self.idling) Aug 20 13:55:56 volumio volumio[1091]: error: The expression evaluated to a falsy value: Aug 20 13:55:56 volumio volumio[1091]: assert.ok(self.idling) Aug 20 13:55:56 volumio volumio[1091]: error: updateQueue error: null Aug 20 13:55:56 volumio startx[1364]: V3D 7.1 not supported by this version of Mesa. Aug 20 13:55:56 volumio volumio[1091]: info: camilladsp spawned new process with pid 1455, instance 1, run: true Aug 20 13:55:56 volumio volumio[1091]: info: camilladsp service started and running in background, instance 1 Aug 20 13:55:56 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:55:56 volumio volumio[1091]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 384000 <-AAAAAAAAAAAAA Aug 20 13:55:56 volumio volumio[1091]: info: FusionDsp loaded Aug 20 13:55:56 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 13:55:56 volumio kernel: broken atomic modeset userspace detected, disabling atomic Aug 20 13:55:56 volumio volumio[1091]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 20 13:55:56 volumio volumio[1091]: info: Adding Signal Path Element [object Object] Aug 20 13:55:56 volumio volumio[1091]: info: Adding fusiondspeq DSP Signal Path Element Aug 20 13:55:56 volumio volumio[1091]: info: FusionDsp - ---- installed callbackRead Aug 20 13:55:56 volumio sudo[1464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 20 13:55:56 volumio volumio[1091]: info: FusionDsp - If filter freq >samplerate/2 then disable it Aug 20 13:55:56 volumio sudo[1464]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:56 volumio volumio[1091]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Aug 20 13:55:56 volumio systemd[1]: Started FusionDsp Daemon. Aug 20 13:55:56 volumio sudo[1464]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:56 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 20 13:55:56 volumio volumio[1091]: info: FusionDsp - {"Reload":{"result":"Ok"}} Aug 20 13:55:57 volumio startx[1364]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Aug 20 13:55:57 volumio volumio[1091]: info: touch_display: Setting screensaver timeout to 120 seconds. Aug 20 13:55:58 volumio dhcpcd[877]: eth0: using static address 192.168.1.98/24 Aug 20 13:55:58 volumio dhcpcd[877]: eth0: adding route to 192.168.1.0/24 Aug 20 13:55:58 volumio dhcpcd[877]: eth0: adding default route via 192.168.1.3 Aug 20 13:55:58 volumio avahi-daemon[815]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.98. Aug 20 13:55:58 volumio avahi-daemon[815]: New relevant interface eth0.IPv4 for mDNS. Aug 20 13:55:58 volumio avahi-daemon[815]: Registering new address record for 192.168.1.98 on eth0.IPv4. Aug 20 13:55:58 volumio sudo[1595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 20 13:55:58 volumio sudo[1595]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:58 volumio sudo[1595]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:58 volumio sudo[1597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 20 13:55:58 volumio sudo[1597]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:58 volumio sudo[1597]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:58 volumio volumio[1091]: verbose: New Socket.io Connection to 192.168.1.98 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Aug 20 13:55:58 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 13:55:59 volumio sudo[1612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 20 13:55:59 volumio sudo[1612]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:59 volumio sudo[1612]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:59 volumio sudo[1614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 20 13:55:59 volumio sudo[1614]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:59 volumio sudo[1614]: pam_unix(sudo:session): session closed for user root Aug 20 13:55:59 volumio volumio[1091]: verbose: New Socket.io Connection to 192.168.1.98 from 192.168.1.100 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Aug 20 13:55:59 volumio volumio[1091]: info: Discovery: adding 1521eca5-005d-449b-b81e-999a69856919 Aug 20 13:55:59 volumio volumio[1091]: info: Discovery: Found device Volumio Aug 20 13:55:59 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:55:59 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:55:59 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 13:55:59 volumio volumio[1091]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 13:55:59 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 13:55:59 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:55:59 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:55:59 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 20 13:55:59 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 20 13:55:59 volumio volumio[1091]: info: Received Get System Info Aug 20 13:55:59 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 13:55:59 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 13:55:59 volumio volumio[1091]: info: Discovery: Getting this device information Aug 20 13:55:59 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:55:59 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:55:59 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 13:55:59 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:55:59 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:55:59 volumio volumio[1091]: info: Listing playlists Aug 20 13:55:59 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 20 13:55:59 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 20 13:55:59 volumio volumio[1091]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 13:55:59 volumio ntpd[1064]: Listen normally on 3 eth0 192.168.1.98:123 Aug 20 13:55:59 volumio ntpd[1064]: new interface(s) found: waking up resolver Aug 20 13:55:59 volumio sudo[1630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.100/\\\\C:\\Users\\nccus\\OneDrive\\Music /mnt/NAS/HACUONG Aug 20 13:55:59 volumio sudo[1630]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:55:59 volumio kernel: CIFS: Attempting to mount \\192.168.1.100\ Aug 20 13:56:00 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:56:00 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:00 volumio nmbd[1050]: [2024/08/20 13:56:00.603320, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 20 13:56:00 volumio systemd[1]: Started Samba NMB Daemon. Aug 20 13:56:00 volumio nmbd[1050]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Aug 20 13:56:00 volumio systemd[1]: Starting Samba Winbind Daemon... Aug 20 13:56:00 volumio winbindd[1708]: [2024/08/20 13:56:00.707025, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Aug 20 13:56:00 volumio winbindd[1708]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Aug 20 13:56:00 volumio winbindd[1708]: [2024/08/20 13:56:00.733254, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 20 13:56:00 volumio systemd[1]: Started Samba Winbind Daemon. Aug 20 13:56:00 volumio winbindd[1708]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Aug 20 13:56:00 volumio systemd[1]: Starting Samba SMB Daemon... Aug 20 13:56:00 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 20 13:56:00 volumio smbd[1715]: [2024/08/20 13:56:00.969148, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 20 13:56:00 volumio smbd[1715]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Aug 20 13:56:00 volumio systemd[1]: Started Samba SMB Daemon. Aug 20 13:56:00 volumio systemd[1]: Reached target Multi-User System. Aug 20 13:56:00 volumio systemd[1]: Reached target Graphical Interface. Aug 20 13:56:00 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Aug 20 13:56:01 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 20 13:56:01 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Aug 20 13:56:01 volumio volumio[1091]: info: Received Get System Info Aug 20 13:56:01 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 13:56:01 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 13:56:01 volumio volumio[1091]: info: Discovery: Getting this device information Aug 20 13:56:01 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:56:01 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Aug 20 13:56:01 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:01 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 13:56:01 volumio systemd[1]: Startup finished in 11.785s (kernel) + 13.539s (userspace) = 25.324s. Aug 20 13:56:01 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Aug 20 13:56:01 volumio volumio[1091]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Aug 20 13:56:01 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 13:56:02 volumio volumio[1091]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::volumioGetVisibleSources Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:56:02 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 20 13:56:02 volumio volumio[1091]: info: Received Get System Info Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 13:56:02 volumio volumio[1091]: info: Discovery: Getting this device information Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:56:02 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:56:02 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:02 volumio volumio[1091]: info: Listing playlists Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 20 13:56:02 volumio volumio[1091]: info: Received Get System Info Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 13:56:02 volumio volumio[1091]: info: Discovery: Getting this device information Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:56:02 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:02 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 13:56:03 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Aug 20 13:56:03 volumio sudo[1743]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 20 13:56:03 volumio sudo[1743]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:03 volumio sudo[1743]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:03 volumio sudo[1746]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 20 13:56:03 volumio sudo[1746]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:03 volumio sudo[1746]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:03 volumio sudo[1749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 20 13:56:03 volumio sudo[1749]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:03 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Aug 20 13:56:03 volumio sudo[1749]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:03 volumio volumio[1091]: info: Upmpdcli Daemon Started Aug 20 13:56:03 volumio volumio[1751]: Generating RSA private key, 4096 bit long modulus (2 primes) Aug 20 13:56:03 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:56:03 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:04 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 20 13:56:04 volumio volumio[1091]: info: Received Get System Info Aug 20 13:56:04 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 13:56:04 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 13:56:04 volumio volumio[1091]: info: Discovery: Getting this device information Aug 20 13:56:04 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:56:04 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:04 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 13:56:04 volumio volumio[1091]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=3.742&uuid=cf7e43b666faa23dd9c1db85f84d3c77" http://updates.volumio.org/downloader-v1/track-device Aug 20 13:56:04 volumio volumio[1091]: % Total % Received % Xferd Average Speed Time Time Time Current Aug 20 13:56:04 volumio volumio[1091]: Dload Upload Total Spent Left Speed Aug 20 13:56:04 volumio volumio[1091]: [132B blob data] Aug 20 13:56:04 volumio volumio[1091]: retrying in 5 seconds, trial 0 Aug 20 13:56:04 volumio volumio[1091]: info: Volumio Calling Home Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Aug 20 13:56:05 volumio volumio[1091]: info: Adding plugin bluetooth to MyMusic Plugins Aug 20 13:56:05 volumio volumio[1091]: info: Adding plugin multiroom to MyMusic Plugins Aug 20 13:56:05 volumio volumio[1091]: info: Adding plugin metavolumio to MyMusic Plugins Aug 20 13:56:05 volumio volumio[1751]: ................................++++ Aug 20 13:56:05 volumio volumio[1091]: info: Adding plugin cd_controller to MyMusic Plugins Aug 20 13:56:05 volumio volumio[1091]: info: Adding plugin smart_inputs to MyMusic Plugins Aug 20 13:56:05 volumio volumio[1091]: info: Adding plugin tidalconnect to MyMusic Plugins Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Aug 20 13:56:05 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:56:05 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:56:05 volumio volumio[1091]: info: Starting MyVolumio Remote Streaming Endpoints Aug 20 13:56:05 volumio volumio[1091]: info: MyVolumio login type: Token Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Aug 20 13:56:05 volumio volumio[1091]: info: Starting Streaming Service Transparent Proxy Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Aug 20 13:56:05 volumio volumio[1091]: info: Streaming services startup Aug 20 13:56:05 volumio volumio[1091]: info: Starting Streaming Daemon Aug 20 13:56:05 volumio sudo[1777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 20 13:56:05 volumio sudo[1777]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:05 volumio sudo[1777]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:05 volumio volumio[1091]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Aug 20 13:56:05 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 20 13:56:05 volumio volumio[1091]: error: Cannot start Volumio Streaming Daemon Aug 20 13:56:05 volumio volumio[1091]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 20 13:56:05 volumio volumio[1091]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 20 13:56:05 volumio volumio[1091]: info: Volumio called home Aug 20 13:56:06 volumio volumio[1091]: STREAMING PROXY: Starting server on port 3245 Aug 20 13:56:06 volumio volumio[1091]: Node JS runtime: 14 Aug 20 13:56:06 volumio volumio[1091]: error: MyVolumio Custom Token format not valid, refreshing it Aug 20 13:56:07 volumio volumio[1091]: info: MyVolumio login type: Token Aug 20 13:56:07 volumio volumio[1091]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Aug 20 13:56:08 volumio volumio[1091]: info: MyVolumio token set successfully Aug 20 13:56:08 volumio volumio[1091]: info: MYVOLUMIO: Adding device Aug 20 13:56:08 volumio volumio[1091]: info: MYVOLUMIO: Evaluating Server Aug 20 13:56:08 volumio volumio[1091]: info: MyVolumio Plan changed: premium Aug 20 13:56:08 volumio volumio[1091]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Aug 20 13:56:08 volumio volumio[1091]: info: Removing browser output: myVolumio user plan is not superstar Aug 20 13:56:08 volumio volumio[1091]: info: Removing audio output: Aug 20 13:56:08 volumio volumio[1091]: info: MYVOLUMIO: Adding device Aug 20 13:56:08 volumio volumio[1091]: info: MYVOLUMIO: Evaluating Server Aug 20 13:56:08 volumio volumio[1091]: info: Remote config written successfully Aug 20 13:56:08 volumio volumio[1091]: info: Starting Tunnel 1 Aug 20 13:56:08 volumio volumio[1091]: info: Starting Tunnel Connection Checker Aug 20 13:56:08 volumio volumio[1091]: info: Completed starting MyVolumio Plugin Aug 20 13:56:09 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 20 13:56:09 volumio volumio[1091]: info: MYVolumio Device enabled Aug 20 13:56:09 volumio volumio[1091]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Aug 20 13:56:09 volumio volumio[1091]: info: MyVolumio status changed Aug 20 13:56:09 volumio volumio[1091]: info: Streaming services startup Aug 20 13:56:09 volumio volumio[1091]: info: Starting Streaming Daemon Aug 20 13:56:09 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Aug 20 13:56:09 volumio sudo[1996]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 20 13:56:09 volumio sudo[1996]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:09 volumio volumio[1091]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Aug 20 13:56:09 volumio sudo[1996]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:09 volumio volumio[1091]: info: [1724136969387] Starting BluetoothController Aug 20 13:56:09 volumio volumio[1091]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Aug 20 13:56:09 volumio sudo[1630]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:09 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Aug 20 13:56:09 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Aug 20 13:56:09 volumio volumio[1091]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Aug 20 13:56:09 volumio sudo[1999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Aug 20 13:56:09 volumio sudo[1999]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:09 volumio sudo[1999]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:09 volumio volumio[1091]: info: MRS: MultiRoom plugin initialized Aug 20 13:56:09 volumio volumio[1091]: info: MRS: STOPPING SNAPCLIENT Aug 20 13:56:09 volumio volumio[1091]: info: MRS: Snap server stop Aug 20 13:56:09 volumio sudo[2015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Aug 20 13:56:09 volumio sudo[2015]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:09 volumio volumio[1091]: info: MRS: STOPPING volumioStreaming Aug 20 13:56:09 volumio sudo[2018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Aug 20 13:56:09 volumio sudo[2018]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:09 volumio sudo[2021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Aug 20 13:56:09 volumio sudo[2021]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:09 volumio sudo[2015]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:09 volumio sudo[2018]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:09 volumio sudo[2024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Aug 20 13:56:09 volumio sudo[2024]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:09 volumio volumio[1091]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Aug 20 13:56:09 volumio sudo[2024]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:09 volumio sudo[2021]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:09 volumio volumio[1091]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Aug 20 13:56:09 volumio volumio[1091]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Aug 20 13:56:09 volumio volumio[1091]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Aug 20 13:56:09 volumio volumio[1091]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Aug 20 13:56:09 volumio volumio[1091]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Aug 20 13:56:09 volumio volumio[1091]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Aug 20 13:56:09 volumio volumio[1091]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Aug 20 13:56:09 volumio volumio[1091]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Aug 20 13:56:09 volumio volumio[1091]: info: Preparing to generate the ALSA configuration file Aug 20 13:56:09 volumio volumio[1091]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 20 13:56:09 volumio volumio[1091]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 20 13:56:09 volumio volumio[1091]: info: Reading ALSA contributions from plugins. Aug 20 13:56:09 volumio volumio[1091]: info: Setting Geolocation for MyVolumio to as2 Aug 20 13:56:09 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:56:09 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:56:09 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: Setting Geolocation for MyVolumio to as2 Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: MRS: Removed streaming files Aug 20 13:56:10 volumio volumio[1091]: info: MRS: volumioStreaming STOPPED Aug 20 13:56:10 volumio volumio[1091]: info: MRS: SNAPSERVER STOPPED Aug 20 13:56:10 volumio volumio[1091]: info: MRS: SNAPCLIENT STOPPED Aug 20 13:56:10 volumio volumio[1091]: info: Cannot mount NAS HACUONG at system boot, trial number 2 ,retrying in 5 seconds Aug 20 13:56:10 volumio volumio[1091]: error: Cannot start Volumio Streaming Daemon Aug 20 13:56:10 volumio volumio[1091]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 20 13:56:10 volumio volumio[1091]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 20 13:56:10 volumio volumio[1091]: info: Asound.conf file unchanged, so no further update is needed Aug 20 13:56:10 volumio volumio[1091]: info: Output device has changed, restarting MPD Aug 20 13:56:10 volumio sudo[2027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 20 13:56:10 volumio sudo[2027]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:10 volumio volumio[1091]: info: Output device has changed, restarting Shairport Sync Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:56:10 volumio sudo[2027]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:10 volumio sudo[2030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 20 13:56:10 volumio sudo[2030]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:10 volumio systemd[1]: Stopping Music Player Daemon... Aug 20 13:56:10 volumio volumio[1091]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 20 13:56:10 volumio systemd[1]: mpd.service: Succeeded. Aug 20 13:56:10 volumio volumio[1091]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 20 13:56:10 volumio systemd[1]: Stopped Music Player Daemon. Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 20 13:56:10 volumio volumio[1091]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Aug 20 13:56:10 volumio volumio[1091]: info: MRS: Pushing multiroomSync output for this device Aug 20 13:56:10 volumio volumio[1091]: info: MRS: Pushing multiroomSync output Aug 20 13:56:10 volumio volumio[1091]: info: Adding audio output: Aug 20 13:56:10 volumio volumio[1091]: info: Adding audio output: Aug 20 13:56:10 volumio volumio[1091]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:56:10 volumio systemd[1]: Starting Music Player Daemon... Aug 20 13:56:10 volumio sudo[2039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio Aug 20 13:56:10 volumio sudo[2039]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:10 volumio volumio[1091]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Aug 20 13:56:10 volumio volumio[1091]: info: Adding METAVOLUMIO REST API Endpoints Aug 20 13:56:10 volumio volumio[1091]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Aug 20 13:56:10 volumio volumio[1091]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Aug 20 13:56:10 volumio volumio[1091]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Aug 20 13:56:10 volumio volumio[1091]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Aug 20 13:56:10 volumio volumio[1091]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Aug 20 13:56:10 volumio volumio[1091]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Aug 20 13:56:10 volumio volumio[1091]: info: Preparing CD Folders Aug 20 13:56:10 volumio volumio[1091]: info: Adding CD REST API Endpoints Aug 20 13:56:10 volumio volumio[1091]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Aug 20 13:56:10 volumio volumio[1091]: info: Starting UDEV Watcher for CD Aug 20 13:56:10 volumio volumio[1091]: info: Detecting CD presence with UDEV Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Aug 20 13:56:10 volumio sudo[2039]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:10 volumio volumio[1091]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Aug 20 13:56:10 volumio volumio[1091]: info: Adding inputs REST Endpoints Aug 20 13:56:10 volumio volumio[1091]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Aug 20 13:56:10 volumio volumio[1091]: info: Scanning Audio Inputs Aug 20 13:56:10 volumio sudo[2035]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 20 13:56:10 volumio sudo[2035]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:10 volumio sudo[2035]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:10 volumio volumio[1091]: info: Checking against Known Cards name Aug 20 13:56:10 volumio volumio[1091]: info: Adding Server instance for streaming Aug 20 13:56:10 volumio volumio[1091]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Aug 20 13:56:10 volumio volumio[1091]: error: Hi Res Audio Failed Login: Missing Login Data Aug 20 13:56:10 volumio volumio[1091]: info: Adding HIGHRESAUDIO REST API Endpoints Aug 20 13:56:10 volumio volumio[1091]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Aug 20 13:56:10 volumio volumio[1091]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Aug 20 13:56:10 volumio volumio[1091]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Aug 20 13:56:10 volumio volumio[1091]: info: Refreshing QOBUZ token Aug 20 13:56:10 volumio volumio[1091]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Aug 20 13:56:10 volumio volumio[1091]: info: [MyVolumio PluginManager] Plugin tidalconnect disabled by user. Not starting Aug 20 13:56:10 volumio volumio[1091]: info: Stopping AccessToken refresher cron Aug 20 13:56:10 volumio volumio[1091]: info: AccessToken refresher cron started Aug 20 13:56:10 volumio volumio[1091]: info: Adding TIDAL REST API Endpoints Aug 20 13:56:10 volumio volumio[1091]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Aug 20 13:56:10 volumio volumio[1091]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Aug 20 13:56:10 volumio volumio[1091]: info: Bluetooth name changed to Volumio Aug 20 13:56:10 volumio volumio[1091]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Aug 20 13:56:10 volumio volumio[1091]: info: MPD Permissions set Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: Starting Shairport Sync Aug 20 13:56:10 volumio sudo[2054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 20 13:56:10 volumio sudo[2054]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:10 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 20 13:56:10 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 20 13:56:10 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 20 13:56:10 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 20 13:56:10 volumio sudo[2054]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:10 volumio volumio[1091]: info: Shairport-Sync Started Aug 20 13:56:10 volumio mpd[2047]: Aug 20 13:56 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 20 13:56:10 volumio systemd[1]: Started Music Player Daemon. Aug 20 13:56:10 volumio sudo[2030]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:10 volumio volumio[1091]: error: updateQueue error: null Aug 20 13:56:10 volumio volumio[1091]: info: Access Token successfully retrieved Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 20 13:56:10 volumio volumio[1091]: info: [1724136970794] CoreMusicLibrary::Adding element QOBUZ Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 20 13:56:10 volumio volumio[1091]: Cannot find translation for source QOBUZ Aug 20 13:56:10 volumio volumio[1091]: info: Stopping AccessToken refresher cron for QOBUZ Aug 20 13:56:10 volumio volumio[1091]: info: AccessToken refresher cron started for QOBUZ Aug 20 13:56:10 volumio volumio[1091]: info: Adding QOBUZ REST API Endpoints Aug 20 13:56:10 volumio volumio[1091]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Aug 20 13:56:10 volumio volumio[1091]: info: BOOT COMPLETED Aug 20 13:56:10 volumio volumio[1091]: [Metrics] CommandRouter: 18s 878.44ms Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::volumiosetStartupVolume Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::Close All Modals sent Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::Close All Modals sent Aug 20 13:56:10 volumio volumio[1091]: info: Updating MyVolumio device info Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:56:10 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:56:11 volumio volumio[1091]: info: Updating MyVolumio device info Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:56:11 volumio volumio[1091]: info: Successfully Added MyVolumio device Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 13:56:11 volumio volumio[1091]: info: Retrieving Cloud Streaming UI Aug 20 13:56:11 volumio volumio[1091]: info: Getting Tidal Cloud Configuration Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 13:56:11 volumio volumio[1091]: info: Getting Qobuz Cloud Configuration Aug 20 13:56:11 volumio volumio[1091]: info: Asking plugin for UI Config Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 13:56:11 volumio volumio[1091]: info: Getting Spotify Cloud Configuration Aug 20 13:56:11 volumio volumio[1091]: info: Asking plugin for UI Config Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 13:56:11 volumio volumio[1091]: info: Saving Spotify Acccount Aug 20 13:56:11 volumio volumio[1091]: info: Got it Aug 20 13:56:11 volumio volumio[1091]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 20 13:56:11 volumio volumio[1091]: info: Got Tidal Cloud Configuration Aug 20 13:56:11 volumio volumio[1091]: info: Got it Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::volumioGetBrowseSources Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::volumioGetBrowseSources Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::volumioGetBrowseSources Aug 20 13:56:11 volumio volumio[1091]: info: Successfully Added MyVolumio device Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 20 13:56:11 volumio volumio[1091]: info: Successfully Updated MyVolumio device Aug 20 13:56:11 volumio volumio[1091]: info: Successfully Updated MyVolumio device Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 20 13:56:11 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 20 13:56:12 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 20 13:56:13 volumio sudo[2065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Aug 20 13:56:13 volumio sudo[2065]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:13 volumio systemd[1]: Started Volumio Bluetooth Module. Aug 20 13:56:13 volumio sudo[2065]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:13 volumio volumio[1091]: info: Volumio BT Module successfully started Aug 20 13:56:13 volumio sudo[2068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Aug 20 13:56:13 volumio sudo[2068]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:13 volumio volumiobt[2067]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Aug 20 13:56:13 volumio sudo[2068]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:14 volumio sudo[2076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Aug 20 13:56:14 volumio sudo[2076]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:14 volumio systemd[1]: Started MyVolumio SSH Tunnel. Aug 20 13:56:14 volumio sudo[2076]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:14 volumio volumio[1091]: info: Remote SSH Started Aug 20 13:56:14 volumio autossh[2079]: port set to 0, monitoring disabled Aug 20 13:56:14 volumio autossh[2079]: starting ssh (count 1) Aug 20 13:56:14 volumio autossh[2079]: ssh child pid is 2082 Aug 20 13:56:14 volumio volumio[1091]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Aug 20 13:56:14 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:56:14 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:14 volumio sudo[2083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Aug 20 13:56:14 volumio sudo[2083]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:14 volumio volumiobt[2067]: pulseaudio: no process found Aug 20 13:56:14 volumio sudo[2083]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:14 volumio dbus-daemon[811]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.24' (uid=1000 pid=2087 comm="/usr/bin/pulseaudio --high-priority=true ") Aug 20 13:56:14 volumio systemd[1]: Starting RealtimeKit Scheduling Policy Service... Aug 20 13:56:14 volumio volumio[1091]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 20 13:56:14 volumio dbus-daemon[811]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Aug 20 13:56:14 volumio rtkit-daemon[2088]: Successfully called chroot. Aug 20 13:56:14 volumio rtkit-daemon[2088]: Successfully dropped privileges. Aug 20 13:56:14 volumio rtkit-daemon[2088]: Successfully limited resources. Aug 20 13:56:14 volumio rtkit-daemon[2088]: Running. Aug 20 13:56:14 volumio rtkit-daemon[2088]: Canary thread running. Aug 20 13:56:14 volumio rtkit-daemon[2088]: Watchdog thread running. Aug 20 13:56:14 volumio dbus-daemon[811]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.25' (uid=0 pid=2088 comm="/usr/lib/rtkit/rtkit-daemon ") Aug 20 13:56:14 volumio systemd[1]: Started RealtimeKit Scheduling Policy Service. Aug 20 13:56:14 volumio systemd[1]: Starting Authorization Manager... Aug 20 13:56:14 volumio volumio[1091]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 20 13:56:14 volumio polkitd[2091]: started daemon version 0.105 using authority implementation `local' version `0.105' Aug 20 13:56:14 volumio dbus-daemon[811]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Aug 20 13:56:14 volumio systemd[1]: Started Authorization Manager. Aug 20 13:56:14 volumio volumiossh-tunnel[2078]: Warning: Permanently added '[as2.myvolumio.org]:2222,[165.232.189.9]:2222' (RSA) to the list of known hosts. Aug 20 13:56:14 volumio pulseaudio[2087]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Aug 20 13:56:14 volumio pulseaudio[2087]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Aug 20 13:56:14 volumio bluetoothd[898]: Endpoint registered: sender=:1.45 path=/MediaEndpoint/A2DPSource Aug 20 13:56:14 volumio bluetoothd[898]: Endpoint registered: sender=:1.45 path=/MediaEndpoint/A2DPSink Aug 20 13:56:14 volumio volumiobt[2067]: Applying permissions Aug 20 13:56:14 volumio volumiobt[2067]: Setting BT discoverable and pairable Aug 20 13:56:14 volumio pulseaudio[2087]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Aug 20 13:56:14 volumio kernel: Bluetooth: RFCOMM TTY layer initialized Aug 20 13:56:14 volumio kernel: Bluetooth: RFCOMM socket layer initialized Aug 20 13:56:14 volumio kernel: Bluetooth: RFCOMM ver 1.11 Aug 20 13:56:14 volumio volumiobt[2067]: [CHG] Controller 2C:CF:67:17:93:2D Class: 0x0008041c Aug 20 13:56:14 volumio volumiobt[2067]: [55B blob data] Aug 20 13:56:14 volumio volumiobt[2067]: [117B blob data] Aug 20 13:56:14 volumio volumiobt[2067]: [117B blob data] Aug 20 13:56:14 volumio volumiobt[2067]: [117B blob data] Aug 20 13:56:14 volumio volumiobt[2067]: [117B blob data] Aug 20 13:56:14 volumio volumiobt[2067]: [117B blob data] Aug 20 13:56:14 volumio volumiobt[2067]: [117B blob data] Aug 20 13:56:14 volumio volumiobt[2067]: [117B blob data] Aug 20 13:56:14 volumio volumiobt[2067]: [117B blob data] Aug 20 13:56:14 volumio volumiobt[2067]: [117B blob data] Aug 20 13:56:14 volumio volumiobt[2067]: [bluetooth]# -e power on Aug 20 13:56:14 volumio volumiobt[2067]: Invalid command in menu main: -e Aug 20 13:56:14 volumio volumiobt[2067]: Aug 20 13:56:14 volumio volumiobt[2067]: Use "help" for a list of available commands in a menu. Aug 20 13:56:14 volumio volumiobt[2067]: Use "menu " if you want to enter any submenu. Aug 20 13:56:14 volumio volumiobt[2067]: Use "back" if you want to return to menu main. Aug 20 13:56:14 volumio volumiobt[2067]: [bluetooth]# agent on Aug 20 13:56:14 volumio volumiobt[2067]: Agent is already registered Aug 20 13:56:14 volumio volumiobt[2067]: [bluetooth]# discoverable on Aug 20 13:56:14 volumio volumiobt[2067]: [bluetooth]# pairable on Aug 20 13:56:14 volumio volumiobt[2067]: [bluetooth]# agent NoInputNoOutput Aug 20 13:56:14 volumio volumiobt[2067]: Agent is already registered Aug 20 13:56:14 volumio volumiobt[2067]: [bluetooth]# default-agent Aug 20 13:56:14 volumio volumiobt[2067]: [bluetooth]# quit Aug 20 13:56:14 volumio volumiobt[2067]: [59B blob data] Aug 20 13:56:15 volumio sudo[2103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.100/\\\\C:\\Users\\nccus\\OneDrive\\Music /mnt/NAS/HACUONG Aug 20 13:56:15 volumio sudo[2103]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 20 13:56:15 volumio kernel: CIFS: Attempting to mount \\192.168.1.100\ Aug 20 13:56:15 volumio volumio[1091]: info: MRS: Getting audio outputs on start Aug 20 13:56:15 volumio volumio[1091]: info: MRS: Requesting all other devices output Aug 20 13:56:15 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 20 13:56:17 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 20 13:56:17 volumio volumio[1091]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 20 13:56:17 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 20 13:56:17 volumio volumio[1091]: info: Received Get System Version Aug 20 13:56:17 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 20 13:56:17 volumio volumio[1091]: info: Received Get System Info Aug 20 13:56:17 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 13:56:17 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 13:56:17 volumio volumio[1091]: info: Discovery: Getting this device information Aug 20 13:56:17 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:56:17 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:17 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 13:56:18 volumio volumio[1751]: .............................................................................................................................................................................................................................................................................++++ Aug 20 13:56:18 volumio volumio[1751]: e is 65537 (0x010001) Aug 20 13:56:18 volumio volumio[1751]: writing RSA key Aug 20 13:56:19 volumio systemd[1]: systemd-fsckd.service: Succeeded. Aug 20 13:56:19 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 20 13:56:19 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Aug 20 13:56:20 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Aug 20 13:56:20 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 20 13:56:20 volumio volumio[1091]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Aug 20 13:56:20 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:56:20 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:20 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 20 13:56:21 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 20 13:56:21 volumio volumio[1091]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 20 13:56:21 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 20 13:56:21 volumio volumio[1091]: info: Received Get System Version Aug 20 13:56:21 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 20 13:56:21 volumio volumio[1091]: info: Received Get System Info Aug 20 13:56:21 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 20 13:56:21 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 20 13:56:21 volumio volumio[1091]: info: Discovery: Getting this device information Aug 20 13:56:21 volumio volumio[1091]: info: CoreCommandRouter::volumioGetState Aug 20 13:56:21 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:21 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 20 13:56:22 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Aug 20 13:56:22 volumio volumio[1091]: verbose: ControllerMpd::sendMpdCommand update Aug 20 13:56:22 volumio volumio[1091]: verbose: ControllerMpd::sendMpdCommand status Aug 20 13:56:22 volumio volumio[1091]: info: Aug 20 13:56:22 volumio volumio[1091]: ---------------------------- MPD announces state update: update Aug 20 13:56:22 volumio volumio[1091]: info: sendMpdCommand update took 6 milliseconds Aug 20 13:56:22 volumio volumio[1091]: info: ControllerMpd::getState Aug 20 13:56:22 volumio volumio[1091]: verbose: ControllerMpd::sendMpdCommand status Aug 20 13:56:22 volumio volumio[1091]: info: sendMpdCommand status took 24 milliseconds Aug 20 13:56:22 volumio volumio[1091]: info: sendMpdCommand status took 24 milliseconds Aug 20 13:56:22 volumio volumio[1091]: verbose: ControllerMpd::parseState Aug 20 13:56:22 volumio volumio[1091]: info: Command Router : Notfying DB Updatetrue Aug 20 13:56:22 volumio volumio[1091]: verbose: ControllerMpd::parseState Aug 20 13:56:22 volumio volumio[1091]: info: ControllerMpd::pushState Aug 20 13:56:22 volumio volumio[1091]: info: CoreCommandRouter::servicePushState Aug 20 13:56:22 volumio volumio[1091]: info: CoreStateMachine::pushState Aug 20 13:56:22 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:22 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Aug 20 13:56:22 volumio volumio[1091]: info: MRS: Pushing multiroomSync output update for this device Aug 20 13:56:22 volumio volumio[1091]: info: MRS: Pushing multiroomSync output Aug 20 13:56:22 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:22 volumio volumio[1091]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 20 13:56:22 volumio volumio[1091]: verbose: CURRENT POSITION 0 Aug 20 13:56:22 volumio volumio[1091]: info: CoreStateMachine::syncState stateService stop Aug 20 13:56:22 volumio volumio[1091]: info: CoreStateMachine::syncState currentStatus stop Aug 20 13:56:22 volumio volumio[1091]: info: CoreStateMachine::pushState Aug 20 13:56:22 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:22 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 13:56:22 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Aug 20 13:56:22 volumio volumio[1091]: info: MRS: Pushing multiroomSync output update for this device Aug 20 13:56:22 volumio volumio[1091]: info: MRS: Pushing multiroomSync output Aug 20 13:56:22 volumio volumio[1091]: info: No code Aug 20 13:56:22 volumio volumio[1091]: info: CoreStateMachine::pushState Aug 20 13:56:22 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:22 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Aug 20 13:56:22 volumio volumio[1091]: info: MRS: Pushing multiroomSync output update for this device Aug 20 13:56:22 volumio volumio[1091]: info: MRS: Pushing multiroomSync output Aug 20 13:56:22 volumio volumio[1091]: info: ------------------------------ 98ms Aug 20 13:56:22 volumio volumio[1091]: info: MPD Database updated - AlbumList cache refreshed Aug 20 13:56:22 volumio volumio[1091]: info: Aug 20 13:56:22 volumio volumio[1091]: ---------------------------- MPD announces state update: database Aug 20 13:56:22 volumio volumio[1091]: verbose: ControllerMpd::sendMpdCommand status Aug 20 13:56:22 volumio volumio[1091]: info: Aug 20 13:56:22 volumio volumio[1091]: ---------------------------- MPD announces state update: update Aug 20 13:56:22 volumio volumio[1091]: info: ControllerMpd::getState Aug 20 13:56:22 volumio volumio[1091]: verbose: ControllerMpd::sendMpdCommand status Aug 20 13:56:22 volumio volumio[1091]: info: ControllerMpd::getState Aug 20 13:56:22 volumio volumio[1091]: verbose: ControllerMpd::sendMpdCommand status Aug 20 13:56:22 volumio volumio[1091]: info: sendMpdCommand status took 16 milliseconds Aug 20 13:56:22 volumio volumio[1091]: info: sendMpdCommand status took 16 milliseconds Aug 20 13:56:22 volumio volumio[1091]: info: sendMpdCommand status took 14 milliseconds Aug 20 13:56:22 volumio volumio[1091]: verbose: ControllerMpd::parseState Aug 20 13:56:23 volumio volumio[1091]: info: Command Router : Notfying DB Updatefalse Aug 20 13:56:23 volumio volumio[1091]: info: CoreCommandRouter::Close All Modals sent Aug 20 13:56:23 volumio volumio[1091]: verbose: ControllerMpd::parseState Aug 20 13:56:23 volumio volumio[1091]: verbose: ControllerMpd::parseState Aug 20 13:56:23 volumio volumio[1091]: info: ControllerMpd::pushState Aug 20 13:56:23 volumio volumio[1091]: info: CoreCommandRouter::servicePushState Aug 20 13:56:23 volumio volumio[1091]: info: CoreStateMachine::pushState Aug 20 13:56:23 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:23 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Aug 20 13:56:23 volumio volumio[1091]: info: MRS: Pushing multiroomSync output update for this device Aug 20 13:56:23 volumio volumio[1091]: info: MRS: Pushing multiroomSync output Aug 20 13:56:23 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:23 volumio volumio[1091]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 20 13:56:23 volumio volumio[1091]: verbose: CURRENT POSITION 0 Aug 20 13:56:23 volumio volumio[1091]: info: CoreStateMachine::syncState stateService stop Aug 20 13:56:23 volumio volumio[1091]: info: CoreStateMachine::syncState currentStatus stop Aug 20 13:56:23 volumio volumio[1091]: info: CoreStateMachine::pushState Aug 20 13:56:23 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:23 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 13:56:23 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Aug 20 13:56:23 volumio volumio[1091]: info: MRS: Pushing multiroomSync output update for this device Aug 20 13:56:23 volumio volumio[1091]: info: MRS: Pushing multiroomSync output Aug 20 13:56:23 volumio volumio[1091]: info: No code Aug 20 13:56:23 volumio volumio[1091]: info: CoreStateMachine::pushState Aug 20 13:56:23 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:23 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Aug 20 13:56:23 volumio volumio[1091]: info: MRS: Pushing multiroomSync output update for this device Aug 20 13:56:23 volumio volumio[1091]: info: MRS: Pushing multiroomSync output Aug 20 13:56:23 volumio volumio[1091]: info: ControllerMpd::pushState Aug 20 13:56:23 volumio volumio[1091]: info: CoreCommandRouter::servicePushState Aug 20 13:56:23 volumio volumio[1091]: info: CoreStateMachine::pushState Aug 20 13:56:23 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:23 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Aug 20 13:56:23 volumio volumio[1091]: info: MRS: Pushing multiroomSync output update for this device Aug 20 13:56:23 volumio volumio[1091]: info: MRS: Pushing multiroomSync output Aug 20 13:56:23 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:23 volumio volumio[1091]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 20 13:56:23 volumio volumio[1091]: verbose: CURRENT POSITION 0 Aug 20 13:56:23 volumio volumio[1091]: info: CoreStateMachine::syncState stateService stop Aug 20 13:56:23 volumio volumio[1091]: info: CoreStateMachine::syncState currentStatus stop Aug 20 13:56:23 volumio volumio[1091]: info: CoreStateMachine::pushState Aug 20 13:56:23 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:23 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Aug 20 13:56:23 volumio volumio[1091]: info: MRS: Pushing multiroomSync output update for this device Aug 20 13:56:23 volumio volumio[1091]: info: MRS: Pushing multiroomSync output Aug 20 13:56:23 volumio volumio[1091]: info: No code Aug 20 13:56:23 volumio volumio[1091]: info: CoreStateMachine::pushState Aug 20 13:56:23 volumio volumio[1091]: info: CorePlayQueue::getTrack 0 Aug 20 13:56:23 volumio volumio[1091]: info: CoreCommandRouter::volumioPushState Aug 20 13:56:23 volumio volumio[1091]: info: MRS: Pushing multiroomSync output update for this device Aug 20 13:56:23 volumio volumio[1091]: info: MRS: Pushing multiroomSync output Aug 20 13:56:23 volumio volumio[1091]: info: ------------------------------ 98ms Aug 20 13:56:23 volumio volumio[1091]: info: ------------------------------ 98ms Aug 20 13:56:23 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 20 13:56:24 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 20 13:56:24 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 20 13:56:24 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 20 13:56:24 volumio volumio-remote-updater[809]: No test mode Aug 20 13:56:24 volumio volumio-remote-updater[809]: No alpha test mode Aug 20 13:56:24 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Aug 20 13:56:25 volumio sudo[2103]: pam_unix(sudo:session): session closed for user root Aug 20 13:56:25 volumio volumio[1091]: info: Cannot mount NAS HACUONG at system boot, trial number 3 ,retrying in 5 seconds Aug 20 13:56:25 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Aug 20 13:56:25 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Aug 20 13:56:25 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:56:25 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 20 13:56:25 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Aug 20 13:56:25 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Aug 20 13:56:25 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 20 13:56:25 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Aug 20 13:56:25 volumio volumio[1091]: info: CoreCommandRouter::volumioGetBrowseSources Aug 20 13:56:25 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 20 13:56:25 volumio volumio[1091]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 20 13:56:25 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 20 13:56:27 volumio volumio[1091]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 20 13:56:30 volumio volumio[1091]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 20 13:56:30 volumio volumio[1091]: TypeError: Cannot read property 'replace' of undefined Aug 20 13:56:30 volumio volumio[1091]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Aug 20 13:56:30 volumio volumio[1091]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Aug 20 13:56:30 volumio volumio[1091]: at listOnTimeout (internal/timers.js:554:17) Aug 20 13:56:30 volumio volumio[1091]: at processTimers (internal/timers.js:497:7) Aug 20 13:56:30 volumio volumio[1091]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 20 13:56:30 volumio sudo[2160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-20 13:55 Aug 20 13:56:30 volumio sudo[2160]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"