-- Logs begin at Sat 2026-01-10 06:14:32 UTC, end at Mon 2026-01-12 11:49:39 UTC. --
Jan 12 11:49:11 ifi systemd[1]: Starting Daily apt download activities...
Jan 12 11:49:11 ifi ntpd[988]: receive: Unexpected origin timestamp 0xed0c6cdf.0b9c23c3 does not match aorg 0000000000.00000000 from server@85.121.50.82 xmt 0xed0f5e37.3cb3d0c4
Jan 12 11:49:11 ifi ntpd[988]: receive: Unexpected origin timestamp 0xed0c6cdf.0bac0750 does not match aorg 0000000000.00000000 from server@172.105.192.74 xmt 0xed0f5e37.55d3a75a
Jan 12 11:49:11 ifi wireless.js[527]: trying...
Jan 12 11:49:11 ifi sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 12 11:49:11 ifi sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:11 ifi sudo[1143]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:11 ifi node[539]: Error: can't read /data/configuration/audio_interface/alsa_controller/config.json. Error: /data/configuration/audio_interface/alsa_controller/config.json: ENOENT: no such file or directory, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jan 12 11:49:11 ifi node[539]: Error get_output_AIO: Error: /data/configuration/audio_interface/alsa_controller/config.json: ENOENT: no such file or directory, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jan 12 11:49:12 ifi systemd[1]: apt-daily.service: Succeeded.
Jan 12 11:49:12 ifi systemd[1]: Started Daily apt download activities.
Jan 12 11:49:12 ifi systemd[1]: Starting Daily apt upgrade and clean activities...
Jan 12 11:49:12 ifi wireless.js[527]: trying...
Jan 12 11:49:12 ifi sudo[1200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 12 11:49:12 ifi sudo[1200]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:12 ifi sudo[1200]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:13 ifi systemd[1]: apt-daily-upgrade.service: Succeeded.
Jan 12 11:49:13 ifi systemd[1]: Started Daily apt upgrade and clean activities.
Jan 12 11:49:13 ifi wireless.js[527]: trying...
Jan 12 11:49:13 ifi sudo[1270]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 12 11:49:13 ifi sudo[1270]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:13 ifi sudo[1270]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:13 ifi node[539]: Error: can't read /data/configuration/audio_interface/alsa_controller/config.json. Error: /data/configuration/audio_interface/alsa_controller/config.json: ENOENT: no such file or directory, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jan 12 11:49:13 ifi node[539]: Error get_output_AIO: Error: /data/configuration/audio_interface/alsa_controller/config.json: ENOENT: no such file or directory, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jan 12 11:49:14 ifi wireless.js[527]: trying...
Jan 12 11:49:14 ifi sudo[1279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 12 11:49:14 ifi sudo[1279]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:14 ifi sudo[1279]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:15 ifi wireless.js[527]: trying...
Jan 12 11:49:15 ifi sudo[1286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 12 11:49:15 ifi sudo[1286]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:15 ifi sudo[1286]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:15 ifi node[539]: Error: can't read /data/configuration/audio_interface/alsa_controller/config.json. Error: /data/configuration/audio_interface/alsa_controller/config.json: ENOENT: no such file or directory, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jan 12 11:49:15 ifi node[539]: Error get_output_AIO: Error: /data/configuration/audio_interface/alsa_controller/config.json: ENOENT: no such file or directory, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jan 12 11:49:16 ifi wireless.js[527]: trying...
Jan 12 11:49:16 ifi sudo[1295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 12 11:49:16 ifi sudo[1295]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:16 ifi sudo[1295]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:17 ifi wireless.js[527]: trying...
Jan 12 11:49:17 ifi sudo[1300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 12 11:49:17 ifi sudo[1300]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:17 ifi sudo[1300]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:17 ifi node[539]: Error: can't read /data/configuration/audio_interface/alsa_controller/config.json. Error: /data/configuration/audio_interface/alsa_controller/config.json: ENOENT: no such file or directory, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jan 12 11:49:17 ifi node[539]: Error get_output_AIO: Error: /data/configuration/audio_interface/alsa_controller/config.json: ENOENT: no such file or directory, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jan 12 11:49:18 ifi wireless.js[527]: trying...
Jan 12 11:49:18 ifi sudo[1309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jan 12 11:49:18 ifi sudo[1309]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:18 ifi sudo[1309]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:19 ifi wireless.js[527]: Overtime, starting plan B
Jan 12 11:49:19 ifi wireless.js[527]: STARTING HOTSPOT
Jan 12 11:49:19 ifi node[539]: Error: can't read /data/configuration/audio_interface/alsa_controller/config.json. Error: /data/configuration/audio_interface/alsa_controller/config.json: ENOENT: no such file or directory, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jan 12 11:49:19 ifi node[539]: Error get_output_AIO: Error: /data/configuration/audio_interface/alsa_controller/config.json: ENOENT: no such file or directory, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jan 12 11:49:19 ifi wpa_supplicant[876]: nl80211: Failed to open /proc/sys/net/ipv4/conf/wlan0/drop_unicast_in_l2_multicast: No such file or directory
Jan 12 11:49:19 ifi wpa_supplicant[876]: nl80211: Failed to set IPv4 unicast in multicast filter
Jan 12 11:49:19 ifi wpa_supplicant[876]: nl80211: Failed to open /proc/sys/net/ipv4/conf/wlan0/drop_unicast_in_l2_multicast: No such file or directory
Jan 12 11:49:19 ifi wpa_supplicant[876]: nl80211: Failed to set IPv4 unicast in multicast filter
Jan 12 11:49:19 ifi wpa_supplicant[876]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0
Jan 12 11:49:19 ifi wpa_supplicant[876]: wlan0: CTRL-EVENT-TERMINATING
Jan 12 11:49:21 ifi node[539]: Error: can't read /data/configuration/audio_interface/alsa_controller/config.json. Error: /data/configuration/audio_interface/alsa_controller/config.json: ENOENT: no such file or directory, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jan 12 11:49:21 ifi node[539]: Error get_output_AIO: Error: /data/configuration/audio_interface/alsa_controller/config.json: ENOENT: no such file or directory, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jan 12 11:49:22 ifi sudo[1344]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Jan 12 11:49:22 ifi sudo[1344]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:22 ifi sudo[1344]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:22 ifi sudo[1351]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Jan 12 11:49:22 ifi sudo[1351]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:22 ifi sudo[1351]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:22 ifi wireless.js[527]: Hotspot is disabled, not starting it
Jan 12 11:49:23 ifi iwconfig[1365]: Error for wireless request "Set Power Management" (8B2C) :
Jan 12 11:49:23 ifi iwconfig[1365]: SET failed on device wlan0 ; Operation not permitted.
Jan 12 11:49:23 ifi systemd[1]: wireless.service: Succeeded.
Jan 12 11:49:23 ifi systemd[1]: Started Wireless Services.
Jan 12 11:49:23 ifi systemd[1]: Started Volumio Backend Module.
Jan 12 11:49:23 ifi systemd[1]: Started Volumio Cpu Tweaker.
Jan 12 11:49:23 ifi node[539]: Success: init system mode AIO
Jan 12 11:49:23 ifi systemd[1]: Started First Start.
Jan 12 11:49:23 ifi systemd[1]: Reached target Multi-User System.
Jan 12 11:49:23 ifi systemd[1]: Reached target Graphical Interface.
Jan 12 11:49:23 ifi systemd[1]: Starting Update UTMP about System Runlevel Changes...
Jan 12 11:49:23 ifi firststart.sh[1368]: Volumio first start configuration script
Jan 12 11:49:23 ifi firststart.sh[1368]: Configuring unconfigured packages
Jan 12 11:49:23 ifi volumio-cpu-tweak[1367]: Setting RT Priority for mpd
Jan 12 11:49:23 ifi systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Jan 12 11:49:23 ifi volumio-cpu-tweak[1367]: Setting MPD Affinity
Jan 12 11:49:23 ifi systemd[1]: Started Update UTMP about System Runlevel Changes.
Jan 12 11:49:23 ifi systemd[1]: Startup finished in 1min 37.343s (kernel) + 35.638s (userspace) = 2min 12.982s.
Jan 12 11:49:23 ifi volumio-cpu-tweak[1367]: pid 784's current affinity mask: f
Jan 12 11:49:23 ifi volumio-cpu-tweak[1367]: pid 784's new affinity mask: 3
Jan 12 11:49:23 ifi volumio-cpu-tweak[1367]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input
Jan 12 11:49:23 ifi volumio-cpu-tweak[1367]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance
Jan 12 11:49:23 ifi systemd[1]: volumio_cpu_tweak.service: Succeeded.
Jan 12 11:49:23 ifi firststart.sh[1368]: Creating /var/log/samba/cores folder
Jan 12 11:49:23 ifi firststart.sh[1368]: Removing default SSH host keys
Jan 12 11:49:23 ifi firststart.sh[1368]: removed '/etc/ssh/ssh_host_dsa_key'
Jan 12 11:49:23 ifi firststart.sh[1368]: removed '/etc/ssh/ssh_host_dsa_key.pub'
Jan 12 11:49:23 ifi firststart.sh[1368]: removed '/etc/ssh/ssh_host_ecdsa_key'
Jan 12 11:49:23 ifi firststart.sh[1368]: removed '/etc/ssh/ssh_host_ecdsa_key.pub'
Jan 12 11:49:23 ifi firststart.sh[1368]: removed '/etc/ssh/ssh_host_rsa_key'
Jan 12 11:49:23 ifi firststart.sh[1368]: removed '/etc/ssh/ssh_host_rsa_key.pub'
Jan 12 11:49:23 ifi firststart.sh[1368]: Generating SSH host keys
Jan 12 11:49:23 ifi node[539]: Error: can't read /data/configuration/audio_interface/alsa_controller/config.json. Error: /data/configuration/audio_interface/alsa_controller/config.json: ENOENT: no such file or directory, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jan 12 11:49:23 ifi node[539]: Error get_output_AIO: Error: /data/configuration/audio_interface/alsa_controller/config.json: ENOENT: no such file or directory, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jan 12 11:49:24 ifi firststart.sh[1368]: debconf: unable to initialize frontend: Dialog
Jan 12 11:49:24 ifi firststart.sh[1368]: debconf: (TERM is not set, so the dialog frontend is not usable.)
Jan 12 11:49:24 ifi firststart.sh[1368]: debconf: falling back to frontend: Readline
Jan 12 11:49:24 ifi firststart.sh[1368]: debconf: unable to initialize frontend: Readline
Jan 12 11:49:24 ifi firststart.sh[1368]: debconf: (This frontend requires a controlling tty.)
Jan 12 11:49:24 ifi firststart.sh[1368]: debconf: falling back to frontend: Teletype
Jan 12 11:49:25 ifi node[539]: Error: can't read /data/configuration/audio_interface/alsa_controller/config.json. Error: /data/configuration/audio_interface/alsa_controller/config.json: ENOENT: no such file or directory, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jan 12 11:49:25 ifi node[539]: Error get_output_AIO: Error: /data/configuration/audio_interface/alsa_controller/config.json: ENOENT: no such file or directory, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jan 12 11:49:26 ifi volumio[1366]: info: -------------------------------------------
Jan 12 11:49:26 ifi volumio[1366]: info: ----- Volumio3 ----
Jan 12 11:49:26 ifi volumio[1366]: info: -------------------------------------------
Jan 12 11:49:26 ifi volumio[1366]: info: ----- System startup ----
Jan 12 11:49:26 ifi volumio[1366]: info: -------------------------------------------
Jan 12 11:49:26 ifi volumio[1366]: info: ConvSwitch: Client Start
Jan 12 11:49:26 ifi volumio[1366]: info: MetaClient: Client Start
Jan 12 11:49:26 ifi node[539]: A new connection has been established.
Jan 12 11:49:27 ifi volumio[1366]: info: File /data/configuration/plugins.json does not exist. Copying from Volumio
Jan 12 11:49:27 ifi volumio[1366]: info: Plugin folders cleanup
Jan 12 11:49:27 ifi volumio[1366]: info: Scanning into folder /volumio/app/plugins/
Jan 12 11:49:27 ifi volumio[1366]: info: Scanning category audio_interface
Jan 12 11:49:27 ifi volumio[1366]: info: Scanning category miscellanea
Jan 12 11:49:27 ifi volumio[1366]: info: Scanning category music_service
Jan 12 11:49:27 ifi volumio[1366]: info: Scanning category plugins.json
Jan 12 11:49:27 ifi volumio[1366]: info: Scanning category system_controller
Jan 12 11:49:27 ifi volumio[1366]: info: Scanning category user_interface
Jan 12 11:49:27 ifi volumio[1366]: info: Scanning into folder /data/plugins/
Jan 12 11:49:27 ifi volumio[1366]: info: Scanning category music_service
Jan 12 11:49:27 ifi volumio[1366]: info: Plugin folders cleanup completed
Jan 12 11:49:27 ifi volumio[1366]: info: -------------------------------------------
Jan 12 11:49:27 ifi volumio[1366]: info: ----- Core plugins startup ----
Jan 12 11:49:27 ifi volumio[1366]: info: -------------------------------------------
Jan 12 11:49:27 ifi volumio[1366]: info: Loading plugins from folder /volumio/app/plugins/
Jan 12 11:49:27 ifi volumio[1366]: info: Adding plugin networkaudiod to MyMusic Plugins
Jan 12 11:49:27 ifi volumio[1366]: info: Adding plugin qobuz_connect to MyMusic Plugins
Jan 12 11:49:27 ifi volumio[1366]: info: Adding plugin spotify_connect to MyMusic Plugins
Jan 12 11:49:27 ifi volumio[1366]: info: Adding plugin tidal_connect to MyMusic Plugins
Jan 12 11:49:27 ifi volumio[1366]: info: Adding plugin upnp to MyMusic Plugins
Jan 12 11:49:27 ifi volumio[1366]: info: Adding plugin airplay1_switch to MyMusic Plugins
Jan 12 11:49:27 ifi volumio[1366]: info: Adding plugin airplay2_switch to MyMusic Plugins
Jan 12 11:49:27 ifi volumio[1366]: info: Adding plugin roon_ready to MyMusic Plugins
Jan 12 11:49:27 ifi volumio[1366]: info: Adding plugin upnp_browser to MyMusic Plugins
Jan 12 11:49:27 ifi volumio[1366]: info: Loading plugins from folder /data/plugins/
Jan 12 11:49:27 ifi volumio[1366]: info: Loading plugin "system"...
Jan 12 11:49:27 ifi volumio[1366]: info: No id defined. Creating one
Jan 12 11:49:27 ifi volumio[1366]: info: Loading plugin "appearance"...
Jan 12 11:49:27 ifi node[539]: Error: can't read /data/configuration/audio_interface/alsa_controller/config.json. Error: /data/configuration/audio_interface/alsa_controller/config.json: ENOENT: no such file or directory, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jan 12 11:49:27 ifi node[539]: Error get_output_AIO: Error: /data/configuration/audio_interface/alsa_controller/config.json: ENOENT: no such file or directory, open '/data/configuration/audio_interface/alsa_controller/config.json'
Jan 12 11:49:28 ifi firststart.sh[1368]: Creating SSH2 RSA key; this may take some time ...
Jan 12 11:49:28 ifi firststart.sh[1368]: 2048 SHA256:CEbSxJT++X9802bKxgr88kRvkjJHiX0hXI6sdE6+xwY root@ifi (RSA)
Jan 12 11:49:29 ifi volumio[1366]: info: Loading plugin "network"...
Jan 12 11:49:29 ifi volumio[1366]: info: Refreshing Cached IP Addresses
Jan 12 11:49:29 ifi sudo[1544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jan 12 11:49:29 ifi sudo[1544]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:29 ifi sudo[1544]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:29 ifi sudo[1546]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 12 11:49:29 ifi sudo[1546]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:29 ifi sudo[1546]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:29 ifi volumio[1366]: info: Loading plugin "services"...
Jan 12 11:49:29 ifi volumio[1366]: info: Loading plugin "alsa_controller"...
Jan 12 11:49:29 ifi sudo[1559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jan 12 11:49:29 ifi sudo[1559]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:29 ifi firststart.sh[1368]: Creating SSH2 DSA key; this may take some time ...
Jan 12 11:49:29 ifi volumio[1366]: warn: The ALSA output card is not set, defaulting to card [object Object]
Jan 12 11:49:29 ifi firststart.sh[1368]: 1024 SHA256:K0vmAVHo6kzKYpH0CgifJf0fxFLguVqxGBcPSmfmKiA root@ifi (DSA)
Jan 12 11:49:29 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jan 12 11:49:29 ifi firststart.sh[1368]: Creating SSH2 ECDSA key; this may take some time ...
Jan 12 11:49:29 ifi volumio[1366]: error: Could not retrieve plugin system_controller i2s_dacs
Jan 12 11:49:29 ifi volumio[1366]: info: Found match in Cards Database: setting mixer None for card iDSD PHANTOM
Jan 12 11:49:29 ifi volumio[1366]: info: Ignoring Mixers Options
Jan 12 11:49:29 ifi volumio[1366]: info: Device 0,0 does not have any Mixer Control Available
Jan 12 11:49:29 ifi volumio[1366]: info: Restoring Previous Volume level: 100 false false
Jan 12 11:49:29 ifi firststart.sh[1368]: 256 SHA256:mNGISGcHzB8TYI38+nuF3FeVx7NCMUKa+wpJK0WTJWY root@ifi (ECDSA)
Jan 12 11:49:29 ifi volumio[1366]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Jan 12 11:49:29 ifi volumio[1366]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Jan 12 11:49:29 ifi volumio[1366]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Jan 12 11:49:29 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 12 11:49:29 ifi volumio[1366]: info: Loading plugin "wizard"...
Jan 12 11:49:29 ifi volumio[1366]: info: Loading plugin "volumio_command_line_client"...
Jan 12 11:49:29 ifi volumio[1366]: info: Loading plugin "networkaudiod"...
Jan 12 11:49:29 ifi volumio[1366]: info: [1768218569542] Starting NAA Service
Jan 12 11:49:29 ifi volumio[1366]: info: Loading plugin "tidal_connect"...
Jan 12 11:49:29 ifi volumio[1366]: info: [1768218569572] Starting Tidal Connect Service
Jan 12 11:49:29 ifi volumio[1366]: info: Loading plugin "upnp"...
Jan 12 11:49:29 ifi volumio[1366]: info: [1768218569588] Starting Upmpd Daemon
Jan 12 11:49:29 ifi volumio[1366]: info: Starting Upmpd Daemon
Jan 12 11:49:29 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jan 12 11:49:29 ifi volumio[1366]: error: ATTENTION!!!: Plugin upnp does not return adequate promise from onVolumioStart: please update!
Jan 12 11:49:29 ifi volumio[1366]: info: Loading plugin "my_music"...
Jan 12 11:49:29 ifi volumio[1366]: info: Loading plugin "mpd"...
Jan 12 11:49:29 ifi node[539]: get outputdevice.value error
Jan 12 11:49:29 ifi node[539]: Error get_output_AIO: TypeError: Cannot read property 'value' of undefined
Jan 12 11:49:30 ifi volumio[1366]: info: Loading plugin "upnp_browser"...
Jan 12 11:49:30 ifi kernel: start_addr=(0x8000), end_addr=(0x10000), buffer_size=(0x8000), smp_number_max=(4096)
Jan 12 11:49:30 ifi sudo[1595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart networkaudiod.service
Jan 12 11:49:30 ifi sudo[1595]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:30 ifi systemd[1]: Stopping Network Audio Adapter daemon...
Jan 12 11:49:30 ifi systemd[1]: networkaudiod.service: Succeeded.
Jan 12 11:49:30 ifi systemd[1]: Stopped Network Audio Adapter daemon.
Jan 12 11:49:30 ifi systemd[1]: Started Network Audio Adapter daemon.
Jan 12 11:49:30 ifi sudo[1595]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:30 ifi networkaudiod[1609]: [/usr/sbin/networkaudiod] (1609): networkaudiod Copyright (C) 2011-2020 Jussi Laako / Signalyst. All rights reserved.
Jan 12 11:49:30 ifi networkaudiod[1609]: [/usr/sbin/networkaudiod] (1609): create alsa engine
Jan 12 11:49:30 ifi networkaudiod[1609]: [/usr/sbin/networkaudiod] (1609): listen discovery on ::
Jan 12 11:49:30 ifi networkaudiod[1609]: [/usr/sbin/networkaudiod] (1609): clSocket::SetOption(): setsockopt(..., 41,20, ...): No such device
Jan 12 11:49:30 ifi networkaudiod[1609]: [/usr/sbin/networkaudiod] (1609): Socket failure, falling back to IPv4-only!
Jan 12 11:49:30 ifi volumio[1366]: info: Loading plugin "qobuz_connect"...
Jan 12 11:49:30 ifi volumio[1366]: info: [1768218570933] Starting Qobuz Connect Service
Jan 12 11:49:30 ifi volumio[1366]: info: Loading plugin "alarm-clock"...
Jan 12 11:49:31 ifi volumio[1366]: info: Loading plugin "last_100"...
Jan 12 11:49:31 ifi volumio[1366]: info: Loading plugin "roon_ready"...
Jan 12 11:49:31 ifi volumio[1366]: info: Starting RoonReady Sync
Jan 12 11:49:31 ifi volumio[1366]: info: Loading plugin "webradio"...
Jan 12 11:49:31 ifi volumio[1366]: info: Loading plugin "i2s_dacs"...
Jan 12 11:49:31 ifi volumio[1366]: info: I2S DAC not set, start Auto-detection
Jan 12 11:49:31 ifi volumio[1366]: info: Loading plugin "volumiodiscovery"...
Jan 12 11:49:31 ifi volumio[1366]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jan 12 11:49:31 ifi volumio[1366]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jan 12 11:49:31 ifi volumio[1366]: *** WARNING *** For more information see
Jan 12 11:49:31 ifi node[1366]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jan 12 11:49:31 ifi volumio[1366]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jan 12 11:49:31 ifi volumio[1366]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jan 12 11:49:31 ifi volumio[1366]: *** WARNING *** For more information see
Jan 12 11:49:31 ifi node[1366]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jan 12 11:49:31 ifi node[1366]: *** WARNING *** For more information see
Jan 12 11:49:31 ifi node[1366]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jan 12 11:49:31 ifi node[1366]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jan 12 11:49:31 ifi node[1366]: *** WARNING *** For more information see
Jan 12 11:49:31 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jan 12 11:49:31 ifi volumio[1366]: info: Loading plugin "spotify_connect"...
Jan 12 11:49:31 ifi volumio[1366]: info: [1768218571545] Starting Spotify Connect Service
Jan 12 11:49:31 ifi volumio[1366]: info: Plugin airplay1_switch is not enabled
Jan 12 11:49:31 ifi volumio[1366]: info: Loading plugin "airplay2_switch"...
Jan 12 11:49:31 ifi volumio[1366]: info: Loading plugin "airplay_emulation"...
Jan 12 11:49:31 ifi networkaudiod[1609]: [/usr/sbin/networkaudiod] (1609): listen discovery on 0.0.0.0
Jan 12 11:49:31 ifi volumio[1366]: info: Starting Shairport Sync
Jan 12 11:49:31 ifi volumio[1366]: info: Loading plugin "networkfs"...
Jan 12 11:49:31 ifi volumio[1366]: info: Starting Udev Watcher for removable devices
Jan 12 11:49:31 ifi node[539]: get outputdevice.value error
Jan 12 11:49:31 ifi node[539]: Error get_output_AIO: TypeError: Cannot read property 'value' of undefined
Jan 12 11:49:31 ifi volumio[1366]: error: Cannot associate FS Label, not mounting
Jan 12 11:49:31 ifi volumio[1366]: error: Cannot associate FS Label, not mounting
Jan 12 11:49:31 ifi volumio[1366]: info: Ignoring mount for partition: BOOT
Jan 12 11:49:31 ifi volumio[1366]: info: Ignoring mount for partition: archivefs
Jan 12 11:49:31 ifi volumio[1366]: info: Ignoring mount for partition: rootfs
Jan 12 11:49:32 ifi volumio[1366]: info: Mounting Device HIKSEMI
Jan 12 11:49:32 ifi sudo[1640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/HIKSEMI -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Jan 12 11:49:32 ifi sudo[1640]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:32 ifi systemd[1]: Reloading.
Jan 12 11:49:32 ifi kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive!
Jan 12 11:49:32 ifi kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Jan 12 11:49:32 ifi sudo[1640]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:32 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jan 12 11:49:32 ifi volumio[1366]: info: Loading plugin "outputs"...
Jan 12 11:49:32 ifi volumio[1366]: info: Loading plugin "albumart"...
Jan 12 11:49:32 ifi volumio[1366]: info: Plugin example_plugin is not enabled
Jan 12 11:49:32 ifi volumio[1366]: info: Loading plugin "inputs"...
Jan 12 11:49:32 ifi volumio[1366]: info: Loading plugin "updater_comm"...
Jan 12 11:49:32 ifi systemd-fstab-generator[1648]: Mount point vfat is not a valid path, ignoring.
Jan 12 11:49:32 ifi systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Jan 12 11:49:32 ifi volumio[1366]: info: Plugin mpdemulation is not enabled
Jan 12 11:49:32 ifi volumio[1366]: info: Loading plugin "rest_api"...
Jan 12 11:49:32 ifi volumio[1366]: info: Loading plugin "websocket"...
Jan 12 11:49:32 ifi volumio[1366]: info: Starting Socket.io Server version 2.3.0
Jan 12 11:49:32 ifi volumio[1366]: info: Plugin ifi-cdplayer is not enabled
Jan 12 11:49:32 ifi systemd[1]: Configuration file /lib/systemd/system/ifi-streamer-thermal.service is marked executable. Please remove executable permission bits. Proceeding anyway.
Jan 12 11:49:32 ifi systemd[1]: Configuration file /lib/systemd/system/ifi-streamer-ethernet.service is marked executable. Please remove executable permission bits. Proceeding anyway.
Jan 12 11:49:32 ifi volumio[1366]: info: Loading i18n strings for locale en
Jan 12 11:49:32 ifi systemd[1]: Configuration file /lib/systemd/system/ifi-mqtt.service is marked executable. Please remove executable permission bits. Proceeding anyway.
Jan 12 11:49:32 ifi systemd[1]: /lib/systemd/system/ifi-mqtt.service:11: Unknown lvalue 'StartLimitIntervalSec' in section 'Service', ignoring
Jan 12 11:49:32 ifi volumio[1366]: Updating browse sources language
Jan 12 11:49:32 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 12 11:49:33 ifi volumio[1366]: Forking 3 albumart workers
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::initPlayerControls
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 12 11:49:33 ifi volumio[1366]: Express server listening on port 3000
Jan 12 11:49:33 ifi volumio[1366]: [Metrics] WebUI: 8s 143.56ms
Jan 12 11:49:33 ifi volumio[1366]: Meta server listening
Jan 12 11:49:33 ifi volumio[1366]: info: CoreStateMachine::resetVolumioState
Jan 12 11:49:33 ifi volumio[1366]: info: CoreStateMachine::getcurrentVolume
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::volumioRetrievevolume
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume
Jan 12 11:49:33 ifi volumio[1366]: info: CoreStateMachine::pushState
Jan 12 11:49:33 ifi volumio[1366]: info: CorePlayQueue::getTrack 0
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::volumioPushState
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 12 11:49:33 ifi volumio[1366]: info: Server listening on port 6599
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Jan 12 11:49:33 ifi volumio[1366]: info: CoreStateMachine::getcurrentVolume
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::volumioRetrievevolume
Jan 12 11:49:33 ifi sudo[1725]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume
Jan 12 11:49:33 ifi volumio[1366]: info: CoreStateMachine::pushState
Jan 12 11:49:33 ifi sudo[1725]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:33 ifi volumio[1366]: info: CorePlayQueue::getTrack 0
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::volumioPushState
Jan 12 11:49:33 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 12 11:49:33 ifi firststart.sh[1368]: rescue-ssh.target is a disabled or a static unit, not starting it.
Jan 12 11:49:33 ifi sudo[1727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service
Jan 12 11:49:33 ifi sudo[1727]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:33 ifi volumio[1366]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Jan 12 11:49:33 ifi volumio[1366]: info: Completed loading Core Plugins
Jan 12 11:49:33 ifi volumio[1366]: info: Preparing to generate the ALSA configuration file
Jan 12 11:49:33 ifi systemd[1]: Started iFi Streamer Tidal Connect Service.
Jan 12 11:49:33 ifi systemd[1]: Started iFi Streamer Tidal Metadata Service.
Jan 12 11:49:33 ifi sudo[1725]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:34 ifi systemd[1]: Started iFi Streamer Qobuz Connect Service.
Jan 12 11:49:34 ifi volumio[1366]: info: Scanning new location : "USB/HIKSEMI"
Jan 12 11:49:34 ifi volumio[1366]: info: Cannot read play queue from file
Jan 12 11:49:34 ifi sudo[1727]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:34 ifi volumio[1366]: info: ConvSwitch: Connected to server
Jan 12 11:49:34 ifi node[532]: ConvSwitch: Add client volumio
Jan 12 11:49:34 ifi volumio[1366]: info: MetaClient: Connected to server
Jan 12 11:49:34 ifi node[539]: A new connection has been established.
Jan 12 11:49:34 ifi volumio[1366]: info: Volumio Network Manager: Network status updated: 1
Jan 12 11:49:34 ifi volumio[1366]: info: NAA Service Started
Jan 12 11:49:34 ifi volumio[1366]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Jan 12 11:49:34 ifi volumio[1366]: info: VolumeController::SetAlsaVolume100
Jan 12 11:49:34 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume
Jan 12 11:49:34 ifi volumio[1366]: info: CoreStateMachine::pushState
Jan 12 11:49:34 ifi volumio[1366]: info: CorePlayQueue::getTrack 0
Jan 12 11:49:34 ifi volumio[1366]: info: CoreCommandRouter::volumioPushState
Jan 12 11:49:34 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 12 11:49:34 ifi volumio[1366]: info: ConvSwitch: Get message: success
Jan 12 11:49:34 ifi volumio[1366]: info: MetaClient: Get message: success
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.557 [1779.1779] DEBUG SampleApp: Starting sample application
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.557 [1779.1779] DEBUG SampleApp: Device Name: iFi
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.558 [1779.1779] DEBUG SampleApp: Manufacturer: Sample manufacturer
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.558 [1779.1779] DEBUG SampleApp: Model: iFi Streamer
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.558 [1779.1779] DEBUG SampleApp: Serial Number: ifi:6a:bd:9e:df:29:66
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.558 [1779.1779] DEBUG SampleApp: Audio output device: volumio
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.558 [1779.1779] DEBUG SampleApp: Volume control device: default
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.558 [1779.1779] DEBUG SampleApp: Volume control element: Master
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.558 [1779.1779] DEBUG SampleApp: Local config server port: 8000
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.570 [1779.1779] ERROR SampleApp: Unable to find ALSA mixer element 'Master' on index 0
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.573 [1779.1779] DEBUG SampleApp: Maximum supported audio quality: HIRES_L3
Jan 12 11:49:34 ifi play[1754]: [Info] MetaClient: MetaClient SDK -- v1.02
Jan 12 11:49:34 ifi node[539]: A new connection has been established.
Jan 12 11:49:34 ifi play[1754]: [Info] MetaClient: MetaClientInit
Jan 12 11:49:34 ifi play[1754]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03
Jan 12 11:49:34 ifi node[532]: ConvSwitch: Add client qobuz-connect
Jan 12 11:49:34 ifi volumio[1366]: verbose: New Socket.io Connection to 192.168.1.190:3000 from 192.168.1.169 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1
Jan 12 11:49:34 ifi play[1754]: [Info] ConvSwitch: ConvSwitchInit
Jan 12 11:49:34 ifi volumio[1366]: verbose: New Socket.io Connection to 192.168.1.190:3000 from 192.168.1.169 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.710 [1779.1779] DEBUG ActiveStateManager: [0xab50a4d0]: Creating new Active State Manager
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.710 [1779.1779] DEBUG NetworkActivityTracker: [0xab50a540]: Creating new Network Activity Tracker
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.716 [1779.1779] DEBUG EndpointManager: [0xab50b4b8]: Creating Endpoint Manager
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.717 [1779.1779] DEBUG PlaybackSessionManager: [0xab50b8a8]: Creating Playback Session Manager
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.717 [1779.1779] DEBUG BackoffTimer: [0xab50ba20]: Creating Backoff Timer
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.717 [1779.1779] DEBUG MediaEngine: [0xab50bb40]: Creating new Media Engine
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.717 [1779.1779] DEBUG AudioRenderer: [0xab50bd60]: Creating Audio Renderer
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.717 [1779.1779] TRACE MediaEngineCommandSequencer: [0xab50beb8]: Creating Media Engine Command Sequencer
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.717 [1779.1779] DEBUG PlaybackControlsManager: [0xab50bf18]: Creating new Playback Controls Manager
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.717 [1779.1779] DEBUG VolumeManager: [0xab50bfa8]: Creating new Volume Manager
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.717 [1779.1779] DEBUG ProtocolHandler: [0xab50c280]: Creating Protocol Handler
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.717 [1779.1779] DEBUG MessageReceiver: [0xab50c320]: Creating Message Receiver
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.717 [1779.1779] DEBUG RendererActivationController: [0xab50c498]: Creating new Renderer Activation Controller
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.717 [1779.1779] TRACE RendererActivationCommandSequencer: [0xab50c540]: Creating Renderer Activation Command Sequencer
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.717 [1779.1779] DEBUG ReportingManager: [0xab50c650]: Creating new Reporting Manager
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.717 [1779.1779] DEBUG StreamingEventReporter: [0xab50c698]: Creating Streaming Event Reporter
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.717 [1779.1779] DEBUG BackoffTimer: [0xab50c778]: Creating Backoff Timer
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.717 [1779.1779] DEBUG TokenExpiryController: [0xab50c888]: Creating Token Expiry Controller
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.717 [1779.1779] DEBUG UserInactivityManager: [0xab50c8d8]: Creating new User Inactivity Manager
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.718 [1779.1779] INFO VolumeManager: [0xab50bfa8]: Setting new playback volume: 100
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.718 [1779.1779] INFO VolumeManager: [0xab50bfa8]: Setting new mute state: 1
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.718 [1779.1779] DEBUG SampleApp: Qobuz Connect has been initialized
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.718 [1779.1779] TRACE SampleApp: Running event loop
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.718 [1779.1779] INFO QobuzConnect: [0xab50c978]: Client initialized!
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.718 [1779.1779] INFO SampleApp: Starting Avahi advertising, name: iFi, service name: _qobuz-connect._tcp
Jan 12 11:49:34 ifi volumio[1366]: verbose: New Socket.io Connection to 192.168.1.190:3000 from 192.168.1.169 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.731 [1779.1779] DEBUG SampleApp: Avahi client state changed: RUNNING
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.738 [1779.1779] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.745 [1779.1779] INFO LocalConfigManager: [0xab50b888]: Starting Local Configuration server
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.746 [1779.1779] INFO SampleApp: Starting Local configuration server
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.747 [1779.1779] INFO SampleApp: Playback mute state changed: 1
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.747 [1779.1779] ERROR SampleApp: Unable to set mute state, no ALSA volume element
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.748 [1779.1779] DEBUG SampleApp: Avahi entry group state changed: REGISTERING
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.748 [1779.1779] INFO SampleApp: Playback volume changed: 100
Jan 12 11:49:34 ifi play[1754]: 20260112 11:49:34.748 [1779.1779] ERROR SampleApp: Unable to set volume, no ALSA volume element
Jan 12 11:49:34 ifi volumio[1366]: verbose: New Socket.io Connection to 192.168.1.190 from 192.168.1.137 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Edg/143.0.0.0 Engine version: 3 Transport: polling Total Clients: 4
Jan 12 11:49:34 ifi volumio[1366]: verbose: New Socket.io Connection to 192.168.1.190:3000 from 192.168.1.241 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Jan 12 11:49:34 ifi volumio[1366]: verbose: New Socket.io Connection to 192.168.1.190:3000 from 192.168.1.241 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Jan 12 11:49:34 ifi volumio[1366]: verbose: New Socket.io Connection to 192.168.1.190:3000 from 192.168.1.241 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jan 12 11:49:34 ifi volumio[1366]: verbose: New Socket.io Connection to 192.168.1.190:3000 from 192.168.1.241 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8
Jan 12 11:49:34 ifi volumio[1366]: verbose: New Socket.io Connection to 192.168.1.190 from 192.168.1.137 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Edg/143.0.0.0 Engine version: 3 Transport: polling Total Clients: 9
Jan 12 11:49:34 ifi volumio[1366]: verbose: New Socket.io Connection to 192.168.1.190:3000 from 192.168.1.241 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Jan 12 11:49:34 ifi volumio[1366]: info: Qobuz Connect Service Started
Jan 12 11:49:34 ifi volumio[1366]: info: Tidal Connect Service Started
Jan 12 11:49:34 ifi firststart.sh[1368]: insserv: warning: current start runlevel(s) (empty) of script `ssh' overrides LSB defaults (2 3 4 5).
Jan 12 11:49:34 ifi firststart.sh[1368]: insserv: warning: current stop runlevel(s) (2 3 4 5) of script `ssh' overrides LSB defaults (empty).
Jan 12 11:49:35 ifi sudo[1785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service
Jan 12 11:49:35 ifi sudo[1785]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:35 ifi sudo[1559]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:35 ifi systemd[1]: Started iFi Streamer Spotify Connect Service.
Jan 12 11:49:35 ifi sudo[1785]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:35 ifi systemd[1]: Reloading.
Jan 12 11:49:35 ifi volumio[1366]: info: ++++--++++ initSocket: {"id":"461a5044-e340-4d4b-bfe9-75e4e6ba44a0"}
Jan 12 11:49:35 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Jan 12 11:49:35 ifi play[1788]: output: volumio mixer: hw:0
Jan 12 11:49:35 ifi volumio[1366]: info: ++++--++++ initSocket: {"id":"461a5044-e340-4d4b-bfe9-75e4e6ba44a0"}
Jan 12 11:49:35 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Jan 12 11:49:35 ifi node[532]: ConvSwitch: Add client spotify
Jan 12 11:49:35 ifi node[539]: A new connection has been established.
Jan 12 11:49:35 ifi volumio[1366]: info: ++++--++++ initSocket: {"id":"461a5044-e340-4d4b-bfe9-75e4e6ba44a0"}
Jan 12 11:49:35 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.547 I api SpRegisterDebugCallbacks [returned value: 0]
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.547 I api SpInit(0xffa5d630, API v66)
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.547 I esdk eSDK version: HEAD-v3.166.69-g24821f73
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.548 I esdk Successfully registered socket callbacks: cre, set_opt, cl, bind, list, con, acc, rd, wr, rd_from, wr_to, err, readable, writable, local_addresses, address, pump
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.548 I esdk Successfully registered dns callback: dns_lookup_callback
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.548 I download Using 128 kB for cache buffer
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.548 I download Using 621 kB for compressed audio buffer
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.548 I esdk Successfully registered error callback
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.576 I esdk Creating IPv4 socket (domain 2)
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.593 I zc webserver: service port 5566 (5566-5576) buffer size 4444
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.593 I zc Started ZeroConf service on port 5566 path /zc alias count 0
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.593 I esdk Creating IPv4 socket (domain 2)
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.593 I api SpInit [returned value: 0]
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.594 I api SpRegisterConnectionCallbacks(0xffa5d618, (nil))
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.594 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.594 I api SpRegisterConnectionCallbacks [returned value: 0]
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.594 I api SpRegisterPlaybackCallbacks(0xffa5d600, (nil))
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.594 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, -
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.594 I api SpRegisterPlaybackCallbacks [returned value: 0]
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.620 W app Couldn't find mixer for volume controls. (tried , SoftMaster)
Jan 12 11:49:35 ifi play[1788]: 2026-01-12 11:49:35.621 I app Initialized!
Jan 12 11:49:35 ifi volumio[1366]: info: ++++--++++ initSocket: {"id":"461a5044-e340-4d4b-bfe9-75e4e6ba44a0"}
Jan 12 11:49:35 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Jan 12 11:49:35 ifi systemd-fstab-generator[1809]: Mount point vfat is not a valid path, ignoring.
Jan 12 11:49:35 ifi volumio[1366]: info: ++++--++++ initSocket: {"id":"461a5044-e340-4d4b-bfe9-75e4e6ba44a0"}
Jan 12 11:49:35 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Jan 12 11:49:35 ifi volumio[1366]: info: Asound.conf file written
Jan 12 11:49:35 ifi play[1754]: 20260112 11:49:35.749 [1779.1779] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED
Jan 12 11:49:35 ifi sudo[1822]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Jan 12 11:49:35 ifi sudo[1822]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:35 ifi volumio[1366]: Starting albumart workers
Jan 12 11:49:35 ifi sudo[1822]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:35 ifi volumio[1366]: No state is present for card PHANTOM
Jan 12 11:49:35 ifi volumio[1366]: Found hardware: "USB-Audio" "USB Mixer" "USB20b1:3008" "" ""
Jan 12 11:49:35 ifi volumio[1366]: Hardware is initialized using a generic method
Jan 12 11:49:35 ifi volumio[1366]: No state is present for card PHANTOM
Jan 12 11:49:35 ifi volumio[1366]: info: Tidal connect: Output device has changed
Jan 12 11:49:35 ifi volumio[1366]: info: Output device has changed, restarting MPD
Jan 12 11:49:36 ifi volumio[1366]: Starting albumart workers
Jan 12 11:49:36 ifi volumio[1366]: info: Qobuz connect: Output device has changed
Jan 12 11:49:36 ifi volumio[1366]: info: Roon Ready: Output device has changed
Jan 12 11:49:36 ifi volumio[1366]: info: Spotify: Output device has changed
Jan 12 11:49:36 ifi volumio[1366]: info: ___________ START PLUGINS ___________
Jan 12 11:49:36 ifi volumio[1366]: info: Setting player name on first start: iDSD PHANTOM
Jan 12 11:49:36 ifi sudo[1833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 12 11:49:36 ifi sudo[1833]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:36 ifi sudo[1833]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:36 ifi volumio[1366]: info: System name has changed, restarting Qobuz Connect
Jan 12 11:49:36 ifi volumio[1366]: info: System name has changed, restarting RoonReady Sync
Jan 12 11:49:36 ifi volumio[1366]: info: Starting RoonReady Sync
Jan 12 11:49:36 ifi systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Jan 12 11:49:36 ifi volumio[1366]: info: System name has changed, restarting Shairport Sync
Jan 12 11:49:36 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 12 11:49:36 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 12 11:49:36 ifi sudo[1837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service
Jan 12 11:49:36 ifi sudo[1837]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:36 ifi volumio[1366]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jan 12 11:49:36 ifi volumio[1366]: Starting albumart workers
Jan 12 11:49:36 ifi systemd[1]: Configuration file /lib/systemd/system/ifi-streamer-thermal.service is marked executable. Please remove executable permission bits. Proceeding anyway.
Jan 12 11:49:36 ifi systemd[1]: Configuration file /lib/systemd/system/ifi-streamer-ethernet.service is marked executable. Please remove executable permission bits. Proceeding anyway.
Jan 12 11:49:36 ifi volumio[1366]: info: Discovery: Restarting Advertising due to device name change
Jan 12 11:49:36 ifi volumio[1366]: info: Setting Hotspot Unique name on first start: iFi-Streamer
Jan 12 11:49:36 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: network , getConfigParam
Jan 12 11:49:36 ifi volumio[1366]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getConfigParam] in plugin network
Jan 12 11:49:36 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: network , saveHotspotSettings
Jan 12 11:49:36 ifi volumio[1366]: info: CoreCommandRouter::Reload Ui
Jan 12 11:49:36 ifi systemd[1]: Configuration file /lib/systemd/system/ifi-mqtt.service is marked executable. Please remove executable permission bits. Proceeding anyway.
Jan 12 11:49:36 ifi systemd[1]: /lib/systemd/system/ifi-mqtt.service:11: Unknown lvalue 'StartLimitIntervalSec' in section 'Service', ignoring
Jan 12 11:49:36 ifi volumio[1366]: info: ControllerMpd::onStart: Initializing MPD
Jan 12 11:49:36 ifi volumio[1366]: info: Creating MPD Configuration file
Jan 12 11:49:36 ifi sudo[1848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli
Jan 12 11:49:36 ifi sudo[1848]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Jan 12 11:49:36 ifi kernel: hid-generic 0003:20B1:3008.0003: hiddev0,hidraw0: USB HID v1.10 Device [iFi (by AMR) iDSD PHANTOM] on usb-xhci-hcd.0.auto-1.2/input3
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Jan 12 11:49:36 ifi kernel: input: iFi (by AMR) iDSD PHANTOM as /devices/platform/usb@ff600000/ff600000.dwc3/xhci-hcd.0.auto/usb4/4-1/4-1.2/4-1.2:1.4/0003:20B1:3008.0004/input/input4
Jan 12 11:49:36 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jan 12 11:49:36 ifi volumio[1366]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jan 12 11:49:36 ifi volumio[1366]: info: [1768218576435] CoreMusicLibrary::Adding element Media Servers
Jan 12 11:49:36 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 12 11:49:36 ifi sudo[1848]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:36 ifi sudo[1855]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jan 12 11:49:36 ifi sudo[1855]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:36 ifi kernel: hid-generic 0003:20B1:3008.0004: input,hidraw1: USB HID v1.11 Device [iFi (by AMR) iDSD PHANTOM] on usb-xhci-hcd.0.auto-1.2/input4
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Jan 12 11:49:36 ifi sudo[1855]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:36 ifi sudo[1858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service
Jan 12 11:49:36 ifi sudo[1858]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:36 ifi systemd-udevd[1853]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Jan 12 11:49:36 ifi volumio[1366]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jan 12 11:49:36 ifi volumio[1366]: info: [1768218576653] CoreMusicLibrary::Adding element Last_100
Jan 12 11:49:36 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 12 11:49:36 ifi volumio[1366]: info: Starting RoonReady Sync
Jan 12 11:49:36 ifi volumio[1366]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jan 12 11:49:36 ifi volumio[1366]: info: [1768218576727] CoreMusicLibrary::Adding element Webradio
Jan 12 11:49:36 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Jan 12 11:49:36 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 12 11:49:36 ifi volumio[1366]: info: Initializing BBC Radios
Jan 12 11:49:36 ifi sudo[1869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service
Jan 12 11:49:36 ifi sudo[1869]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Jan 12 11:49:36 ifi kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:36 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Jan 12 11:49:37 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 12 11:49:37 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 12 11:49:37 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 12 11:49:37 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Jan 12 11:49:37 ifi kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Jan 12 11:49:37 ifi kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:37 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Jan 12 11:49:37 ifi kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Jan 12 11:49:37 ifi kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:37 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Jan 12 11:49:37 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 12 11:49:37 ifi ifi_metadata[1736]: [Info] MetaClient: MetaClient SDK -- v1.02
Jan 12 11:49:37 ifi ifi_metadata[1736]: [Info] MetaClient: MetaClientInit
Jan 12 11:49:37 ifi ifi_metadata[1736]: Could not connect: Reason::CONNECTION_ERROR
Jan 12 11:49:37 ifi sudo[1889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -snf /usr/local/bin/airplay2 /usr/local/bin/shairport-sync
Jan 12 11:49:37 ifi sudo[1889]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:37 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Jan 12 11:49:37 ifi kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Jan 12 11:49:37 ifi kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:37 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Jan 12 11:49:37 ifi kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Jan 12 11:49:37 ifi kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:37 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Jan 12 11:49:37 ifi sudo[1889]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:37 ifi volumio[1366]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jan 12 11:49:37 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jan 12 11:49:37 ifi volumio[1366]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jan 12 11:49:37 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Jan 12 11:49:37 ifi kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Jan 12 11:49:37 ifi kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:37 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Jan 12 11:49:37 ifi kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Jan 12 11:49:37 ifi kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:37 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Jan 12 11:49:37 ifi volumio[1366]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jan 12 11:49:37 ifi volumio[1366]: info: Volumio Calling Home
Jan 12 11:49:37 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree
Jan 12 11:49:37 ifi kernel: rk808 1-0018: Looking up vcc4-supply from device tree
Jan 12 11:49:37 ifi kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:37 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree
Jan 12 11:49:37 ifi kernel: rk808 1-0018: Looking up vcc5-supply from device tree
Jan 12 11:49:37 ifi kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed
Jan 12 11:49:37 ifi kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree
Jan 12 11:49:37 ifi systemd[1]: Stopping Music Player Daemon...
Jan 12 11:49:37 ifi systemd[1]: Started iFi Streamer Roon Ready Service.
Jan 12 11:49:37 ifi sudo[1837]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:37 ifi sudo[1869]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:37 ifi systemd[1]: mpd.service: Succeeded.
Jan 12 11:49:37 ifi systemd[1]: Stopped Music Player Daemon.
Jan 12 11:49:37 ifi play[1914]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input
Jan 12 11:49:37 ifi systemd[1]: mpd.socket: Succeeded.
Jan 12 11:49:37 ifi systemd[1]: Closed mpd.socket.
Jan 12 11:49:37 ifi sudo[1858]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:38 ifi firststart.sh[1368]: Enabling SSH for first boot
Jan 12 11:49:38 ifi systemd[1]: Starting OpenBSD Secure Shell server...
Jan 12 11:49:38 ifi node[532]: ConvSwitch: Add client tidal
Jan 12 11:49:38 ifi sshd[1982]: Server listening on 0.0.0.0 port 22.
Jan 12 11:49:38 ifi sshd[1982]: Server listening on :: port 22.
Jan 12 11:49:38 ifi systemd[1]: Started OpenBSD Secure Shell server.
Jan 12 11:49:38 ifi firststart.sh[1368]: Disabling firststart service
Jan 12 11:49:38 ifi tidal_connect_application[1912]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi.
Jan 12 11:49:38 ifi tidal_connect_application[1912]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jan 12 11:49:38 ifi tidal_connect_application[1912]: *** WARNING *** For more information see
Jan 12 11:49:38 ifi volumio[1366]: info: Spotify Connect Service Started
Jan 12 11:49:38 ifi node[532]: ConvSwitch: Add client roon-ready
Jan 12 11:49:38 ifi firststart.sh[1368]: Removed /etc/systemd/system/multi-user.target.wants/firststart.service.
Jan 12 11:49:38 ifi systemd[1]: Reloading.
Jan 12 11:49:38 ifi volumio[1366]: info: Starting RoonReady Sync
Jan 12 11:49:38 ifi sudo[2001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service
Jan 12 11:49:38 ifi sudo[2001]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:38 ifi ifi_metadata[1736]: Connected
Jan 12 11:49:38 ifi sudo[2010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service
Jan 12 11:49:38 ifi sudo[2010]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:38 ifi sudo[2014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf
Jan 12 11:49:38 ifi sudo[2014]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 12 11:49:38 ifi volumio[1366]: MPD error: Cannot assign requested address
Jan 12 11:49:38 ifi volumio[1366]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 12 11:49:38 ifi sudo[2014]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:38 ifi volumio[1366]: Error: Command failed: /usr/bin/mpc update "USB/HIKSEMI"
Jan 12 11:49:38 ifi volumio[1366]: MPD error: Cannot assign requested address
Jan 12 11:49:38 ifi volumio[1366]: at checkExecSyncError (child_process.js:790:11)
Jan 12 11:49:38 ifi volumio[1366]: at execSync (child_process.js:863:15)
Jan 12 11:49:38 ifi volumio[1366]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:1418:11)
Jan 12 11:49:38 ifi volumio[1366]: at listOnTimeout (internal/timers.js:557:17)
Jan 12 11:49:38 ifi volumio[1366]: at processTimers (internal/timers.js:500:7) {
Jan 12 11:49:38 ifi volumio[1366]: status: 1,
Jan 12 11:49:38 ifi volumio[1366]: signal: null,
Jan 12 11:49:38 ifi volumio[1366]: output: [
Jan 12 11:49:38 ifi volumio[1366]: null,
Jan 12 11:49:38 ifi volumio[1366]: ,
Jan 12 11:49:38 ifi volumio[1366]:
Jan 12 11:49:38 ifi volumio[1366]: ],
Jan 12 11:49:38 ifi volumio[1366]: pid: 2013,
Jan 12 11:49:38 ifi volumio[1366]: stdout: ,
Jan 12 11:49:38 ifi volumio[1366]: stderr:
Jan 12 11:49:38 ifi volumio[1366]: }
Jan 12 11:49:38 ifi volumio[1366]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 12 11:49:38 ifi systemd-fstab-generator[2021]: Mount point vfat is not a valid path, ignoring.
Jan 12 11:49:39 ifi systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Jan 12 11:49:39 ifi systemd[1]: Configuration file /lib/systemd/system/ifi-streamer-thermal.service is marked executable. Please remove executable permission bits. Proceeding anyway.
Jan 12 11:49:39 ifi systemd[1]: Configuration file /lib/systemd/system/ifi-streamer-ethernet.service is marked executable. Please remove executable permission bits. Proceeding anyway.
Jan 12 11:49:39 ifi systemd[1]: Configuration file /lib/systemd/system/ifi-mqtt.service is marked executable. Please remove executable permission bits. Proceeding anyway.
Jan 12 11:49:39 ifi systemd[1]: /lib/systemd/system/ifi-mqtt.service:11: Unknown lvalue 'StartLimitIntervalSec' in section 'Service', ignoring
Jan 12 11:49:39 ifi firststart.sh[1368]: Finalizing
Jan 12 11:49:39 ifi systemd[1]: Stopping iFi Streamer Roon Ready Service...
Jan 12 11:49:39 ifi systemd[1]: Stopping iFi Streamer Qobuz Connect Service...
Jan 12 11:49:39 ifi systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM
Jan 12 11:49:39 ifi systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded.
Jan 12 11:49:39 ifi systemd[1]: Stopped iFi Streamer Qobuz Connect Service.
Jan 12 11:49:39 ifi node[532]: ConvSwitch: Drop client roon-ready
Jan 12 11:49:39 ifi node[539]: Closing connection with the client qobuz-connect
Jan 12 11:49:39 ifi systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM
Jan 12 11:49:39 ifi systemd[1]: ifi-streamer-roon-ready.service: Succeeded.
Jan 12 11:49:39 ifi systemd[1]: Stopped iFi Streamer Roon Ready Service.
Jan 12 11:49:39 ifi node[532]: ConvSwitch: Drop client qobuz-connect
Jan 12 11:49:39 ifi sudo[2001]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:39 ifi systemd[1]: Started iFi Streamer Roon Ready Service.
Jan 12 11:49:39 ifi sudo[2010]: pam_unix(sudo:session): session closed for user root
Jan 12 11:49:39 ifi systemd[1]: firststart.service: Succeeded.
Jan 12 11:49:39 ifi play[2055]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input
Jan 12 11:49:39 ifi sudo[2062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-12 11:48
Jan 12 11:49:39 ifi sudo[2062]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="34471775a56eaef70dedee9091ea8dd3dd0bbfae"
VOLUMIO_FE_VERSION="b98de5eb915e4b6034288cf7ef1ed10f64866e3f"
VOLUMIO_FE3_VERSION="55f0bdb3a9761a4ec0153897917e610c48766e5d"
VOLUMIO_BE_VERSION="20ae35eb7ef90995f428a5a9931aff74da3f664a"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="ifi"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat Jan 10 14:22:48 CST 2026"
VOLUMIO_VERSION="2.02.7.1"
VOLUMIO_HARDWARE="idsd-phantom"
VOLUMIO_DEVICENAME="iDSD PHANTOM"
VOLUMIO_HASH="072c88cf38eb616b807f39ada2aefc06"