-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Thu 2025-09-11 21:28:14 CEST. --
Sep 11 21:28:00 volumio fake-hwclock[196]: Thu Sep 11 19:28:00 UTC 2025
Sep 11 21:28:00 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped.
Sep 11 21:28:00 volumio systemd[1]: Starting Load/Save Random Seed...
Sep 11 21:28:00 volumio systemd[1]: Starting Create System Users...
Sep 11 21:28:00 volumio systemd[1]: Started Restore / save the current clock.
Sep 11 21:28:00 volumio systemd[1]: Started Load/Save Random Seed.
Sep 11 21:28:00 volumio systemd[1]: dynamicswap.service: Succeeded.
Sep 11 21:28:00 volumio systemd[1]: Started Create System Users.
Sep 11 21:28:00 volumio systemd[1]: Starting Create Static Device Nodes in /dev...
Sep 11 21:28:00 volumio systemd[1]: Started udev Coldplug all Devices.
Sep 11 21:28:00 volumio systemd[1]: Starting Helper to synchronize boot up for ifupdown...
Sep 11 21:28:00 volumio systemd[1]: Started Helper to synchronize boot up for ifupdown.
Sep 11 21:28:00 volumio systemd[1]: Started Create Static Device Nodes in /dev.
Sep 11 21:28:00 volumio systemd[1]: Reached target Local File Systems (Pre).
Sep 11 21:28:00 volumio systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway.
Sep 11 21:28:00 volumio systemd[1]: Mounting /tmp...
Sep 11 21:28:00 volumio systemd[1]: Mounting /var/spool/cups...
Sep 11 21:28:00 volumio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway.
Sep 11 21:28:00 volumio systemd[1]: Mounting /var/log...
Sep 11 21:28:00 volumio systemd[1]: Starting udev Kernel Device Manager...
Sep 11 21:28:00 volumio systemd[1]: Mounted /tmp.
Sep 11 21:28:00 volumio systemd[1]: Mounted /var/spool/cups.
Sep 11 21:28:00 volumio systemd[1]: Mounted /var/log.
Sep 11 21:28:00 volumio systemd[1]: Starting Flush Journal to Persistent Storage...
Sep 11 21:28:00 volumio systemd[1]: Mounting /var/spool/cups/tmp...
Sep 11 21:28:00 volumio systemd[1]: Mounted /var/spool/cups/tmp.
Sep 11 21:28:00 volumio systemd-udevd[232]: Network interface NamePolicy= disabled on kernel command line, ignoring.
Sep 11 21:28:00 volumio systemd-journald[201]: Runtime journal (/run/log/journal/ba41094955353179f46b1ad365cba63d) is 7.5M, max 30.0M, 22.5M free.
Sep 11 21:28:00 volumio systemd[1]: Started Flush Journal to Persistent Storage.
Sep 11 21:28:00 volumio systemd[1]: Started udev Kernel Device Manager.
Sep 11 21:28:00 volumio systemd[1]: Starting Show Plymouth Boot Screen...
Sep 11 21:28:00 volumio systemd[1]: Received SIGRTMIN+20 from PID 250 (plymouthd).
Sep 11 21:28:00 volumio systemd[1]: Started Show Plymouth Boot Screen.
Sep 11 21:28:00 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Sep 11 21:28:00 volumio systemd[1]: Reached target Local Encrypted Volumes.
Sep 11 21:28:00 volumio systemd[1]: Started Forward Password Requests to Plymouth Directory Watch.
Sep 11 21:28:00 volumio systemd-udevd[239]: Using default interface naming scheme 'v240'.
Sep 11 21:28:00 volumio systemd-udevd[239]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Sep 11 21:28:00 volumio kernel: mc: Linux media interface: v0.10
Sep 11 21:28:00 volumio kernel: rpi-gpiomem fe200000.gpiomem: window base 0xfe200000 size 0x00001000
Sep 11 21:28:00 volumio kernel: rpi-gpiomem fe200000.gpiomem: initialised 1 regions as /dev/gpiomem
Sep 11 21:28:00 volumio systemd[1]: Found device /dev/ttyAMA0.
Sep 11 21:28:00 volumio kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
Sep 11 21:28:00 volumio kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver
Sep 11 21:28:00 volumio kernel: [vc_sm_connected_init]: start
Sep 11 21:28:00 volumio kernel: [vc_sm_connected_init]: installed successfully
Sep 11 21:28:00 volumio kernel: videodev: Linux video capture interface: v2.00
Sep 11 21:28:00 volumio kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Sep 11 21:28:00 volumio kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
Sep 11 21:28:00 volumio kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
Sep 11 21:28:00 volumio kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
Sep 11 21:28:00 volumio kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
Sep 11 21:28:00 volumio kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned.
Sep 11 21:28:00 volumio kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
Sep 11 21:28:00 volumio kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
Sep 11 21:28:00 volumio kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
Sep 11 21:28:00 volumio kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller
Sep 11 21:28:00 volumio kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
Sep 11 21:28:00 volumio kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
Sep 11 21:28:00 volumio kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
Sep 11 21:28:00 volumio kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10
Sep 11 21:28:00 volumio kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode
Sep 11 21:28:00 volumio kernel: rpivid feb10000.codec: Device registered as /dev/video19
Sep 11 21:28:00 volumio kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20
Sep 11 21:28:00 volumio kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21
Sep 11 21:28:00 volumio kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22
Sep 11 21:28:00 volumio kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23
Sep 11 21:28:00 volumio kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller
Sep 11 21:28:00 volumio kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
Sep 11 21:28:00 volumio kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
Sep 11 21:28:00 volumio kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
Sep 11 21:28:00 volumio kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
Sep 11 21:28:00 volumio kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11
Sep 11 21:28:00 volumio kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode
Sep 11 21:28:00 volumio kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12
Sep 11 21:28:00 volumio kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp
Sep 11 21:28:00 volumio kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18
Sep 11 21:28:00 volumio kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx
Sep 11 21:28:00 volumio kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31
Sep 11 21:28:00 volumio kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image
Sep 11 21:28:00 volumio kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
Sep 11 21:28:00 volumio kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored
Sep 11 21:28:00 volumio kernel: bcm2835_audio bcm2835_audio: card created with 4 channels
Sep 11 21:28:00 volumio kernel: bcm2835_audio bcm2835_audio: card created with 4 channels
Sep 11 21:28:01 volumio systemd-udevd[244]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Sep 11 21:28:01 volumio systemd[1]: Found device /dev/mmcblk0p5.
Sep 11 21:28:01 volumio kernel: pcm512x 1-004d: supply AVDD not found, using dummy regulator
Sep 11 21:28:01 volumio kernel: pcm512x 1-004d: supply DVDD not found, using dummy regulator
Sep 11 21:28:01 volumio kernel: pcm512x 1-004d: supply CPVDD not found, using dummy regulator
Sep 11 21:28:01 volumio kernel: pcm512x 1-004c: supply AVDD not found, using dummy regulator
Sep 11 21:28:01 volumio kernel: pcm512x 1-004c: supply DVDD not found, using dummy regulator
Sep 11 21:28:01 volumio kernel: pcm512x 1-004c: supply CPVDD not found, using dummy regulator
Sep 11 21:28:01 volumio systemd[1]: Found device /dev/mmcblk0p8.
Sep 11 21:28:01 volumio kernel: alsactl[364]: memfd_create() called without MFD_EXEC or MFD_NOEXEC_SEAL set
Sep 11 21:28:01 volumio kernel: snd-allo-piano-dac-plus soc:sound: Dsp Firmware File Name: allo/piano/2.2/allo-piano-dsp-44100-60-0.bin
Sep 11 21:28:01 volumio kernel: logitech-djreceiver 0003:046D:C52B.0003: hiddev96,hidraw0: USB HID v1.11 Device [Logitech USB Receiver] on usb-0000:01:00.0-1.3/input2
Sep 11 21:28:01 volumio kernel: EXT4-fs (mmcblk0p5): mounted filesystem 5d531654-ff56-4324-9a4b-ec7c5012b986 r/w with ordered data mode. Quota mode: none.
Sep 11 21:28:01 volumio kernel: ext4 filesystem being mounted at /media/SETTINGS supports timestamps until 2038-01-19 (0x7fffffff)
Sep 11 21:28:01 volumio systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped.
Sep 11 21:28:01 volumio systemd[1]: Condition check resulted in Huge Pages File System being skipped.
Sep 11 21:28:01 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped.
Sep 11 21:28:01 volumio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
Sep 11 21:28:01 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Sep 11 21:28:01 volumio systemd[1]: Condition check resulted in FUSE Control File System being skipped.
Sep 11 21:28:01 volumio systemd[1]: Starting File System Check on /dev/mmcblk0p8...
Sep 11 21:28:01 volumio systemd[1]: Mounting /media/SETTINGS...
Sep 11 21:28:01 volumio systemd[1]: Mounted /media/SETTINGS.
Sep 11 21:28:01 volumio systemd[1]: Started File System Check Daemon to report status.
Sep 11 21:28:01 volumio kernel: input: Logitech Wireless Device PID:4063 Keyboard as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.3/1-1.3:1.2/0003:046D:C52B.0003/0003:046D:4063.0004/input/input5
Sep 11 21:28:01 volumio systemd-fsck[384]: fsck.fat 4.1 (2017-01-24)
Sep 11 21:28:01 volumio systemd-fsck[384]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt.
Sep 11 21:28:01 volumio systemd-fsck[384]: Automatically removing dirty bit.
Sep 11 21:28:01 volumio systemd-fsck[384]: Performing changes.
Sep 11 21:28:01 volumio systemd-fsck[384]: /dev/mmcblk0p8: 550 files, 42547/61311 clusters
Sep 11 21:28:01 volumio systemd[1]: Started File System Check on /dev/mmcblk0p8.
Sep 11 21:28:01 volumio systemd[1]: Mounting /boot...
Sep 11 21:28:02 volumio systemd[1]: Mounted /boot.
Sep 11 21:28:02 volumio systemd[1]: Reached target Local File Systems.
Sep 11 21:28:02 volumio systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped.
Sep 11 21:28:02 volumio systemd[1]: Starting Preprocess NFS configuration...
Sep 11 21:28:02 volumio systemd[1]: Condition check resulted in Load AppArmor profiles being skipped.
Sep 11 21:28:02 volumio systemd[1]: Started ifup for eth0.
Sep 11 21:28:02 volumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data...
Sep 11 21:28:02 volumio systemd[1]: Starting Raise network interfaces...
Sep 11 21:28:02 volumio systemd[1]: Starting Create Volatile Files and Directories...
Sep 11 21:28:02 volumio systemd[1]: nfs-config.service: Succeeded.
Sep 11 21:28:02 volumio systemd[1]: Started Preprocess NFS configuration.
Sep 11 21:28:02 volumio systemd[1]: Received SIGRTMIN+20 from PID 250 (plymouthd).
Sep 11 21:28:02 volumio systemd[1]: plymouth-read-write.service: Succeeded.
Sep 11 21:28:02 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data.
Sep 11 21:28:02 volumio systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped.
Sep 11 21:28:02 volumio systemd[1]: Condition check resulted in RPC security service for NFS server being skipped.
Sep 11 21:28:02 volumio systemd[1]: Reached target NFS client services.
Sep 11 21:28:02 volumio kernel: snd-allo-piano-dac-plus soc:sound: Dsp Firmware File Name: allo/piano/2.1/allo-piano-dsp-44100-60-1.bin
Sep 11 21:28:02 volumio systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
Sep 11 21:28:02 volumio systemd[1]: Started Create Volatile Files and Directories.
Sep 11 21:28:02 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm.
Sep 11 21:28:02 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Sep 11 21:28:02 volumio systemd[1]: Condition check resulted in Network Time Synchronization being skipped.
Sep 11 21:28:02 volumio systemd[1]: Starting RPC bind portmap service...
Sep 11 21:28:02 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown.
Sep 11 21:28:02 volumio systemd[1]: Reached target System Initialization.
Sep 11 21:28:02 volumio kernel: input: Logitech Wireless Device PID:4063 Mouse as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.3/1-1.3:1.2/0003:046D:C52B.0003/0003:046D:4063.0004/input/input6
Sep 11 21:28:02 volumio kernel: hid-generic 0003:046D:4063.0004: input,hidraw1: USB HID v1.11 Keyboard [Logitech Wireless Device PID:4063] on usb-0000:01:00.0-1.3/input2:1
Sep 11 21:28:02 volumio kernel: input: Logitech Wireless Device PID:400a Mouse as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.3/1-1.3:1.2/0003:046D:C52B.0003/0003:046D:400A.0005/input/input10
Sep 11 21:28:02 volumio kernel: hid-generic 0003:046D:400A.0005: input,hidraw2: USB HID v1.11 Mouse [Logitech Wireless Device PID:400a] on usb-0000:01:00.0-1.3/input2:2
Sep 11 21:28:02 volumio kernel: input: Logitech Wireless Device PID:4082 Keyboard as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.3/1-1.3:1.2/0003:046D:C52B.0003/0003:046D:4082.0006/input/input14
Sep 11 21:28:02 volumio systemd[1]: Starting Docker Socket for the API.
Sep 11 21:28:02 volumio systemd[1]: Started CUPS Scheduler.
Sep 11 21:28:02 volumio systemd[1]: Reached target Paths.
Sep 11 21:28:02 volumio systemd[1]: Started Daily Cleanup of Temporary Directories.
Sep 11 21:28:02 volumio systemd[1]: Listening on CUPS Scheduler.
Sep 11 21:28:02 volumio systemd[1]: Started Daily apt download activities.
Sep 11 21:28:02 volumio systemd[1]: Started Daily apt upgrade and clean activities.
Sep 11 21:28:02 volumio systemd[1]: Reached target Timers.
Sep 11 21:28:02 volumio systemd[1]: Listening on D-Bus System Message Bus Socket.
Sep 11 21:28:02 volumio systemd[1]: Listening on triggerhappy.socket.
Sep 11 21:28:02 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
Sep 11 21:28:02 volumio systemd[1]: Listening on Docker Socket for the API.
Sep 11 21:28:02 volumio systemd[1]: Reached target Sockets.
Sep 11 21:28:02 volumio systemd[1]: Reached target Basic System.
Sep 11 21:28:02 volumio systemd[1]: Starting triggerhappy global hotkey daemon...
Sep 11 21:28:02 volumio systemd[1]: Started Volumio Iptables Module.
Sep 11 21:28:02 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Sep 11 21:28:02 volumio systemd[1]: Condition check resulted in Configure Bluetooth Modems connected by UART being skipped.
Sep 11 21:28:02 volumio systemd[1]: Started D-Bus System Message Bus.
Sep 11 21:28:02 volumio thd[419]: Unable to parse trigger line:
Sep 11 21:28:02 volumio thd[419]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle
Sep 11 21:28:02 volumio thd[419]: Unable to parse trigger line:
Sep 11 21:28:02 volumio thd[419]: Unable to parse trigger line:
Sep 11 21:28:02 volumio thd[419]: Found socket passed from systemd
Sep 11 21:28:02 volumio systemd[1]: Started CUPS Scheduler.
Sep 11 21:28:02 volumio kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database
Sep 11 21:28:02 volumio systemd[1]: Starting Wireless Services...
Sep 11 21:28:02 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
Sep 11 21:28:02 volumio systemd[1]: Starting Login Service...
Sep 11 21:28:02 volumio systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped.
Sep 11 21:28:02 volumio systemd[1]: Started volumio-remote-updater.service.
Sep 11 21:28:02 volumio systemd[1]: Starting dhcpcd on all interfaces...
Sep 11 21:28:02 volumio kernel: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf'
Sep 11 21:28:02 volumio kernel: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328'
Sep 11 21:28:02 volumio kernel: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Sep 11 21:28:02 volumio kernel: Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
Sep 11 21:28:02 volumio systemd[1]: Started Volumio Log Rotation Service.
Sep 11 21:28:02 volumio systemd[1]: Started MPD Monitor Service.
Sep 11 21:28:02 volumio systemd[1]: Condition check resulted in Volumio SSH enabler being skipped.
Sep 11 21:28:02 volumio systemd[1]: Started Manage Sound Card State (restore and store).
Sep 11 21:28:02 volumio systemd[1]: Starting Save/Restore Sound Card State...
Sep 11 21:28:02 volumio alsactl[440]: alsactl 1.1.8 daemon started
Sep 11 21:28:02 volumio systemd[1]: Starting Volumio Time Update Utility...
Sep 11 21:28:02 volumio systemd[1]: Starting WPA supplicant...
Sep 11 21:28:02 volumio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped.
Sep 11 21:28:02 volumio systemd[1]: Started triggerhappy global hotkey daemon.
Sep 11 21:28:02 volumio ifup[398]: command failed: No such device (-19)
Sep 11 21:28:02 volumio sh[394]: command failed: No such device (-19)
Sep 11 21:28:02 volumio mpd_monitor.sh[438]: MPD Monitor Service: Starting MPD Monitor Service
Sep 11 21:28:02 volumio volumio-time-update[442]: volumio-time-update-util: Fetching time from Volumio...
Sep 11 21:28:02 volumio dhcpcd[432]: Not running dhcpcd because /etc/network/interfaces
Sep 11 21:28:02 volumio dhcpcd[432]: defines some interfaces that will use a
Sep 11 21:28:02 volumio dhcpcd[432]: DHCP client or static address
Sep 11 21:28:02 volumio kernel: input: Logitech Wireless Device PID:4082 Mouse as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.3/1-1.3:1.2/0003:046D:C52B.0003/0003:046D:4082.0006/input/input15
Sep 11 21:28:02 volumio kernel: hid-generic 0003:046D:4082.0006: input,hidraw3: USB HID v1.11 Keyboard [Logitech Wireless Device PID:4082] on usb-0000:01:00.0-1.3/input2:3
Sep 11 21:28:02 volumio kernel: input: Logitech M280/320/275 as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.3/1-1.3:1.2/0003:046D:C52B.0003/0003:046D:4040.0007/input/input19
Sep 11 21:28:02 volumio kernel: logitech-hidpp-device 0003:046D:4040.0007: input,hidraw4: USB HID v1.11 Mouse [Logitech M280/320/275] on usb-0000:01:00.0-1.3/input2:4
Sep 11 21:28:02 volumio systemd-logind[428]: New seat seat0.
Sep 11 21:28:02 volumio avahi-daemon[427]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113).
Sep 11 21:28:02 volumio avahi-daemon[427]: Successfully dropped root privileges.
Sep 11 21:28:02 volumio avahi-daemon[427]: avahi-daemon 0.7 starting up.
Sep 11 21:28:02 volumio mpd_monitor.sh[438]: MPD error: Cannot assign requested address
Sep 11 21:28:02 volumio mpd_monitor.sh[438]: MPD Monitor Service: MPD Appears to be inactive, restarting
Sep 11 21:28:02 volumio ifup[398]: command failed: No such device (-19)
Sep 11 21:28:02 volumio systemd[1]: Started RPC bind portmap service.
Sep 11 21:28:02 volumio systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED
Sep 11 21:28:02 volumio systemd[1]: dhcpcd.service: Failed with result 'exit-code'.
Sep 11 21:28:02 volumio systemd[1]: Failed to start dhcpcd on all interfaces.
Sep 11 21:28:02 volumio avahi-daemon[427]: Successfully called chroot().
Sep 11 21:28:02 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack.
Sep 11 21:28:02 volumio avahi-daemon[427]: Successfully dropped remaining capabilities.
Sep 11 21:28:02 volumio wpa_supplicant[443]: Successfully initialized wpa_supplicant
Sep 11 21:28:02 volumio avahi-daemon[427]: No service file found in /etc/avahi/services.
Sep 11 21:28:02 volumio systemd[1]: Started WPA supplicant.
Sep 11 21:28:02 volumio avahi-daemon[427]: Network interface enumeration completed.
Sep 11 21:28:02 volumio avahi-daemon[427]: Server startup complete. Host name is volumio.local. Local service cookie is 3582475392.
Sep 11 21:28:02 volumio mpd_monitor.sh[438]: mpd: no process found
Sep 11 21:28:02 volumio systemd[1]: Started Login Service.
Sep 11 21:28:02 volumio thd[419]: Error reading device '/dev/input/event0'
Sep 11 21:28:02 volumio systemd[1]: Started Make remote CUPS printers available locally.
Sep 11 21:28:02 volumio systemd[1]: Reached target Remote File Systems (Pre).
Sep 11 21:28:02 volumio systemd[1]: Reached target Remote File Systems.
Sep 11 21:28:02 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling...
Sep 11 21:28:02 volumio systemd[1]: Reached target RPC Port Mapper.
Sep 11 21:28:02 volumio systemd[1]: Listening on mpd.socket.
Sep 11 21:28:03 volumio kernel: 8021q: 802.1Q VLAN Support v1.8
Sep 11 21:28:03 volumio thd[419]: Error reading device '/dev/input/event1'
Sep 11 21:28:03 volumio kernel: input: Logitech MX Anywhere 2 as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.3/1-1.3:1.2/0003:046D:C52B.0003/0003:046D:4063.0004/input/input20
Sep 11 21:28:03 volumio volumio-remote-updater[430]: Error: No active session
Sep 11 21:28:03 volumio volumio-remote-updater[430]: [2025-09-11 21:28:03] [info] asio async_connect error: system:111 (Connection refused)
Sep 11 21:28:03 volumio volumio-remote-updater[430]: [2025-09-11 21:28:03] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Sep 11 21:28:03 volumio volumio-remote-updater[430]: [2025-09-11 21:28:03] [error] handle_connect error: Underlying Transport Error
Sep 11 21:28:03 volumio volumio-time-update[442]: volumio-time-update-util: Date not found in response
Sep 11 21:28:03 volumio volumio-time-update[442]: volumio-time-update-util: Retrying in 5 seconds...
Sep 11 21:28:03 volumio volumio[421]: Could not open config: /tmp/upmpdcli.conf
Sep 11 21:28:03 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Sep 11 21:28:03 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Sep 11 21:28:03 volumio kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay)
Sep 11 21:28:03 volumio kernel: bcmgenet fd580000.ethernet eth0: Link is Down
Sep 11 21:28:03 volumio sh[394]: eth0: waiting for carrier
Sep 11 21:28:03 volumio systemd[1]: iptables.service: Succeeded.
Sep 11 21:28:03 volumio dhcpcd[491]: eth0: waiting for carrier
Sep 11 21:28:03 volumio loadcpufreq[511]: Loading cpufreq kernel modules...done (none).
Sep 11 21:28:03 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling.
Sep 11 21:28:03 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters...
Sep 11 21:28:03 volumio systemd[1]: Started Raise network interfaces.
Sep 11 21:28:03 volumio systemd[1]: Reached target Network.
Sep 11 21:28:03 volumio systemd[1]: Starting OpenBSD Secure Shell server...
Sep 11 21:28:03 volumio systemd[1]: Starting Network Time Service...
Sep 11 21:28:03 volumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped.
Sep 11 21:28:03 volumio systemd[1]: Starting containerd container runtime...
Sep 11 21:28:03 volumio systemd[1]: Starting Permit User Sessions...
Sep 11 21:28:03 volumio systemd[1]: Reached target Network is Online.
Sep 11 21:28:03 volumio systemd[1]: Starting Samba NMB Daemon...
Sep 11 21:28:03 volumio systemd[1]: Starting /etc/rc.local Compatibility...
Sep 11 21:28:03 volumio systemd[1]: Starting LSB: Brings up/down network automatically...
Sep 11 21:28:03 volumio systemd[1]: Started Permit User Sessions.
Sep 11 21:28:03 volumio kernel: logitech-hidpp-device 0003:046D:4063.0004: input,hidraw1: USB HID v1.11 Keyboard [Logitech MX Anywhere 2] on usb-0000:01:00.0-1.3/input2:1
Sep 11 21:28:03 volumio thd[419]: Error reading device '/dev/input/event2'
Sep 11 21:28:03 volumio systemd[1]: Started Save/Restore Sound Card State.
Sep 11 21:28:03 volumio systemd[1]: Reached target Sound Card.
Sep 11 21:28:03 volumio ifplugd(eth0)[628]: ifplugd 0.28 initializing.
Sep 11 21:28:03 volumio ifplugd(eth0)[628]: Using interface eth0/DC:A6:32:CA:F0:13 with driver (version: 6.6.62-v7l+)
Sep 11 21:28:03 volumio systemd[1]: Starting Music Player Daemon...
Sep 11 21:28:03 volumio ifplugd(eth0)[628]: Using detection mode: SIOCETHTOOL
Sep 11 21:28:03 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 11 21:28:03 volumio ifplugd(eth0)[628]: Initialization complete, link beat not detected.
Sep 11 21:28:03 volumio kernel: input: Logitech M325 as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.3/1-1.3:1.2/0003:046D:C52B.0003/0003:046D:400A.0005/input/input21
Sep 11 21:28:03 volumio cpufrequtils[587]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done.
Sep 11 21:28:03 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters.
Sep 11 21:28:03 volumio kernel: logitech-hidpp-device 0003:046D:400A.0005: input,hidraw2: USB HID v1.11 Mouse [Logitech M325] on usb-0000:01:00.0-1.3/input2:2
Sep 11 21:28:03 volumio ifplugd[596]: Network Interface Plugging Daemon...start eth0...done.
Sep 11 21:28:03 volumio systemd[1]: Started LSB: Brings up/down network automatically.
Sep 11 21:28:03 volumio ntpd[591]: ntpd 4.2.8p12@1.3728-o (1): Starting
Sep 11 21:28:03 volumio haveged[415]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K
Sep 11 21:28:03 volumio haveged[415]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488
Sep 11 21:28:03 volumio haveged[415]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.002
Sep 11 21:28:03 volumio haveged[415]: haveged: fills: 0, generated: 0
Sep 11 21:28:03 volumio ntpd[591]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103
Sep 11 21:28:03 volumio ntpd[636]: proto: precision = 0.834 usec (-20)
Sep 11 21:28:03 volumio systemd[1]: Started Network Time Service.
Sep 11 21:28:03 volumio sshd[635]: Server listening on 0.0.0.0 port 22.
Sep 11 21:28:03 volumio sshd[635]: Server listening on :: port 22.
Sep 11 21:28:03 volumio systemd[1]: Started OpenBSD Secure Shell server.
Sep 11 21:28:03 volumio ntpd[636]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Sep 11 21:28:03 volumio ntpd[636]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Sep 11 21:28:03 volumio ntpd[636]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 258 days ago
Sep 11 21:28:03 volumio ntpd[636]: Listen and drop on 0 v6wildcard [::]:123
Sep 11 21:28:03 volumio ntpd[636]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Sep 11 21:28:03 volumio ntpd[636]: Listen normally on 2 lo 127.0.0.1:123
Sep 11 21:28:03 volumio ntpd[636]: Listening on routing socket on fd #19 for interface updates
Sep 11 21:28:03 volumio ntpd[636]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Sep 11 21:28:03 volumio ntpd[636]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Sep 11 21:28:03 volumio sudo[617]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -t volumio
Sep 11 21:28:03 volumio sudo[623]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 11 21:28:03 volumio sudo[623]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:03 volumio sudo[617]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:03 volumio sudo[623]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Sep 11 21:28:03 volumio sudo[623]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:03 volumio sudo[617]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:04 volumio kernel: input: Logitech MX Master3 Mac as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.3/1-1.3:1.2/0003:046D:C52B.0003/0003:046D:4082.0006/input/input22
Sep 11 21:28:04 volumio kernel: logitech-hidpp-device 0003:046D:4082.0006: input,hidraw3: USB HID v1.11 Keyboard [Logitech MX Master3 Mac] on usb-0000:01:00.0-1.3/input2:3
Sep 11 21:28:04 volumio nmbd[599]: [2025/09/11 21:28:04.633517, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns)
Sep 11 21:28:04 volumio nmbd[599]: started asyncdns process 663
Sep 11 21:28:04 volumio nmbd[599]: [2025/09/11 21:28:04.635350, 0] ../lib/util/become_daemon.c:149(daemon_status)
Sep 11 21:28:04 volumio nmbd[599]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...
Sep 11 21:28:04 volumio nmbd[599]: [2025/09/11 21:28:04.635547, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets)
Sep 11 21:28:04 volumio nmbd[599]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
Sep 11 21:28:04 volumio systemd-udevd[249]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Sep 11 21:28:04 volumio systemd-udevd[246]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Sep 11 21:28:04 volumio ntpd[636]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Sep 11 21:28:04 volumio systemd-udevd[235]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Sep 11 21:28:04 volumio systemd-udevd[237]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Sep 11 21:28:04 volumio systemd-udevd[241]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Sep 11 21:28:04 volumio sudo[669]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -t volumio
Sep 11 21:28:04 volumio sudo[669]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:04 volumio systemd-udevd[247]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Sep 11 21:28:04 volumio systemd-logind[428]: Watching system buttons on /dev/input/event0 (Logitech MX Anywhere 2)
Sep 11 21:28:04 volumio sudo[669]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:04 volumio systemd-udevd[239]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Sep 11 21:28:04 volumio systemd-udevd[243]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Sep 11 21:28:04 volumio systemd-logind[428]: Watching system buttons on /dev/input/event2 (Logitech MX Master3 Mac)
Sep 11 21:28:05 volumio wireless.js[425]: WIRELESS: No wireless interface, exiting
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05+02:00" level=warning msg="containerd config version `1` has been deprecated and will be converted on each startup in containerd v2.0, use `containerd config migrate` after upgrading to containerd 2.0 to avoid conversion on startup"
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.220308233+02:00" level=info msg="starting containerd" revision=d2d58213f83a351ca8f528a95fbd145f5654e957 version=1.6.33
Sep 11 21:28:05 volumio iw[679]: command failed: No such device (-19)
Sep 11 21:28:05 volumio iwconfig[683]: Error for wireless request "Set Power Management" (8B2C) :
Sep 11 21:28:05 volumio iwconfig[683]: SET failed on device wlan0 ; No such device.
Sep 11 21:28:05 volumio systemd[1]: wireless.service: Succeeded.
Sep 11 21:28:05 volumio systemd[1]: Started Wireless Services.
Sep 11 21:28:05 volumio systemd[1]: Started Volumio Backend Module.
Sep 11 21:28:05 volumio systemd[1]: Started Volumio Cpu Tweaker.
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.350207478+02:00" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.358725381+02: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.6.62-v7l+\\n\"): skip plugin" type=io.containerd.snapshotter.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.358921323+02:00" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.359685852+02:00" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.360415788+02: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
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.360569082+02:00" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.360667192+02:00" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured"
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.360746451+02:00" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.363897544+02:00" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.365593229+02:00" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Sep 11 21:28:05 volumio volumio-cpu-tweak[687]: Setting RT Priority for mpd
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.366584329+02: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
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.366729494+02:00" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.366904862+02:00" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured"
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.367226969+02:00" level=info msg="metadata content store policy set" policy=shared
Sep 11 21:28:05 volumio volumio-cpu-tweak[687]: pid 35's current scheduling policy: SCHED_OTHER
Sep 11 21:28:05 volumio volumio-cpu-tweak[687]: pid 35's current scheduling priority: 0
Sep 11 21:28:05 volumio volumio-cpu-tweak[687]: Setting MPD Affinity
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.383348286+02:00" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.383506340+02:00" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.383612987+02:00" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.383826855+02:00" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.384127277+02:00" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.384373386+02:00" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.386366381+02:00" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.386813562+02:00" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.388596430+02:00" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.388743799+02:00" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.388812743+02:00" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.388886834+02:00" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.388958870+02:00" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.389039888+02:00" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.389103628+02:00" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.389164350+02:00" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.389223275+02:00" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.389318385+02:00" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.389420773+02:00" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.389485716+02:00" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.389552549+02:00" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.389622289+02:00" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.389693473+02:00" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.389755843+02:00" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.389856045+02:00" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.389942396+02:00" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.390017747+02:00" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.390088969+02:00" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.390150079+02:00" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.390226615+02:00" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.390299152+02:00" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.390369503+02:00" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.390420280+02:00" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Sep 11 21:28:05 volumio volumio-cpu-tweak[687]: pid 3's current affinity mask: f
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.395231966+02:00" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Sep 11 21:28:05 volumio volumio-cpu-tweak[687]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input
Sep 11 21:28:05 volumio volumio-cpu-tweak[687]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.405791124+02:00" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.406043158+02:00" level=info msg=serving... address=/run/containerd/containerd.sock
Sep 11 21:28:05 volumio containerd[598]: time="2025-09-11T21:28:05.406320710+02:00" level=info msg="containerd successfully booted in 0.196721s"
Sep 11 21:28:05 volumio systemd[1]: Started containerd container runtime.
Sep 11 21:28:05 volumio systemd[1]: Starting Docker Application Container Engine...
Sep 11 21:28:05 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded.
Sep 11 21:28:05 volumio ntpd[636]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Sep 11 21:28:05 volumio sudo[710]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -t volumio
Sep 11 21:28:05 volumio sudo[710]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:05 volumio sudo[710]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:06 volumio sh[394]: eth0: carrier acquired
Sep 11 21:28:06 volumio dhcpcd[491]: eth0: carrier acquired
Sep 11 21:28:06 volumio sh[394]: DUID 00:01:00:01:2d:5e:64:ca:dc:a6:32:ca:f0:13
Sep 11 21:28:06 volumio sh[394]: eth0: IAID 32:ca:f0:13
Sep 11 21:28:06 volumio dhcpcd[491]: DUID 00:01:00:01:2d:5e:64:ca:dc:a6:32:ca:f0:13
Sep 11 21:28:06 volumio dhcpcd[491]: eth0: IAID 32:ca:f0:13
Sep 11 21:28:06 volumio kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off
Sep 11 21:28:06 volumio sh[394]: eth0: adding address fe80::5aa:cfb5:5918:e17
Sep 11 21:28:06 volumio sh[394]: ipv6_addaddr1: Permission denied
Sep 11 21:28:06 volumio dhcpcd[491]: eth0: adding address fe80::5aa:cfb5:5918:e17
Sep 11 21:28:06 volumio dhcpcd[491]: ipv6_addaddr1: Permission denied
Sep 11 21:28:06 volumio sh[394]: eth0: soliciting a DHCP lease
Sep 11 21:28:06 volumio dhcpcd[491]: eth0: soliciting a DHCP lease
Sep 11 21:28:06 volumio ifplugd(eth0)[628]: Link beat detected.
Sep 11 21:28:06 volumio ntpd[636]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Sep 11 21:28:06 volumio ifplugd(eth0)[628]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
Sep 11 21:28:06 volumio ifplugd(eth0)[628]: client: ifup: waiting for lock on /run/network/ifstate.eth0
Sep 11 21:28:06 volumio mpd[647]: Sep 11 21:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Sep 11 21:28:06 volumio systemd[1]: Started Music Player Daemon.
Sep 11 21:28:06 volumio mpd_monitor.sh[438]: MPD Monitor Service: MPD restarted due to no mpc output.
Sep 11 21:28:06 volumio sudo[725]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -t volumio
Sep 11 21:28:06 volumio sudo[725]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:06 volumio sudo[725]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:07 volumio sh[394]: eth0: soliciting an IPv6 router
Sep 11 21:28:07 volumio dhcpcd[491]: eth0: soliciting an IPv6 router
Sep 11 21:28:07 volumio volumio[686]: info: -------------------------------------------
Sep 11 21:28:07 volumio volumio[686]: info: ----- Volumio3 ----
Sep 11 21:28:07 volumio volumio[686]: info: -------------------------------------------
Sep 11 21:28:07 volumio volumio[686]: info: ----- System startup ----
Sep 11 21:28:07 volumio volumio[686]: info: -------------------------------------------
Sep 11 21:28:07 volumio dockerd[704]: time="2025-09-11T21:28:07.643152736+02:00" level=info msg="Starting up"
Sep 11 21:28:07 volumio ntpd[636]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Sep 11 21:28:07 volumio sudo[753]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -t volumio
Sep 11 21:28:07 volumio sudo[753]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:08 volumio sudo[753]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:08 volumio dockerd[704]: time="2025-09-11T21:28:08.078889892+02:00" level=error msg="failed to mount overlay: invalid argument" storage-driver=overlay2
Sep 11 21:28:08 volumio dockerd[704]: time="2025-09-11T21:28:08.082062393+02:00" level=error msg="exec: \"fuse-overlayfs\": executable file not found in $PATH" storage-driver=fuse-overlayfs
Sep 11 21:28:08 volumio kernel: overlay: filesystem on /var/lib/docker/check-overlayfs-support2999957387/upper not supported as upperdir
Sep 11 21:28:08 volumio volumio-remote-updater[430]: [2025-09-11 21:28:08] [connect] Successful connection
Sep 11 21:28:08 volumio volumio-time-update[442]: volumio-time-update-util: Fetching time from Volumio...
Sep 11 21:28:08 volumio volumio-time-update[442]: volumio-time-update-util: Date not found in response
Sep 11 21:28:08 volumio volumio-time-update[442]: volumio-time-update-util: Retrying in 5 seconds...
Sep 11 21:28:08 volumio volumio[686]: info: MYVOLUMIO Environment detected
Sep 11 21:28:08 volumio volumio[686]: info: Plugin folders cleanup
Sep 11 21:28:08 volumio volumio[686]: info: Scanning into folder /volumio/app/plugins/
Sep 11 21:28:08 volumio volumio[686]: info: Scanning category audio_interface
Sep 11 21:28:08 volumio volumio[686]: info: Scanning category miscellanea
Sep 11 21:28:08 volumio volumio[686]: info: Scanning category music_service
Sep 11 21:28:08 volumio volumio[686]: info: Scanning category plugins.json
Sep 11 21:28:08 volumio volumio[686]: info: Scanning category system_controller
Sep 11 21:28:08 volumio volumio[686]: info: Scanning category user_interface
Sep 11 21:28:08 volumio volumio[686]: info: Scanning into folder /data/plugins/
Sep 11 21:28:08 volumio volumio[686]: info: Scanning category music_service
Sep 11 21:28:08 volumio volumio[686]: info: Plugin folders cleanup completed
Sep 11 21:28:08 volumio volumio[686]: info: -------------------------------------------
Sep 11 21:28:08 volumio volumio[686]: info: ----- Core plugins startup ----
Sep 11 21:28:08 volumio volumio[686]: info: -------------------------------------------
Sep 11 21:28:08 volumio volumio[686]: info: Loading plugins from folder /volumio/app/plugins/
Sep 11 21:28:08 volumio volumio[686]: info: Adding plugin upnp to MyMusic Plugins
Sep 11 21:28:08 volumio volumio[686]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 11 21:28:08 volumio volumio[686]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 11 21:28:08 volumio volumio[686]: info: Loading plugins from folder /data/plugins/
Sep 11 21:28:08 volumio volumio[686]: info: Loading plugin "system"...
Sep 11 21:28:08 volumio volumio[686]: info: Loading plugin "appearance"...
Sep 11 21:28:08 volumio dockerd[704]: time="2025-09-11T21:28:08.629070266+02:00" level=info msg="Loading containers: start."
Sep 11 21:28:08 volumio kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
Sep 11 21:28:08 volumio kernel: Bridge firewalling registered
Sep 11 21:28:09 volumio sudo[802]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -t volumio
Sep 11 21:28:09 volumio sudo[802]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:09 volumio sudo[802]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:09 volumio systemd-udevd[237]: Using default interface naming scheme 'v240'.
Sep 11 21:28:09 volumio systemd-udevd[237]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Sep 11 21:28:09 volumio avahi-daemon[427]: Joining mDNS multicast group on interface br-098c88e78272.IPv4 with address 172.31.0.1.
Sep 11 21:28:09 volumio avahi-daemon[427]: New relevant interface br-098c88e78272.IPv4 for mDNS.
Sep 11 21:28:09 volumio avahi-daemon[427]: Registering new address record for 172.31.0.1 on br-098c88e78272.IPv4.
Sep 11 21:28:09 volumio systemd-udevd[237]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Sep 11 21:28:09 volumio avahi-daemon[427]: Joining mDNS multicast group on interface docker0.IPv4 with address 172.17.0.1.
Sep 11 21:28:09 volumio avahi-daemon[427]: New relevant interface docker0.IPv4 for mDNS.
Sep 11 21:28:09 volumio avahi-daemon[427]: Registering new address record for 172.17.0.1 on docker0.IPv4.
Sep 11 21:28:09 volumio systemd-udevd[237]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Sep 11 21:28:09 volumio nmbd[599]: [2025/09/11 21:28:09.641621, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Sep 11 21:28:09 volumio nmbd[599]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Sep 11 21:28:09 volumio systemd[1]: Started Samba NMB Daemon.
Sep 11 21:28:09 volumio avahi-daemon[427]: Joining mDNS multicast group on interface br-8ebf469cc3ae.IPv4 with address 172.18.0.1.
Sep 11 21:28:09 volumio avahi-daemon[427]: New relevant interface br-8ebf469cc3ae.IPv4 for mDNS.
Sep 11 21:28:09 volumio avahi-daemon[427]: Registering new address record for 172.18.0.1 on br-8ebf469cc3ae.IPv4.
Sep 11 21:28:09 volumio systemd[1]: Starting Samba Winbind Daemon...
Sep 11 21:28:09 volumio volumio[686]: info: Loading plugin "network"...
Sep 11 21:28:09 volumio volumio[686]: info: Refreshing Cached IP Addresses
Sep 11 21:28:09 volumio sudo[907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 11 21:28:09 volumio sudo[907]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:09 volumio sudo[909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 11 21:28:09 volumio sudo[909]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:09 volumio sudo[907]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:09 volumio volumio[686]: info: Loading plugin "services"...
Sep 11 21:28:09 volumio sudo[909]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:09 volumio volumio[686]: info: Loading plugin "alsa_controller"...
Sep 11 21:28:09 volumio sudo[919]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 11 21:28:09 volumio sudo[919]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:09 volumio sudo[919]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:09 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 11 21:28:09 volumio volumio[686]: info: Loading plugin "wizard"...
Sep 11 21:28:09 volumio volumio[686]: info: Loading plugin "networkfs"...
Sep 11 21:28:09 volumio sh[394]: eth0: offered 10.0.20.20 from 10.0.20.1
Sep 11 21:28:09 volumio dhcpcd[491]: eth0: offered 10.0.20.20 from 10.0.20.1
Sep 11 21:28:09 volumio sh[394]: eth0: probing address 10.0.20.20/24
Sep 11 21:28:09 volumio dhcpcd[491]: eth0: probing address 10.0.20.20/24
Sep 11 21:28:09 volumio winbindd[897]: [2025/09/11 21:28:09.960551, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Sep 11 21:28:09 volumio winbindd[897]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Sep 11 21:28:09 volumio volumio[686]: info: Starting Udev Watcher for removable devices
Sep 11 21:28:09 volumio winbindd[897]: [2025/09/11 21:28:09.976926, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Sep 11 21:28:09 volumio systemd[1]: Started Samba Winbind Daemon.
Sep 11 21:28:09 volumio winbindd[897]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Sep 11 21:28:10 volumio systemd[1]: Starting Samba SMB Daemon...
Sep 11 21:28:10 volumio volumio[686]: info: Ignoring mount for partition: RECOVERY
Sep 11 21:28:10 volumio volumio[686]: info: Ignoring mount for partition: volumio_data
Sep 11 21:28:10 volumio volumio[686]: info: Ignoring mount for partition: System
Sep 11 21:28:10 volumio sudo[958]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -t volumio
Sep 11 21:28:10 volumio sudo[958]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:10 volumio volumio[686]: info: Ignoring mount for partition: Storage
Sep 11 21:28:10 volumio sudo[958]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:10 volumio volumio[686]: info: Ignoring mount for partition: boot0
Sep 11 21:28:10 volumio volumio[686]: info: Ignoring mount for partition: root
Sep 11 21:28:10 volumio volumio[686]: info: Ignoring mount for partition: prjboot
Sep 11 21:28:10 volumio volumio[686]: info: Ignoring mount for partition: prjroot
Sep 11 21:28:10 volumio volumio[686]: error: Cannot associate FS Label, not mounting
Sep 11 21:28:10 volumio volumio[686]: info: Ignoring mount for partition: SETTINGS
Sep 11 21:28:10 volumio volumio[686]: info: Ignoring mount for partition: boot64
Sep 11 21:28:10 volumio volumio[686]: info: Ignoring mount for partition: root64
Sep 11 21:28:10 volumio volumio[686]: info: Ignoring mount for partition: boot
Sep 11 21:28:10 volumio volumio[686]: info: Ignoring mount for partition: volumio
Sep 11 21:28:10 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 11 21:28:10 volumio volumio[686]: info: Loading plugin "volumio_command_line_client"...
Sep 11 21:28:10 volumio volumio[686]: info: Loading plugin "upnp"...
Sep 11 21:28:10 volumio volumio[686]: info: [1757618890287] Starting Upmpd Daemon
Sep 11 21:28:10 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 11 21:28:10 volumio volumio[686]: info: Loading plugin "my_music"...
Sep 11 21:28:10 volumio volumio[686]: info: Loading plugin "mpd"...
Sep 11 21:28:10 volumio dockerd[704]: time="2025-09-11T21:28:10.337729706+02:00" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address"
Sep 11 21:28:10 volumio smbd[950]: [2025/09/11 21:28:10.378460, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Sep 11 21:28:10 volumio smbd[950]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Sep 11 21:28:10 volumio systemd[1]: Started Samba SMB Daemon.
Sep 11 21:28:10 volumio systemd-udevd[249]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Sep 11 21:28:10 volumio systemd-udevd[249]: Using default interface naming scheme 'v240'.
Sep 11 21:28:10 volumio systemd-udevd[249]: Could not generate persistent MAC address for veth55b6ff2: No such file or directory
Sep 11 21:28:10 volumio systemd-udevd[237]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Sep 11 21:28:10 volumio systemd-udevd[237]: Could not generate persistent MAC address for veth022961e: No such file or directory
Sep 11 21:28:10 volumio kernel: br-8ebf469cc3ae: port 1(veth55b6ff2) entered blocking state
Sep 11 21:28:10 volumio kernel: br-8ebf469cc3ae: port 1(veth55b6ff2) entered disabled state
Sep 11 21:28:10 volumio kernel: veth55b6ff2: entered allmulticast mode
Sep 11 21:28:10 volumio kernel: veth55b6ff2: entered promiscuous mode
Sep 11 21:28:10 volumio kernel: br-8ebf469cc3ae: port 1(veth55b6ff2) entered blocking state
Sep 11 21:28:10 volumio kernel: br-8ebf469cc3ae: port 1(veth55b6ff2) entered forwarding state
Sep 11 21:28:10 volumio kernel: br-8ebf469cc3ae: port 1(veth55b6ff2) entered disabled state
Sep 11 21:28:10 volumio volumio[686]: info: Loading plugin "upnp_browser"...
Sep 11 21:28:10 volumio systemd-udevd[243]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Sep 11 21:28:10 volumio systemd-udevd[243]: Using default interface naming scheme 'v240'.
Sep 11 21:28:10 volumio systemd-udevd[243]: Could not generate persistent MAC address for veth7df75da: No such file or directory
Sep 11 21:28:10 volumio kernel: br-8ebf469cc3ae: port 2(veth2c24d04) entered blocking state
Sep 11 21:28:10 volumio kernel: br-8ebf469cc3ae: port 2(veth2c24d04) entered disabled state
Sep 11 21:28:10 volumio kernel: veth2c24d04: entered allmulticast mode
Sep 11 21:28:10 volumio kernel: veth2c24d04: entered promiscuous mode
Sep 11 21:28:10 volumio kernel: br-8ebf469cc3ae: port 2(veth2c24d04) entered blocking state
Sep 11 21:28:10 volumio kernel: br-8ebf469cc3ae: port 2(veth2c24d04) entered forwarding state
Sep 11 21:28:10 volumio kernel: br-8ebf469cc3ae: port 2(veth2c24d04) entered disabled state
Sep 11 21:28:10 volumio systemd-udevd[241]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Sep 11 21:28:10 volumio systemd-udevd[241]: Using default interface naming scheme 'v240'.
Sep 11 21:28:10 volumio systemd-udevd[241]: Could not generate persistent MAC address for veth2c24d04: No such file or directory
Sep 11 21:28:11 volumio volumio[686]: info: Loading plugin "alarm-clock"...
Sep 11 21:28:11 volumio sudo[1098]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -t volumio
Sep 11 21:28:11 volumio sudo[1098]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:11 volumio sudo[1098]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:11 volumio volumio[686]: info: Loading plugin "airplay_emulation"...
Sep 11 21:28:11 volumio volumio[686]: info: Starting Shairport Sync
Sep 11 21:28:11 volumio volumio[686]: info: Loading plugin "last_100"...
Sep 11 21:28:11 volumio volumio[686]: info: Loading plugin "webradio"...
Sep 11 21:28:11 volumio containerd[598]: time="2025-09-11T21:28:11.269703052+02:00" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
Sep 11 21:28:11 volumio containerd[598]: time="2025-09-11T21:28:11.272973922+02:00" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
Sep 11 21:28:11 volumio containerd[598]: time="2025-09-11T21:28:11.273065329+02:00" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Sep 11 21:28:11 volumio containerd[598]: time="2025-09-11T21:28:11.270122158+02:00" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
Sep 11 21:28:11 volumio containerd[598]: time="2025-09-11T21:28:11.273953615+02:00" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
Sep 11 21:28:11 volumio containerd[598]: time="2025-09-11T21:28:11.274137927+02:00" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Sep 11 21:28:11 volumio containerd[598]: time="2025-09-11T21:28:11.275087083+02:00" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/337c7f0755dcd50c4f798dfc9bce44ea8b16b8114f48c69ec9bcee69ecc556e7 pid=1107 runtime=io.containerd.runc.v2
Sep 11 21:28:11 volumio containerd[598]: time="2025-09-11T21:28:11.276220682+02:00" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/947ae12c1c2567e4f27ad1905f32ffdca39ad54523319a5c28116125f7627032 pid=1108 runtime=io.containerd.runc.v2
Sep 11 21:28:11 volumio systemd[1]: run-docker-runtime\x2drunc-moby-947ae12c1c2567e4f27ad1905f32ffdca39ad54523319a5c28116125f7627032-runc.4zgQnz.mount: Succeeded.
Sep 11 21:28:11 volumio volumio[686]: info: Loading plugin "i2s_dacs"...
Sep 11 21:28:11 volumio volumio[686]: info: Loading plugin "volumiodiscovery"...
Sep 11 21:28:11 volumio volumio[686]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 11 21:28:11 volumio volumio[686]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 11 21:28:11 volumio volumio[686]: *** WARNING *** For more information see
Sep 11 21:28:11 volumio volumio[686]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 11 21:28:11 volumio node[686]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 11 21:28:11 volumio volumio[686]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 11 21:28:11 volumio volumio[686]: *** WARNING *** For more information see
Sep 11 21:28:11 volumio node[686]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 11 21:28:11 volumio node[686]: *** WARNING *** For more information see
Sep 11 21:28:11 volumio node[686]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 11 21:28:11 volumio node[686]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 11 21:28:11 volumio node[686]: *** WARNING *** For more information see
Sep 11 21:28:11 volumio containerd[598]: time="2025-09-11T21:28:11.440978826+02:00" level=info msg="shim disconnected" id=947ae12c1c2567e4f27ad1905f32ffdca39ad54523319a5c28116125f7627032
Sep 11 21:28:11 volumio containerd[598]: time="2025-09-11T21:28:11.441784021+02:00" level=warning msg="cleaning up after shim disconnected" id=947ae12c1c2567e4f27ad1905f32ffdca39ad54523319a5c28116125f7627032 namespace=moby
Sep 11 21:28:11 volumio containerd[598]: time="2025-09-11T21:28:11.441838891+02:00" level=info msg="cleaning up dead shim"
Sep 11 21:28:11 volumio volumio[686]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 11 21:28:11 volumio volumio[686]: info: Discovery: Started advertising with name: Volumio
Sep 11 21:28:11 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 11 21:28:11 volumio volumio[686]: info: Loading plugin "squeezelite_mc"...
Sep 11 21:28:11 volumio containerd[598]: time="2025-09-11T21:28:11.485400544+02:00" level=warning msg="cleanup warnings time=\"2025-09-11T21:28:11+02:00\" level=info msg=\"starting signal loop\" namespace=moby pid=1160 runtime=io.containerd.runc.v2\ntime=\"2025-09-11T21:28:11+02:00\" level=warning msg=\"failed to read init pid file\" error=\"open /run/containerd/io.containerd.runtime.v2.task/moby/947ae12c1c2567e4f27ad1905f32ffdca39ad54523319a5c28116125f7627032/init.pid: no such file or directory\" runtime=io.containerd.runc.v2\n"
Sep 11 21:28:11 volumio containerd[598]: time="2025-09-11T21:28:11.487986847+02:00" level=error msg="copy shim log" error="read /proc/self/fd/14: file already closed"
Sep 11 21:28:11 volumio dockerd[704]: time="2025-09-11T21:28:11.489470479+02:00" level=error msg="stream copy error: reading from a closed fifo"
Sep 11 21:28:11 volumio dockerd[704]: time="2025-09-11T21:28:11.492886940+02:00" level=error msg="stream copy error: reading from a closed fifo"
Sep 11 21:28:11 volumio kernel: br-8ebf469cc3ae: port 2(veth2c24d04) entered disabled state
Sep 11 21:28:11 volumio kernel: veth2c24d04 (unregistering): left allmulticast mode
Sep 11 21:28:11 volumio kernel: veth2c24d04 (unregistering): left promiscuous mode
Sep 11 21:28:11 volumio kernel: br-8ebf469cc3ae: port 2(veth2c24d04) entered disabled state
Sep 11 21:28:11 volumio dockerd[704]: time="2025-09-11T21:28:11.908808432+02:00" level=error msg="failed to start container" container=947ae12c1c2567e4f27ad1905f32ffdca39ad54523319a5c28116125f7627032 error="failed to create task for container: failed to create shim task: OCI runtime create failed: runc create failed: unable to start container process: error during container init: error mounting \"/home/volumio/projects/dockerfiles/sshd/config/sshd_config\" to rootfs at \"/etc/ssh/sshd_config\": mount /home/volumio/projects/dockerfiles/sshd/config/sshd_config:/etc/ssh/sshd_config (via /proc/self/fd/6), flags: 0x5000: not a directory: unknown: Are you trying to mount a directory onto a file (or vice-versa)? Check if the specified host path exists and is the expected type"
Sep 11 21:28:11 volumio kernel: eth0: renamed from veth022961e
Sep 11 21:28:12 volumio kernel: br-8ebf469cc3ae: port 1(veth55b6ff2) entered blocking state
Sep 11 21:28:12 volumio kernel: br-8ebf469cc3ae: port 1(veth55b6ff2) entered forwarding state
Sep 11 21:28:12 volumio containerd[598]: time="2025-09-11T21:28:12.061717897+02:00" level=error msg="add cg to OOM monitor" error="cgroups: memory cgroup not supported on this system"
Sep 11 21:28:12 volumio dockerd[704]: time="2025-09-11T21:28:12.099989314+02:00" level=info msg="Loading containers: done."
Sep 11 21:28:12 volumio dockerd[704]: time="2025-09-11T21:28:12.139217553+02:00" level=warning msg="WARNING: No memory limit support"
Sep 11 21:28:12 volumio dockerd[704]: time="2025-09-11T21:28:12.139299311+02:00" level=warning msg="WARNING: No swap limit support"
Sep 11 21:28:12 volumio dockerd[704]: time="2025-09-11T21:28:12.139336385+02:00" level=warning msg="WARNING: No kernel memory TCP limit support"
Sep 11 21:28:12 volumio dockerd[704]: time="2025-09-11T21:28:12.139368996+02:00" level=warning msg="WARNING: No oom kill disable support"
Sep 11 21:28:12 volumio dockerd[704]: time="2025-09-11T21:28:12.139400051+02:00" level=warning msg="WARNING: daemon is not using the default seccomp profile"
Sep 11 21:28:12 volumio dockerd[704]: time="2025-09-11T21:28:12.139479365+02:00" level=info msg="Docker daemon" commit=de5c9cf containerd-snapshotter=false storage-driver=vfs version=26.1.4
Sep 11 21:28:12 volumio dockerd[704]: time="2025-09-11T21:28:12.140332392+02:00" level=info msg="Daemon has completed initialization"
Sep 11 21:28:12 volumio sudo[1225]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -t volumio
Sep 11 21:28:12 volumio sudo[1225]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:12 volumio sudo[1225]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:12 volumio volumio[686]: info: Loading plugin "outputs"...
Sep 11 21:28:12 volumio volumio[686]: info: Loading plugin "albumart"...
Sep 11 21:28:12 volumio volumio[686]: info: Plugin example_plugin is not enabled
Sep 11 21:28:12 volumio volumio[686]: info: Loading plugin "inputs"...
Sep 11 21:28:12 volumio volumio[686]: info: Loading plugin "updater_comm"...
Sep 11 21:28:12 volumio volumio[686]: info: Plugin mpdemulation is not enabled
Sep 11 21:28:12 volumio volumio[686]: info: Loading plugin "rest_api"...
Sep 11 21:28:12 volumio volumio[686]: info: Loading plugin "websocket"...
Sep 11 21:28:12 volumio volumio[686]: info: Starting Socket.io Server version 2.3.0
Sep 11 21:28:12 volumio volumio[686]: Forking 3 albumart workers
Sep 11 21:28:12 volumio volumio[686]: info: Loading i18n strings for locale en
Sep 11 21:28:12 volumio volumio[686]: Updating browse sources language
Sep 11 21:28:12 volumio dockerd[704]: time="2025-09-11T21:28:12.951708925+02:00" level=info msg="API listen on /run/docker.sock"
Sep 11 21:28:12 volumio systemd[1]: Started Docker Application Container Engine.
Sep 11 21:28:12 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::initPlayerControls
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 11 21:28:13 volumio volumio[686]: Express server listening on port 3000
Sep 11 21:28:13 volumio volumio[686]: [Metrics] WebUI: 6s 289.73ms
Sep 11 21:28:13 volumio volumio-time-update[442]: volumio-time-update-util: Fetching time from Volumio...
Sep 11 21:28:13 volumio volumio[686]: info: CoreStateMachine::resetVolumioState
Sep 11 21:28:13 volumio volumio[686]: info: CoreStateMachine::getcurrentVolume
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::volumioRetrievevolume
Sep 11 21:28:13 volumio volumio[686]: info: CoreStateMachine::pushState
Sep 11 21:28:13 volumio volumio[686]: info: CorePlayQueue::getTrack 0
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::volumioPushState
Sep 11 21:28:13 volumio sudo[1285]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -t volumio
Sep 11 21:28:13 volumio sudo[1285]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:13 volumio volumio-time-update[442]: volumio-time-update-util: Date not found in response
Sep 11 21:28:13 volumio volumio-time-update[442]: volumio-time-update-util: Retrying in 5 seconds...
Sep 11 21:28:13 volumio sudo[1285]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:13 volumio volumio[686]: info: Cannot read play queue from file
Sep 11 21:28:13 volumio volumio[686]: info: Volumio Network Manager: Network status updated: 0
Sep 11 21:28:13 volumio volumio[686]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Sep 11 21:28:13 volumio volumio[686]: wlan0 Interface doesn't support scanning.
Sep 11 21:28:13 volumio volumio[686]: info: Cannot use regular scanning, forcing with ap-force
Sep 11 21:28:13 volumio sudo[1291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Sep 11 21:28:13 volumio sudo[1291]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:13 volumio sudo[1291]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:13 volumio volumio[686]: command failed: No such device (-19)
Sep 11 21:28:13 volumio volumio[686]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Sep 11 21:28:13 volumio volumio[686]: command failed: No such device (-19)
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 11 21:28:13 volumio volumio[686]: info: CoreStateMachine::setRepeat null single undefined
Sep 11 21:28:13 volumio volumio[686]: info: CoreStateMachine::pushState
Sep 11 21:28:13 volumio volumio[686]: info: CorePlayQueue::getTrack 0
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::volumioPushState
Sep 11 21:28:13 volumio volumio[686]: info: CoreStateMachine::setRandom null
Sep 11 21:28:13 volumio volumio[686]: info: CoreStateMachine::pushState
Sep 11 21:28:13 volumio volumio[686]: info: CorePlayQueue::getTrack 0
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::volumioPushState
Sep 11 21:28:13 volumio volumio[686]: info: Setting Device type: Raspberry PI
Sep 11 21:28:13 volumio volumio[686]: info: Completed loading Core Plugins
Sep 11 21:28:13 volumio volumio[686]: info: Preparing to generate the ALSA configuration file
Sep 11 21:28:13 volumio volumio[686]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Sep 11 21:28:13 volumio volumio[686]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03112
Sep 11 21:28:13 volumio volumio[686]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Sep 11 21:28:13 volumio volumio[686]: info: Asound.conf file unchanged, so no further update is needed
Sep 11 21:28:13 volumio volumio[686]: info: Output device has changed, restarting MPD
Sep 11 21:28:13 volumio volumio[686]: Starting albumart workers
Sep 11 21:28:13 volumio volumio[686]: info: Output device has changed, restarting Shairport Sync
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 11 21:28:13 volumio volumio[686]: Starting albumart workers
Sep 11 21:28:13 volumio sudo[1303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 11 21:28:13 volumio sudo[1306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 11 21:28:13 volumio sudo[1306]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:13 volumio sudo[1303]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:13 volumio sudo[1303]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:13 volumio systemd[1]: Stopping Music Player Daemon...
Sep 11 21:28:13 volumio ntpd[636]: Listen normally on 3 br-8ebf469cc3ae 172.18.0.1:123
Sep 11 21:28:13 volumio ntpd[636]: new interface(s) found: waking up resolver
Sep 11 21:28:13 volumio volumio[686]: Starting albumart workers
Sep 11 21:28:13 volumio volumio[686]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 11 21:28:13 volumio volumio[686]: info: ___________ START PLUGINS ___________
Sep 11 21:28:13 volumio volumio[686]: info: ControllerMpd::onStart: Initializing MPD
Sep 11 21:28:13 volumio volumio[686]: info: Creating MPD Configuration file
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 11 21:28:13 volumio volumio[686]: info: [1757618893732] CoreMusicLibrary::Adding element Media Servers
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 11 21:28:13 volumio systemd[1]: mpd.service: Succeeded.
Sep 11 21:28:13 volumio systemd[1]: Stopped Music Player Daemon.
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 21:28:13 volumio sudo[1313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 11 21:28:13 volumio sudo[1313]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:13 volumio sudo[1313]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:13 volumio volumio[686]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 11 21:28:13 volumio sudo[1314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 11 21:28:13 volumio sudo[1314]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:13 volumio systemd[1]: Starting Music Player Daemon...
Sep 11 21:28:13 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Sep 11 21:28:13 volumio systemd[1]: mpd.service: Succeeded.
Sep 11 21:28:13 volumio systemd[1]: Stopped Music Player Daemon.
Sep 11 21:28:13 volumio systemd[1]: Starting Music Player Daemon...
Sep 11 21:28:13 volumio volumio[686]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 11 21:28:13 volumio volumio[686]: info: [1757618893875] CoreMusicLibrary::Adding element Last_100
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 11 21:28:13 volumio volumio[686]: info: [1757618893878] CoreMusicLibrary::Adding element Webradio
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 11 21:28:13 volumio volumio[686]: info: Initializing BBC Radios
Sep 11 21:28:13 volumio sudo[1324]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Sep 11 21:28:13 volumio sudo[1324]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:13 volumio sudo[1324]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 11 21:28:13 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 11 21:28:14 volumio volumio[686]: info: [squeezelite_mc] Starting proxy server...
Sep 11 21:28:14 volumio volumio[686]: info: Volumio Calling Home
Sep 11 21:28:14 volumio volumio[686]: info: [squeezelite_mc] Proxy server started on port 42185
Sep 11 21:28:14 volumio volumio[686]: info: CoreCommandRouter::volumioRetrievevolume
Sep 11 21:28:14 volumio volumio[686]: info: CoreStateMachine::pushState
Sep 11 21:28:14 volumio volumio[686]: info: CorePlayQueue::getTrack 0
Sep 11 21:28:14 volumio volumio[686]: info: CoreCommandRouter::volumioPushState
Sep 11 21:28:14 volumio volumio[686]: info: [squeezelite_mc] Server discovery started
Sep 11 21:28:14 volumio volumio[686]: info: [squeezelite_mc] Player finder started
Sep 11 21:28:14 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 21:28:14 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 11 21:28:14 volumio volumio[686]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 11 21:28:14 volumio volumio[686]: info: [squeezelite_mc] Executing aplay -D hw:2 --nonblock -f MPEG /dev/zero 2>&1 || true
Sep 11 21:28:14 volumio sudo[1365]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -t volumio
Sep 11 21:28:14 volumio volumio[686]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 11 21:28:14 volumio sudo[1365]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 11 21:28:14 volumio volumio[686]: Error: send ENETUNREACH 255.255.255.255:3483
Sep 11 21:28:14 volumio volumio[686]: at doSend (dgram.js:692:16)
Sep 11 21:28:14 volumio volumio[686]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12)
Sep 11 21:28:14 volumio volumio[686]: at afterDns (dgram.js:638:5)
Sep 11 21:28:14 volumio volumio[686]: at processTicksAndRejections (internal/process/task_queues.js:81:21) {
Sep 11 21:28:14 volumio volumio[686]: errno: -101,
Sep 11 21:28:14 volumio volumio[686]: code: 'ENETUNREACH',
Sep 11 21:28:14 volumio volumio[686]: syscall: 'send',
Sep 11 21:28:14 volumio volumio[686]: address: '255.255.255.255',
Sep 11 21:28:14 volumio volumio[686]: port: 3483
Sep 11 21:28:14 volumio volumio[686]: }
Sep 11 21:28:14 volumio volumio[686]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 11 21:28:14 volumio sudo[1365]: pam_unix(sudo:session): session closed for user root
Sep 11 21:28:14 volumio sh[394]: eth0: leased 10.0.20.20 for 86400 seconds
Sep 11 21:28:14 volumio dhcpcd[491]: eth0: leased 10.0.20.20 for 86400 seconds
Sep 11 21:28:14 volumio sh[394]: eth0: adding route to 10.0.20.0/24
Sep 11 21:28:14 volumio sh[394]: eth0: adding default route via 10.0.20.1
Sep 11 21:28:14 volumio dhcpcd[491]: eth0: adding route to 10.0.20.0/24
Sep 11 21:28:14 volumio dhcpcd[491]: eth0: adding default route via 10.0.20.1
Sep 11 21:28:14 volumio avahi-daemon[427]: Joining mDNS multicast group on interface eth0.IPv4 with address 10.0.20.20.
Sep 11 21:28:14 volumio avahi-daemon[427]: New relevant interface eth0.IPv4 for mDNS.
Sep 11 21:28:14 volumio avahi-daemon[427]: Registering new address record for 10.0.20.20 on eth0.IPv4.
Sep 11 21:28:14 volumio sh[394]: forked to background, child pid 1401
Sep 11 21:28:14 volumio dhcpcd[491]: forked to background, child pid 1401
Sep 11 21:28:14 volumio sudo[1397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-11 21:27
Sep 11 21:28:14 volumio sudo[1397]: 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="147953990fca4aa103a8f90538ef56fb0454638c"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST"
VOLUMIO_VERSION="3.799"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"