-- Logs begin at Thu 2019-02-14 07:11:59 -03, end at Fri 2024-08-30 10:31:32 -03. -- Aug 30 10:30:50 streamer fake-hwclock[306]: Fri Aug 30 13:30:50 UTC 2024 Aug 30 10:30:50 streamer systemd[1]: Started Load Kernel Modules. Aug 30 10:30:50 streamer systemd[1]: Started Restore / save the current clock. Aug 30 10:30:50 streamer systemd[1]: Starting Apply Kernel Variables... Aug 30 10:30:50 streamer systemd[1]: Mounting FUSE Control File System... Aug 30 10:30:50 streamer systemd[1]: Mounting Kernel Configuration File System... Aug 30 10:30:50 streamer systemd[1]: Mounted FUSE Control File System. Aug 30 10:30:50 streamer systemd[1]: Mounted Kernel Configuration File System. Aug 30 10:30:50 streamer systemd[1]: Started Load/Save Random Seed. Aug 30 10:30:50 streamer systemd[1]: Started Apply Kernel Variables. Aug 30 10:30:50 streamer systemd[1]: dynamicswap.service: Succeeded. Aug 30 10:30:50 streamer systemd[1]: Started Create System Users. Aug 30 10:30:50 streamer systemd[1]: Starting Create Static Device Nodes in /dev... Aug 30 10:30:50 streamer systemd[1]: Started udev Coldplug all Devices. Aug 30 10:30:50 streamer systemd[1]: Starting Helper to synchronize boot up for ifupdown... Aug 30 10:30:50 streamer systemd[1]: Started Helper to synchronize boot up for ifupdown. Aug 30 10:30:50 streamer systemd[1]: Started Create Static Device Nodes in /dev. Aug 30 10:30:50 streamer systemd[1]: Reached target Local File Systems (Pre). Aug 30 10:30:50 streamer systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Aug 30 10:30:50 streamer systemd[1]: Mounting /tmp... Aug 30 10:30:50 streamer systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Aug 30 10:30:50 streamer systemd[1]: Mounting /var/log... Aug 30 10:30:50 streamer systemd[1]: Mounting /var/spool/cups... Aug 30 10:30:50 streamer systemd[1]: Starting udev Kernel Device Manager... Aug 30 10:30:50 streamer systemd[1]: Mounted /tmp. Aug 30 10:30:50 streamer systemd[1]: Mounted /var/log. Aug 30 10:30:50 streamer systemd[1]: Mounted /var/spool/cups. Aug 30 10:30:50 streamer systemd[1]: Mounting /var/spool/cups/tmp... Aug 30 10:30:50 streamer systemd[1]: Starting Flush Journal to Persistent Storage... Aug 30 10:30:50 streamer systemd[1]: Mounted /var/spool/cups/tmp. Aug 30 10:30:50 streamer systemd-udevd[346]: Network interface NamePolicy= disabled on kernel command line, ignoring. Aug 30 10:30:50 streamer systemd-journald[302]: Runtime journal (/run/log/journal/3c3812e622e46b6dc8110864638cf76c) is 11.2M, max 30.0M, 18.7M free. Aug 30 10:30:50 streamer systemd[1]: Started Flush Journal to Persistent Storage. Aug 30 10:30:50 streamer systemd[1]: Started udev Kernel Device Manager. Aug 30 10:30:50 streamer systemd[1]: Starting Show Plymouth Boot Screen... Aug 30 10:30:50 streamer systemd[1]: plymouth-start.service: Succeeded. Aug 30 10:30:50 streamer systemd[1]: Started Show Plymouth Boot Screen. Aug 30 10:30:50 streamer systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Aug 30 10:30:50 streamer systemd[1]: Reached target Paths. Aug 30 10:30:50 streamer systemd[1]: Reached target Local Encrypted Volumes. Aug 30 10:30:50 streamer systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Aug 30 10:30:50 streamer kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Aug 30 10:30:50 streamer kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Aug 30 10:30:50 streamer kernel: [vc_sm_connected_init]: start Aug 30 10:30:50 streamer kernel: mc: Linux media interface: v0.10 Aug 30 10:30:50 streamer kernel: [vc_sm_connected_init]: installed successfully Aug 30 10:30:51 streamer kernel: rpi-gpiomem 3f200000.gpiomem: window base 0x3f200000 size 0x00001000 Aug 30 10:30:51 streamer kernel: rpi-gpiomem 3f200000.gpiomem: initialised 1 regions as /dev/gpiomem Aug 30 10:30:51 streamer kernel: videodev: Linux video capture interface: v2.00 Aug 30 10:30:51 streamer kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Aug 30 10:30:51 streamer kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Aug 30 10:30:51 streamer kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Aug 30 10:30:51 streamer kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Aug 30 10:30:51 streamer kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Aug 30 10:30:51 streamer kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Aug 30 10:30:51 streamer kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Aug 30 10:30:51 streamer kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Aug 30 10:30:51 streamer kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Aug 30 10:30:51 streamer kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Aug 30 10:30:51 streamer kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Aug 30 10:30:51 streamer kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Aug 30 10:30:51 streamer kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 Aug 30 10:30:51 streamer kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 Aug 30 10:30:51 streamer kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 Aug 30 10:30:51 streamer kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 Aug 30 10:30:51 streamer kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Aug 30 10:30:51 streamer kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Aug 30 10:30:51 streamer kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Aug 30 10:30:51 streamer kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Aug 30 10:30:51 streamer kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Aug 30 10:30:51 streamer kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Aug 30 10:30:51 streamer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Aug 30 10:30:51 streamer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Aug 30 10:30:51 streamer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Aug 30 10:30:51 streamer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Aug 30 10:30:51 streamer systemd[1]: Found device /dev/disk/by-uuid/7F72-C251. Aug 30 10:30:51 streamer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Aug 30 10:30:51 streamer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Aug 30 10:30:51 streamer kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Aug 30 10:30:51 streamer kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored Aug 30 10:30:51 streamer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 Aug 30 10:30:51 streamer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx Aug 30 10:30:51 streamer kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Aug 30 10:30:51 streamer kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 Aug 30 10:30:51 streamer kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image Aug 30 10:30:51 streamer systemd-udevd[350]: Using default interface naming scheme 'v240'. Aug 30 10:30:51 streamer kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Aug 30 10:30:51 streamer systemd-udevd[350]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 30 10:30:51 streamer systemd[1]: Starting File System Check on /dev/disk/by-uuid/7F72-C251... Aug 30 10:30:51 streamer kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Aug 30 10:30:51 streamer systemd[1]: Started File System Check Daemon to report status. Aug 30 10:30:52 streamer kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' Aug 30 10:30:52 streamer kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' Aug 30 10:30:52 streamer kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Aug 30 10:30:52 streamer kernel: Bluetooth: Core ver 2.22 Aug 30 10:30:52 streamer kernel: NET: Registered PF_BLUETOOTH protocol family Aug 30 10:30:52 streamer kernel: Bluetooth: HCI device and connection manager initialized Aug 30 10:30:52 streamer kernel: Bluetooth: HCI socket layer initialized Aug 30 10:30:52 streamer kernel: Bluetooth: L2CAP socket layer initialized Aug 30 10:30:52 streamer kernel: Bluetooth: SCO socket layer initialized Aug 30 10:30:52 streamer systemd-fsck[411]: fsck.fat 4.1 (2017-01-24) Aug 30 10:30:52 streamer systemd-fsck[411]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Aug 30 10:30:52 streamer systemd-fsck[411]: Automatically removing dirty bit. Aug 30 10:30:52 streamer systemd-fsck[411]: Performing changes. Aug 30 10:30:52 streamer systemd-fsck[411]: /dev/mmcblk0p1: 376 files, 33707/46774 clusters Aug 30 10:30:52 streamer kernel: usb 1-1.1.2: 1:3 : unsupported format bits 0x100000000 Aug 30 10:30:52 streamer kernel: Bluetooth: HCI UART driver ver 2.3 Aug 30 10:30:52 streamer kernel: Bluetooth: HCI UART protocol H4 registered Aug 30 10:30:52 streamer kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Aug 30 10:30:52 streamer kernel: Bluetooth: HCI UART protocol Broadcom registered Aug 30 10:30:52 streamer kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator Aug 30 10:30:52 streamer kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator Aug 30 10:30:52 streamer kernel: usbcore: registered new interface driver snd-usb-audio Aug 30 10:30:52 streamer systemd[1]: Started File System Check on /dev/disk/by-uuid/7F72-C251. Aug 30 10:30:52 streamer kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Aug 30 10:30:52 streamer kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Aug 30 10:30:52 streamer kernel: usbcore: registered new interface driver brcmfmac Aug 30 10:30:52 streamer kernel: uart-pl011 3f201000.serial: no DMA platform data Aug 30 10:30:52 streamer systemd-udevd[355]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 30 10:30:52 streamer kernel: Bluetooth: hci0: BCM: chip id 107 Aug 30 10:30:52 streamer kernel: Bluetooth: hci0: BCM: features 0x2f Aug 30 10:30:52 streamer kernel: Bluetooth: hci0: BCM4345C0 Aug 30 10:30:52 streamer kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 Aug 30 10:30:52 streamer kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch Aug 30 10:30:52 streamer 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 30 10:30:52 streamer systemd-udevd[355]: Using default interface naming scheme 'v240'. Aug 30 10:30:52 streamer systemd-udevd[355]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 30 10:30:53 streamer kernel: Bluetooth: hci0: BCM: features 0x2f Aug 30 10:30:53 streamer kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+ Aug 30 10:30:53 streamer kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342 Aug 30 10:30:53 streamer kernel: Bluetooth: hci0: BCM: Using default device address (43:45:c0:00:1f:ac) Aug 30 10:30:53 streamer systemd[1]: Condition check resulted in 7800 being skipped. Aug 30 10:30:53 streamer systemd[1]: Created slice system-bthelper.slice. Aug 30 10:30:53 streamer kernel: hwmon hwmon1: Undervoltage detected! Aug 30 10:30:53 streamer systemd[1]: Starting Show Plymouth Boot Screen... Aug 30 10:30:53 streamer systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Aug 30 10:30:53 streamer systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Aug 30 10:30:53 streamer systemd[1]: Condition check resulted in Huge Pages File System being skipped. Aug 30 10:30:53 streamer systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Aug 30 10:30:53 streamer systemd[1]: Mounting /boot... Aug 30 10:30:53 streamer systemd[1]: Starting Load/Save RF Kill Switch Status... Aug 30 10:30:53 streamer systemd[1]: plymouth-start.service: Succeeded. Aug 30 10:30:53 streamer systemd[1]: Started Show Plymouth Boot Screen. Aug 30 10:30:53 streamer systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Aug 30 10:30:53 streamer systemd[1]: Mounted /boot. Aug 30 10:30:53 streamer systemd[1]: Reached target Local File Systems. Aug 30 10:30:53 streamer systemd[1]: Starting Create Volatile Files and Directories... Aug 30 10:30:53 streamer systemd[1]: Starting Preprocess NFS configuration... Aug 30 10:30:53 streamer systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Aug 30 10:30:53 streamer systemd[1]: Condition check resulted in Load AppArmor profiles being skipped. Aug 30 10:30:53 streamer systemd[1]: Started ifup for eth0. Aug 30 10:30:53 streamer systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Aug 30 10:30:53 streamer systemd[1]: Starting Raise network interfaces... Aug 30 10:30:53 streamer systemd[1]: plymouth-read-write.service: Succeeded. Aug 30 10:30:53 streamer systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Aug 30 10:30:53 streamer systemd[1]: Received SIGRTMIN+20 from PID 193 (plymouthd). Aug 30 10:30:53 streamer systemd[1]: Started Load/Save RF Kill Switch Status. Aug 30 10:30:53 streamer systemd[1]: nfs-config.service: Succeeded. Aug 30 10:30:53 streamer systemd[1]: Started Preprocess NFS configuration. Aug 30 10:30:53 streamer systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Aug 30 10:30:53 streamer systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Aug 30 10:30:53 streamer systemd[1]: Reached target NFS client services. Aug 30 10:30:54 streamer systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Aug 30 10:30:54 streamer systemd[1]: Started Create Volatile Files and Directories. Aug 30 10:30:54 streamer systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Aug 30 10:30:54 streamer systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Aug 30 10:30:54 streamer systemd-udevd[361]: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7. Aug 30 10:30:54 streamer systemd[1]: Starting RPC bind portmap service... Aug 30 10:30:54 streamer systemd[1]: Starting Update UTMP about System Boot/Shutdown... Aug 30 10:30:54 streamer systemd[1]: Started ifup for wlan0. Aug 30 10:30:54 streamer systemd[1]: Started RPC bind portmap service. Aug 30 10:30:54 streamer systemd[1]: Started Update UTMP about System Boot/Shutdown. Aug 30 10:30:54 streamer systemd[1]: Reached target System Initialization. Aug 30 10:30:54 streamer kernel: 8021q: 802.1Q VLAN Support v1.8 Aug 30 10:30:54 streamer systemd[1]: apt-daily.timer: Not using persistent file timestamp Sun 2024-09-01 09:02:18 -03 as it is in the future. Aug 30 10:30:54 streamer systemd[1]: Started Daily apt download activities. Aug 30 10:30:54 streamer systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Sun 2024-09-01 06:07:43 -03 as it is in the future. Aug 30 10:30:54 streamer systemd[1]: Started Daily apt upgrade and clean activities. Aug 30 10:30:54 streamer systemd[1]: Listening on triggerhappy.socket. Aug 30 10:30:54 streamer systemd[1]: Starting Docker Socket for the API. Aug 30 10:30:54 streamer systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Aug 30 10:30:54 streamer systemd[1]: Started Daily Cleanup of Temporary Directories. Aug 30 10:30:54 streamer systemd[1]: Reached target Timers. Aug 30 10:30:54 streamer systemd[1]: Listening on D-Bus System Message Bus Socket. Aug 30 10:30:54 streamer systemd[1]: Reached target Remote File Systems (Pre). Aug 30 10:30:54 streamer systemd[1]: Reached target Remote File Systems. Aug 30 10:30:54 streamer systemd[1]: Reached target RPC Port Mapper. Aug 30 10:30:54 streamer systemd[1]: Listening on Docker Socket for the API. Aug 30 10:30:54 streamer systemd[1]: Reached target Sockets. Aug 30 10:30:54 streamer systemd[1]: Reached target Basic System. Aug 30 10:30:54 streamer systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Aug 30 10:30:54 streamer systemd[1]: Started D-Bus System Message Bus. Aug 30 10:30:54 streamer kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Aug 30 10:30:54 streamer systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Aug 30 10:30:54 streamer systemd[1]: Starting triggerhappy global hotkey daemon... Aug 30 10:30:54 streamer systemd[1]: Started Volumio Log Rotation Service. Aug 30 10:30:54 streamer systemd[1]: Started Manage Sound Card State (restore and store). Aug 30 10:30:54 streamer systemd[1]: Starting Save/Restore Sound Card State... Aug 30 10:30:54 streamer systemd[1]: Started volumio-remote-updater.service. Aug 30 10:30:54 streamer alsactl[595]: alsactl 1.1.8 daemon started Aug 30 10:30:54 streamer systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Aug 30 10:30:54 streamer systemd[1]: Started UPnP Renderer front-end to MPD. Aug 30 10:30:54 streamer systemd[1]: Starting Wireless Services... Aug 30 10:30:54 streamer systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Aug 30 10:30:54 streamer systemd[1]: Starting dhcpcd on all interfaces... Aug 30 10:30:54 streamer systemd[1]: Starting Login Service... Aug 30 10:30:54 streamer systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Aug 30 10:30:54 streamer systemd[1]: Started Volumio Iptables Module. Aug 30 10:30:54 streamer systemd[1]: Starting WPA supplicant... Aug 30 10:30:54 streamer systemd[1]: Starting Configure Bluetooth Modems connected by UART... Aug 30 10:30:54 streamer dhcpcd[605]: Not running dhcpcd because /etc/network/interfaces Aug 30 10:30:54 streamer dhcpcd[605]: defines some interfaces that will use a Aug 30 10:30:54 streamer dhcpcd[605]: DHCP client or static address Aug 30 10:30:54 streamer thd[591]: Unable to parse trigger line: Aug 30 10:30:54 streamer thd[591]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Aug 30 10:30:54 streamer thd[591]: Unable to parse trigger line: Aug 30 10:30:54 streamer thd[591]: Unable to parse trigger line: Aug 30 10:30:54 streamer thd[591]: Found socket passed from systemd Aug 30 10:30:54 streamer systemd-logind[606]: New seat seat0. Aug 30 10:30:54 streamer avahi-daemon[588]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Aug 30 10:30:54 streamer avahi-daemon[588]: Successfully dropped root privileges. Aug 30 10:30:54 streamer avahi-daemon[588]: avahi-daemon 0.7 starting up. Aug 30 10:30:55 streamer kernel: 8021q: adding VLAN 0 to HW filter on device eth0 Aug 30 10:30:55 streamer sh[506]: eth0: waiting for carrier Aug 30 10:30:55 streamer dhcpcd[539]: eth0: waiting for carrier Aug 30 10:30:55 streamer kernel: lan78xx 1-1.1.1:1.0 eth0: Link is Down Aug 30 10:30:55 streamer volumio-remote-updater[598]: Error: No active session Aug 30 10:30:55 streamer volumio-remote-updater[598]: [2024-08-30 10:30:55] [info] asio async_connect error: system:111 (Connection refused) Aug 30 10:30:55 streamer volumio-remote-updater[598]: [2024-08-30 10:30:55] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 30 10:30:55 streamer volumio-remote-updater[598]: [2024-08-30 10:30:55] [error] handle_connect error: Underlying Transport Error Aug 30 10:30:55 streamer systemd[1]: Started Login Service. Aug 30 10:30:55 streamer systemd[1]: Started triggerhappy global hotkey daemon. Aug 30 10:30:55 streamer systemd[1]: Started Save/Restore Sound Card State. Aug 30 10:30:55 streamer systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Aug 30 10:30:55 streamer systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Aug 30 10:30:55 streamer systemd[1]: Failed to start dhcpcd on all interfaces. Aug 30 10:30:55 streamer systemd[1]: hciuart.service: Succeeded. Aug 30 10:30:55 streamer wpa_supplicant[609]: Successfully initialized wpa_supplicant Aug 30 10:30:55 streamer systemd[1]: Started Configure Bluetooth Modems connected by UART. Aug 30 10:30:55 streamer avahi-daemon[588]: Successfully called chroot(). Aug 30 10:30:55 streamer avahi-daemon[588]: Successfully dropped remaining capabilities. Aug 30 10:30:55 streamer avahi-daemon[588]: Loading service file /services/volumio.service. Aug 30 10:30:55 streamer avahi-daemon[588]: Network interface enumeration completed. Aug 30 10:30:55 streamer avahi-daemon[588]: Server startup complete. Host name is streamer.local. Local service cookie is 3355360584. Aug 30 10:30:55 streamer avahi-daemon[588]: Service "Streamer" (/services/volumio.service) successfully established. Aug 30 10:30:55 streamer volumio[599]: Could not open config: /tmp/upmpdcli.conf Aug 30 10:30:55 streamer systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:30:55 streamer systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Aug 30 10:30:55 streamer systemd[1]: Started WPA supplicant. Aug 30 10:30:55 streamer systemd[1]: Started Avahi mDNS/DNS-SD Stack. Aug 30 10:30:55 streamer sh[548]: wlan0=wlan0 Aug 30 10:30:55 streamer kernel: hwmon hwmon1: Voltage normalised Aug 30 10:30:55 streamer systemd[1]: Starting Raspberry Pi bluetooth helper... Aug 30 10:30:55 streamer systemd[1]: Reached target Sound Card. Aug 30 10:30:55 streamer bthelper[685]: Raspberry Pi BDADDR already set Aug 30 10:30:55 streamer systemd[1]: Started Raise network interfaces. Aug 30 10:30:55 streamer systemd[1]: Started Raspberry Pi bluetooth helper. Aug 30 10:30:56 streamer systemd[1]: iptables.service: Succeeded. Aug 30 10:30:56 streamer systemd[1]: Starting Bluetooth service... Aug 30 10:30:56 streamer systemd[1]: Reached target Network. Aug 30 10:30:56 streamer systemd[1]: Starting Network Time Service... Aug 30 10:30:56 streamer systemd[1]: Starting Permit User Sessions... Aug 30 10:30:56 streamer systemd[1]: Starting OpenBSD Secure Shell server... Aug 30 10:30:56 streamer systemd[1]: Reached target Network is Online. Aug 30 10:30:56 streamer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 10:30:56 streamer systemd[1]: Starting Samba NMB Daemon... Aug 30 10:30:56 streamer systemd[1]: Starting LSB: Brings up/down network automatically... Aug 30 10:30:56 streamer systemd[1]: Starting /etc/rc.local Compatibility... Aug 30 10:30:56 streamer systemd[1]: Starting containerd container runtime... Aug 30 10:30:56 streamer systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Aug 30 10:30:56 streamer systemd[1]: Started /etc/rc.local Compatibility. Aug 30 10:30:56 streamer loadcpufreq[607]: Loading cpufreq kernel modules...done (none). Aug 30 10:30:56 streamer systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Aug 30 10:30:56 streamer systemd[1]: Started Permit User Sessions. Aug 30 10:30:56 streamer systemd[1]: Starting Hold until boot process finishes up... Aug 30 10:30:56 streamer systemd[1]: Starting Terminate Plymouth Boot Screen... Aug 30 10:30:56 streamer systemd[1]: Starting LSB: set CPUFreq kernel parameters... Aug 30 10:30:56 streamer systemd[1]: Received SIGRTMIN+21 from PID 193 (plymouthd). Aug 30 10:30:56 streamer ifplugd[749]: Network Interface Plugging Daemon...error: unexpectedly disconnected from boot status daemon Aug 30 10:30:56 streamer systemd[1]: plymouth-quit-wait.service: Succeeded. Aug 30 10:30:56 streamer systemd[1]: Started Hold until boot process finishes up. Aug 30 10:30:56 streamer systemd[1]: plymouth-quit.service: Succeeded. Aug 30 10:30:56 streamer systemd[1]: Started Terminate Plymouth Boot Screen. Aug 30 10:30:56 streamer systemd[1]: Received SIGRTMIN+21 from PID 193 (n/a). Aug 30 10:30:56 streamer ifplugd(eth0)[784]: ifplugd 0.28 initializing. Aug 30 10:30:56 streamer ifplugd(eth0)[784]: Using interface eth0/B8:27:EB:58:62:A5 with driver (version: 6.1.69-v7+) Aug 30 10:30:56 streamer ifplugd(eth0)[784]: Using detection mode: SIOCETHTOOL Aug 30 10:30:56 streamer ifplugd(eth0)[784]: Initialization complete, link beat not detected. Aug 30 10:30:56 streamer systemd[1]: Started Getty on tty1. Aug 30 10:30:56 streamer systemd[1]: Reached target Login Prompts. Aug 30 10:30:56 streamer bluetoothd[735]: Bluetooth daemon 5.50 Aug 30 10:30:56 streamer bluetoothd[735]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Aug 30 10:30:56 streamer systemd[1]: Started Bluetooth service. Aug 30 10:30:56 streamer systemd[1]: Reached target Bluetooth. Aug 30 10:30:56 streamer bluetoothd[735]: Starting SDP server Aug 30 10:30:56 streamer bluetoothd[735]: Excluding (cli) sap Aug 30 10:30:56 streamer ifplugd[749]: start eth0...done. Aug 30 10:30:56 streamer systemd[1]: Started LSB: Brings up/down network automatically. Aug 30 10:30:56 streamer ntpd[739]: ntpd 4.2.8p12@1.3728-o (1): Starting Aug 30 10:30:56 streamer ntpd[739]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Aug 30 10:30:56 streamer systemd[1]: Started Network Time Service. Aug 30 10:30:56 streamer kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Aug 30 10:30:56 streamer kernel: Bluetooth: BNEP filters: protocol multicast Aug 30 10:30:56 streamer kernel: Bluetooth: BNEP socket layer initialized Aug 30 10:30:56 streamer bluetoothd[735]: Bluetooth management interface 1.22 initialized Aug 30 10:30:56 streamer kernel: Bluetooth: MGMT ver 1.22 Aug 30 10:30:56 streamer dbus-daemon[580]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=735 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Aug 30 10:30:56 streamer ntpd[792]: proto: precision = 1.510 usec (-19) Aug 30 10:30:56 streamer cpufrequtils[771]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Aug 30 10:30:56 streamer ntpd[792]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Aug 30 10:30:56 streamer ntpd[792]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Aug 30 10:30:56 streamer systemd[1]: Started LSB: set CPUFreq kernel parameters. Aug 30 10:30:56 streamer ntpd[792]: Listen and drop on 0 v6wildcard [::]:123 Aug 30 10:30:56 streamer ntpd[792]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Aug 30 10:30:56 streamer ntpd[792]: Listen normally on 2 lo 127.0.0.1:123 Aug 30 10:30:56 streamer ntpd[792]: Listening on routing socket on fd #19 for interface updates Aug 30 10:30:56 streamer ntpd[792]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 30 10:30:56 streamer ntpd[792]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 30 10:30:56 streamer systemd[1]: Starting Hostname Service... Aug 30 10:30:56 streamer sshd[796]: Server listening on 0.0.0.0 port 22. Aug 30 10:30:56 streamer sshd[796]: Server listening on :: port 22. Aug 30 10:30:56 streamer systemd[1]: Started OpenBSD Secure Shell server. Aug 30 10:30:56 streamer bluetoothd[735]: Failed to set privacy: Rejected (0x0b) Aug 30 10:30:57 streamer dbus-daemon[580]: [system] Successfully activated service 'org.freedesktop.hostname1' Aug 30 10:30:57 streamer systemd[1]: Started Hostname Service. Aug 30 10:30:57 streamer haveged[532]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Aug 30 10:30:57 streamer haveged[532]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Aug 30 10:30:57 streamer haveged[532]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.0004 Aug 30 10:30:57 streamer haveged[532]: haveged: fills: 0, generated: 0 Aug 30 10:30:57 streamer ntpd[792]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Aug 30 10:30:57 streamer kernel: hwmon hwmon1: Undervoltage detected! Aug 30 10:30:58 streamer nmbd[755]: [2024/08/30 10:30:58.252916, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Aug 30 10:30:58 streamer nmbd[755]: started asyncdns process 814 Aug 30 10:30:58 streamer nmbd[755]: [2024/08/30 10:30:58.261760, 0] ../lib/util/become_daemon.c:149(daemon_status) Aug 30 10:30:58 streamer nmbd[755]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Aug 30 10:30:58 streamer nmbd[755]: [2024/08/30 10:30:58.261902, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Aug 30 10:30:58 streamer nmbd[755]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Aug 30 10:30:58 streamer ntpd[792]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58-03:00" level=warning msg="containerd config version `1` has been deprecated and will be removed in containerd v2.0, please switch to version `2`, see https://github.com/containerd/containerd/blob/main/docs/PLUGINS.md#version-header" Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.756639890-03:00" level=info msg="starting containerd" revision=3dce8eb055cbb6872793272b4f20ed16117344f8 version=1.6.21 Aug 30 10:30:58 streamer wireless.js[601]: Cleaning previous... Aug 30 10:30:58 streamer systemd[1]: systemd-rfkill.service: Succeeded. Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.920219291-03:00" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.923940847-03:00" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.934697964-03:00" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.1.69-v7+\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.934961349-03:00" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.936202597-03:00" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (overlay) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.936376346-03:00" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.936488794-03:00" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.936586033-03:00" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.940203631-03:00" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.941902795-03:00" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.942871127-03:00" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.943060293-03:00" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.943347584-03:00" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.943443938-03:00" level=info msg="metadata content store policy set" policy=shared Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.955255532-03:00" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.955479282-03:00" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.956760529-03:00" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.957062196-03:00" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.957202716-03:00" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.957307247-03:00" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.957401935-03:00" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.957503966-03:00" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.957602299-03:00" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.957701830-03:00" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.957796778-03:00" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.957890319-03:00" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.958277246-03:00" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.958774224-03:00" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.962834529-03:00" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.963166872-03:00" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.963464789-03:00" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.964198173-03:00" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.964402079-03:00" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.964509839-03:00" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.964602495-03:00" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.964713015-03:00" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.964816505-03:00" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.964919369-03:00" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.965014109-03:00" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.965127859-03:00" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.978048721-03:00" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.978282158-03:00" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.978425648-03:00" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.978548616-03:00" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.978686324-03:00" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.978792053-03:00" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.978969813-03:00" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.980395384-03:00" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.980838300-03:00" level=info msg=serving... address=/run/containerd/containerd.sock Aug 30 10:30:58 streamer systemd[1]: Started containerd container runtime. Aug 30 10:30:58 streamer containerd[756]: time="2024-08-30T10:30:58.982399547-03:00" level=info msg="containerd successfully booted in 0.236004s" Aug 30 10:30:59 streamer sudo[826]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Aug 30 10:30:59 streamer sudo[826]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:30:59 streamer sudo[826]: pam_unix(sudo:session): session closed for user root Aug 30 10:30:59 streamer systemd[1]: Starting Docker Application Container Engine... Aug 30 10:30:59 streamer sudo[830]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Aug 30 10:30:59 streamer sudo[830]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:30:59 streamer sudo[830]: pam_unix(sudo:session): session closed for user root Aug 30 10:30:59 streamer ntpd[792]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Aug 30 10:30:59 streamer wireless.js[601]: Stopped aP Aug 30 10:30:59 streamer sudo[842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Aug 30 10:30:59 streamer sudo[842]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:30:59 streamer sudo[842]: pam_unix(sudo:session): session closed for user root Aug 30 10:30:59 streamer kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Aug 30 10:30:59 streamer sudo[844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Aug 30 10:30:59 streamer sudo[844]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:30:59 streamer sudo[844]: pam_unix(sudo:session): session closed for user root Aug 30 10:30:59 streamer sudo[851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Aug 30 10:30:59 streamer sudo[851]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:30:59 streamer sudo[851]: pam_unix(sudo:session): session closed for user root Aug 30 10:30:59 streamer sudo[853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Aug 30 10:30:59 streamer sudo[853]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:00 streamer volumio-remote-updater[598]: [2024-08-30 10:31:00] [info] asio async_connect error: system:111 (Connection refused) Aug 30 10:31:00 streamer volumio-remote-updater[598]: [2024-08-30 10:31:00] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 30 10:31:00 streamer volumio-remote-updater[598]: [2024-08-30 10:31:00] [error] handle_connect error: Underlying Transport Error Aug 30 10:31:00 streamer ntpd[792]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Aug 30 10:31:01 streamer bthelper[685]: Changing power off succeeded Aug 30 10:31:01 streamer bthelper[685]: [CHG] Controller B8:27:EB:F2:C8:0F Powered: no Aug 30 10:31:01 streamer bthelper[685]: [CHG] Controller B8:27:EB:F2:C8:0F Discovering: no Aug 30 10:31:01 streamer bthelper[685]: [CHG] Controller B8:27:EB:F2:C8:0F Class: 0x00000000 Aug 30 10:31:01 streamer bthelper[685]: [CHG] Controller B8:27:EB:F2:C8:0F Class: 0x0000041c Aug 30 10:31:01 streamer bthelper[685]: Changing power on succeeded Aug 30 10:31:01 streamer dockerd[828]: time="2024-08-30T10:31:01.778643608-03:00" level=info msg="Starting up" Aug 30 10:31:01 streamer dockerd[828]: time="2024-08-30T10:31:01.860584662-03:00" level=error msg="failed to mount overlay: invalid argument" storage-driver=overlay2 Aug 30 10:31:01 streamer dockerd[828]: time="2024-08-30T10:31:01.861428098-03:00" level=error msg="exec: \"fuse-overlayfs\": executable file not found in $PATH" storage-driver=fuse-overlayfs Aug 30 10:31:01 streamer kernel: overlayfs: filesystem on '/var/lib/docker/check-overlayfs-support1343293925/upper' not supported as upperdir Aug 30 10:31:01 streamer kernel: hwmon hwmon1: Voltage normalised Aug 30 10:31:01 streamer dockerd[828]: time="2024-08-30T10:31:01.988183033-03:00" level=info msg="Loading containers: start." Aug 30 10:31:02 streamer kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Aug 30 10:31:02 streamer kernel: Bridge firewalling registered Aug 30 10:31:02 streamer sudo[853]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:02 streamer wireless.js[601]: SETTING APPROPRIATE REG DOMAIN: AR Aug 30 10:31:02 streamer sudo[902]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Aug 30 10:31:02 streamer sudo[902]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:02 streamer sudo[902]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:02 streamer systemd-udevd[361]: Using default interface naming scheme 'v240'. Aug 30 10:31:02 streamer systemd-udevd[361]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 30 10:31:02 streamer sudo[904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set AR Aug 30 10:31:02 streamer sudo[904]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:02 streamer sudo[904]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:02 streamer wireless.js[601]: SUCCESSFULLY SET NEW REGDOMAIN: AR Aug 30 10:31:02 streamer wireless.js[601]: Start wireless flow Aug 30 10:31:02 streamer wireless.js[601]: Stopped hotspot (if there).. Aug 30 10:31:02 streamer sudo[923]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Aug 30 10:31:02 streamer sudo[923]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:02 streamer sudo[923]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:02 streamer sudo[929]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Aug 30 10:31:02 streamer sudo[929]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:03 streamer sudo[929]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:03 streamer avahi-daemon[588]: Joining mDNS multicast group on interface docker0.IPv4 with address 172.18.0.1. Aug 30 10:31:03 streamer avahi-daemon[588]: New relevant interface docker0.IPv4 for mDNS. Aug 30 10:31:03 streamer avahi-daemon[588]: Registering new address record for 172.18.0.1 on docker0.IPv4. Aug 30 10:31:03 streamer wireless.js[601]: DHCP IP Aug 30 10:31:03 streamer wireless.js[601]: Start ap Aug 30 10:31:03 streamer wpa_supplicant[947]: Successfully initialized wpa_supplicant Aug 30 10:31:03 streamer sudo[949]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Aug 30 10:31:03 streamer sudo[949]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:03 streamer kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Aug 30 10:31:03 streamer dhcpcd[951]: dev: loaded udev Aug 30 10:31:03 streamer systemd[1]: Started Samba NMB Daemon. Aug 30 10:31:03 streamer nmbd[755]: [2024/08/30 10:31:03.267767, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 30 10:31:03 streamer nmbd[755]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Aug 30 10:31:03 streamer dhcpcd-run-hooks[974]: wlan0: starting wpa_supplicant Aug 30 10:31:03 streamer systemd[1]: Starting Samba Winbind Daemon... Aug 30 10:31:03 streamer dhcpcd-run-hooks[994]: wlan0: failed to start wpa_supplicant Aug 30 10:31:03 streamer dhcpcd-run-hooks[995]: 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 Aug 30 10:31:03 streamer dhcpcd[951]: wlan0: connected to Access Point `' Aug 30 10:31:03 streamer dhcpcd[951]: no interfaces have a carrier Aug 30 10:31:03 streamer dhcpcd[951]: forked to background, child pid 1006 Aug 30 10:31:03 streamer dhcpcd[1006]: eth0: waiting for carrier Aug 30 10:31:03 streamer dhcpcd[1006]: wlan0: waiting for carrier Aug 30 10:31:03 streamer sudo[949]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:03 streamer winbindd[975]: [2024/08/30 10:31:03.946249, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Aug 30 10:31:03 streamer winbindd[975]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Aug 30 10:31:03 streamer winbindd[975]: [2024/08/30 10:31:03.996517, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 30 10:31:03 streamer systemd[1]: Started Samba Winbind Daemon. Aug 30 10:31:03 streamer winbindd[975]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Aug 30 10:31:04 streamer kernel: hwmon hwmon1: Undervoltage detected! Aug 30 10:31:04 streamer systemd[1]: Starting Samba SMB Daemon... Aug 30 10:31:04 streamer wireless.js[601]: trying... Aug 30 10:31:04 streamer sudo[1019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 10:31:04 streamer sudo[1019]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:04 streamer sudo[1019]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:04 streamer dockerd[828]: time="2024-08-30T10:31:04.327989039-03:00" level=info msg="Removing stale sandbox 028ab646db073fa2f0144767c4fafb96c95777d8f32cd04e1f795d4363225a38 (3f1e1ebe2d29d871d413d4cf91a58b9714510575d9c95bdbded43b72dd96e714)" Aug 30 10:31:04 streamer dockerd[828]: time="2024-08-30T10:31:04.586852492-03:00" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint a0c931201564cc8b05eebabfe05f0b805f7c3a486311ac2ce1dea533b7eaf1f8 08a6e12c8031753a6e4e186d6042913816392851a48951530cce6425b00a806c], retrying...." Aug 30 10:31:04 streamer systemd[1]: run-docker-netns-028ab646db07.mount: Succeeded. Aug 30 10:31:04 streamer winbindd[975]: [2024/08/30 10:31:04.972018, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Aug 30 10:31:04 streamer winbindd[975]: res_names->count = 3, expected 4 Aug 30 10:31:05 streamer smbd[1016]: [2024/08/30 10:31:05.028994, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 30 10:31:05 streamer smbd[1016]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Aug 30 10:31:05 streamer systemd[1]: Started Samba SMB Daemon. Aug 30 10:31:05 streamer dockerd[828]: time="2024-08-30T10:31:05.139412618-03:00" level=info msg="Default bridge (docker0) is assigned with an IP address 172.18.0.0/16. Daemon option --bip can be used to set a preferred IP address" Aug 30 10:31:05 streamer wireless.js[601]: trying... Aug 30 10:31:05 streamer sudo[1059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 10:31:05 streamer sudo[1059]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:05 streamer sudo[1059]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:05 streamer kernel: docker0: port 1(vethf984134) entered blocking state Aug 30 10:31:05 streamer kernel: docker0: port 1(vethf984134) entered disabled state Aug 30 10:31:05 streamer kernel: device vethf984134 entered promiscuous mode Aug 30 10:31:05 streamer systemd-udevd[361]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 30 10:31:05 streamer systemd-udevd[361]: Could not generate persistent MAC address for veth11cb4be: No such file or directory Aug 30 10:31:05 streamer systemd-udevd[356]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 30 10:31:05 streamer systemd-udevd[356]: Using default interface naming scheme 'v240'. Aug 30 10:31:05 streamer systemd-udevd[356]: Could not generate persistent MAC address for vethf984134: No such file or directory Aug 30 10:31:05 streamer dhcpcd[1006]: veth11cb4be: waiting for carrier Aug 30 10:31:05 streamer kernel: docker0: port 1(vethf984134) entered blocking state Aug 30 10:31:05 streamer kernel: docker0: port 1(vethf984134) entered forwarding state Aug 30 10:31:05 streamer dhcpcd[1006]: vethf984134: waiting for carrier Aug 30 10:31:05 streamer dhcpcd[1006]: veth11cb4be: carrier acquired Aug 30 10:31:05 streamer dhcpcd[1006]: DUID 00:01:00:01:2b:1f:b6:7f:b8:27:eb:0d:37:f0 Aug 30 10:31:05 streamer dhcpcd[1006]: veth11cb4be: IAID 57:4d:e2:6e Aug 30 10:31:05 streamer dhcpcd[1006]: veth11cb4be: adding address fe80::2682:4f24:1e93:501f Aug 30 10:31:05 streamer dhcpcd[1006]: ipv6_addaddr1: Permission denied Aug 30 10:31:05 streamer dhcpcd[1006]: vethf984134: carrier acquired Aug 30 10:31:05 streamer dhcpcd[1006]: vethf984134: IAID c1:28:cb:df Aug 30 10:31:05 streamer dhcpcd[1006]: vethf984134: adding address fe80::1d68:7fa0:5a00:ee71 Aug 30 10:31:05 streamer dhcpcd[1006]: ipv6_addaddr1: Permission denied Aug 30 10:31:05 streamer dhcpcd[1006]: veth11cb4be: soliciting a DHCP lease Aug 30 10:31:05 streamer dhcpcd[1006]: vethf984134: soliciting an IPv6 router Aug 30 10:31:05 streamer dhcpcd[1006]: vethf984134: soliciting a DHCP lease Aug 30 10:31:05 streamer wpa_supplicant[982]: wlan0: Trying to associate with SSID 'Sun' Aug 30 10:31:06 streamer wireless.js[601]: trying... Aug 30 10:31:06 streamer sudo[1149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 10:31:06 streamer sudo[1149]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:06 streamer containerd[756]: time="2024-08-30T10:31:06.197315765-03:00" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 30 10:31:06 streamer containerd[756]: time="2024-08-30T10:31:06.198110972-03:00" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 30 10:31:06 streamer containerd[756]: time="2024-08-30T10:31:06.198293211-03:00" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 30 10:31:06 streamer sudo[1149]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:06 streamer containerd[756]: time="2024-08-30T10:31:06.206618197-03:00" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/3f1e1ebe2d29d871d413d4cf91a58b9714510575d9c95bdbded43b72dd96e714 pid=1152 runtime=io.containerd.runc.v2 Aug 30 10:31:06 streamer dhcpcd[1006]: veth11cb4be: soliciting an IPv6 router Aug 30 10:31:07 streamer wireless.js[601]: trying... Aug 30 10:31:07 streamer sudo[1196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 10:31:07 streamer sudo[1196]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:07 streamer sudo[1196]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:07 streamer dhcpcd[1006]: veth11cb4be: carrier lost Aug 30 10:31:07 streamer kernel: docker0: port 1(vethf984134) entered disabled state Aug 30 10:31:07 streamer kernel: eth0: renamed from veth11cb4be Aug 30 10:31:07 streamer dhcpcd[1006]: veth11cb4be: removing interface Aug 30 10:31:07 streamer kernel: docker0: port 1(vethf984134) entered blocking state Aug 30 10:31:07 streamer kernel: docker0: port 1(vethf984134) entered forwarding state Aug 30 10:31:07 streamer containerd[756]: time="2024-08-30T10:31:07.472115355-03:00" level=error msg="add cg to OOM monitor" error="cgroups: memory cgroup not supported on this system" Aug 30 10:31:07 streamer dhcpcd[1006]: vethf984134: carrier lost Aug 30 10:31:07 streamer dockerd[828]: time="2024-08-30T10:31:07.527544008-03:00" level=info msg="Loading containers: done." Aug 30 10:31:07 streamer dhcpcd[1006]: vethf984134: carrier acquired Aug 30 10:31:07 streamer dhcpcd[1006]: vethf984134: IAID c1:28:cb:df Aug 30 10:31:07 streamer dhcpcd[1006]: vethf984134: soliciting an IPv6 router Aug 30 10:31:07 streamer dockerd[828]: time="2024-08-30T10:31:07.627097740-03:00" level=warning msg="WARNING: No memory limit support" Aug 30 10:31:07 streamer dockerd[828]: time="2024-08-30T10:31:07.627229823-03:00" level=warning msg="WARNING: No swap limit support" Aug 30 10:31:07 streamer dockerd[828]: time="2024-08-30T10:31:07.627284927-03:00" level=warning msg="WARNING: No kernel memory TCP limit support" Aug 30 10:31:07 streamer dockerd[828]: time="2024-08-30T10:31:07.627340969-03:00" level=warning msg="WARNING: No oom kill disable support" Aug 30 10:31:07 streamer dockerd[828]: time="2024-08-30T10:31:07.627396438-03:00" level=warning msg="WARNING: No blkio throttle.read_bps_device support" Aug 30 10:31:07 streamer dockerd[828]: time="2024-08-30T10:31:07.627451281-03:00" level=warning msg="WARNING: No blkio throttle.write_bps_device support" Aug 30 10:31:07 streamer dockerd[828]: time="2024-08-30T10:31:07.627506281-03:00" level=warning msg="WARNING: No blkio throttle.read_iops_device support" Aug 30 10:31:07 streamer dockerd[828]: time="2024-08-30T10:31:07.627560083-03:00" level=warning msg="WARNING: No blkio throttle.write_iops_device support" Aug 30 10:31:07 streamer dockerd[828]: time="2024-08-30T10:31:07.627708208-03:00" level=info msg="Docker daemon" commit=94d3ad6 graphdriver=vfs version=23.0.5 Aug 30 10:31:07 streamer dockerd[828]: time="2024-08-30T10:31:07.629091591-03:00" level=info msg="Daemon has completed initialization" Aug 30 10:31:07 streamer volumio-remote-updater[598]: [2024-08-30 10:31:07] [info] asio async_connect error: system:111 (Connection refused) Aug 30 10:31:07 streamer volumio-remote-updater[598]: [2024-08-30 10:31:07] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 30 10:31:07 streamer volumio-remote-updater[598]: [2024-08-30 10:31:07] [error] handle_connect error: Underlying Transport Error Aug 30 10:31:08 streamer wireless.js[601]: trying... Aug 30 10:31:08 streamer kernel: hwmon hwmon1: Voltage normalised Aug 30 10:31:08 streamer sudo[1274]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 10:31:08 streamer sudo[1274]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:08 streamer sudo[1274]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:08 streamer systemd[1]: Started Docker Application Container Engine. Aug 30 10:31:08 streamer dockerd[828]: time="2024-08-30T10:31:08.425407175-03:00" level=info msg="API listen on /run/docker.sock" Aug 30 10:31:08 streamer dhcpcd[1006]: vethf984134: soliciting a DHCP lease Aug 30 10:31:08 streamer dhcpcd[1006]: wlan0: carrier acquired Aug 30 10:31:08 streamer dhcpcd[1006]: wlan0: connected to Access Point `Sun' Aug 30 10:31:08 streamer wpa_supplicant[982]: wlan0: Associated with 7a:45:58:15:7c:01 Aug 30 10:31:08 streamer wpa_supplicant[982]: wlan0: CTRL-EVENT-CONNECTED - Connection to 7a:45:58:15:7c:01 completed [id=0 id_str=] Aug 30 10:31:08 streamer wpa_supplicant[982]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Aug 30 10:31:08 streamer wpa_supplicant[982]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=AR Aug 30 10:31:08 streamer dhcpcd[1006]: wlan0: IAID eb:0d:37:f0 Aug 30 10:31:08 streamer dhcpcd[1006]: wlan0: adding address fe80::57dd:84da:f9af:16aa Aug 30 10:31:08 streamer dhcpcd[1006]: ipv6_addaddr1: Permission denied Aug 30 10:31:08 streamer dhcpcd[1006]: wlan0: carrier lost Aug 30 10:31:08 streamer dhcpcd[1006]: wlan0: carrier acquired Aug 30 10:31:08 streamer dhcpcd[1006]: wlan0: IAID eb:0d:37:f0 Aug 30 10:31:09 streamer wireless.js[601]: trying... Aug 30 10:31:09 streamer sudo[1305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 10:31:09 streamer sudo[1305]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:09 streamer sudo[1305]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:09 streamer dhcpcd[1006]: wlan0: rebinding lease of 172.17.0.102 Aug 30 10:31:09 streamer dhcpcd[1006]: wlan0: probing address 172.17.0.102/24 Aug 30 10:31:09 streamer dhcpcd[1006]: wlan0: soliciting an IPv6 router Aug 30 10:31:09 streamer ntpd[792]: Listen normally on 3 docker0 172.18.0.1:123 Aug 30 10:31:09 streamer ntpd[792]: new interface(s) found: waking up resolver Aug 30 10:31:10 streamer wireless.js[601]: trying... Aug 30 10:31:10 streamer sudo[1317]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 10:31:10 streamer sudo[1317]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:10 streamer sudo[1317]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:11 streamer wireless.js[601]: trying... Aug 30 10:31:11 streamer sudo[1320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 10:31:11 streamer sudo[1320]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:11 streamer sudo[1320]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:12 streamer wireless.js[601]: trying... Aug 30 10:31:12 streamer sudo[1323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 10:31:12 streamer sudo[1323]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:12 streamer sudo[1323]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:13 streamer wireless.js[601]: trying... Aug 30 10:31:13 streamer sudo[1326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 10:31:13 streamer sudo[1326]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:13 streamer sudo[1326]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:13 streamer dhcpcd[1006]: vethf984134: probing for an IPv4LL address Aug 30 10:31:13 streamer dhcpcd[1006]: wlan0: leased 172.17.0.102 for 86400 seconds Aug 30 10:31:13 streamer avahi-daemon[588]: Joining mDNS multicast group on interface wlan0.IPv4 with address 172.17.0.102. Aug 30 10:31:13 streamer avahi-daemon[588]: New relevant interface wlan0.IPv4 for mDNS. Aug 30 10:31:13 streamer dhcpcd[1006]: wlan0: adding route to 172.17.0.0/24 Aug 30 10:31:13 streamer dhcpcd[1006]: wlan0: adding default route via 172.17.0.1 Aug 30 10:31:13 streamer avahi-daemon[588]: Registering new address record for 172.17.0.102 on wlan0.IPv4. Aug 30 10:31:14 streamer wireless.js[601]: trying... Aug 30 10:31:14 streamer sudo[1350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 30 10:31:14 streamer sudo[1350]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:14 streamer sudo[1350]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:14 streamer wireless.js[601]: Connected to: ----Sun Aug 30 10:31:14 streamer wireless.js[601]: ---- Aug 30 10:31:14 streamer sudo[1353]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 10:31:14 streamer sudo[1353]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:14 streamer sudo[1353]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:14 streamer wireless.js[601]: ... joined AP, wlan0 IPv4 is 172.17.0.102, ipV6 is undefined Aug 30 10:31:14 streamer wireless.js[601]: It's done! AP Aug 30 10:31:14 streamer systemd[1]: Started Wireless Services. Aug 30 10:31:14 streamer systemd[1]: Started Volumio Backend Module. Aug 30 10:31:14 streamer kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Aug 30 10:31:14 streamer systemd[1]: Started Volumio Cpu Tweaker. Aug 30 10:31:14 streamer systemd[1]: Reached target Multi-User System. Aug 30 10:31:14 streamer systemd[1]: Reached target Graphical Interface. Aug 30 10:31:14 streamer systemd[1]: Starting Update UTMP about System Runlevel Changes... Aug 30 10:31:14 streamer systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Aug 30 10:31:14 streamer systemd[1]: Started Update UTMP about System Runlevel Changes. Aug 30 10:31:14 streamer systemd[1]: Startup finished in 15.593s (kernel) + 26.569s (userspace) = 42.163s. Aug 30 10:31:14 streamer volumio-cpu-tweak[1359]: Setting RT Priority for mpd Aug 30 10:31:14 streamer volumio-cpu-tweak[1359]: pid 35's current scheduling policy: SCHED_OTHER Aug 30 10:31:14 streamer volumio-cpu-tweak[1359]: pid 35's current scheduling priority: 0 Aug 30 10:31:14 streamer volumio-cpu-tweak[1359]: Setting MPD Affinity Aug 30 10:31:14 streamer volumio-cpu-tweak[1359]: pid 3's current affinity mask: f Aug 30 10:31:14 streamer volumio-cpu-tweak[1359]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Aug 30 10:31:14 streamer volumio-cpu-tweak[1359]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Aug 30 10:31:14 streamer systemd[1]: volumio_cpu_tweak.service: Succeeded. Aug 30 10:31:15 streamer ntpd[792]: Listen normally on 4 wlan0 172.17.0.102:123 Aug 30 10:31:15 streamer ntpd[792]: new interface(s) found: waking up resolver Aug 30 10:31:17 streamer volumio[1358]: info: ------------------------------------------- Aug 30 10:31:17 streamer volumio[1358]: info: ----- Volumio3 ---- Aug 30 10:31:17 streamer volumio[1358]: info: ------------------------------------------- Aug 30 10:31:17 streamer volumio[1358]: info: ----- System startup ---- Aug 30 10:31:17 streamer volumio[1358]: info: ------------------------------------------- Aug 30 10:31:17 streamer volumio-remote-updater[598]: [2024-08-30 10:31:17] [connect] Successful connection Aug 30 10:31:18 streamer volumio[1358]: info: MYVOLUMIO Environment detected Aug 30 10:31:18 streamer dhcpcd[1006]: vethf984134: using IPv4LL address 169.254.125.145 Aug 30 10:31:18 streamer avahi-daemon[588]: Joining mDNS multicast group on interface vethf984134.IPv4 with address 169.254.125.145. Aug 30 10:31:18 streamer dhcpcd[1006]: vethf984134: adding route to 169.254.0.0/16 Aug 30 10:31:18 streamer avahi-daemon[588]: New relevant interface vethf984134.IPv4 for mDNS. Aug 30 10:31:18 streamer avahi-daemon[588]: Registering new address record for 169.254.125.145 on vethf984134.IPv4. Aug 30 10:31:18 streamer volumio[1358]: info: Plugin folders cleanup Aug 30 10:31:18 streamer volumio[1358]: info: Scanning into folder /volumio/app/plugins/ Aug 30 10:31:18 streamer volumio[1358]: info: Scanning category audio_interface Aug 30 10:31:18 streamer volumio[1358]: info: Scanning category miscellanea Aug 30 10:31:18 streamer volumio[1358]: info: Scanning category music_service Aug 30 10:31:18 streamer volumio[1358]: info: Scanning category plugins.json Aug 30 10:31:18 streamer volumio[1358]: info: Scanning category system_controller Aug 30 10:31:18 streamer volumio[1358]: info: Scanning category user_interface Aug 30 10:31:18 streamer volumio[1358]: info: Scanning into folder /data/plugins/ Aug 30 10:31:18 streamer volumio[1358]: info: Scanning category audio_interface Aug 30 10:31:18 streamer volumio[1358]: info: Scanning category music_service Aug 30 10:31:18 streamer volumio[1358]: info: Scanning category system_controller Aug 30 10:31:18 streamer volumio[1358]: info: Scanning category user_interface Aug 30 10:31:18 streamer volumio[1358]: info: Plugin folders cleanup completed Aug 30 10:31:18 streamer volumio[1358]: info: ------------------------------------------- Aug 30 10:31:18 streamer volumio[1358]: info: ----- Core plugins startup ---- Aug 30 10:31:18 streamer volumio[1358]: info: ------------------------------------------- Aug 30 10:31:18 streamer volumio[1358]: info: Loading plugins from folder /volumio/app/plugins/ Aug 30 10:31:18 streamer volumio[1358]: info: Adding plugin upnp to MyMusic Plugins Aug 30 10:31:18 streamer volumio[1358]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 30 10:31:18 streamer volumio[1358]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 30 10:31:18 streamer volumio[1358]: info: Loading plugins from folder /data/plugins/ Aug 30 10:31:18 streamer volumio[1358]: info: Loading plugin "system"... Aug 30 10:31:18 streamer volumio[1358]: info: Loading plugin "appearance"... Aug 30 10:31:19 streamer ntpd[792]: Listen normally on 5 vethf984134 169.254.125.145:123 Aug 30 10:31:19 streamer ntpd[792]: new interface(s) found: waking up resolver Aug 30 10:31:20 streamer volumio[1358]: info: Loading plugin "network"... Aug 30 10:31:20 streamer volumio[1358]: info: Refreshing Cached IP Addresses Aug 30 10:31:20 streamer sudo[1409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 10:31:20 streamer sudo[1409]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:20 streamer volumio[1358]: info: Loading plugin "services"... Aug 30 10:31:20 streamer sudo[1411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 10:31:20 streamer sudo[1411]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:20 streamer sudo[1409]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:20 streamer volumio[1358]: info: Loading plugin "alsa_controller"... Aug 30 10:31:20 streamer sudo[1411]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:20 streamer sudo[1413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 30 10:31:20 streamer sudo[1413]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:20 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 10:31:20 streamer volumio[1358]: info: Loading plugin "wizard"... Aug 30 10:31:20 streamer volumio[1358]: info: Loading plugin "networkfs"... Aug 30 10:31:20 streamer volumio[1358]: info: Starting Udev Watcher for removable devices Aug 30 10:31:20 streamer sudo[1422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=homeassistant,password=passdesamba,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //ha/media/Music /mnt/NAS/HA Aug 30 10:31:20 streamer sudo[1422]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:20 streamer volumio[1358]: info: Ignoring mount for partition: boot Aug 30 10:31:20 streamer volumio[1358]: info: Ignoring mount for partition: volumio Aug 30 10:31:20 streamer volumio[1358]: info: Ignoring mount for partition: volumio_data Aug 30 10:31:20 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 10:31:20 streamer volumio[1358]: info: Loading plugin "volumio_command_line_client"... Aug 30 10:31:20 streamer volumio[1358]: info: Loading plugin "upnp"... Aug 30 10:31:20 streamer volumio[1358]: info: [1725024680497] Starting Upmpd Daemon Aug 30 10:31:20 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 10:31:20 streamer volumio[1358]: info: Loading plugin "my_music"... Aug 30 10:31:20 streamer volumio[1358]: info: Loading plugin "mpd"... Aug 30 10:31:20 streamer kernel: Key type cifs.spnego registered Aug 30 10:31:20 streamer kernel: Key type cifs.idmap registered Aug 30 10:31:20 streamer 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 30 10:31:20 streamer kernel: CIFS: Attempting to mount \\ha\media Aug 30 10:31:21 streamer volumio[1358]: info: Loading plugin "upnp_browser"... Aug 30 10:31:21 streamer volumio[1358]: info: Loading plugin "alarm-clock"... Aug 30 10:31:21 streamer volumio[1358]: info: Loading plugin "airplay_emulation"... Aug 30 10:31:21 streamer volumio[1358]: info: Starting Shairport Sync Aug 30 10:31:21 streamer volumio[1358]: info: Loading plugin "last_100"... Aug 30 10:31:21 streamer volumio[1358]: info: Loading plugin "webradio"... Aug 30 10:31:21 streamer volumio[1358]: info: Loading plugin "i2s_dacs"... Aug 30 10:31:21 streamer volumio[1358]: info: I2S DAC not set, start Auto-detection Aug 30 10:31:21 streamer volumio[1358]: info: Loading plugin "volumiodiscovery"... Aug 30 10:31:22 streamer volumio[1358]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 10:31:22 streamer node[1358]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 10:31:22 streamer volumio[1358]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 10:31:22 streamer node[1358]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 10:31:22 streamer volumio[1358]: *** WARNING *** For more information see Aug 30 10:31:22 streamer node[1358]: *** WARNING *** For more information see Aug 30 10:31:22 streamer volumio[1358]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 10:31:22 streamer node[1358]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 10:31:22 streamer volumio[1358]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 10:31:22 streamer node[1358]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 10:31:22 streamer volumio[1358]: *** WARNING *** For more information see Aug 30 10:31:22 streamer node[1358]: *** WARNING *** For more information see Aug 30 10:31:22 streamer volumio[1358]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 30 10:31:22 streamer volumio[1358]: info: Discovery: Started advertising with name: Streamer Aug 30 10:31:22 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 10:31:22 streamer volumio[1358]: info: Loading plugin "spop"... Aug 30 10:31:22 streamer systemd[1]: systemd-fsckd.service: Succeeded. Aug 30 10:31:23 streamer sudo[1422]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:23 streamer volumio[1358]: info: Loading plugin "ytcr"... Aug 30 10:31:23 streamer sudo[1413]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:25 streamer sh[506]: timed out Aug 30 10:31:25 streamer dhcpcd[539]: timed out Aug 30 10:31:25 streamer sh[506]: dhcpcd exited Aug 30 10:31:25 streamer dhcpcd[539]: dhcpcd exited Aug 30 10:31:25 streamer sh[506]: ifup: failed to bring up eth0 Aug 30 10:31:25 streamer systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:31:25 streamer systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Aug 30 10:31:25 streamer volumio[1358]: info: Loading plugin "outputs"... Aug 30 10:31:25 streamer volumio[1358]: info: Loading plugin "albumart"... Aug 30 10:31:25 streamer volumio[1358]: info: Plugin example_plugin is not enabled Aug 30 10:31:25 streamer volumio[1358]: info: Loading plugin "inputs"... Aug 30 10:31:25 streamer volumio[1358]: info: Loading plugin "updater_comm"... Aug 30 10:31:26 streamer volumio[1358]: info: Plugin mpdemulation is not enabled Aug 30 10:31:26 streamer volumio[1358]: info: Loading plugin "rest_api"... Aug 30 10:31:26 streamer volumio[1358]: info: Loading plugin "websocket"... Aug 30 10:31:26 streamer volumio[1358]: info: Starting Socket.io Server version 2.3.0 Aug 30 10:31:26 streamer volumio[1358]: info: Loading plugin "fusiondsp"... Aug 30 10:31:26 streamer volumio[1358]: Forking 3 albumart workers Aug 30 10:31:26 streamer volumio[1358]: info: Applying required configuration parameters for plugin fusiondsp Aug 30 10:31:26 streamer volumio[1358]: info: Loading plugin "snapclient"... Aug 30 10:31:27 streamer systemd[1]: systemd-hostnamed.service: Succeeded. Aug 30 10:31:27 streamer volumio[1358]: Starting albumart workers Aug 30 10:31:27 streamer volumio[1358]: Starting albumart workers Aug 30 10:31:27 streamer volumio[1358]: Starting albumart workers Aug 30 10:31:27 streamer volumio[1358]: info: Applying required configuration parameters for plugin snapclient Aug 30 10:31:27 streamer volumio[1358]: info: Loading plugin "backup_restore"... Aug 30 10:31:27 streamer volumio[1358]: info: Applying required configuration parameters for plugin backup_restore Aug 30 10:31:27 streamer volumio[1358]: info: Plugin Systeminfo is not enabled Aug 30 10:31:28 streamer volumio[1358]: info: Loading i18n strings for locale en Aug 30 10:31:28 streamer volumio[1358]: Updating browse sources language Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::initPlayerControls Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 10:31:28 streamer volumio[1358]: Express server listening on port 3000 Aug 30 10:31:28 streamer volumio[1358]: [Metrics] WebUI: 12s 217.65ms Aug 30 10:31:28 streamer volumio[1358]: info: CoreStateMachine::resetVolumioState Aug 30 10:31:28 streamer volumio[1358]: info: CoreStateMachine::getcurrentVolume Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::volumioRetrievevolume Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::volumioGetState Aug 30 10:31:28 streamer volumio[1358]: info: CorePlayQueue::getTrack 0 Aug 30 10:31:28 streamer volumio[1358]: info: Reloading queue from file Aug 30 10:31:28 streamer volumio[1358]: info: VolumeController:: Volume=93 Mute =false Aug 30 10:31:28 streamer volumio[1358]: info: CoreStateMachine::pushState Aug 30 10:31:28 streamer volumio[1358]: info: CorePlayQueue::getTrack 0 Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::volumioPushState Aug 30 10:31:28 streamer volumio[1358]: info: CoreStateMachine::updateTrackBlock Aug 30 10:31:28 streamer volumio[1358]: info: CorePlayQueue::getTrackBlock Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::volumioRetrievevolume Aug 30 10:31:28 streamer volumio[1358]: info: CoreStateMachine::setRepeat true single undefined Aug 30 10:31:28 streamer volumio[1358]: info: CoreStateMachine::pushState Aug 30 10:31:28 streamer volumio[1358]: info: CorePlayQueue::getTrack 0 Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::volumioPushState Aug 30 10:31:28 streamer volumio[1358]: info: CoreStateMachine::setRandom undefined Aug 30 10:31:28 streamer volumio[1358]: info: CoreStateMachine::pushState Aug 30 10:31:28 streamer volumio[1358]: info: CorePlayQueue::getTrack 0 Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::volumioPushState Aug 30 10:31:28 streamer volumio[1358]: info: Setting Device type: Raspberry PI Aug 30 10:31:28 streamer volumio[1358]: info: Listing playlists Aug 30 10:31:28 streamer volumio[1358]: info: Listing playlists Aug 30 10:31:28 streamer volumio[1358]: info: Completed loading Core Plugins Aug 30 10:31:28 streamer volumio[1358]: info: Preparing to generate the ALSA configuration file Aug 30 10:31:28 streamer volumio[1358]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 30 10:31:28 streamer volumio[1358]: info: Reading ALSA contributions from plugins. Aug 30 10:31:28 streamer volumio[1358]: info: VolumeController:: Volume=93 Mute =false Aug 30 10:31:28 streamer volumio[1358]: info: CoreStateMachine::pushState Aug 30 10:31:28 streamer volumio[1358]: info: CorePlayQueue::getTrack 0 Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::volumioPushState Aug 30 10:31:28 streamer volumio[1358]: info: Discovery: adding 5e64db9d-387a-4a0f-8943-463ef7ec36b3 Aug 30 10:31:28 streamer volumio[1358]: info: Discovery: Found device Streamer Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::volumioGetState Aug 30 10:31:28 streamer volumio[1358]: info: CorePlayQueue::getTrack 0 Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::volumioGetState Aug 30 10:31:28 streamer volumio[1358]: info: CorePlayQueue::getTrack 0 Aug 30 10:31:28 streamer volumio[1358]: info: Discovery: this is already registered, 5e64db9d-387a-4a0f-8943-463ef7ec36b3 Aug 30 10:31:28 streamer volumio[1358]: info: Discovery: Found device Streamer Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::volumioGetState Aug 30 10:31:28 streamer volumio[1358]: info: CorePlayQueue::getTrack 0 Aug 30 10:31:28 streamer volumio[1358]: info: Discovery: this is already registered, 5e64db9d-387a-4a0f-8943-463ef7ec36b3 Aug 30 10:31:28 streamer volumio[1358]: info: Discovery: Found device Streamer Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::volumioGetState Aug 30 10:31:28 streamer volumio[1358]: info: CorePlayQueue::getTrack 0 Aug 30 10:31:28 streamer volumio[1358]: info: Asound.conf file unchanged, so no further update is needed Aug 30 10:31:28 streamer volumio[1358]: info: Output device has changed, restarting MPD Aug 30 10:31:28 streamer volumio[1358]: info: Output device has changed, restarting Shairport Sync Aug 30 10:31:28 streamer sudo[1519]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:28 streamer sudo[1519]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:28 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 10:31:28 streamer sudo[1519]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:28 streamer sudo[1521]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 10:31:28 streamer sudo[1521]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:28 streamer volumio[1358]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 10:31:29 streamer volumio[1358]: info: ___________ START PLUGINS ___________ Aug 30 10:31:29 streamer volumio[1358]: info: ControllerMpd::onStart: Initializing MPD Aug 30 10:31:29 streamer volumio[1358]: info: Creating MPD Configuration file Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 10:31:29 streamer volumio[1358]: info: [1725024689042] CoreMusicLibrary::Adding element Media Servers Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 10:31:29 streamer sudo[1529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 10:31:29 streamer sudo[1529]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:29 streamer systemd[1]: Listening on mpd.socket. Aug 30 10:31:29 streamer sudo[1529]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:29 streamer systemd[1]: Starting Music Player Daemon... Aug 30 10:31:29 streamer sudo[1531]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 10:31:29 streamer sudo[1531]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 10:31:29 streamer systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 30 10:31:29 streamer systemd[1]: mpd.service: Succeeded. Aug 30 10:31:29 streamer systemd[1]: Stopped Music Player Daemon. Aug 30 10:31:29 streamer systemd[1]: Starting Music Player Daemon... Aug 30 10:31:29 streamer volumio[1358]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 10:31:29 streamer volumio[1358]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 10:31:29 streamer volumio[1358]: info: [1725024689198] CoreMusicLibrary::Adding element Last_100 Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 10:31:29 streamer volumio[1358]: info: [1725024689202] CoreMusicLibrary::Adding element Webradio Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 10:31:29 streamer volumio[1358]: info: Initializing BBC Radios Aug 30 10:31:29 streamer sudo[1538]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 10:31:29 streamer sudo[1538]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:29 streamer sudo[1538]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 30 10:31:29 streamer sudo[1538]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 10:31:29 streamer volumio[1358]: info: Creating Spotify config file Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:29 streamer volumio[1358]: info: Loading i18n strings for locale en Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:29 streamer volumio[1358]: info: FusionDsp - mixtype--------------------- Hardware Aug 30 10:31:29 streamer volumio[1358]: info: Volumio Calling Home Aug 30 10:31:29 streamer sudo[1555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart snapclient Aug 30 10:31:29 streamer sudo[1555]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:29 streamer systemd[1]: Started Snapcast client. Aug 30 10:31:29 streamer sudo[1555]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:29 streamer volumio[1358]: info: Preparing to generate the ALSA configuration file Aug 30 10:31:29 streamer snapclient[1559]: Home directory not accessible: Permission denied Aug 30 10:31:29 streamer volumio[1358]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 30 10:31:29 streamer volumio[1358]: info: Reading ALSA contributions from plugins. Aug 30 10:31:29 streamer volumio[1358]: info: [SnapClient] snapclient started Aug 30 10:31:29 streamer volumio[1358]: info: MPD Permissions set Aug 30 10:31:29 streamer volumio[1358]: info: MPD Permissions set Aug 30 10:31:29 streamer volumio[1358]: info: Spotify config file written Aug 30 10:31:29 streamer snapclient[1559]: W: [pulseaudio] core-util.c: Failed to open configuration file '/var/lib/snapclient/.config/pulse//daemon.conf': Permission denied Aug 30 10:31:29 streamer snapclient[1559]: W: [pulseaudio] daemon-conf.c: Failed to open configuration file: Permission denied Aug 30 10:31:29 streamer volumio[1358]: 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 30 10:31:29 streamer sudo[1563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:29 streamer snapclient[1559]: Home directory not accessible: Permission denied Aug 30 10:31:29 streamer sudo[1563]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:29 streamer snapclient[1559]: W: [pulseaudio] core-util.c: Failed to open configuration file '/var/lib/snapclient/.config/pulse//daemon.conf': Permission denied Aug 30 10:31:29 streamer snapclient[1559]: W: [pulseaudio] daemon-conf.c: Failed to open configuration file: Permission denied Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:29 streamer systemd[1]: Started go-librespot Daemon. Aug 30 10:31:29 streamer sudo[1563]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:29 streamer go-librespot[1570]: Librespot-go daemon starting... Aug 30 10:31:29 streamer snapclient[1559]: Version 0.26.0, revision e30a9f33 Aug 30 10:31:29 streamer snapclient[1559]: Resolving host IP for: 172.17.0.19 Aug 30 10:31:29 streamer snapclient[1559]: Connecting Aug 30 10:31:29 streamer snapclient[1559]: Connected to 172.17.0.19 Aug 30 10:31:29 streamer snapclient[1559]: My MAC: "b8:27:eb:0d:37:f0", socket: 9 Aug 30 10:31:29 streamer volumio[1358]: info: Starting Shairport Sync Aug 30 10:31:29 streamer volumio[1358]: info: Starting Shairport Sync Aug 30 10:31:29 streamer volumio[1358]: info: Starting Shairport Sync Aug 30 10:31:29 streamer sudo[1579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 10:31:29 streamer sudo[1579]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:29 streamer sudo[1581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 10:31:29 streamer sudo[1581]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:29 streamer volumio[1358]: info: CoreCommandRouter::volumioGetState Aug 30 10:31:29 streamer volumio[1358]: info: CorePlayQueue::getTrack 0 Aug 30 10:31:29 streamer sudo[1584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 10:31:29 streamer sudo[1584]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:29 streamer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 10:31:29 streamer systemd[1]: shairport-sync.service: Succeeded. Aug 30 10:31:29 streamer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 10:31:30 streamer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 10:31:30 streamer sudo[1581]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:30 streamer sudo[1579]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:30 streamer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 10:31:30 streamer systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 30 10:31:30 streamer systemd[1]: shairport-sync.service: Succeeded. Aug 30 10:31:30 streamer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 10:31:30 streamer volumio[1358]: info: Asound.conf file unchanged, so no further update is needed Aug 30 10:31:30 streamer volumio[1358]: info: Output device has changed, restarting MPD Aug 30 10:31:30 streamer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 10:31:30 streamer sudo[1584]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:30 streamer volumio[1358]: info: Output device has changed, restarting Shairport Sync Aug 30 10:31:30 streamer sudo[1594]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 10:31:30 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:30 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 10:31:30 streamer sudo[1594]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:30 streamer sudo[1594]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:30 streamer sudo[1598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 10:31:30 streamer sudo[1598]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:30 streamer systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 30 10:31:30 streamer systemd[1]: mpd.service: Succeeded. Aug 30 10:31:30 streamer systemd[1]: Stopped Music Player Daemon. Aug 30 10:31:30 streamer volumio[1358]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 10:31:30 streamer volumio[1358]: info: Shairport-Sync Started Aug 30 10:31:30 streamer volumio[1358]: Error adding Membership: Error: addMembership EINVAL Aug 30 10:31:30 streamer volumio[1358]: info: Shairport-Sync Started Aug 30 10:31:30 streamer volumio[1358]: info: Volumio called home Aug 30 10:31:30 streamer systemd[1]: Starting Music Player Daemon... Aug 30 10:31:30 streamer volumio[1358]: info: MPD Permissions set Aug 30 10:31:30 streamer volumio[1358]: info: Shairport-Sync Started Aug 30 10:31:30 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:30 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:30 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:30 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:30 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:30 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:30 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:30 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:30 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 10:31:30 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:30 streamer volumio[1358]: info: Starting Shairport Sync Aug 30 10:31:30 streamer sudo[1605]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 10:31:30 streamer sudo[1605]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:30 streamer sudo[1605]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 30 10:31:30 streamer sudo[1605]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:30 streamer sudo[1611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 10:31:30 streamer sudo[1611]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:30 streamer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 10:31:30 streamer systemd[1]: shairport-sync.service: Succeeded. Aug 30 10:31:30 streamer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 10:31:30 streamer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 10:31:30 streamer go-librespot[1570]: time="2024-08-30T10:31:30-03:00" level=info msg="generated new device id: 39f28c4a5843062784663ff12d9ed6178f685b89" Aug 30 10:31:30 streamer sudo[1611]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:30 streamer sudo[1617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 10:31:30 streamer sudo[1617]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:30 streamer sudo[1617]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:30 streamer volumio[1358]: info: Shairport-Sync Started Aug 30 10:31:30 streamer sudo[1621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 10:31:30 streamer sudo[1621]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:30 streamer sudo[1621]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:30 streamer sudo[1625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 30 10:31:30 streamer sudo[1625]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:30 streamer systemd[1]: Started UPnP Renderer front-end to MPD. Aug 30 10:31:30 streamer sudo[1625]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:30 streamer volumio[1358]: info: Upmpdcli Daemon Started Aug 30 10:31:31 streamer snapclient[1559]: ServerSettings - buffer: 2000, latency: 0, volume: 78, muted: 0 Aug 30 10:31:31 streamer snapclient[1559]: Codec: flac, sampleformat: 44100:16:2 Aug 30 10:31:31 streamer snapclient[1559]: Player name: alsa, device: sysdefault:CARD=Pro, description: DX3 Pro+, USB Audio Aug 30 10:31:31 streamer snapclient[1559]: Default Audio Device, idx: 27, sharing mode: unspecified, parameters: Aug 30 10:31:31 streamer snapclient[1559]: Mixer mode: software, parameters: Aug 30 10:31:31 streamer snapclient[1559]: Sampleformat: 44100:16:2, stream: 44100:16:2 Aug 30 10:31:31 streamer snapclient[1559]: Using default buffer_time: 80 ms, default fragments: 4 Aug 30 10:31:31 streamer snapclient[1559]: Period time too small, changing from 20000 to 21333 Aug 30 10:31:31 streamer snapclient[1559]: PCM name: sysdefault:CARD=Pro, sample rate: 44100 Hz, channels: 2, buffer time: 85328 us, periods: 4, period time: 21333 us, period frames: 940 Aug 30 10:31:31 streamer snapclient[1559]: No chunks available Aug 30 10:31:31 streamer snapclient[1559]: Failed to get chunk Aug 30 10:31:31 streamer go-librespot[1570]: time="2024-08-30T10:31:31-03:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 30 10:31:31 streamer go-librespot[1570]: time="2024-08-30T10:31:31-03:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 30 10:31:31 streamer go-librespot[1570]: time="2024-08-30T10:31:31-03:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 30 10:31:31 streamer go-librespot[1570]: time="2024-08-30T10:31:31-03:00" level=debug msg="zeroconf server listening on port 37755" Aug 30 10:31:31 streamer volumio[1358]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Aug 30 10:31:31 streamer volumio[1358]: info: camilladsp service started and running in background, instance 1 Aug 30 10:31:31 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 10:31:31 streamer volumio[1358]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 10:31:31 streamer volumio[1358]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Aug 30 10:31:31 streamer volumio[1358]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 10:31:31 streamer volumio[1358]: info: FusionDsp loaded Aug 30 10:31:31 streamer volumio[1358]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 10:31:31 streamer sudo[1643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 30 10:31:31 streamer sudo[1643]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:31:31 streamer volumio[1358]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 30 10:31:31 streamer volumio[1358]: info: Adding Signal Path Element [object Object] Aug 30 10:31:31 streamer volumio[1358]: info: Adding fusiondspeq DSP Signal Path Element Aug 30 10:31:31 streamer volumio[1358]: info: FusionDsp - ---- installed callbackRead Aug 30 10:31:31 streamer volumio[1358]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 10:31:31 streamer sudo[1643]: pam_unix(sudo:session): session closed for user root Aug 30 10:31:31 streamer volumio[1358]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 30 10:31:31 streamer volumio[1358]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Aug 30 10:31:31 streamer volumio[1358]: at onErrorNT (internal/child_process.js:465:16) Aug 30 10:31:31 streamer volumio[1358]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Aug 30 10:31:31 streamer volumio[1358]: errno: -2, Aug 30 10:31:31 streamer volumio[1358]: code: 'ENOENT', Aug 30 10:31:31 streamer volumio[1358]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 10:31:31 streamer volumio[1358]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 10:31:31 streamer volumio[1358]: spawnargs: [ Aug 30 10:31:31 streamer volumio[1358]: '-p', Aug 30 10:31:31 streamer volumio[1358]: 9876, Aug 30 10:31:31 streamer volumio[1358]: '-o', Aug 30 10:31:31 streamer volumio[1358]: '/tmp/camilladsp.log', Aug 30 10:31:31 streamer volumio[1358]: '-l', Aug 30 10:31:31 streamer volumio[1358]: 'warn', Aug 30 10:31:31 streamer volumio[1358]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 30 10:31:31 streamer volumio[1358]: ] Aug 30 10:31:31 streamer volumio[1358]: } Aug 30 10:31:31 streamer volumio[1358]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 10:31:31 streamer snapclient[1559]: diff to server [ms]: 1.02649e+09 Aug 30 10:31:32 streamer sudo[1654]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-30 10:30 Aug 30 10:31:32 streamer sudo[1654]: 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"