-- Logs begin at Thu 2019-02-14 18:12:00 CST, end at Thu 2024-10-03 15:20:55 CST. -- Oct 03 15:19:43 volumio-4f fake-hwclock[306]: Thu Oct 3 07:19:43 UTC 2024 Oct 03 15:19:43 volumio-4f systemd[1]: Started Restore / save the current clock. Oct 03 15:19:43 volumio-4f systemd[1]: Started Remount Root and Kernel File Systems. Oct 03 15:19:43 volumio-4f systemd[1]: Mounted RPC Pipe File System. Oct 03 15:19:43 volumio-4f systemd[1]: Mounted POSIX Message Queue File System. Oct 03 15:19:43 volumio-4f systemd[1]: Mounted Kernel Debug File System. Oct 03 15:19:43 volumio-4f systemd[1]: Mounted FUSE Control File System. Oct 03 15:19:43 volumio-4f systemd[1]: Mounted Kernel Configuration File System. Oct 03 15:19:43 volumio-4f systemd[1]: Starting Load/Save Random Seed... Oct 03 15:19:43 volumio-4f systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Oct 03 15:19:43 volumio-4f systemd[1]: Starting Create System Users... Oct 03 15:19:43 volumio-4f systemd[1]: Started Apply Kernel Variables. Oct 03 15:19:43 volumio-4f systemd[1]: Started Load/Save Random Seed. Oct 03 15:19:43 volumio-4f systemd[1]: dynamicswap.service: Succeeded. Oct 03 15:19:43 volumio-4f systemd[1]: Started Create System Users. Oct 03 15:19:43 volumio-4f systemd[1]: Starting Create Static Device Nodes in /dev... Oct 03 15:19:43 volumio-4f systemd[1]: Started udev Coldplug all Devices. Oct 03 15:19:43 volumio-4f systemd[1]: Starting Helper to synchronize boot up for ifupdown... Oct 03 15:19:43 volumio-4f systemd[1]: Started Create Static Device Nodes in /dev. Oct 03 15:19:43 volumio-4f systemd[1]: Reached target Local File Systems (Pre). Oct 03 15:19:43 volumio-4f systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Oct 03 15:19:43 volumio-4f systemd[1]: Mounting /var/log... Oct 03 15:19:43 volumio-4f systemd[1]: Mounting /var/spool/cups... Oct 03 15:19:43 volumio-4f systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Oct 03 15:19:43 volumio-4f systemd[1]: Mounting /tmp... Oct 03 15:19:43 volumio-4f systemd[1]: Starting udev Kernel Device Manager... Oct 03 15:19:43 volumio-4f systemd[1]: Mounted /var/log. Oct 03 15:19:43 volumio-4f systemd[1]: Mounted /var/spool/cups. Oct 03 15:19:43 volumio-4f systemd[1]: Mounted /tmp. Oct 03 15:19:43 volumio-4f systemd[1]: Mounting /var/spool/cups/tmp... Oct 03 15:19:43 volumio-4f systemd[1]: Starting Flush Journal to Persistent Storage... Oct 03 15:19:43 volumio-4f systemd[1]: Mounted /var/spool/cups/tmp. Oct 03 15:19:43 volumio-4f systemd-udevd[346]: Network interface NamePolicy= disabled on kernel command line, ignoring. Oct 03 15:19:43 volumio-4f systemd-journald[305]: Runtime journal (/run/log/journal/a615280fd3b4564a2a95d8e26513f6fc) is 7.5M, max 30.0M, 22.5M free. Oct 03 15:19:43 volumio-4f systemd[1]: Started Flush Journal to Persistent Storage. Oct 03 15:19:43 volumio-4f systemd[1]: Started udev Kernel Device Manager. Oct 03 15:19:43 volumio-4f systemd[1]: Starting Show Plymouth Boot Screen... Oct 03 15:19:43 volumio-4f systemd[1]: plymouth-start.service: Succeeded. Oct 03 15:19:43 volumio-4f systemd[1]: Started Show Plymouth Boot Screen. Oct 03 15:19:43 volumio-4f systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Oct 03 15:19:43 volumio-4f systemd[1]: Reached target Local Encrypted Volumes. Oct 03 15:19:43 volumio-4f systemd[1]: Reached target Paths. Oct 03 15:19:43 volumio-4f systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Oct 03 15:19:44 volumio-4f kernel: mc: Linux media interface: v0.10 Oct 03 15:19:44 volumio-4f kernel: rpi-gpiomem 3f200000.gpiomem: window base 0x3f200000 size 0x00001000 Oct 03 15:19:44 volumio-4f kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Oct 03 15:19:44 volumio-4f kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Oct 03 15:19:44 volumio-4f kernel: [vc_sm_connected_init]: start Oct 03 15:19:44 volumio-4f kernel: rpi-gpiomem 3f200000.gpiomem: initialised 1 regions as /dev/gpiomem Oct 03 15:19:44 volumio-4f kernel: [vc_sm_connected_init]: installed successfully Oct 03 15:19:44 volumio-4f kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Oct 03 15:19:44 volumio-4f kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored Oct 03 15:19:44 volumio-4f kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Oct 03 15:19:44 volumio-4f kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Oct 03 15:19:44 volumio-4f kernel: videodev: Linux video capture interface: v2.00 Oct 03 15:19:44 volumio-4f kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Oct 03 15:19:44 volumio-4f kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Oct 03 15:19:44 volumio-4f kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Oct 03 15:19:44 volumio-4f kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Oct 03 15:19:44 volumio-4f kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Oct 03 15:19:44 volumio-4f kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Oct 03 15:19:44 volumio-4f kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Oct 03 15:19:44 volumio-4f kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Oct 03 15:19:44 volumio-4f kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Oct 03 15:19:44 volumio-4f kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Oct 03 15:19:44 volumio-4f kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Oct 03 15:19:44 volumio-4f kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Oct 03 15:19:44 volumio-4f kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Oct 03 15:19:44 volumio-4f kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Oct 03 15:19:44 volumio-4f kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Oct 03 15:19:44 volumio-4f systemd[1]: Found device /dev/disk/by-uuid/781E-BEF0. Oct 03 15:19:45 volumio-4f kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Oct 03 15:19:45 volumio-4f kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Oct 03 15:19:45 volumio-4f kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Oct 03 15:19:45 volumio-4f kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Oct 03 15:19:45 volumio-4f kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Oct 03 15:19:45 volumio-4f kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Oct 03 15:19:45 volumio-4f kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Oct 03 15:19:45 volumio-4f kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Oct 03 15:19:45 volumio-4f kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Oct 03 15:19:45 volumio-4f kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Oct 03 15:19:45 volumio-4f kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Oct 03 15:19:45 volumio-4f kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Oct 03 15:19:45 volumio-4f kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Oct 03 15:19:45 volumio-4f kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Oct 03 15:19:45 volumio-4f kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 Oct 03 15:19:45 volumio-4f kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image Oct 03 15:19:45 volumio-4f kernel: Bluetooth: Core ver 2.22 Oct 03 15:19:45 volumio-4f kernel: NET: Registered PF_BLUETOOTH protocol family Oct 03 15:19:45 volumio-4f kernel: Bluetooth: HCI device and connection manager initialized Oct 03 15:19:45 volumio-4f kernel: Bluetooth: HCI socket layer initialized Oct 03 15:19:45 volumio-4f kernel: Bluetooth: L2CAP socket layer initialized Oct 03 15:19:45 volumio-4f kernel: Bluetooth: SCO socket layer initialized Oct 03 15:19:45 volumio-4f systemd[1]: Starting File System Check on /dev/disk/by-uuid/781E-BEF0... Oct 03 15:19:45 volumio-4f systemd-udevd[359]: Using default interface naming scheme 'v240'. Oct 03 15:19:45 volumio-4f systemd[1]: Started File System Check Daemon to report status. Oct 03 15:19:45 volumio-4f systemd-udevd[359]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Oct 03 15:19:45 volumio-4f kernel: Bluetooth: HCI UART driver ver 2.3 Oct 03 15:19:45 volumio-4f kernel: Bluetooth: HCI UART protocol H4 registered Oct 03 15:19:45 volumio-4f kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Oct 03 15:19:45 volumio-4f kernel: Bluetooth: HCI UART protocol Broadcom registered Oct 03 15:19:45 volumio-4f kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Oct 03 15:19:45 volumio-4f kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Oct 03 15:19:45 volumio-4f kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Oct 03 15:19:45 volumio-4f kernel: uart-pl011 3f201000.serial: no DMA platform data Oct 03 15:19:45 volumio-4f kernel: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Oct 03 15:19:45 volumio-4f kernel: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Oct 03 15:19:45 volumio-4f kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Oct 03 15:19:45 volumio-4f kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' Oct 03 15:19:45 volumio-4f systemd-fsck[404]: fsck.fat 4.1 (2017-01-24) Oct 03 15:19:45 volumio-4f systemd-fsck[404]: /dev/mmcblk0p1: 401 files, 34806/46774 clusters Oct 03 15:19:45 volumio-4f systemd[1]: Started File System Check on /dev/disk/by-uuid/781E-BEF0. Oct 03 15:19:45 volumio-4f systemd[1]: Mounting /boot... Oct 03 15:19:45 volumio-4f kernel: Bluetooth: hci0: BCM: chip id 94 Oct 03 15:19:45 volumio-4f kernel: Bluetooth: hci0: BCM: features 0x2e Oct 03 15:19:45 volumio-4f kernel: Bluetooth: hci0: BCM43430A1 Oct 03 15:19:45 volumio-4f kernel: Bluetooth: hci0: BCM43430A1 (001.002.009) build 0000 Oct 03 15:19:45 volumio-4f kernel: Bluetooth: hci0: BCM43430A1 'brcm/BCM43430A1.hcd' Patch Oct 03 15:19:45 volumio-4f systemd[1]: Mounted /boot. Oct 03 15:19:46 volumio-4f kernel: brcmfmac: F1 signature read @0x18000000=0x1541a9a6 Oct 03 15:19:46 volumio-4f kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 Oct 03 15:19:46 volumio-4f kernel: usbcore: registered new interface driver brcmfmac Oct 03 15:19:46 volumio-4f systemd-udevd[353]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Oct 03 15:19:46 volumio-4f kernel: usb 1-1.3: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. Oct 03 15:19:46 volumio-4f kernel: usb 1-1.3: [10] FU [PCM Playback Volume] ch = 2, val = -32767/0/1 Oct 03 15:19:46 volumio-4f kernel: usb 1-1.3: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. Oct 03 15:19:46 volumio-4f kernel: usb 1-1.3: [10] FU [PCM Playback Volume] ch = 1, val = -32767/0/1 Oct 03 15:19:46 volumio-4f kernel: usbcore: registered new interface driver snd-usb-audio Oct 03 15:19:46 volumio-4f kernel: brcmfmac: brcmf_c_process_txcap_blob: no txcap_blob available (err=-2) Oct 03 15:19:46 volumio-4f kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43430/1 wl0: Jul 19 2021 03:24:18 version 7.45.98 (TOB) (56df937 CY) FWID 01-8e14b897 Oct 03 15:19:46 volumio-4f kernel: Bluetooth: hci0: BCM: features 0x2e Oct 03 15:19:46 volumio-4f kernel: Bluetooth: hci0: BCM43438A1 37.4MHz Raspberry Pi 3-0141 Oct 03 15:19:46 volumio-4f kernel: Bluetooth: hci0: BCM43430A1 (001.002.009) build 0508 Oct 03 15:19:46 volumio-4f systemd-udevd[355]: Using default interface naming scheme 'v240'. Oct 03 15:19:46 volumio-4f systemd-udevd[355]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Oct 03 15:19:47 volumio-4f kernel: hwmon hwmon1: Undervoltage detected! Oct 03 15:19:47 volumio-4f systemd[1]: Condition check resulted in SMSC9512/9514 Fast Ethernet Adapter being skipped. Oct 03 15:19:47 volumio-4f kernel: alsactl[501]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set Oct 03 15:19:47 volumio-4f systemd[1]: Created slice system-bthelper.slice. Oct 03 15:19:47 volumio-4f systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Oct 03 15:19:47 volumio-4f systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Oct 03 15:19:47 volumio-4f systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Oct 03 15:19:47 volumio-4f systemd[1]: Condition check resulted in Huge Pages File System being skipped. Oct 03 15:19:47 volumio-4f systemd[1]: Starting Show Plymouth Boot Screen... Oct 03 15:19:47 volumio-4f systemd[1]: Reached target Local File Systems. Oct 03 15:19:47 volumio-4f systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Oct 03 15:19:47 volumio-4f systemd[1]: Starting Create Volatile Files and Directories... Oct 03 15:19:47 volumio-4f systemd-udevd[359]: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7. Oct 03 15:19:47 volumio-4f systemd[1]: Started ifup for eth0. Oct 03 15:19:47 volumio-4f systemd[1]: Starting Preprocess NFS configuration... Oct 03 15:19:47 volumio-4f systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Oct 03 15:19:48 volumio-4f systemd[1]: nfs-config.service: Succeeded. Oct 03 15:19:48 volumio-4f systemd[1]: Started Preprocess NFS configuration. Oct 03 15:19:48 volumio-4f systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Oct 03 15:19:48 volumio-4f systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Oct 03 15:19:48 volumio-4f systemd[1]: Reached target NFS client services. Oct 03 15:19:48 volumio-4f systemd[1]: Starting Load/Save RF Kill Switch Status... Oct 03 15:19:48 volumio-4f systemd[1]: Received SIGRTMIN+20 from PID 197 (plymouthd). Oct 03 15:19:48 volumio-4f systemd[1]: plymouth-read-write.service: Succeeded. Oct 03 15:19:48 volumio-4f systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Oct 03 15:19:48 volumio-4f systemd[1]: Started Create Volatile Files and Directories. Oct 03 15:19:48 volumio-4f systemd[1]: plymouth-start.service: Succeeded. Oct 03 15:19:48 volumio-4f systemd[1]: Started Show Plymouth Boot Screen. Oct 03 15:19:48 volumio-4f systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Oct 03 15:19:48 volumio-4f systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Oct 03 15:19:48 volumio-4f systemd[1]: Starting Update UTMP about System Boot/Shutdown... Oct 03 15:19:48 volumio-4f systemd[1]: Starting RPC bind portmap service... Oct 03 15:19:48 volumio-4f systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Oct 03 15:19:48 volumio-4f systemd[1]: Started Load/Save RF Kill Switch Status. Oct 03 15:19:48 volumio-4f systemd[1]: Started Helper to synchronize boot up for ifupdown. Oct 03 15:19:48 volumio-4f systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Oct 03 15:19:48 volumio-4f systemd[1]: Started RPC bind portmap service. Oct 03 15:19:48 volumio-4f systemd[1]: Reached target RPC Port Mapper. Oct 03 15:19:48 volumio-4f systemd[1]: Reached target Remote File Systems (Pre). Oct 03 15:19:48 volumio-4f systemd[1]: Reached target Remote File Systems. Oct 03 15:19:48 volumio-4f systemd[1]: Started ifup for wlan0. Oct 03 15:19:48 volumio-4f systemd[1]: Starting Raise network interfaces... Oct 03 15:19:48 volumio-4f systemd[1]: Started Update UTMP about System Boot/Shutdown. Oct 03 15:19:48 volumio-4f systemd[1]: Reached target System Initialization. Oct 03 15:19:48 volumio-4f systemd[1]: Started Daily apt download activities. Oct 03 15:19:48 volumio-4f systemd[1]: Started Daily Cleanup of Temporary Directories. Oct 03 15:19:48 volumio-4f systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Oct 03 15:19:48 volumio-4f systemd[1]: Started Daily apt upgrade and clean activities. Oct 03 15:19:48 volumio-4f systemd[1]: Reached target Timers. Oct 03 15:19:48 volumio-4f systemd[1]: Listening on D-Bus System Message Bus Socket. Oct 03 15:19:48 volumio-4f systemd[1]: Listening on triggerhappy.socket. Oct 03 15:19:48 volumio-4f systemd[1]: Reached target Sockets. Oct 03 15:19:48 volumio-4f systemd[1]: Reached target Basic System. Oct 03 15:19:48 volumio-4f systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Oct 03 15:19:48 volumio-4f systemd[1]: Starting triggerhappy global hotkey daemon... Oct 03 15:19:48 volumio-4f systemd[1]: Started volumio-remote-updater.service. Oct 03 15:19:48 volumio-4f systemd[1]: Started Manage Sound Card State (restore and store). Oct 03 15:19:48 volumio-4f kernel: 8021q: 802.1Q VLAN Support v1.8 Oct 03 15:19:48 volumio-4f kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211 Oct 03 15:19:48 volumio-4f thd[560]: Unable to parse trigger line: Oct 03 15:19:48 volumio-4f thd[560]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Oct 03 15:19:48 volumio-4f thd[560]: Unable to parse trigger line: Oct 03 15:19:48 volumio-4f thd[560]: Found socket passed from systemd Oct 03 15:19:48 volumio-4f systemd[1]: Started D-Bus System Message Bus. Oct 03 15:19:48 volumio-4f alsactl[565]: alsactl 1.1.8 daemon started Oct 03 15:19:48 volumio-4f systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Oct 03 15:19:48 volumio-4f systemd[1]: Started UPnP Renderer front-end to MPD. Oct 03 15:19:48 volumio-4f systemd[1]: Starting Save/Restore Sound Card State... Oct 03 15:19:48 volumio-4f systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Oct 03 15:19:48 volumio-4f systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Oct 03 15:19:48 volumio-4f systemd[1]: Starting Login Service... Oct 03 15:19:48 volumio-4f systemd[1]: Starting WPA supplicant... Oct 03 15:19:48 volumio-4f systemd[1]: Started Volumio Iptables Module. Oct 03 15:19:48 volumio-4f systemd[1]: Started Volumio Log Rotation Service. Oct 03 15:19:48 volumio-4f systemd[1]: Starting dhcpcd on all interfaces... Oct 03 15:19:48 volumio-4f systemd[1]: Starting Wireless Services... Oct 03 15:19:48 volumio-4f systemd[1]: Starting Configure Bluetooth Modems connected by UART... Oct 03 15:19:48 volumio-4f systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Oct 03 15:19:48 volumio-4f systemd[1]: Started triggerhappy global hotkey daemon. Oct 03 15:19:49 volumio-4f dhcpcd[592]: Not running dhcpcd because /etc/network/interfaces Oct 03 15:19:49 volumio-4f dhcpcd[592]: defines some interfaces that will use a Oct 03 15:19:49 volumio-4f dhcpcd[592]: DHCP client or static address Oct 03 15:19:49 volumio-4f systemd-logind[579]: New seat seat0. Oct 03 15:19:49 volumio-4f systemd[1]: Started Save/Restore Sound Card State. Oct 03 15:19:49 volumio-4f systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Oct 03 15:19:49 volumio-4f systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Oct 03 15:19:49 volumio-4f systemd[1]: Failed to start dhcpcd on all interfaces. Oct 03 15:19:49 volumio-4f systemd[1]: Reached target Sound Card. Oct 03 15:19:49 volumio-4f kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Oct 03 15:19:49 volumio-4f avahi-daemon[572]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Oct 03 15:19:49 volumio-4f avahi-daemon[572]: Successfully dropped root privileges. Oct 03 15:19:49 volumio-4f avahi-daemon[572]: avahi-daemon 0.7 starting up. Oct 03 15:19:49 volumio-4f volumio-remote-updater[562]: Error: No active session Oct 03 15:19:49 volumio-4f volumio-remote-updater[562]: [2024-10-03 15:19:49] [info] asio async_connect error: system:111 (Connection refused) Oct 03 15:19:49 volumio-4f volumio-remote-updater[562]: [2024-10-03 15:19:49] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 03 15:19:49 volumio-4f volumio-remote-updater[562]: [2024-10-03 15:19:49] [error] handle_connect error: Underlying Transport Error Oct 03 15:19:49 volumio-4f sh[514]: eth0: waiting for carrier Oct 03 15:19:49 volumio-4f dhcpcd[539]: eth0: waiting for carrier Oct 03 15:19:49 volumio-4f kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup Oct 03 15:19:49 volumio-4f kernel: smsc95xx 1-1.1:1.0 eth0: Link is Down Oct 03 15:19:50 volumio-4f systemd[1]: Started Login Service. Oct 03 15:19:50 volumio-4f systemd[1]: hciuart.service: Succeeded. Oct 03 15:19:50 volumio-4f systemd[1]: Started Configure Bluetooth Modems connected by UART. Oct 03 15:19:50 volumio-4f wpa_supplicant[585]: Successfully initialized wpa_supplicant Oct 03 15:19:50 volumio-4f avahi-daemon[572]: Successfully called chroot(). Oct 03 15:19:50 volumio-4f avahi-daemon[572]: Successfully dropped remaining capabilities. Oct 03 15:19:50 volumio-4f avahi-daemon[572]: Loading service file /services/volumio.service. Oct 03 15:19:50 volumio-4f avahi-daemon[572]: Network interface enumeration completed. Oct 03 15:19:50 volumio-4f avahi-daemon[572]: Server startup complete. Host name is volumio-4f.local. Local service cookie is 3636354868. Oct 03 15:19:50 volumio-4f avahi-daemon[572]: Service "Volumio 4F" (/services/volumio.service) successfully established. Oct 03 15:19:50 volumio-4f systemd[1]: Started Avahi mDNS/DNS-SD Stack. Oct 03 15:19:50 volumio-4f systemd[1]: Started WPA supplicant. Oct 03 15:19:50 volumio-4f ifup[541]: ifup: waiting for lock on /run/network/ifstate.wlan0 Oct 03 15:19:50 volumio-4f sh[537]: wlan0=wlan0 Oct 03 15:19:50 volumio-4f loadcpufreq[554]: Loading cpufreq kernel modules...done (none). Oct 03 15:19:50 volumio-4f volumio[575]: Could not open config: /tmp/upmpdcli.conf Oct 03 15:19:50 volumio-4f systemd[1]: Starting Raspberry Pi bluetooth helper... Oct 03 15:19:50 volumio-4f systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Oct 03 15:19:50 volumio-4f systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 03 15:19:50 volumio-4f systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 03 15:19:50 volumio-4f systemd[1]: Starting LSB: set CPUFreq kernel parameters... Oct 03 15:19:50 volumio-4f bthelper[709]: Raspberry Pi BDADDR already set Oct 03 15:19:50 volumio-4f systemd[1]: Started Raise network interfaces. Oct 03 15:19:50 volumio-4f systemd[1]: Reached target Network. Oct 03 15:19:50 volumio-4f systemd[1]: Starting OpenBSD Secure Shell server... Oct 03 15:19:50 volumio-4f systemd[1]: Starting Network Time Service... Oct 03 15:19:50 volumio-4f systemd[1]: Starting Permit User Sessions... Oct 03 15:19:50 volumio-4f systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Oct 03 15:19:50 volumio-4f systemd[1]: Reached target Network is Online. Oct 03 15:19:50 volumio-4f systemd[1]: Starting /etc/rc.local Compatibility... Oct 03 15:19:50 volumio-4f systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 03 15:19:50 volumio-4f systemd[1]: Starting Samba NMB Daemon... Oct 03 15:19:50 volumio-4f systemd[1]: Starting LSB: Brings up/down network automatically... Oct 03 15:19:50 volumio-4f systemd[1]: Started Raspberry Pi bluetooth helper. Oct 03 15:19:50 volumio-4f systemd[1]: Started Permit User Sessions. Oct 03 15:19:50 volumio-4f systemd[1]: Started /etc/rc.local Compatibility. Oct 03 15:19:50 volumio-4f systemd[1]: iptables.service: Succeeded. Oct 03 15:19:51 volumio-4f systemd[1]: Starting Terminate Plymouth Boot Screen... Oct 03 15:19:51 volumio-4f systemd[1]: Starting Hold until boot process finishes up... Oct 03 15:19:51 volumio-4f systemd[1]: Starting Bluetooth service... Oct 03 15:19:51 volumio-4f systemd[1]: plymouth-quit.service: Succeeded. Oct 03 15:19:51 volumio-4f systemd[1]: Started Terminate Plymouth Boot Screen. Oct 03 15:19:51 volumio-4f systemd[1]: plymouth-quit-wait.service: Succeeded. Oct 03 15:19:51 volumio-4f systemd[1]: Started Hold until boot process finishes up. Oct 03 15:19:51 volumio-4f systemd[1]: Received SIGRTMIN+21 from PID 197 (n/a). Oct 03 15:19:51 volumio-4f systemd[1]: Received SIGRTMIN+21 from PID 197 (n/a). Oct 03 15:19:51 volumio-4f systemd[1]: Started Getty on tty1. Oct 03 15:19:51 volumio-4f systemd[1]: Reached target Login Prompts. Oct 03 15:19:51 volumio-4f haveged[527]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Oct 03 15:19:51 volumio-4f haveged[527]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Oct 03 15:19:51 volumio-4f haveged[527]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99896 Oct 03 15:19:51 volumio-4f haveged[527]: haveged: fills: 0, generated: 0 Oct 03 15:19:51 volumio-4f sshd[769]: Server listening on 0.0.0.0 port 22. Oct 03 15:19:51 volumio-4f sshd[769]: Server listening on :: port 22. Oct 03 15:19:51 volumio-4f systemd[1]: Started OpenBSD Secure Shell server. Oct 03 15:19:51 volumio-4f ntpd[748]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 03 15:19:51 volumio-4f systemd[1]: Started Network Time Service. Oct 03 15:19:51 volumio-4f ntpd[748]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Oct 03 15:19:51 volumio-4f ntpd[778]: proto: precision = 1.406 usec (-19) Oct 03 15:19:51 volumio-4f ifplugd(eth0)[788]: ifplugd 0.28 initializing. Oct 03 15:19:51 volumio-4f ifplugd(eth0)[788]: Using interface eth0/B8:27:EB:93:8E:83 with driver (version: 6.6.47-v7+) Oct 03 15:19:51 volumio-4f ifplugd(eth0)[788]: Using detection mode: SIOCETHTOOL Oct 03 15:19:51 volumio-4f ifplugd(eth0)[788]: Initialization complete, link beat not detected. Oct 03 15:19:51 volumio-4f cpufrequtils[729]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Oct 03 15:19:51 volumio-4f systemd[1]: Started LSB: set CPUFreq kernel parameters. Oct 03 15:19:51 volumio-4f ntpd[778]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 03 15:19:51 volumio-4f ntpd[778]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 03 15:19:51 volumio-4f ntpd[778]: Listen and drop on 0 v6wildcard [::]:123 Oct 03 15:19:51 volumio-4f ntpd[778]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 03 15:19:51 volumio-4f ntpd[778]: Listen normally on 2 lo 127.0.0.1:123 Oct 03 15:19:51 volumio-4f ntpd[778]: Listening on routing socket on fd #19 for interface updates Oct 03 15:19:51 volumio-4f ntpd[778]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 03 15:19:51 volumio-4f ntpd[778]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 03 15:19:51 volumio-4f ifplugd[753]: Network Interface Plugging Daemon...start eth0...done. Oct 03 15:19:51 volumio-4f systemd[1]: Started LSB: Brings up/down network automatically. Oct 03 15:19:51 volumio-4f bluetoothd[765]: Bluetooth daemon 5.50 Oct 03 15:19:51 volumio-4f bluetoothd[765]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Oct 03 15:19:51 volumio-4f systemd[1]: Started Bluetooth service. Oct 03 15:19:51 volumio-4f systemd[1]: Reached target Bluetooth. Oct 03 15:19:51 volumio-4f bluetoothd[765]: Starting SDP server Oct 03 15:19:51 volumio-4f bluetoothd[765]: Excluding (cli) sap Oct 03 15:19:51 volumio-4f kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Oct 03 15:19:51 volumio-4f kernel: Bluetooth: BNEP filters: protocol multicast Oct 03 15:19:51 volumio-4f kernel: Bluetooth: BNEP socket layer initialized Oct 03 15:19:51 volumio-4f kernel: Bluetooth: MGMT ver 1.22 Oct 03 15:19:51 volumio-4f bluetoothd[765]: Bluetooth management interface 1.22 initialized Oct 03 15:19:51 volumio-4f dbus-daemon[567]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=765 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Oct 03 15:19:51 volumio-4f bluetoothd[765]: Failed to set privacy: Rejected (0x0b) Oct 03 15:19:52 volumio-4f systemd[1]: Starting Hostname Service... Oct 03 15:19:52 volumio-4f ntpd[778]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Oct 03 15:19:52 volumio-4f dbus-daemon[567]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 03 15:19:52 volumio-4f systemd[1]: Started Hostname Service. Oct 03 15:19:53 volumio-4f nmbd[760]: [2024/10/03 15:19:53.034963, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Oct 03 15:19:53 volumio-4f nmbd[760]: started asyncdns process 800 Oct 03 15:19:53 volumio-4f nmbd[760]: [2024/10/03 15:19:53.038894, 0] ../lib/util/become_daemon.c:149(daemon_status) Oct 03 15:19:53 volumio-4f nmbd[760]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Oct 03 15:19:53 volumio-4f nmbd[760]: [2024/10/03 15:19:53.039195, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Oct 03 15:19:53 volumio-4f nmbd[760]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Oct 03 15:19:53 volumio-4f systemd[1]: systemd-rfkill.service: Succeeded. Oct 03 15:19:53 volumio-4f ntpd[778]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Oct 03 15:19:53 volumio-4f wireless.js[593]: Cleaning previous... Oct 03 15:19:53 volumio-4f sudo[808]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Oct 03 15:19:54 volumio-4f sudo[808]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:19:54 volumio-4f sudo[808]: pam_unix(sudo:session): session closed for user root Oct 03 15:19:54 volumio-4f sudo[810]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Oct 03 15:19:54 volumio-4f sudo[810]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:19:54 volumio-4f ntpd[778]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Oct 03 15:19:54 volumio-4f sudo[810]: pam_unix(sudo:session): session closed for user root Oct 03 15:19:54 volumio-4f volumio-remote-updater[562]: [2024-10-03 15:19:54] [info] asio async_connect error: system:111 (Connection refused) Oct 03 15:19:54 volumio-4f volumio-remote-updater[562]: [2024-10-03 15:19:54] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 03 15:19:54 volumio-4f volumio-remote-updater[562]: [2024-10-03 15:19:54] [error] handle_connect error: Underlying Transport Error Oct 03 15:19:54 volumio-4f wireless.js[593]: Stopped aP Oct 03 15:19:54 volumio-4f sudo[817]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Oct 03 15:19:54 volumio-4f sudo[817]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:19:54 volumio-4f sudo[817]: pam_unix(sudo:session): session closed for user root Oct 03 15:19:54 volumio-4f kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Oct 03 15:19:54 volumio-4f sudo[819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Oct 03 15:19:54 volumio-4f sudo[819]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:19:54 volumio-4f sudo[819]: pam_unix(sudo:session): session closed for user root Oct 03 15:19:54 volumio-4f sudo[826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Oct 03 15:19:54 volumio-4f sudo[826]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:19:54 volumio-4f sudo[826]: pam_unix(sudo:session): session closed for user root Oct 03 15:19:54 volumio-4f sudo[828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Oct 03 15:19:54 volumio-4f sudo[828]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:19:55 volumio-4f ntpd[778]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Oct 03 15:19:55 volumio-4f sudo[828]: pam_unix(sudo:session): session closed for user root Oct 03 15:19:55 volumio-4f wireless.js[593]: SETTING APPROPRIATE REG DOMAIN: CN Oct 03 15:19:55 volumio-4f sudo[833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Oct 03 15:19:55 volumio-4f sudo[833]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:19:55 volumio-4f sudo[833]: pam_unix(sudo:session): session closed for user root Oct 03 15:19:55 volumio-4f sudo[836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set CN Oct 03 15:19:55 volumio-4f sudo[836]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:19:55 volumio-4f bthelper[709]: Changing power off succeeded Oct 03 15:19:55 volumio-4f sudo[836]: pam_unix(sudo:session): session closed for user root Oct 03 15:19:55 volumio-4f wireless.js[593]: SUCCESSFULLY SET NEW REGDOMAIN: CN Oct 03 15:19:55 volumio-4f wireless.js[593]: Start wireless flow Oct 03 15:19:55 volumio-4f wireless.js[593]: Stopped hotspot (if there).. Oct 03 15:19:55 volumio-4f sudo[841]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Oct 03 15:19:55 volumio-4f sudo[841]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:19:55 volumio-4f sudo[841]: pam_unix(sudo:session): session closed for user root Oct 03 15:19:55 volumio-4f sudo[843]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Oct 03 15:19:55 volumio-4f sudo[843]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:19:55 volumio-4f bthelper[709]: [CHG] Controller B8:27:EB:39:24:29 Class: 0x0000041c Oct 03 15:19:55 volumio-4f bthelper[709]: Changing power on succeeded Oct 03 15:19:56 volumio-4f sudo[843]: pam_unix(sudo:session): session closed for user root Oct 03 15:19:56 volumio-4f wireless.js[593]: DHCP IP Oct 03 15:19:56 volumio-4f wireless.js[593]: Start ap Oct 03 15:19:56 volumio-4f wpa_supplicant[849]: Successfully initialized wpa_supplicant Oct 03 15:19:56 volumio-4f sudo[850]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Oct 03 15:19:56 volumio-4f sudo[850]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:19:56 volumio-4f kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Oct 03 15:19:56 volumio-4f dhcpcd[851]: dev: loaded udev Oct 03 15:19:56 volumio-4f dhcpcd-run-hooks[869]: wlan0: starting wpa_supplicant Oct 03 15:19:56 volumio-4f dhcpcd-run-hooks[874]: wlan0: failed to start wpa_supplicant Oct 03 15:19:56 volumio-4f dhcpcd-run-hooks[875]: wlan0: Successfully initialized wpa_supplicant nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Ma Oct 03 15:19:56 volumio-4f dhcpcd[851]: wlan0: connected to Access Point `' Oct 03 15:19:56 volumio-4f dhcpcd[851]: no interfaces have a carrier Oct 03 15:19:56 volumio-4f dhcpcd[851]: forked to background, child pid 885 Oct 03 15:19:56 volumio-4f dhcpcd[885]: eth0: waiting for carrier Oct 03 15:19:56 volumio-4f dhcpcd[885]: wlan0: waiting for carrier Oct 03 15:19:56 volumio-4f sudo[850]: pam_unix(sudo:session): session closed for user root Oct 03 15:19:57 volumio-4f wpa_supplicant[873]: wlan0: Trying to associate with SSID '3off' Oct 03 15:19:57 volumio-4f dhcpcd[885]: wlan0: carrier acquired Oct 03 15:19:57 volumio-4f dhcpcd[885]: wlan0: connected to Access Point `3off' Oct 03 15:19:57 volumio-4f wpa_supplicant[873]: wlan0: Associated with 28:d1:27:e9:19:b4 Oct 03 15:19:57 volumio-4f wpa_supplicant[873]: wlan0: CTRL-EVENT-CONNECTED - Connection to 28:d1:27:e9:19:b4 completed [id=0 id_str=] Oct 03 15:19:57 volumio-4f wpa_supplicant[873]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Oct 03 15:19:57 volumio-4f wpa_supplicant[873]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=CN Oct 03 15:19:57 volumio-4f wireless.js[593]: trying... Oct 03 15:19:57 volumio-4f dhcpcd[885]: DUID 00:01:00:01:2c:a6:b5:4c:b8:27:eb:93:8e:83 Oct 03 15:19:57 volumio-4f dhcpcd[885]: wlan0: IAID eb:c6:db:d6 Oct 03 15:19:57 volumio-4f dhcpcd[885]: wlan0: adding address fe80::ba27:ebff:fec6:dbd6 Oct 03 15:19:57 volumio-4f dhcpcd[885]: ipv6_addaddr1: Permission denied Oct 03 15:19:57 volumio-4f dhcpcd[885]: wlan0: probing address 192.168.1.24/24 Oct 03 15:19:57 volumio-4f sudo[889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 03 15:19:57 volumio-4f sudo[889]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:19:57 volumio-4f sudo[889]: pam_unix(sudo:session): session closed for user root Oct 03 15:19:57 volumio-4f dhcpcd[885]: wlan0: carrier lost Oct 03 15:19:57 volumio-4f dhcpcd[885]: wlan0: carrier acquired Oct 03 15:19:57 volumio-4f dhcpcd[885]: wlan0: IAID eb:c6:db:d6 Oct 03 15:19:57 volumio-4f dhcpcd[885]: wlan0: probing address 192.168.1.24/24 Oct 03 15:19:58 volumio-4f dhcpcd[885]: wlan0: soliciting an IPv6 router Oct 03 15:19:58 volumio-4f wireless.js[593]: trying... Oct 03 15:19:58 volumio-4f sudo[912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 03 15:19:58 volumio-4f sudo[912]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:19:58 volumio-4f sudo[912]: pam_unix(sudo:session): session closed for user root Oct 03 15:19:59 volumio-4f wireless.js[593]: trying... Oct 03 15:19:59 volumio-4f sudo[915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 03 15:19:59 volumio-4f sudo[915]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:19:59 volumio-4f sudo[915]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:00 volumio-4f wireless.js[593]: trying... Oct 03 15:20:00 volumio-4f sudo[918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 03 15:20:00 volumio-4f sudo[918]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:00 volumio-4f sudo[918]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:01 volumio-4f wireless.js[593]: trying... Oct 03 15:20:01 volumio-4f sudo[921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 03 15:20:01 volumio-4f sudo[921]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:01 volumio-4f sudo[921]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:02 volumio-4f volumio-remote-updater[562]: [2024-10-03 15:20:02] [info] asio async_connect error: system:111 (Connection refused) Oct 03 15:20:02 volumio-4f volumio-remote-updater[562]: [2024-10-03 15:20:02] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 03 15:20:02 volumio-4f volumio-remote-updater[562]: [2024-10-03 15:20:02] [error] handle_connect error: Underlying Transport Error Oct 03 15:20:02 volumio-4f dhcpcd[885]: wlan0: using static address 192.168.1.24/24 Oct 03 15:20:02 volumio-4f avahi-daemon[572]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.24. Oct 03 15:20:02 volumio-4f dhcpcd[885]: wlan0: adding route to 192.168.1.0/24 Oct 03 15:20:02 volumio-4f avahi-daemon[572]: New relevant interface wlan0.IPv4 for mDNS. Oct 03 15:20:02 volumio-4f dhcpcd[885]: wlan0: adding default route via 192.168.1.1 Oct 03 15:20:02 volumio-4f avahi-daemon[572]: Registering new address record for 192.168.1.24 on wlan0.IPv4. Oct 03 15:20:02 volumio-4f wireless.js[593]: trying... Oct 03 15:20:02 volumio-4f sudo[945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 03 15:20:02 volumio-4f sudo[945]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:02 volumio-4f sudo[945]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:02 volumio-4f wireless.js[593]: Connected to: ----3off Oct 03 15:20:02 volumio-4f wireless.js[593]: ---- Oct 03 15:20:02 volumio-4f sudo[948]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 03 15:20:02 volumio-4f sudo[948]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:02 volumio-4f sudo[948]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:02 volumio-4f wireless.js[593]: ... joined AP, wlan0 IPv4 is 192.168.1.24, ipV6 is undefined Oct 03 15:20:02 volumio-4f wireless.js[593]: It's done! AP Oct 03 15:20:02 volumio-4f systemd[1]: Started Wireless Services. Oct 03 15:20:02 volumio-4f kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Oct 03 15:20:02 volumio-4f systemd[1]: Started Volumio Backend Module. Oct 03 15:20:02 volumio-4f systemd[1]: Started Volumio Cpu Tweaker. Oct 03 15:20:02 volumio-4f volumio-cpu-tweak[954]: Setting RT Priority for mpd Oct 03 15:20:02 volumio-4f volumio-cpu-tweak[954]: pid 35's current scheduling policy: SCHED_OTHER Oct 03 15:20:02 volumio-4f volumio-cpu-tweak[954]: pid 35's current scheduling priority: 0 Oct 03 15:20:02 volumio-4f volumio-cpu-tweak[954]: Setting MPD Affinity Oct 03 15:20:02 volumio-4f volumio-cpu-tweak[954]: pid 3's current affinity mask: f Oct 03 15:20:02 volumio-4f volumio-cpu-tweak[954]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Oct 03 15:20:02 volumio-4f volumio-cpu-tweak[954]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Oct 03 15:20:02 volumio-4f systemd[1]: volumio_cpu_tweak.service: Succeeded. Oct 03 15:20:03 volumio-4f nmbd[760]: [2024/10/03 15:20:03.047398, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 03 15:20:03 volumio-4f systemd[1]: Started Samba NMB Daemon. Oct 03 15:20:03 volumio-4f nmbd[760]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Oct 03 15:20:03 volumio-4f systemd[1]: Starting Samba Winbind Daemon... Oct 03 15:20:03 volumio-4f ntpd[778]: Listen normally on 3 wlan0 192.168.1.24:123 Oct 03 15:20:03 volumio-4f ntpd[778]: new interface(s) found: waking up resolver Oct 03 15:20:03 volumio-4f winbindd[970]: [2024/10/03 15:20:03.802549, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Oct 03 15:20:03 volumio-4f winbindd[970]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Oct 03 15:20:04 volumio-4f winbindd[970]: [2024/10/03 15:20:04.109735, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 03 15:20:04 volumio-4f winbindd[970]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Oct 03 15:20:04 volumio-4f systemd[1]: Started Samba Winbind Daemon. Oct 03 15:20:04 volumio-4f systemd[1]: Starting Samba SMB Daemon... Oct 03 15:20:05 volumio-4f smbd[975]: [2024/10/03 15:20:05.592107, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 03 15:20:05 volumio-4f systemd[1]: Started Samba SMB Daemon. Oct 03 15:20:05 volumio-4f smbd[975]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Oct 03 15:20:05 volumio-4f systemd[1]: Reached target Multi-User System. Oct 03 15:20:05 volumio-4f systemd[1]: Reached target Graphical Interface. Oct 03 15:20:05 volumio-4f systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 03 15:20:05 volumio-4f systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Oct 03 15:20:05 volumio-4f systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 03 15:20:05 volumio-4f systemd[1]: Startup finished in 17.883s (kernel) + 25.008s (userspace) = 42.891s. Oct 03 15:20:08 volumio-4f volumio[953]: info: ------------------------------------------- Oct 03 15:20:08 volumio-4f volumio[953]: info: ----- Volumio3 ---- Oct 03 15:20:08 volumio-4f volumio[953]: info: ------------------------------------------- Oct 03 15:20:08 volumio-4f volumio[953]: info: ----- System startup ---- Oct 03 15:20:08 volumio-4f volumio[953]: info: ------------------------------------------- Oct 03 15:20:10 volumio-4f volumio[953]: info: MYVOLUMIO Environment detected Oct 03 15:20:11 volumio-4f volumio[953]: info: Plugin folders cleanup Oct 03 15:20:11 volumio-4f volumio[953]: info: Scanning into folder /volumio/app/plugins/ Oct 03 15:20:11 volumio-4f volumio[953]: info: Scanning category audio_interface Oct 03 15:20:11 volumio-4f volumio[953]: info: Scanning category miscellanea Oct 03 15:20:11 volumio-4f volumio[953]: info: Scanning category music_service Oct 03 15:20:11 volumio-4f volumio[953]: info: Scanning category plugins.json Oct 03 15:20:11 volumio-4f volumio[953]: info: Scanning category system_controller Oct 03 15:20:11 volumio-4f volumio[953]: info: Scanning category user_interface Oct 03 15:20:11 volumio-4f volumio[953]: info: Scanning into folder /data/plugins/ Oct 03 15:20:11 volumio-4f volumio[953]: info: Scanning category music_service Oct 03 15:20:11 volumio-4f volumio[953]: info: Plugin folders cleanup completed Oct 03 15:20:11 volumio-4f volumio[953]: info: ------------------------------------------- Oct 03 15:20:11 volumio-4f volumio[953]: info: ----- Core plugins startup ---- Oct 03 15:20:11 volumio-4f volumio[953]: info: ------------------------------------------- Oct 03 15:20:11 volumio-4f volumio[953]: info: Loading plugins from folder /volumio/app/plugins/ Oct 03 15:20:11 volumio-4f volumio[953]: info: Adding plugin upnp to MyMusic Plugins Oct 03 15:20:11 volumio-4f volumio[953]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 03 15:20:11 volumio-4f volumio[953]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 03 15:20:11 volumio-4f volumio[953]: info: Loading plugins from folder /data/plugins/ Oct 03 15:20:11 volumio-4f volumio[953]: info: Loading plugin "system"... Oct 03 15:20:11 volumio-4f volumio[953]: info: Loading plugin "appearance"... Oct 03 15:20:12 volumio-4f volumio-remote-updater[562]: [2024-10-03 15:20:12] [connect] Successful connection Oct 03 15:20:13 volumio-4f volumio[953]: info: Loading plugin "network"... Oct 03 15:20:14 volumio-4f volumio[953]: info: Refreshing Cached IP Addresses Oct 03 15:20:14 volumio-4f sudo[998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 03 15:20:14 volumio-4f sudo[998]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:14 volumio-4f sudo[998]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:14 volumio-4f volumio[953]: info: Loading plugin "services"... Oct 03 15:20:14 volumio-4f sudo[1000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 03 15:20:14 volumio-4f sudo[1000]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:14 volumio-4f volumio[953]: info: Loading plugin "alsa_controller"... Oct 03 15:20:14 volumio-4f sudo[1000]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:14 volumio-4f sudo[1003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 03 15:20:14 volumio-4f sudo[1003]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:14 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 03 15:20:14 volumio-4f volumio[953]: info: Loading plugin "wizard"... Oct 03 15:20:14 volumio-4f volumio[953]: info: Loading plugin "networkfs"... Oct 03 15:20:14 volumio-4f volumio[953]: info: Starting Udev Watcher for removable devices Oct 03 15:20:14 volumio-4f sudo[1011]: 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.246/Music /mnt/NAS/Vault Oct 03 15:20:14 volumio-4f sudo[1011]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:14 volumio-4f volumio[953]: info: Ignoring mount for partition: boot Oct 03 15:20:14 volumio-4f volumio[953]: info: Ignoring mount for partition: volumio Oct 03 15:20:14 volumio-4f volumio[953]: info: Ignoring mount for partition: volumio_data Oct 03 15:20:14 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 03 15:20:14 volumio-4f volumio[953]: info: Loading plugin "volumio_command_line_client"... Oct 03 15:20:14 volumio-4f volumio[953]: info: Plugin upnp is not enabled Oct 03 15:20:14 volumio-4f volumio[953]: info: Loading plugin "my_music"... Oct 03 15:20:14 volumio-4f volumio[953]: info: Loading plugin "mpd"... Oct 03 15:20:14 volumio-4f kernel: Key type cifs.spnego registered Oct 03 15:20:14 volumio-4f kernel: Key type cifs.idmap registered Oct 03 15:20:14 volumio-4f 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. Oct 03 15:20:14 volumio-4f kernel: CIFS: Attempting to mount //192.168.1.246/Music Oct 03 15:20:15 volumio-4f sudo[1003]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:15 volumio-4f kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Oct 03 15:20:15 volumio-4f kernel: CIFS: VFS: \\192.168.1.246 Send error in SessSetup = -13 Oct 03 15:20:15 volumio-4f kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Oct 03 15:20:15 volumio-4f sudo[1011]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:15 volumio-4f volumio[953]: info: Plugin upnp_browser is not enabled Oct 03 15:20:15 volumio-4f volumio[953]: info: Loading plugin "alarm-clock"... Oct 03 15:20:15 volumio-4f systemd[1]: systemd-fsckd.service: Succeeded. Oct 03 15:20:16 volumio-4f volumio[953]: info: Plugin airplay_emulation is not enabled Oct 03 15:20:16 volumio-4f volumio[953]: info: Loading plugin "last_100"... Oct 03 15:20:16 volumio-4f volumio[953]: info: Loading plugin "webradio"... Oct 03 15:20:16 volumio-4f volumio[953]: info: Loading plugin "i2s_dacs"... Oct 03 15:20:16 volumio-4f volumio[953]: info: Loading plugin "volumiodiscovery"... Oct 03 15:20:16 volumio-4f volumio[953]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 03 15:20:16 volumio-4f volumio[953]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 03 15:20:16 volumio-4f volumio[953]: *** WARNING *** For more information see Oct 03 15:20:16 volumio-4f node[953]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 03 15:20:16 volumio-4f volumio[953]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 03 15:20:16 volumio-4f volumio[953]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 03 15:20:16 volumio-4f volumio[953]: *** WARNING *** For more information see Oct 03 15:20:16 volumio-4f node[953]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 03 15:20:16 volumio-4f node[953]: *** WARNING *** For more information see Oct 03 15:20:16 volumio-4f node[953]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 03 15:20:16 volumio-4f node[953]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 03 15:20:16 volumio-4f node[953]: *** WARNING *** For more information see Oct 03 15:20:16 volumio-4f volumio[953]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 03 15:20:16 volumio-4f volumio[953]: info: Discovery: Started advertising with name: Volumio 4F Oct 03 15:20:16 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 03 15:20:16 volumio-4f volumio[953]: info: Loading plugin "youtube2"... Oct 03 15:20:19 volumio-4f volumio[953]: info: Loading plugin "ytcr"... Oct 03 15:20:19 volumio-4f sh[514]: timed out Oct 03 15:20:19 volumio-4f dhcpcd[539]: timed out Oct 03 15:20:19 volumio-4f sh[514]: dhcpcd exited Oct 03 15:20:19 volumio-4f dhcpcd[539]: dhcpcd exited Oct 03 15:20:19 volumio-4f sh[514]: ifup: failed to bring up eth0 Oct 03 15:20:19 volumio-4f systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Oct 03 15:20:19 volumio-4f systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Oct 03 15:20:22 volumio-4f systemd[1]: systemd-hostnamed.service: Succeeded. Oct 03 15:20:25 volumio-4f volumio[953]: info: Loading plugin "ytmusic"... Oct 03 15:20:27 volumio-4f volumio-remote-updater[562]: [2024-10-03 15:20:27] [connect] Successful connection Oct 03 15:20:28 volumio-4f volumio[953]: info: Loading plugin "outputs"... Oct 03 15:20:28 volumio-4f volumio[953]: info: Loading plugin "albumart"... Oct 03 15:20:28 volumio-4f volumio[953]: info: Plugin example_plugin is not enabled Oct 03 15:20:28 volumio-4f volumio[953]: info: Loading plugin "inputs"... Oct 03 15:20:28 volumio-4f volumio[953]: info: Loading plugin "updater_comm"... Oct 03 15:20:28 volumio-4f volumio[953]: info: Plugin mpdemulation is not enabled Oct 03 15:20:28 volumio-4f volumio[953]: info: Loading plugin "rest_api"... Oct 03 15:20:28 volumio-4f volumio[953]: info: Loading plugin "websocket"... Oct 03 15:20:28 volumio-4f volumio[953]: info: Starting Socket.io Server version 2.3.0 Oct 03 15:20:28 volumio-4f volumio[953]: info: Loading plugin "RoonBridge"... Oct 03 15:20:28 volumio-4f volumio[953]: Forking 3 albumart workers Oct 03 15:20:29 volumio-4f volumio[953]: info: Applying required configuration parameters for plugin RoonBridge Oct 03 15:20:29 volumio-4f volumio[953]: info: Loading plugin "motherearthradio"... Oct 03 15:20:29 volumio-4f volumio[953]: info: Applying required configuration parameters for plugin motherearthradio Oct 03 15:20:29 volumio-4f volumio[953]: info: [1727940029989] [MotherEarth] API delay: 5 Oct 03 15:20:29 volumio-4f volumio[953]: info: Loading plugin "volroon"... Oct 03 15:20:30 volumio-4f volumio[953]: Starting albumart workers Oct 03 15:20:30 volumio-4f volumio[953]: info: Applying required configuration parameters for plugin volroon Oct 03 15:20:30 volumio-4f volumio[953]: Starting albumart workers Oct 03 15:20:30 volumio-4f volumio[953]: Starting albumart workers Oct 03 15:20:30 volumio-4f volumio[953]: info: Loading i18n strings for locale zh_TW Oct 03 15:20:30 volumio-4f volumio[953]: Updating browse sources language Oct 03 15:20:30 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 03 15:20:31 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 15:20:31 volumio-4f volumio[953]: info: CoreCommandRouter::initPlayerControls Oct 03 15:20:31 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:31 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:31 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:31 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:31 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:31 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:31 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:31 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:31 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 03 15:20:31 volumio-4f volumio[953]: Express server listening on port 3000 Oct 03 15:20:31 volumio-4f volumio[953]: [Metrics] WebUI: 24s 536.99ms Oct 03 15:20:31 volumio-4f volumio[953]: info: CoreStateMachine::resetVolumioState Oct 03 15:20:31 volumio-4f volumio[953]: info: CoreStateMachine::getcurrentVolume Oct 03 15:20:31 volumio-4f volumio[953]: info: CoreCommandRouter::volumioRetrievevolume Oct 03 15:20:31 volumio-4f volumio[953]: info: Cannot mount NAS Vault at system boot, trial number 1 ,retrying in 5 seconds Oct 03 15:20:32 volumio-4f volumio[953]: info: Reloading queue from file Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreStateMachine::setRepeat null single undefined Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreStateMachine::pushState Oct 03 15:20:32 volumio-4f volumio[953]: info: CorePlayQueue::getTrack 0 Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreCommandRouter::volumioPushState Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreStateMachine::setRandom null Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreStateMachine::pushState Oct 03 15:20:32 volumio-4f volumio[953]: info: CorePlayQueue::getTrack 0 Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreCommandRouter::volumioPushState Oct 03 15:20:32 volumio-4f volumio[953]: info: VolumeController:: Volume=46 Mute =false Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreStateMachine::pushState Oct 03 15:20:32 volumio-4f volumio[953]: info: CorePlayQueue::getTrack 0 Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreCommandRouter::volumioPushState Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreStateMachine::updateTrackBlock Oct 03 15:20:32 volumio-4f volumio[953]: info: CorePlayQueue::getTrackBlock Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreCommandRouter::volumioRetrievevolume Oct 03 15:20:32 volumio-4f volumio[953]: info: Setting Device type: Raspberry PI Oct 03 15:20:32 volumio-4f volumio[953]: info: Completed loading Core Plugins Oct 03 15:20:32 volumio-4f volumio[953]: info: Preparing to generate the ALSA configuration file Oct 03 15:20:32 volumio-4f volumio[953]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Oct 03 15:20:32 volumio-4f volumio[953]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082 Oct 03 15:20:32 volumio-4f volumio[953]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Oct 03 15:20:32 volumio-4f volumio[953]: info: Asound.conf file unchanged, so no further update is needed Oct 03 15:20:32 volumio-4f volumio[953]: info: Output device has changed, restarting MPD Oct 03 15:20:32 volumio-4f sudo[1108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAplayInfo Oct 03 15:20:32 volumio-4f sudo[1108]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:32 volumio-4f sudo[1108]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:32 volumio-4f sudo[1110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 03 15:20:32 volumio-4f sudo[1110]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:32 volumio-4f volumio[953]: info: volroon::Output device has changed Oct 03 15:20:32 volumio-4f volumio[953]: info: ___________ START PLUGINS ___________ Oct 03 15:20:32 volumio-4f volumio[953]: info: ControllerMpd::onStart: Initializing MPD Oct 03 15:20:32 volumio-4f volumio[953]: info: Creating MPD Configuration file Oct 03 15:20:32 volumio-4f systemd[1]: Listening on mpd.socket. Oct 03 15:20:32 volumio-4f sudo[1117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 03 15:20:32 volumio-4f volumio[953]: info: [1727940032757] CoreMusicLibrary::Adding element Last_100 Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 03 15:20:32 volumio-4f volumio[953]: info: [1727940032767] CoreMusicLibrary::Adding element Webradio Oct 03 15:20:32 volumio-4f sudo[1117]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 03 15:20:32 volumio-4f sudo[1117]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:32 volumio-4f systemd[1]: Starting Music Player Daemon... Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 03 15:20:32 volumio-4f volumio[953]: info: Initializing BBC Radios Oct 03 15:20:32 volumio-4f sudo[1119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 03 15:20:32 volumio-4f sudo[1119]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:32 volumio-4f systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 03 15:20:32 volumio-4f systemd[1]: mpd.service: Succeeded. Oct 03 15:20:32 volumio-4f systemd[1]: Stopped Music Player Daemon. Oct 03 15:20:32 volumio-4f systemd[1]: Starting Music Player Daemon... Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 03 15:20:32 volumio-4f volumio[953]: info: [1727940032945] CoreMusicLibrary::Adding element YouTube2 Oct 03 15:20:32 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 03 15:20:32 volumio-4f volumio[953]: Cannot find translation for source YouTube2 Oct 03 15:20:33 volumio-4f volumio[953]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 03 15:20:33 volumio-4f volumio[953]: info: [1727940033046] CoreMusicLibrary::Adding element YouTube Music Oct 03 15:20:33 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 03 15:20:33 volumio-4f volumio[953]: Cannot find translation for source YouTube2 Oct 03 15:20:33 volumio-4f volumio[953]: Cannot find translation for source YouTube Music Oct 03 15:20:33 volumio-4f volumio[953]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 03 15:20:33 volumio-4f volumio[953]: info: [1727940033097] CoreMusicLibrary::Adding element Mother Earth Radio Oct 03 15:20:33 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 03 15:20:33 volumio-4f volumio[953]: Cannot find translation for source YouTube2 Oct 03 15:20:33 volumio-4f volumio[953]: Cannot find translation for source YouTube Music Oct 03 15:20:33 volumio-4f volumio[953]: Cannot find translation for source Mother Earth Radio Oct 03 15:20:33 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAplayInfo Oct 03 15:20:33 volumio-4f sudo[1126]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 03 15:20:33 volumio-4f sudo[1126]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:33 volumio-4f sudo[1135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Oct 03 15:20:33 volumio-4f sudo[1126]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 03 15:20:33 volumio-4f sudo[1135]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:33 volumio-4f sudo[1126]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:33 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:33 volumio-4f systemd[1]: Started RoonBridge. Oct 03 15:20:33 volumio-4f sudo[1135]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:33 volumio-4f sudo[1142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Oct 03 15:20:33 volumio-4f sudo[1142]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:33 volumio-4f sudo[1142]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:33 volumio-4f volumio[953]: info: volroon::Roon API Services Started Oct 03 15:20:33 volumio-4f volumio[953]: info: Volumio Calling Home Oct 03 15:20:33 volumio-4f volumio[953]: info: Discovery: adding 2cebcda1-ec61-4547-9519-aa066f8e2fb5 Oct 03 15:20:33 volumio-4f volumio[953]: info: Discovery: Found device Volumio 4F Oct 03 15:20:33 volumio-4f volumio[953]: info: CoreCommandRouter::volumioGetState Oct 03 15:20:33 volumio-4f volumio[953]: info: CorePlayQueue::getTrack 0 Oct 03 15:20:33 volumio-4f volumio[953]: info: ::Roon Bridge has successfully started Oct 03 15:20:33 volumio-4f volumio[953]: info: MPD Permissions set Oct 03 15:20:33 volumio-4f volumio[953]: info: MPD Permissions set Oct 03 15:20:33 volumio-4f volumio[953]: info: VolumeController:: Volume=46 Mute =false Oct 03 15:20:33 volumio-4f volumio[953]: info: CoreCommandRouter::volumioGetState Oct 03 15:20:33 volumio-4f volumio[953]: info: CorePlayQueue::getTrack 0 Oct 03 15:20:33 volumio-4f volumio[953]: info: CoreStateMachine::pushState Oct 03 15:20:33 volumio-4f volumio[953]: info: CorePlayQueue::getTrack 0 Oct 03 15:20:33 volumio-4f volumio[953]: info: CoreCommandRouter::volumioPushState Oct 03 15:20:34 volumio-4f volumio[953]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 03 15:20:34 volumio-4f volumio[953]: info: Volumio called home Oct 03 15:20:34 volumio-4f volumio[953]: info: CoreCommandRouter::volumioGetState Oct 03 15:20:34 volumio-4f volumio[953]: info: CorePlayQueue::getTrack 0 Oct 03 15:20:35 volumio-4f volumio[953]: info: [yt-cast-receiver] DIAL server listening on port 8098 Oct 03 15:20:36 volumio-4f volroon[1143]: 00:00:00.032 Warn: get lock file path: /tmp/.rnbgem0- Oct 03 15:20:36 volumio-4f sudo[1167]: 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.246/Music /mnt/NAS/Vault Oct 03 15:20:36 volumio-4f sudo[1167]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:37 volumio-4f kernel: CIFS: Attempting to mount //192.168.1.246/Music Oct 03 15:20:37 volumio-4f sudo[1167]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:37 volumio-4f kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Oct 03 15:20:37 volumio-4f kernel: CIFS: VFS: \\192.168.1.246 Send error in SessSetup = -13 Oct 03 15:20:37 volumio-4f kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Oct 03 15:20:37 volumio-4f volumio[953]: info: Cannot mount NAS Vault at system boot, trial number 2 ,retrying in 5 seconds Oct 03 15:20:37 volumio-4f volroon[1143]: 00:00:01.222 Trace: [childprocess] using unix child process Oct 03 15:20:37 volumio-4f volroon[1143]: 00:00:01.403 Debug: PathForResource, filename: ../.update Oct 03 15:20:37 volumio-4f volroon[1143]: 00:00:01.558 Debug: PathForResource, candidate: /data/plugins/music_service/volroon/RoonBridge/Bridge/../.update Oct 03 15:20:37 volumio-4f volroon[1143]: 00:00:01.579 Debug: PathForResource, filename: RAATServer Oct 03 15:20:37 volumio-4f volroon[1143]: 00:00:01.579 Debug: PathForResource, candidate: /data/plugins/music_service/volroon/RoonBridge/Bridge/RAATServer Oct 03 15:20:37 volumio-4f volroon[1143]: 00:00:01.581 Debug: PathForResource, filename: RoonBridgeHelper Oct 03 15:20:37 volumio-4f volroon[1143]: 00:00:01.581 Debug: PathForResource, candidate: /data/plugins/music_service/volroon/RoonBridge/Bridge/RoonBridgeHelper Oct 03 15:20:37 volumio-4f volroon[1143]: Initializing Oct 03 15:20:37 volumio-4f volroon[1143]: 00:00:01.691 Info: Starting /data/plugins/music_service/volroon/RoonBridge/Bridge/RoonBridgeHelper Oct 03 15:20:38 volumio-4f volroon[1143]: 00:00:01.798 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/volroon/RoonBridge/Bridge/RAATServer Oct 03 15:20:38 volumio-4f volroon[1143]: Not Running (.o) Oct 03 15:20:38 volumio-4f volroon[1143]: Running Oct 03 15:20:39 volumio-4f mpd[1139]: Oct 03 15:20 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 03 15:20:39 volumio-4f systemd[1]: Started Music Player Daemon. Oct 03 15:20:39 volumio-4f sudo[1110]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:39 volumio-4f sudo[1119]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:39 volumio-4f volumio[953]: info: Completed starting Core Plugins Oct 03 15:20:39 volumio-4f volumio[953]: info: ------------------------------------------- Oct 03 15:20:39 volumio-4f volumio[953]: info: ----- MyVolumio plugins startup ---- Oct 03 15:20:39 volumio-4f volumio[953]: info: ------------------------------------------- Oct 03 15:20:39 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 03 15:20:39 volumio-4f volumio[953]: error: MPD error: The expression evaluated to a falsy value: Oct 03 15:20:39 volumio-4f volumio[953]: assert.ok(self.idling) Oct 03 15:20:39 volumio-4f volumio[953]: error: The expression evaluated to a falsy value: Oct 03 15:20:39 volumio-4f volumio[953]: assert.ok(self.idling) Oct 03 15:20:39 volumio-4f volumio[953]: error: updateQueue error: null Oct 03 15:20:39 volumio-4f volumio[953]: info: MPD running with PID1139 Oct 03 15:20:39 volumio-4f volumio[953]: ,establishing connection Oct 03 15:20:39 volumio-4f volumio[953]: error: updateQueue error: null Oct 03 15:20:40 volumio-4f volroon[1143]: 00:00:00.084 Warn: get lock file path: /tmp/.rnbhgem0- Oct 03 15:20:42 volumio-4f volumio-remote-updater[562]: [2024-10-03 15:20:42] [connect] Successful connection Oct 03 15:20:42 volumio-4f sudo[1206]: 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.246/Music /mnt/NAS/Vault Oct 03 15:20:42 volumio-4f sudo[1206]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:42 volumio-4f volumio-remote-updater[562]: [2024-10-03 15:20:42] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1727940042 101 Oct 03 15:20:42 volumio-4f volumio[953]: 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: 2 Oct 03 15:20:42 volumio-4f kernel: CIFS: Attempting to mount //192.168.1.246/Music Oct 03 15:20:42 volumio-4f sudo[1206]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:42 volumio-4f kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Oct 03 15:20:42 volumio-4f kernel: CIFS: VFS: \\192.168.1.246 Send error in SessSetup = -13 Oct 03 15:20:42 volumio-4f kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Oct 03 15:20:42 volumio-4f volumio[953]: info: Cannot mount NAS Vault at system boot, trial number 3 ,retrying in 5 seconds Oct 03 15:20:44 volumio-4f volumio[953]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Oct 03 15:20:45 volumio-4f volumio[953]: info: volroon::Roon Core Paired: 192.168.1.246:9330 with ID of: cc4042c2-70c7-4e64-b3fb-bb1b7f450392 Oct 03 15:20:45 volumio-4f volumio[953]: error: volroon::Metadata - ReferenceError: roonPausedTimer is not defined Oct 03 15:20:46 volumio-4f volumio[953]: error: volroon::Metadata - ReferenceError: roonPausedTimer is not defined Oct 03 15:20:47 volumio-4f sudo[1236]: 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.246/Music /mnt/NAS/Vault Oct 03 15:20:47 volumio-4f sudo[1236]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:47 volumio-4f kernel: CIFS: Attempting to mount //192.168.1.246/Music Oct 03 15:20:47 volumio-4f kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Oct 03 15:20:47 volumio-4f kernel: CIFS: VFS: \\192.168.1.246 Send error in SessSetup = -13 Oct 03 15:20:47 volumio-4f kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Oct 03 15:20:47 volumio-4f sudo[1236]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:47 volumio-4f volumio[953]: info: Cannot mount NAS Vault at system boot, trial number 4 ,retrying in 5 seconds Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 03 15:20:47 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 03 15:20:47 volumio-4f volumio[953]: info: Adding plugin bluetooth to MyMusic Plugins Oct 03 15:20:47 volumio-4f volumio[953]: info: Adding plugin multiroom to MyMusic Plugins Oct 03 15:20:47 volumio-4f volumio[953]: info: Adding plugin metavolumio to MyMusic Plugins Oct 03 15:20:47 volumio-4f volumio[953]: info: Adding plugin cd_controller to MyMusic Plugins Oct 03 15:20:47 volumio-4f volumio[953]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 03 15:20:48 volumio-4f volumio[953]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 03 15:20:48 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 03 15:20:49 volumio-4f volumiologrotate[590]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Oct 03 15:20:49 volumio-4f volumiologrotate[590]: ls: cannot access '4F': No such file or directory Oct 03 15:20:50 volumio-4f volumio[953]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 03 15:20:50 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 03 15:20:50 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 15:20:50 volumio-4f volumio[953]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 03 15:20:50 volumio-4f volumio[953]: info: Starting MyVolumio Remote Streaming Endpoints Oct 03 15:20:50 volumio-4f volumio[953]: info: MyVolumio login type: Token Oct 03 15:20:50 volumio-4f volumio[953]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 03 15:20:50 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 03 15:20:53 volumio-4f volumio[953]: info: Starting Streaming Service Transparent Proxy Oct 03 15:20:53 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 03 15:20:53 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 03 15:20:53 volumio-4f volumio[953]: info: Streaming services startup Oct 03 15:20:53 volumio-4f volumio[953]: info: Starting Streaming Daemon Oct 03 15:20:54 volumio-4f sudo[1292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 03 15:20:54 volumio-4f sudo[1292]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:54 volumio-4f sudo[1292]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:54 volumio-4f volumio[953]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 03 15:20:54 volumio-4f sudo[1300]: 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.246/Music /mnt/NAS/Vault Oct 03 15:20:54 volumio-4f sudo[1300]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 03 15:20:54 volumio-4f kernel: CIFS: Attempting to mount //192.168.1.246/Music Oct 03 15:20:54 volumio-4f sudo[1300]: pam_unix(sudo:session): session closed for user root Oct 03 15:20:54 volumio-4f kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Oct 03 15:20:54 volumio-4f kernel: CIFS: VFS: \\192.168.1.246 Send error in SessSetup = -13 Oct 03 15:20:54 volumio-4f kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Oct 03 15:20:54 volumio-4f volumio[953]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Oct 03 15:20:54 volumio-4f volumio[953]: error: Cannot start Volumio Streaming Daemon Oct 03 15:20:54 volumio-4f volumio[953]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 03 15:20:54 volumio-4f volumio[953]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 03 15:20:54 volumio-4f volumio[953]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 03 15:20:54 volumio-4f volumio[953]: TypeError: Cannot read property 'ping' of undefined Oct 03 15:20:54 volumio-4f volumio[953]: at Timeout._onTimeout (/data/plugins/music_service/volroon/node_modules/node-roon-api/transport-websocket.js:26:21) Oct 03 15:20:54 volumio-4f volumio[953]: at listOnTimeout (internal/timers.js:554:17) Oct 03 15:20:54 volumio-4f volumio[953]: at processTimers (internal/timers.js:497:7) Oct 03 15:20:54 volumio-4f volumio[953]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 03 15:20:55 volumio-4f sudo[1315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-03 15:19 Oct 03 15:20:55 volumio-4f sudo[1315]: 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="35b821ff7c588ea2ff28d7b2bc9bb02e49e3ab6c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8ef80245b1f7b577b29fe08b77efdc88d53369e5" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 18 Sep 2024 02:17:42 PM CEST" VOLUMIO_VERSION="3.758" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cfa71b4386e95e4d11d00ae35602129a"