-- Logs begin at Sat 2025-11-15 07:41:13 UTC, end at Thu 2025-12-11 11:46:41 UTC. -- Dec 11 11:45:00 ifi-zen-stream3 wireless.js[511]: trying... Dec 11 11:45:00 ifi-zen-stream3 sudo[1284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 11 11:45:00 ifi-zen-stream3 sudo[1284]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:00 ifi-zen-stream3 sudo[1284]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:01 ifi-zen-stream3 wireless.js[511]: trying... Dec 11 11:45:01 ifi-zen-stream3 sudo[1293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 11 11:45:01 ifi-zen-stream3 sudo[1293]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:01 ifi-zen-stream3 sudo[1293]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:02 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 11 11:45:02 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 11 11:45:02 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 11 11:45:02 ifi-zen-stream3 wireless.js[511]: trying... Dec 11 11:45:02 ifi-zen-stream3 sudo[1318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 11 11:45:02 ifi-zen-stream3 sudo[1318]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:02 ifi-zen-stream3 sudo[1318]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:03 ifi-zen-stream3 wireless.js[511]: trying... Dec 11 11:45:03 ifi-zen-stream3 sudo[1330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 11 11:45:03 ifi-zen-stream3 sudo[1330]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:03 ifi-zen-stream3 sudo[1330]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:04 ifi-zen-stream3 wireless.js[511]: trying... Dec 11 11:45:04 ifi-zen-stream3 sudo[1334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 11 11:45:04 ifi-zen-stream3 sudo[1334]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:04 ifi-zen-stream3 sudo[1334]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:05 ifi-zen-stream3 wireless.js[511]: trying... Dec 11 11:45:05 ifi-zen-stream3 sudo[1343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 11 11:45:05 ifi-zen-stream3 sudo[1343]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:05 ifi-zen-stream3 sudo[1343]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:06 ifi-zen-stream3 wireless.js[511]: Overtime, starting plan B Dec 11 11:45:06 ifi-zen-stream3 wireless.js[511]: STARTING HOTSPOT Dec 11 11:45:06 ifi-zen-stream3 wpa_supplicant[905]: nl80211: Failed to open /proc/sys/net/ipv4/conf/wlan0/drop_unicast_in_l2_multicast: No such file or directory Dec 11 11:45:06 ifi-zen-stream3 wpa_supplicant[905]: nl80211: Failed to set IPv4 unicast in multicast filter Dec 11 11:45:06 ifi-zen-stream3 wpa_supplicant[905]: nl80211: Failed to open /proc/sys/net/ipv4/conf/wlan0/drop_unicast_in_l2_multicast: No such file or directory Dec 11 11:45:06 ifi-zen-stream3 wpa_supplicant[905]: nl80211: Failed to set IPv4 unicast in multicast filter Dec 11 11:45:06 ifi-zen-stream3 wpa_supplicant[905]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Dec 11 11:45:06 ifi-zen-stream3 wpa_supplicant[905]: wlan0: CTRL-EVENT-TERMINATING Dec 11 11:45:07 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 11 11:45:07 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 11 11:45:07 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 11 11:45:10 ifi-zen-stream3 sudo[1388]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Dec 11 11:45:10 ifi-zen-stream3 sudo[1388]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:10 ifi-zen-stream3 sudo[1388]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:10 ifi-zen-stream3 sudo[1390]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Dec 11 11:45:10 ifi-zen-stream3 sudo[1390]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:10 ifi-zen-stream3 sudo[1390]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:10 ifi-zen-stream3 wireless.js[511]: Hotspot is disabled, not starting it Dec 11 11:45:10 ifi-zen-stream3 iwconfig[1395]: Error for wireless request "Set Power Management" (8B2C) : Dec 11 11:45:10 ifi-zen-stream3 iwconfig[1395]: SET failed on device wlan0 ; Operation not permitted. Dec 11 11:45:10 ifi-zen-stream3 systemd[1]: wireless.service: Succeeded. Dec 11 11:45:10 ifi-zen-stream3 systemd[1]: Started Wireless Services. Dec 11 11:45:10 ifi-zen-stream3 systemd[1]: Started Volumio Backend Module. Dec 11 11:45:10 ifi-zen-stream3 systemd[1]: Started Volumio Cpu Tweaker. Dec 11 11:45:10 ifi-zen-stream3 systemd[1]: Started iFi Streamer hotspot button irq daemon. Dec 11 11:45:10 ifi-zen-stream3 systemd[1]: Reached target Multi-User System. Dec 11 11:45:10 ifi-zen-stream3 systemd[1]: Reached target Graphical Interface. Dec 11 11:45:10 ifi-zen-stream3 systemd[1]: Starting Update UTMP about System Runlevel Changes... Dec 11 11:45:10 ifi-zen-stream3 volumio-cpu-tweak[1397]: Setting RT Priority for mpd Dec 11 11:45:10 ifi-zen-stream3 volumio-cpu-tweak[1397]: pid 35's current scheduling policy: SCHED_OTHER Dec 11 11:45:10 ifi-zen-stream3 volumio-cpu-tweak[1397]: pid 35's current scheduling priority: 0 Dec 11 11:45:10 ifi-zen-stream3 volumio-cpu-tweak[1397]: Setting MPD Affinity Dec 11 11:45:10 ifi-zen-stream3 volumio-cpu-tweak[1397]: pid 3's current affinity mask: 1 Dec 11 11:45:10 ifi-zen-stream3 volumio-cpu-tweak[1397]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Dec 11 11:45:10 ifi-zen-stream3 volumio-cpu-tweak[1397]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Dec 11 11:45:10 ifi-zen-stream3 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Dec 11 11:45:10 ifi-zen-stream3 systemd[1]: Started Update UTMP about System Runlevel Changes. Dec 11 11:45:10 ifi-zen-stream3 systemd[1]: Startup finished in 3.600s (kernel) + 35.234s (userspace) = 38.834s. Dec 11 11:45:10 ifi-zen-stream3 systemd[1]: volumio_cpu_tweak.service: Succeeded. Dec 11 11:45:13 ifi-zen-stream3 volumio[1396]: info: ------------------------------------------- Dec 11 11:45:13 ifi-zen-stream3 volumio[1396]: info: ----- Volumio3 ---- Dec 11 11:45:13 ifi-zen-stream3 volumio[1396]: info: ------------------------------------------- Dec 11 11:45:13 ifi-zen-stream3 volumio[1396]: info: ----- System startup ---- Dec 11 11:45:13 ifi-zen-stream3 volumio[1396]: info: ------------------------------------------- Dec 11 11:45:13 ifi-zen-stream3 volumio[1396]: info: ConvSwitch: Client Start Dec 11 11:45:13 ifi-zen-stream3 volumio[1396]: info: MetaClient: Client Start Dec 11 11:45:13 ifi-zen-stream3 node[487]: A new connection has been established. Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Plugin folders cleanup Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Scanning into folder /volumio/app/plugins/ Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Scanning category audio_interface Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Scanning category miscellanea Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Scanning category music_service Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Scanning category plugins.json Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Scanning category system_controller Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Scanning category user_interface Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Scanning into folder /data/plugins/ Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Scanning category music_service Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Plugin folders cleanup completed Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: ------------------------------------------- Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: ----- Core plugins startup ---- Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: ------------------------------------------- Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Loading plugins from folder /volumio/app/plugins/ Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Adding plugin networkaudiod to MyMusic Plugins Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Adding plugin qobuz_connect to MyMusic Plugins Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Adding plugin spotify_connect to MyMusic Plugins Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Adding plugin tidal_connect to MyMusic Plugins Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Adding plugin upnp to MyMusic Plugins Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Adding plugin airplay1_switch to MyMusic Plugins Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Adding plugin airplay2_switch to MyMusic Plugins Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Adding plugin roon_ready to MyMusic Plugins Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Loading plugins from folder /data/plugins/ Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Loading plugin "system"... Dec 11 11:45:14 ifi-zen-stream3 volumio[1396]: info: Loading plugin "appearance"... Dec 11 11:45:16 ifi-zen-stream3 volumio[1396]: info: Loading plugin "network"... Dec 11 11:45:16 ifi-zen-stream3 volumio[1396]: info: Refreshing Cached IP Addresses Dec 11 11:45:16 ifi-zen-stream3 sudo[1477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 11 11:45:16 ifi-zen-stream3 sudo[1477]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:16 ifi-zen-stream3 sudo[1477]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:16 ifi-zen-stream3 sudo[1479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 11 11:45:16 ifi-zen-stream3 sudo[1479]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:16 ifi-zen-stream3 sudo[1479]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:16 ifi-zen-stream3 volumio[1396]: info: Loading plugin "services"... Dec 11 11:45:16 ifi-zen-stream3 volumio[1396]: info: Loading plugin "alsa_controller"... Dec 11 11:45:16 ifi-zen-stream3 sudo[1490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 11 11:45:16 ifi-zen-stream3 sudo[1490]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:16 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 11 11:45:16 ifi-zen-stream3 volumio[1396]: info: Loading plugin "wizard"... Dec 11 11:45:16 ifi-zen-stream3 volumio[1396]: info: Loading plugin "networkfs"... Dec 11 11:45:16 ifi-zen-stream3 volumio[1396]: info: Starting Udev Watcher for removable devices Dec 11 11:45:16 ifi-zen-stream3 volumio[1396]: error: Cannot associate FS Label, not mounting Dec 11 11:45:16 ifi-zen-stream3 volumio[1396]: error: Cannot associate FS Label, not mounting Dec 11 11:45:16 ifi-zen-stream3 volumio[1396]: info: Ignoring mount for partition: BOOT Dec 11 11:45:16 ifi-zen-stream3 volumio[1396]: info: Ignoring mount for partition: archivefs Dec 11 11:45:17 ifi-zen-stream3 volumio[1396]: info: Ignoring mount for partition: rootfs Dec 11 11:45:17 ifi-zen-stream3 volumio[1396]: info: Mounting Device Samsung_USB Dec 11 11:45:17 ifi-zen-stream3 kernel: start_addr=(0x8000), end_addr=(0x10000), buffer_size=(0x8000), smp_number_max=(4096) Dec 11 11:45:17 ifi-zen-stream3 sudo[1521]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Samsung_USB -o noatime Dec 11 11:45:17 ifi-zen-stream3 sudo[1521]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:17 ifi-zen-stream3 sudo[1521]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:17 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 11 11:45:17 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 11 11:45:17 ifi-zen-stream3 volumio[1396]: info: Loading plugin "volumio_command_line_client"... Dec 11 11:45:17 ifi-zen-stream3 volumio[1396]: info: Loading plugin "networkaudiod"... Dec 11 11:45:17 ifi-zen-stream3 volumio[1396]: info: [1765453517854] Starting NAA Service Dec 11 11:45:17 ifi-zen-stream3 volumio[1396]: info: Loading plugin "tidal_connect"... Dec 11 11:45:17 ifi-zen-stream3 volumio[1396]: info: [1765453517888] Starting Tidal Connect Service Dec 11 11:45:17 ifi-zen-stream3 volumio[1396]: info: Loading plugin "upnp"... Dec 11 11:45:17 ifi-zen-stream3 sudo[1539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart networkaudiod.service Dec 11 11:45:17 ifi-zen-stream3 sudo[1539]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:17 ifi-zen-stream3 volumio[1396]: info: [1765453517905] Starting Upmpd Daemon Dec 11 11:45:17 ifi-zen-stream3 volumio[1396]: info: Starting Upmpd Daemon Dec 11 11:45:17 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 11 11:45:17 ifi-zen-stream3 volumio[1396]: error: ATTENTION!!!: Plugin upnp does not return adequate promise from onVolumioStart: please update! Dec 11 11:45:17 ifi-zen-stream3 volumio[1396]: info: Loading plugin "my_music"... Dec 11 11:45:17 ifi-zen-stream3 systemd[1]: Stopping Network Audio Adapter daemon... Dec 11 11:45:17 ifi-zen-stream3 systemd[1]: networkaudiod.service: Succeeded. Dec 11 11:45:17 ifi-zen-stream3 systemd[1]: Stopped Network Audio Adapter daemon. Dec 11 11:45:17 ifi-zen-stream3 volumio[1396]: info: Loading plugin "mpd"... Dec 11 11:45:17 ifi-zen-stream3 systemd[1]: Started Network Audio Adapter daemon. Dec 11 11:45:17 ifi-zen-stream3 networkaudiod[1545]: [/usr/sbin/networkaudiod] (1545): networkaudiod Copyright (C) 2011-2020 Jussi Laako / Signalyst. All rights reserved. Dec 11 11:45:17 ifi-zen-stream3 sudo[1539]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:17 ifi-zen-stream3 networkaudiod[1545]: [/usr/sbin/networkaudiod] (1545): create alsa engine Dec 11 11:45:17 ifi-zen-stream3 networkaudiod[1545]: [/usr/sbin/networkaudiod] (1545): listen discovery on :: Dec 11 11:45:17 ifi-zen-stream3 networkaudiod[1545]: [/usr/sbin/networkaudiod] (1545): clSocket::SetOption(): setsockopt(..., 41,20, ...): No such device Dec 11 11:45:17 ifi-zen-stream3 networkaudiod[1545]: [/usr/sbin/networkaudiod] (1545): Socket failure, falling back to IPv4-only! Dec 11 11:45:18 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 11 11:45:18 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 11 11:45:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:18 ifi-zen-stream3 volumio[1396]: info: Loading plugin "upnp_browser"... Dec 11 11:45:18 ifi-zen-stream3 networkaudiod[1545]: [/usr/sbin/networkaudiod] (1545): listen discovery on 0.0.0.0 Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Loading plugin "qobuz_connect"... Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: [1765453519134] Starting Qobuz Connect Service Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Loading plugin "alarm-clock"... Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Loading plugin "last_100"... Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Loading plugin "roon_ready"... Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Starting RoonReady Sync Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Loading plugin "webradio"... Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Loading plugin "i2s_dacs"... Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: I2S DAC not set, start Auto-detection Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Loading plugin "volumiodiscovery"... Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: *** WARNING *** For more information see Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 11 11:45:19 ifi-zen-stream3 node[1396]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: *** WARNING *** For more information see Dec 11 11:45:19 ifi-zen-stream3 node[1396]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 11 11:45:19 ifi-zen-stream3 node[1396]: *** WARNING *** For more information see Dec 11 11:45:19 ifi-zen-stream3 node[1396]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 11 11:45:19 ifi-zen-stream3 node[1396]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 11 11:45:19 ifi-zen-stream3 node[1396]: *** WARNING *** For more information see Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Loading plugin "spotify_connect"... Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: [1765453519702] Starting Spotify Connect Service Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Plugin airplay1_switch is not enabled Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Loading plugin "airplay2_switch"... Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Loading plugin "airplay_emulation"... Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Starting Shairport Sync Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Loading plugin "outputs"... Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Loading plugin "albumart"... Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Plugin example_plugin is not enabled Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Loading plugin "inputs"... Dec 11 11:45:19 ifi-zen-stream3 volumio[1396]: info: Loading plugin "updater_comm"... Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: info: Plugin mpdemulation is not enabled Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: info: Loading plugin "rest_api"... Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: info: Loading plugin "websocket"... Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: info: Starting Socket.io Server version 2.3.0 Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: info: Plugin ifi-cdplayer is not enabled Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: info: Loading i18n strings for locale en Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: Updating browse sources language Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: Forking 3 albumart workers Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::initPlayerControls Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: Express server listening on port 3000 Dec 11 11:45:20 ifi-zen-stream3 volumio[1396]: [Metrics] WebUI: 8s 805.52ms Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::resetVolumioState Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::getcurrentVolume Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioRetrievevolume Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: Meta server listening Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 0 Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: Server listening on port 6599 Dec 11 11:45:21 ifi-zen-stream3 sudo[1637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Dec 11 11:45:21 ifi-zen-stream3 sudo[1637]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:21 ifi-zen-stream3 sudo[1638]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Dec 11 11:45:21 ifi-zen-stream3 sudo[1638]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: MPD error: Connection refused Dec 11 11:45:21 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service. Dec 11 11:45:21 ifi-zen-stream3 sudo[1637]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: Completed loading Core Plugins Dec 11 11:45:21 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service. Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: Preparing to generate the ALSA configuration file Dec 11 11:45:21 ifi-zen-stream3 node[487]: A new connection has been established. Dec 11 11:45:21 ifi-zen-stream3 systemd[1]: Started iFi Streamer Qobuz Connect Service. Dec 11 11:45:21 ifi-zen-stream3 sudo[1638]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: Cannot read play queue from file Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: ConvSwitch: Connected to server Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: MetaClient: Connected to server Dec 11 11:45:21 ifi-zen-stream3 node[504]: ConvSwitch: Add client volumio Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: Volumio Network Manager: Network status updated: 1 Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: NAA Service Started Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: ConvSwitch: Get message: success Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: MetaClient: Get message: success Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: Qobuz Connect Service Started Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: Tidal Connect Service Started Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: Asound.conf file unchanged, so no further update is needed Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: Tidal connect: Output device has changed Dec 11 11:45:21 ifi-zen-stream3 volumio[1396]: info: Output device has changed, restarting MPD Dec 11 11:45:21 ifi-zen-stream3 play[1649]: 20251211 11:45:21.962 [1674.1674] DEBUG SampleApp: Starting sample application Dec 11 11:45:21 ifi-zen-stream3 play[1649]: 20251211 11:45:21.962 [1674.1674] DEBUG SampleApp: Device Name: ZEN Stream3 Dec 11 11:45:21 ifi-zen-stream3 play[1649]: 20251211 11:45:21.962 [1674.1674] DEBUG SampleApp: Manufacturer: Sample manufacturer Dec 11 11:45:21 ifi-zen-stream3 play[1649]: 20251211 11:45:21.962 [1674.1674] DEBUG SampleApp: Model: iFi Streamer Dec 11 11:45:21 ifi-zen-stream3 play[1649]: 20251211 11:45:21.962 [1674.1674] DEBUG SampleApp: Serial Number: ifi:32:b5:8a:ca:11:71 Dec 11 11:45:21 ifi-zen-stream3 play[1649]: 20251211 11:45:21.963 [1674.1674] DEBUG SampleApp: Audio output device: volumio Dec 11 11:45:21 ifi-zen-stream3 play[1649]: 20251211 11:45:21.963 [1674.1674] DEBUG SampleApp: Volume control device: default Dec 11 11:45:21 ifi-zen-stream3 play[1649]: 20251211 11:45:21.963 [1674.1674] DEBUG SampleApp: Volume control element: Master Dec 11 11:45:21 ifi-zen-stream3 play[1649]: 20251211 11:45:21.963 [1674.1674] DEBUG SampleApp: Local config server port: 8000 Dec 11 11:45:21 ifi-zen-stream3 play[1649]: 20251211 11:45:21.969 [1674.1674] ERROR SampleApp: Unable to find ALSA mixer element 'Master' on index 0 Dec 11 11:45:21 ifi-zen-stream3 play[1649]: 20251211 11:45:21.974 [1674.1674] DEBUG SampleApp: Maximum supported audio quality: HIRES_L3 Dec 11 11:45:21 ifi-zen-stream3 play[1649]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 11 11:45:21 ifi-zen-stream3 node[487]: A new connection has been established. Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: Qobuz connect: Output device has changed Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: Roon Ready: Output device has changed Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: Spotify: Output device has changed Dec 11 11:45:22 ifi-zen-stream3 play[1649]: [Info] MetaClient: MetaClientInit Dec 11 11:45:22 ifi-zen-stream3 play[1649]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: ___________ START PLUGINS ___________ Dec 11 11:45:22 ifi-zen-stream3 node[504]: ConvSwitch: Add client qobuz-connect Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::onStart: Initializing MPD Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: Creating MPD Configuration file Dec 11 11:45:22 ifi-zen-stream3 play[1649]: [Info] ConvSwitch: ConvSwitchInit Dec 11 11:45:22 ifi-zen-stream3 sudo[1679]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 11 11:45:22 ifi-zen-stream3 sudo[1679]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.111 [1674.1674] DEBUG ActiveStateManager: [0xab216098]: Creating new Active State Manager Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.112 [1674.1674] DEBUG NetworkActivityTracker: [0xab216108]: Creating new Network Activity Tracker Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.119 [1674.1674] DEBUG EndpointManager: [0xab217080]: Creating Endpoint Manager Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.119 [1674.1674] DEBUG PlaybackSessionManager: [0xab217470]: Creating Playback Session Manager Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.119 [1674.1674] DEBUG BackoffTimer: [0xab2175e8]: Creating Backoff Timer Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] DEBUG MediaEngine: [0xab217708]: Creating new Media Engine Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] DEBUG AudioRenderer: [0xab217928]: Creating Audio Renderer Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] TRACE MediaEngineCommandSequencer: [0xab217a80]: Creating Media Engine Command Sequencer Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] DEBUG PlaybackControlsManager: [0xab217ae0]: Creating new Playback Controls Manager Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] DEBUG VolumeManager: [0xab217b70]: Creating new Volume Manager Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] DEBUG ProtocolHandler: [0xab217e48]: Creating Protocol Handler Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] DEBUG MessageReceiver: [0xab217ee8]: Creating Message Receiver Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] DEBUG RendererActivationController: [0xab218060]: Creating new Renderer Activation Controller Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] TRACE RendererActivationCommandSequencer: [0xab218108]: Creating Renderer Activation Command Sequencer Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] DEBUG ReportingManager: [0xab218218]: Creating new Reporting Manager Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] DEBUG StreamingEventReporter: [0xab218260]: Creating Streaming Event Reporter Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] DEBUG BackoffTimer: [0xab218340]: Creating Backoff Timer Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] DEBUG TokenExpiryController: [0xab218450]: Creating Token Expiry Controller Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] DEBUG UserInactivityManager: [0xab2184a0]: Creating new User Inactivity Manager Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] INFO VolumeManager: [0xab217b70]: Setting new playback volume: 100 Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] INFO VolumeManager: [0xab217b70]: Setting new mute state: 1 Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] DEBUG SampleApp: Qobuz Connect has been initialized Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] TRACE SampleApp: Running event loop Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] INFO QobuzConnect: [0xab218540]: Client initialized! Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.120 [1674.1674] INFO SampleApp: Starting Avahi advertising, name: ZEN Stream3, service name: _qobuz-connect._tcp Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.139 [1674.1674] DEBUG SampleApp: Avahi client state changed: RUNNING Dec 11 11:45:22 ifi-zen-stream3 sudo[1679]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.151 [1674.1674] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.159 [1674.1674] INFO LocalConfigManager: [0xab217450]: Starting Local Configuration server Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.159 [1674.1674] INFO SampleApp: Starting Local configuration server Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.160 [1674.1674] INFO SampleApp: Playback mute state changed: 1 Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.161 [1674.1674] ERROR SampleApp: Unable to set mute state, no ALSA volume element Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.161 [1674.1674] DEBUG SampleApp: Avahi entry group state changed: REGISTERING Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.161 [1674.1674] INFO SampleApp: Playback volume changed: 100 Dec 11 11:45:22 ifi-zen-stream3 play[1649]: 20251211 11:45:22.161 [1674.1674] ERROR SampleApp: Unable to set volume, no ALSA volume element Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: [1765453522197] CoreMusicLibrary::Adding element Media Servers Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 11:45:22 ifi-zen-stream3 sudo[1683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 11 11:45:22 ifi-zen-stream3 sudo[1683]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:22 ifi-zen-stream3 sudo[1683]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:22 ifi-zen-stream3 sudo[1687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Dec 11 11:45:22 ifi-zen-stream3 sudo[1490]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:22 ifi-zen-stream3 sudo[1687]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: [1765453522311] CoreMusicLibrary::Adding element Last_100 Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: Starting RoonReady Sync Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: [1765453522348] CoreMusicLibrary::Adding element Webradio Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: Initializing BBC Radios Dec 11 11:45:22 ifi-zen-stream3 sudo[1691]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Dec 11 11:45:22 ifi-zen-stream3 sudo[1691]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: Starting albumart workers Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 11:45:22 ifi-zen-stream3 sudo[1687]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:22 ifi-zen-stream3 systemd[1]: Started iFi Streamer Roon Ready Service. Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 11:45:22 ifi-zen-stream3 sudo[1691]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:22 ifi-zen-stream3 sudo[1704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -snf /usr/local/bin/airplay2 /usr/local/bin/shairport-sync Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: Starting albumart workers Dec 11 11:45:22 ifi-zen-stream3 sudo[1704]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:22 ifi-zen-stream3 sudo[1704]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:22 ifi-zen-stream3 play[1705]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: Starting albumart workers Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 11 11:45:22 ifi-zen-stream3 volumio[1396]: info: Volumio Calling Home Dec 11 11:45:23 ifi-zen-stream3 play[1649]: 20251211 11:45:23.108 [1674.1674] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED Dec 11 11:45:23 ifi-zen-stream3 node[504]: ConvSwitch: Add client roon-ready Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setRepeat null single undefined Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 0 Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setRandom null Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 0 Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: Starting RoonReady Sync Dec 11 11:45:23 ifi-zen-stream3 sudo[1755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Dec 11 11:45:23 ifi-zen-stream3 sudo[1755]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: ConvSwitch: Get message: request:pause Dec 11 11:45:23 ifi-zen-stream3 sudo[1758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Dec 11 11:45:23 ifi-zen-stream3 sudo[1758]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:23 ifi-zen-stream3 sudo[1762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Dec 11 11:45:23 ifi-zen-stream3 sudo[1762]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: Airplay2 Started Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: error: Could not retrieve plugin music_service airplay1_switch Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: Disabling plugin airplay1_switch Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: Done. Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: RoonReady Started Dec 11 11:45:23 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Qobuz Connect Service... Dec 11 11:45:23 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Roon Ready Service... Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: MPD Permissions set Dec 11 11:45:23 ifi-zen-stream3 volumio[1396]: info: MPD Permissions set Dec 11 11:45:23 ifi-zen-stream3 node[504]: ConvSwitch: Drop client qobuz-connect Dec 11 11:45:23 ifi-zen-stream3 node[487]: Closing connection with the client qobuz-connect Dec 11 11:45:23 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 11 11:45:23 ifi-zen-stream3 sudo[1772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Dec 11 11:45:23 ifi-zen-stream3 sudo[1772]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:23 ifi-zen-stream3 node[504]: ConvSwitch: Drop client roon-ready Dec 11 11:45:23 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM Dec 11 11:45:23 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded. Dec 11 11:45:23 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Qobuz Connect Service. Dec 11 11:45:23 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM Dec 11 11:45:23 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Succeeded. Dec 11 11:45:23 ifi-zen-stream3 sudo[1775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Dec 11 11:45:23 ifi-zen-stream3 sudo[1775]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:23 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Roon Ready Service. Dec 11 11:45:24 ifi-zen-stream3 sudo[1755]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: Discovery: adding 5037b813-3f83-434b-abdd-bef954704e79 Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: Discovery: Found device ZEN Stream3 Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 0 Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: error: Could not retrieve plugin audio_interface multiroom Dec 11 11:45:24 ifi-zen-stream3 sudo[1800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Dec 11 11:45:24 ifi-zen-stream3 sudo[1800]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: Roon Ready playback start Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:24 ifi-zen-stream3 sudo[1775]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: Starting Roon Ready metadata receiver Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: Error adding Membership: Error: addMembership EINVAL Dec 11 11:45:24 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service. Dec 11 11:45:24 ifi-zen-stream3 sudo[1762]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:24 ifi-zen-stream3 systemd[1]: Started iFi Streamer Roon Ready Service. Dec 11 11:45:24 ifi-zen-stream3 sudo[1758]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:24 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 11 11:45:24 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 11 11:45:24 ifi-zen-stream3 play[1824]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Dec 11 11:45:24 ifi-zen-stream3 ifi_metadata[1645]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 11 11:45:24 ifi-zen-stream3 ifi_metadata[1645]: [Info] MetaClient: MetaClientInit Dec 11 11:45:24 ifi-zen-stream3 ifi_metadata[1645]: Could not connect: Reason::CONNECTION_ERROR Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:24 ifi-zen-stream3 sudo[1772]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:24 ifi-zen-stream3 sudo[1800]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 11 11:45:24 ifi-zen-stream3 sudo[1842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Dec 11 11:45:24 ifi-zen-stream3 sudo[1842]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:24 ifi-zen-stream3 play[1818]: output: volumio mixer: hw:0 Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:24 ifi-zen-stream3 node[504]: ConvSwitch: Add client spotify Dec 11 11:45:24 ifi-zen-stream3 node[487]: Closing connection with the client tidal-connect Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:24 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:24 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Dec 11 11:45:24 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:24 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:24 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service... Dec 11 11:45:24 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Dec 11 11:45:24 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Dec 11 11:45:24 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service. Dec 11 11:45:24 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service. Dec 11 11:45:24 ifi-zen-stream3 node[487]: A new connection has been established. Dec 11 11:45:24 ifi-zen-stream3 sudo[1842]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 11 11:45:24 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service. Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.817 I api SpRegisterDebugCallbacks [returned value: 0] Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.818 I api SpInit(0xffb66c00, API v66) Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.818 I esdk eSDK version: HEAD-v3.166.69-g24821f73 Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.819 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 Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.819 I esdk Successfully registered dns callback: dns_lookup_callback Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.819 I download Using 128 kB for cache buffer Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.819 I download Using 621 kB for compressed audio buffer Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.819 I esdk Successfully registered error callback Dec 11 11:45:24 ifi-zen-stream3 node[487]: A new connection has been established. Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.831 I esdk Creating IPv4 socket (domain 2) Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.831 I zc webserver: service port 5566 (5566-5576) buffer size 4444 Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.831 I zc Started ZeroConf service on port 5566 path /zc alias count 0 Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.831 I esdk Creating IPv4 socket (domain 2) Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.832 I api SpInit [returned value: 0] Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.832 I api SpRegisterConnectionCallbacks(0xffb66be8, (nil)) Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.832 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.832 I api SpRegisterConnectionCallbacks [returned value: 0] Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.832 I api SpRegisterPlaybackCallbacks(0xffb66bd0, (nil)) Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.832 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, - Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.832 I api SpRegisterPlaybackCallbacks [returned value: 0] Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.840 W app Couldn't find mixer for volume controls. (tried , SoftMaster) Dec 11 11:45:24 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:24.840 I app Initialized! Dec 11 11:45:24 ifi-zen-stream3 node[504]: ConvSwitch: Add client roon-ready Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: RoonReady Started Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: Spotify Connect Service Started Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.socket mpd.service Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: Job for mpd.socket canceled. Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: Job for mpd.service canceled. Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: Completed starting Core Plugins Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: [Metrics] CommandRouter: 11s 593.52ms Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::Close All Modals sent Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumiosetStartupVolume Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: warning: volume is underfined, set volume to 100 Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: VolumeController::SetAlsaVolume100 Dec 11 11:45:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 0 Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:45:25 ifi-zen-stream3 kernel: wm8804 0-003b: wm8804_hw_params rate: 0xac44 format: 0x2 Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: error: MPD error: Error: connect ENOENT /run/mpd/socket Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: error: connect ENOENT /run/mpd/socket {"errno":-2,"code":"ENOENT","syscall":"connect","address":"/run/mpd/socket"} Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: ConvSwitch: Get message: request:pause Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: Tidal Connect Service Started Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: Shairport-Sync Stopped Dec 11 11:45:25 ifi-zen-stream3 sudo[1904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Dec 11 11:45:25 ifi-zen-stream3 sudo[1904]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: Starting Shairport Sync Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: Starting Shairport Sync Dec 11 11:45:25 ifi-zen-stream3 systemd[1]: Listening on mpd.socket. Dec 11 11:45:25 ifi-zen-stream3 sudo[1915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 11 11:45:25 ifi-zen-stream3 sudo[1915]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:25 ifi-zen-stream3 systemd[1]: Starting Music Player Daemon... Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: Roon Ready playback start Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: Roon Ready metadata receiver is on Dec 11 11:45:25 ifi-zen-stream3 sudo[1918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 11 11:45:25 ifi-zen-stream3 sudo[1918]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:25 ifi-zen-stream3 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 11 11:45:25 ifi-zen-stream3 sudo[1915]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:25 ifi-zen-stream3 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getState Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:45:25 ifi-zen-stream3 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Dec 11 11:45:25 ifi-zen-stream3 systemd[1]: shairport-sync.service: Succeeded. Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 0 Dec 11 11:45:25 ifi-zen-stream3 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 11 11:45:25 ifi-zen-stream3 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 11 11:45:25 ifi-zen-stream3 sudo[1918]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:25 ifi-zen-stream3 sudo[1919]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 11 11:45:25 ifi-zen-stream3 sudo[1919]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:25 ifi-zen-stream3 sudo[1919]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 11 11:45:25 ifi-zen-stream3 sudo[1919]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: Shairport-Sync Started Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: Error adding Membership: Error: addMembership EINVAL Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: Shairport-Sync Started Dec 11 11:45:25 ifi-zen-stream3 sudo[1927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Dec 11 11:45:25 ifi-zen-stream3 sudo[1927]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:25 ifi-zen-stream3 systemd[1]: Started iFi Streamer Qobuz Connect Service. Dec 11 11:45:25 ifi-zen-stream3 sudo[1927]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:25 ifi-zen-stream3 volumio[1396]: info: Qobuz Connect Service Started Dec 11 11:45:25 ifi-zen-stream3 play[1929]: 20251211 11:45:25.893 [1946.1946] DEBUG SampleApp: Starting sample application Dec 11 11:45:25 ifi-zen-stream3 play[1929]: 20251211 11:45:25.895 [1946.1946] DEBUG SampleApp: Device Name: ZEN Stream3 Dec 11 11:45:25 ifi-zen-stream3 play[1929]: 20251211 11:45:25.896 [1946.1946] DEBUG SampleApp: Manufacturer: Sample manufacturer Dec 11 11:45:25 ifi-zen-stream3 play[1929]: 20251211 11:45:25.896 [1946.1946] DEBUG SampleApp: Model: iFi Streamer Dec 11 11:45:25 ifi-zen-stream3 play[1929]: 20251211 11:45:25.896 [1946.1946] DEBUG SampleApp: Serial Number: ifi:32:b5:8a:ca:11:71 Dec 11 11:45:25 ifi-zen-stream3 play[1929]: 20251211 11:45:25.896 [1946.1946] DEBUG SampleApp: Audio output device: volumio Dec 11 11:45:25 ifi-zen-stream3 play[1929]: 20251211 11:45:25.896 [1946.1946] DEBUG SampleApp: Volume control device: default Dec 11 11:45:25 ifi-zen-stream3 play[1929]: 20251211 11:45:25.896 [1946.1946] DEBUG SampleApp: Volume control element: Master Dec 11 11:45:25 ifi-zen-stream3 play[1929]: 20251211 11:45:25.896 [1946.1946] DEBUG SampleApp: Local config server port: 8000 Dec 11 11:45:25 ifi-zen-stream3 play[1929]: 20251211 11:45:25.914 [1946.1946] ERROR SampleApp: Unable to find ALSA mixer element 'Master' on index 0 Dec 11 11:45:25 ifi-zen-stream3 play[1929]: 20251211 11:45:25.914 [1946.1946] DEBUG SampleApp: Maximum supported audio quality: HIRES_L3 Dec 11 11:45:25 ifi-zen-stream3 play[1929]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 11 11:45:25 ifi-zen-stream3 node[487]: A new connection has been established. Dec 11 11:45:25 ifi-zen-stream3 play[1929]: [Info] MetaClient: MetaClientInit Dec 11 11:45:25 ifi-zen-stream3 play[1929]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Dec 11 11:45:25 ifi-zen-stream3 node[504]: ConvSwitch: Add client qobuz-connect Dec 11 11:45:26 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 11 11:45:26 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 11 11:45:26 ifi-zen-stream3 play[1929]: [Info] ConvSwitch: ConvSwitchInit Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.023 [1946.1946] DEBUG ActiveStateManager: [0xaaf5a098]: Creating new Active State Manager Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.023 [1946.1946] DEBUG NetworkActivityTracker: [0xaaf5a108]: Creating new Network Activity Tracker Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.024 [1946.1946] DEBUG EndpointManager: [0xaaf5b080]: Creating Endpoint Manager Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.024 [1946.1946] DEBUG PlaybackSessionManager: [0xaaf5b470]: Creating Playback Session Manager Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.024 [1946.1946] DEBUG BackoffTimer: [0xaaf5b5e8]: Creating Backoff Timer Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.024 [1946.1946] DEBUG MediaEngine: [0xaaf5b708]: Creating new Media Engine Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.025 [1946.1946] DEBUG AudioRenderer: [0xaaf5b928]: Creating Audio Renderer Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.025 [1946.1946] TRACE MediaEngineCommandSequencer: [0xaaf5ba80]: Creating Media Engine Command Sequencer Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.025 [1946.1946] DEBUG PlaybackControlsManager: [0xaaf5bae0]: Creating new Playback Controls Manager Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.025 [1946.1946] DEBUG VolumeManager: [0xaaf5bb70]: Creating new Volume Manager Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.025 [1946.1946] DEBUG ProtocolHandler: [0xaaf5be48]: Creating Protocol Handler Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.025 [1946.1946] DEBUG MessageReceiver: [0xaaf5bee8]: Creating Message Receiver Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.025 [1946.1946] DEBUG RendererActivationController: [0xaaf5c060]: Creating new Renderer Activation Controller Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.025 [1946.1946] TRACE RendererActivationCommandSequencer: [0xaaf5c108]: Creating Renderer Activation Command Sequencer Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.025 [1946.1946] DEBUG ReportingManager: [0xaaf5c218]: Creating new Reporting Manager Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.025 [1946.1946] DEBUG StreamingEventReporter: [0xaaf5c260]: Creating Streaming Event Reporter Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.025 [1946.1946] DEBUG BackoffTimer: [0xaaf5c340]: Creating Backoff Timer Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.025 [1946.1946] DEBUG TokenExpiryController: [0xaaf5c450]: Creating Token Expiry Controller Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.025 [1946.1946] DEBUG UserInactivityManager: [0xaaf5c4a0]: Creating new User Inactivity Manager Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.025 [1946.1946] INFO VolumeManager: [0xaaf5bb70]: Setting new playback volume: 100 Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.026 [1946.1946] INFO VolumeManager: [0xaaf5bb70]: Setting new mute state: 1 Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.026 [1946.1946] DEBUG SampleApp: Qobuz Connect has been initialized Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.026 [1946.1946] TRACE SampleApp: Running event loop Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.026 [1946.1946] INFO QobuzConnect: [0xaaf5c540]: Client initialized! Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.026 [1946.1946] INFO SampleApp: Starting Avahi advertising, name: ZEN Stream3, service name: _qobuz-connect._tcp Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.046 [1946.1946] DEBUG SampleApp: Avahi client state changed: RUNNING Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.051 [1946.1946] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED Dec 11 11:45:26 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.062 [1946.1946] INFO LocalConfigManager: [0xaaf5b450]: Starting Local Configuration server Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.062 [1946.1946] INFO SampleApp: Starting Local configuration server Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.063 [1946.1946] INFO SampleApp: Playback mute state changed: 1 Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.063 [1946.1946] ERROR SampleApp: Unable to set mute state, no ALSA volume element Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.064 [1946.1946] DEBUG SampleApp: Avahi entry group state changed: REGISTERING Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.064 [1946.1946] INFO SampleApp: Playback volume changed: 100 Dec 11 11:45:26 ifi-zen-stream3 play[1929]: 20251211 11:45:26.064 [1946.1946] ERROR SampleApp: Unable to set volume, no ALSA volume element Dec 11 11:45:26 ifi-zen-stream3 node[504]: ConvSwitch: Drop client roon-ready Dec 11 11:45:26 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Dec 11 11:45:26 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Dec 11 11:45:26 ifi-zen-stream3 sudo[1962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Dec 11 11:45:26 ifi-zen-stream3 sudo[1962]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:26 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:26.641 E esdk select error: 4 -> Interrupted system call Dec 11 11:45:26 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service... Dec 11 11:45:26 ifi-zen-stream3 node[504]: ConvSwitch: Drop client spotify Dec 11 11:45:26 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:26.649 I app Exiting with error = 0 Dec 11 11:45:26 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:26.649 I api SpFree() Dec 11 11:45:26 ifi-zen-stream3 play[1818]: 2025-12-11 11:45:26.651 I api SpFree [returned value: 0] Dec 11 11:45:26 ifi-zen-stream3 play[1818]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Dec 11 11:45:26 ifi-zen-stream3 play[1818]: [Info] ConvSwitch: ConvSwitchInit Dec 11 11:45:26 ifi-zen-stream3 play[1818]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 11 11:45:26 ifi-zen-stream3 play[1818]: [Info] MetaClient: MetaClientInit Dec 11 11:45:26 ifi-zen-stream3 play[1818]: [Info] ConvSwitch: ConvSwitchExit Dec 11 11:45:26 ifi-zen-stream3 play[1818]: [Info] MetaClient: MetaClientExit Dec 11 11:45:26 ifi-zen-stream3 node[487]: Closing connection with the client spotify Dec 11 11:45:26 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Dec 11 11:45:26 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Dec 11 11:45:26 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service. Dec 11 11:45:26 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service. Dec 11 11:45:26 ifi-zen-stream3 sudo[1962]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:26 ifi-zen-stream3 volumio[1396]: info: Spotify Connect Service Started Dec 11 11:45:26 ifi-zen-stream3 play[1964]: output: volumio mixer: hw:0 Dec 11 11:45:26 ifi-zen-stream3 node[504]: ConvSwitch: Add client spotify Dec 11 11:45:26 ifi-zen-stream3 node[487]: A new connection has been established. Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.907 I api SpRegisterDebugCallbacks [returned value: 0] Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.907 I api SpInit(0xffdf21e0, API v66) Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.908 I esdk eSDK version: HEAD-v3.166.69-g24821f73 Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.908 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 Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.908 I esdk Successfully registered dns callback: dns_lookup_callback Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.908 I download Using 128 kB for cache buffer Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.909 I download Using 621 kB for compressed audio buffer Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.909 I esdk Successfully registered error callback Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.921 I esdk Creating IPv4 socket (domain 2) Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.922 I zc webserver: service port 5566 (5566-5576) buffer size 4444 Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.922 I zc Started ZeroConf service on port 5566 path /zc alias count 0 Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.922 I esdk Creating IPv4 socket (domain 2) Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.922 I api SpInit [returned value: 0] Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.922 I api SpRegisterConnectionCallbacks(0xffdf21c8, (nil)) Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.922 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.922 I api SpRegisterConnectionCallbacks [returned value: 0] Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.922 I api SpRegisterPlaybackCallbacks(0xffdf21b0, (nil)) Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.922 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, - Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.923 I api SpRegisterPlaybackCallbacks [returned value: 0] Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.933 W app Couldn't find mixer for volume controls. (tried , SoftMaster) Dec 11 11:45:26 ifi-zen-stream3 play[1964]: 2025-12-11 11:45:26.933 I app Initialized! Dec 11 11:45:27 ifi-zen-stream3 play[1929]: 20251211 11:45:27.011 [1946.1946] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED Dec 11 11:45:27 ifi-zen-stream3 node[504]: ConvSwitch: Add client tidal Dec 11 11:45:27 ifi-zen-stream3 tidal_connect_application[1986]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi. Dec 11 11:45:27 ifi-zen-stream3 tidal_connect_application[1986]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 11 11:45:27 ifi-zen-stream3 tidal_connect_application[1986]: *** WARNING *** For more information see Dec 11 11:45:27 ifi-zen-stream3 ifi_metadata[1876]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 11 11:45:27 ifi-zen-stream3 ifi_metadata[1876]: [Info] MetaClient: MetaClientInit Dec 11 11:45:27 ifi-zen-stream3 ifi_metadata[1876]: Connected Dec 11 11:45:27 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Dec 11 11:45:27 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 1. Dec 11 11:45:27 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Roon Ready Service. Dec 11 11:45:27 ifi-zen-stream3 systemd[1]: Started iFi Streamer Roon Ready Service. Dec 11 11:45:27 ifi-zen-stream3 play[2009]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Dec 11 11:45:27 ifi-zen-stream3 sudo[2051]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 11 11:45:27 ifi-zen-stream3 sudo[2051]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:27 ifi-zen-stream3 sudo[2051]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:27 ifi-zen-stream3 node[504]: ConvSwitch: Add client roon-ready Dec 11 11:45:27 ifi-zen-stream3 sudo[2056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 11 11:45:27 ifi-zen-stream3 sudo[2056]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:28 ifi-zen-stream3 sudo[2056]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: ConvSwitch: Get message: request:pause Dec 11 11:45:28 ifi-zen-stream3 sudo[2062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart upmpdcli.service Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::serviceStop Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::serviceStop Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:45:28 ifi-zen-stream3 sudo[2062]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: Roon Ready Stop Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:28 ifi-zen-stream3 systemd[1]: Starting UPnP Renderer front-end to MPD... Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: Roon Ready playback start Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:28 ifi-zen-stream3 volumio[1396]: info: Roon Ready metadata receiver is on Dec 11 11:45:29 ifi-zen-stream3 mpd[1925]: Dec 11 11:45 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 11 11:45:29 ifi-zen-stream3 systemd[1]: Started Music Player Daemon. Dec 11 11:45:29 ifi-zen-stream3 sudo[1904]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:29 ifi-zen-stream3 volumio[1396]: info: Restarted MPD. Dec 11 11:45:29 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 11 11:45:29 ifi-zen-stream3 volumio[1396]: error: updateQueue error: null Dec 11 11:45:29 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 11 11:45:29 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 11 11:45:29 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:45:29 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:45:29 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::serviceStop Dec 11 11:45:29 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::serviceStop Dec 11 11:45:29 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:45:29 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:45:29 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:29 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:29 ifi-zen-stream3 volumio[1396]: info: Roon Ready Stop Dec 11 11:45:29 ifi-zen-stream3 node[504]: ConvSwitch: Drop client roon-ready Dec 11 11:45:29 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=exited, status=1/FAILURE Dec 11 11:45:29 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Failed with result 'exit-code'. Dec 11 11:45:30 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Service RestartSec=1s expired, scheduling restart. Dec 11 11:45:30 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Scheduled restart job, restart counter is at 2. Dec 11 11:45:30 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Roon Ready Service. Dec 11 11:45:30 ifi-zen-stream3 systemd[1]: Started iFi Streamer Roon Ready Service. Dec 11 11:45:30 ifi-zen-stream3 play[2103]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Dec 11 11:45:30 ifi-zen-stream3 node[504]: ConvSwitch: Add client roon-ready Dec 11 11:45:31 ifi-zen-stream3 volumio[1396]: info: ConvSwitch: Get message: request:pause Dec 11 11:45:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:45:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:45:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:45:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:45:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:31 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:45:31 ifi-zen-stream3 volumio[1396]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Dec 11 11:45:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Dec 11 11:45:31 ifi-zen-stream3 volumio[1396]: info: Roon Ready playback start Dec 11 11:45:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:45:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:45:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:45:31 ifi-zen-stream3 volumio[1396]: info: Roon Ready metadata receiver is on Dec 11 11:45:32 ifi-zen-stream3 volumio[1396]: info: BOOT COMPLETED Dec 11 11:45:32 ifi-zen-stream3 node[487]: A new connection has been established. Dec 11 11:45:33 ifi-zen-stream3 systemd[1]: Started UPnP Renderer front-end to MPD. Dec 11 11:45:33 ifi-zen-stream3 sudo[2062]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:33 ifi-zen-stream3 volumio[1396]: info: Upmpdcli Daemon Started Dec 11 11:45:33 ifi-zen-stream3 volumio[1396]: New connection from ::ffff:127.0.0.1:35216 Dec 11 11:45:33 ifi-zen-stream3 volumio[1396]: Connected to MPD server Dec 11 11:45:33 ifi-zen-stream3 volumio[1396]: New connection from ::ffff:127.0.0.1:35220 Dec 11 11:45:33 ifi-zen-stream3 volumio[1396]: Connected to MPD server Dec 11 11:45:33 ifi-zen-stream3 volumio[2171]: Generating RSA private key, 4096 bit long modulus (2 primes) Dec 11 11:45:34 ifi-zen-stream3 volumio[1396]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Dec 11 11:45:34 ifi-zen-stream3 volumio[2171]: ......................++++ Dec 11 11:45:38 ifi-zen-stream3 volumiologrotate[496]: ls: cannot access '/var/log/samba/log.wb-ZEN': No such file or directory Dec 11 11:45:38 ifi-zen-stream3 volumiologrotate[496]: ls: cannot access 'STREAM3': No such file or directory Dec 11 11:45:40 ifi-zen-stream3 volumio[2171]: ..............................................................................++++ Dec 11 11:45:40 ifi-zen-stream3 volumio[2171]: e is 65537 (0x010001) Dec 11 11:45:40 ifi-zen-stream3 volumio[2171]: writing RSA key Dec 11 11:45:45 ifi-zen-stream3 sudo[2341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 11 11:45:45 ifi-zen-stream3 sudo[2341]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:45 ifi-zen-stream3 sudo[2343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 11 11:45:45 ifi-zen-stream3 sudo[2341]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:45 ifi-zen-stream3 sudo[2343]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:45 ifi-zen-stream3 sudo[2343]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: verbose: New Socket.io Connection to 192.168.3.157 from 192.168.3.28 UA: Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getBrowseSources: null Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetVisibleSources Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getMultiRoomDevices: null Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getMultiroom: null Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: error: Could not retrieve plugin audio_interface multiroom Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getAudioOutputs: null Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getState Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getMenuItems Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getUiSettings Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getWizard Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getPrivacySettings Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 11 11:45:45 ifi-zen-stream3 sudo[2352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 11 11:45:45 ifi-zen-stream3 sudo[2352]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:45 ifi-zen-stream3 sudo[2352]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:45 ifi-zen-stream3 sudo[2354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 11 11:45:45 ifi-zen-stream3 sudo[2354]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:45 ifi-zen-stream3 sudo[2354]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: verbose: New Socket.io Connection to 192.168.3.157 from 192.168.3.28 UA: Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getState Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getMultiRoomDevices: null Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getMultiroom: null Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: error: Could not retrieve plugin audio_interface multiroom Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getAudioOutputs: null Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getBrowseSources: null Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetVisibleSources Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getMenuItems Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ listPlaylist: null Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: Listing playlists Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getUiSettings Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getWizard Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getPrivacySettings Dec 11 11:45:45 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 11 11:45:46 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getMenuItems Dec 11 11:45:47 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getMyVolumioStatus Dec 11 11:45:47 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getSystemInfo Dec 11 11:45:47 ifi-zen-stream3 volumio[1396]: info: Received Get System Info Dec 11 11:45:47 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 11 11:45:47 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 11 11:45:47 ifi-zen-stream3 volumio[1396]: info: Discovery: Getting this device information Dec 11 11:45:47 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:45:47 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 11 11:45:47 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getIfiUser: null Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::close And Set GDPR Agree Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , savePrivacySettings Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::Reload Ui Dec 11 11:45:49 ifi-zen-stream3 sudo[2399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 11 11:45:49 ifi-zen-stream3 sudo[2399]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:49 ifi-zen-stream3 sudo[2400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 11 11:45:49 ifi-zen-stream3 sudo[2400]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:45:49 ifi-zen-stream3 sudo[2399]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:49 ifi-zen-stream3 sudo[2400]: pam_unix(sudo:session): session closed for user root Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: verbose: New Socket.io Connection to 192.168.3.157 from 192.168.3.28 UA: Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getState Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getMultiRoomDevices: null Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getMultiroom: null Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: error: Could not retrieve plugin audio_interface multiroom Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getAudioOutputs: null Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getBrowseSources: null Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetVisibleSources Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getMenuItems Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: ++++--++++ listPlaylist: null Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: Listing playlists Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getUiSettings Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getWizard Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getPrivacySettings Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 11 11:45:49 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getMenuItems Dec 11 11:45:51 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getMyVolumioStatus Dec 11 11:45:51 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getSystemInfo Dec 11 11:45:51 ifi-zen-stream3 volumio[1396]: info: Received Get System Info Dec 11 11:45:51 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 11 11:45:51 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 11 11:45:51 ifi-zen-stream3 volumio[1396]: info: Discovery: Getting this device information Dec 11 11:45:51 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:45:51 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 11 11:45:51 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getIfiUser: null Dec 11 11:45:52 ifi-zen-stream3 volumio[1396]: info: ++++--++++ browseLibrary: {"uri":"music-library"} Dec 11 11:45:52 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 11 11:45:52 ifi-zen-stream3 volumio[1396]: info: CURURI: music-library Dec 11 11:45:52 ifi-zen-stream3 volumio[1396]: error: Failed LSINFO: null Dec 11 11:45:52 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getQueue Dec 11 11:45:52 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetQueue Dec 11 11:45:52 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::getQueue Dec 11 11:45:52 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getQueue Dec 11 11:45:52 ifi-zen-stream3 volumio[1396]: info: Preload queue cleared Dec 11 11:45:52 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 11 11:45:52 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 11:45:52 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 11 11:45:52 ifi-zen-stream3 volumio[1396]: error: Could not retrieve plugin system_controller my_volumio Dec 11 11:45:53 ifi-zen-stream3 volumio[1396]: info: ++++--++++ browseLibrary: {"uri":"music-library/USB","prevUri":"music-library"} Dec 11 11:45:53 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 11 11:45:53 ifi-zen-stream3 volumio[1396]: info: CURURI: music-library/USB Dec 11 11:45:53 ifi-zen-stream3 volumio[1396]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Dec 11 11:45:53 ifi-zen-stream3 volumio[1396]: info: Preload queue cleared Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: ++++--++++ updateDb: "music-library/USB" Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand update Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand status Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces state update: update Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand update took 13 milliseconds Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::getState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand status Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand status took 15 milliseconds Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand status took 6 milliseconds Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: Command Router : Notfying DB Updatetrue Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: networkfs , getMountFileCnt Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMountFileCnt] in plugin networkfs Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::pushState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::servicePushState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 0 Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: verbose: CURRENT POSITION 0 Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 114ms Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: MPD Database updated - AlbumList cache refreshed Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces state update: database Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand status Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces state update: update Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::getState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand status Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::getState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand status Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand status took 25 milliseconds Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand status took 23 milliseconds Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand status took 21 milliseconds Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: Command Router : Notfying DB Updatefalse Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::pushState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::servicePushState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 0 Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: verbose: CURRENT POSITION 0 Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::pushState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::servicePushState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 0 Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: verbose: CURRENT POSITION 0 Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 116ms Dec 11 11:45:55 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 115ms Dec 11 11:46:03 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 11 11:46:03 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 11 11:46:03 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 11 11:46:05 ifi-zen-stream3 volumio[1396]: modalDone Dec 11 11:46:11 ifi-zen-stream3 volumio[1396]: info: ++++--++++ browseLibrary: {"uri":"music-library"} Dec 11 11:46:11 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 11 11:46:11 ifi-zen-stream3 volumio[1396]: info: CURURI: music-library Dec 11 11:46:11 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 11 11:46:11 ifi-zen-stream3 volumio[1396]: info: Preload queue cleared Dec 11 11:46:11 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 11 11:46:11 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 11 11:46:12 ifi-zen-stream3 volumio[1396]: info: ++++--++++ browseLibrary: {"uri":"music-library/USB","prevUri":"music-library"} Dec 11 11:46:12 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 11 11:46:12 ifi-zen-stream3 volumio[1396]: info: CURURI: music-library/USB Dec 11 11:46:12 ifi-zen-stream3 volumio[1396]: info: Preload queue cleared Dec 11 11:46:12 ifi-zen-stream3 volumio[1396]: info: ++++--++++ browseLibrary: {"uri":"music-library/USB/Samsung_USB","prevUri":"music-library/USB"} Dec 11 11:46:12 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 11 11:46:12 ifi-zen-stream3 volumio[1396]: info: CURURI: music-library/USB/Samsung_USB Dec 11 11:46:12 ifi-zen-stream3 volumio[1396]: info: Preload queue cleared Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: ++++--++++ browseLibrary: {"uri":"music-library/USB/Samsung_USB/歌曲","prevUri":"music-library/USB/Samsung_USB"} Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: CURURI: music-library/USB/Samsung_USB/歌曲 Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Preload queue cleared Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Preloading song: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Preloading song: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Preloading song: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Preloading song: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Preloading song: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Preloading song: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Preloading song: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Preloading song: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Preloading song: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Preloading song: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Exploding uri music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac in service mpd Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: ALBUMART /albumart?cacheid=183_1765453573475&web=//extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2%2F(352kHz)Divertimento%20352.8-24.flac&metadata=false Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: URI /mnt/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Exploding uri music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac in service mpd Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: ALBUMART /albumart?cacheid=183_1765453573514&web=//extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2%2F(48kHz)Divertimento%2048-24.flac&metadata=false Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: URI /mnt/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Exploding uri music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac in service mpd Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: ALBUMART /albumart?cacheid=183_1765453573564&web=//extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2%2F10%20Sisters%20Of%20The%20Moon-Magenta.OFS.mqb.auth1.flac&metadata=false Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: URI /mnt/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Exploding uri music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac in service mpd Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: ALBUMART /albumart?cacheid=183_1765453573616&web=TrondheimSolistene/DIVERTIMENTI/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2%2F(88kHz)Divertimento%2088-24.flac&metadata=false Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: URI /mnt/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Exploding uri music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac in service mpd Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: ALBUMART /albumart?cacheid=183_1765453573666&web=TrondheimSolistene/DIVERTIMENTI/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2%2F(96kHz)Divertimento%2096-24.flac&metadata=false Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: URI /mnt/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Exploding uri music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac in service mpd Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: ALBUMART /albumart?cacheid=183_1765453573717&web=TrondheimSolistene/DIVERTIMENTI/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2%2F01%20-%20Divertimento%2048-24.flac&metadata=false Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: URI /mnt/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Exploding uri music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac in service mpd Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: ALBUMART /albumart?cacheid=183_1765453573769&web=TrondheimSolistene/DIVERTIMENTI/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2%2F02%20-%20Divertimento%20192-24.flac&metadata=false Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: URI /mnt/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Exploding uri music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac in service mpd Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: ALBUMART /albumart?cacheid=183_1765453573820&web=TrondheimSolistene/DIVERTIMENTI/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2%2F02%20-%20Divertimento%2088-24.flac&metadata=false Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: URI /mnt/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Exploding uri music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac in service mpd Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: ALBUMART /albumart?cacheid=183_1765453573871&web=Minnesota%20Orchestra%2C%20Eiji%20Oue/Exotic%20Dances%20From%20The%20Opera/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2%2F(176kHz)Tchaikovsky%20Hopak%20176-24.flac&metadata=false Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: URI /mnt/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: Exploding uri music-library/USB/Samsung_USB/歌曲/Carmen 44.flac in service mpd Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: ALBUMART /albumart?cacheid=183_1765453573922&web=Carmen/RMAF%202010/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2%2FCarmen%2044.flac&metadata=false Dec 11 11:46:13 ifi-zen-stream3 volumio[1396]: info: URI /mnt/USB/Samsung_USB/歌曲/Carmen 44.flac Dec 11 11:46:14 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getMenuItems Dec 11 11:46:15 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getMenuItems Dec 11 11:46:16 ifi-zen-stream3 volumio[1396]: info: ++++--++++ getUiConfig: {"page":"audio_interface/alsa_controller"} Dec 11 11:46:16 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 11 11:46:16 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 11 11:46:16 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 11:46:16 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 11 11:46:16 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 11:46:16 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 11:46:16 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 11:46:16 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 11:46:16 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 11:46:16 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 11:46:16 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 11:46:16 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 11 11:46:16 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 11 11:46:17 ifi-zen-stream3 volumio[1396]: info: ++++--++++ callMethod: {"type":"controller","endpoint":"audio_interface/alsa_controller","method":"saveAlsaOptions","data":{"output_device":{"value":"5","label":"ZEN DAC 3 (UCA1)"}}} Dec 11 11:46:17 ifi-zen-stream3 volumio[1396]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Dec 11 11:46:17 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 11 11:46:17 ifi-zen-stream3 volumio[1396]: info: Preparing to save Alsa Options, stopping services first Dec 11 11:46:17 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:46:17 ifi-zen-stream3 volumio[1396]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"ZEN DAC 3 (UCA1)"}} Dec 11 11:46:17 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 11 11:46:17 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , forceDoP Dec 11 11:46:17 ifi-zen-stream3 volumio[1396]: info: ZEN DAC 3 (UCA1): Does not support DSD Native. Dec 11 11:46:17 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 11 11:46:17 ifi-zen-stream3 volumio[1396]: info: Ignoring Mixers Options Dec 11 11:46:17 ifi-zen-stream3 volumio[1396]: info: Device 5 does not have any Mixer Control Available Dec 11 11:46:17 ifi-zen-stream3 volumio[1396]: info: Restoring Previous Volume level: 100 false false Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: Updating Volume Controller Parameters: Device: 5 Name: ZEN DAC 3 (UCA1) Mixer: None Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: Preparing to generate the ALSA configuration file Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: wizard , refreshWizarOutputDevices Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: Asound.conf file written Dec 11 11:46:18 ifi-zen-stream3 sudo[2687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 11 11:46:18 ifi-zen-stream3 sudo[2687]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:46:18 ifi-zen-stream3 sudo[2687]: pam_unix(sudo:session): session closed for user root Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: No state is present for card rkifispdif Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: Found hardware: "rk-ifi-spdif" "" "" "" "" Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: Hardware is initialized using a generic method Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: No state is present for card rkifispdif Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: No state is present for card Z3UCA1 Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: Found hardware: "USB-Audio" "USB Mixer" "USB20b1:0010" "" "" Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: Hardware is initialized using a generic method Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: No state is present for card Z3UCA1 Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: Tidal connect: Output device has changed Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: Output device has changed, restarting MPD Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: Qobuz connect: Output device has changed Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: Roon Ready: Output device has changed Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: Spotify: Output device has changed Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: Tidal connect: Output device has changed Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: Output device has changed, restarting MPD Dec 11 11:46:18 ifi-zen-stream3 sudo[2692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 11 11:46:18 ifi-zen-stream3 sudo[2692]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:46:18 ifi-zen-stream3 sudo[2692]: pam_unix(sudo:session): session closed for user root Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: Qobuz connect: Output device has changed Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: Roon Ready: Output device has changed Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: Spotify: Output device has changed Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: MPD Permissions set Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 sudo[2695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 11 11:46:18 ifi-zen-stream3 sudo[2695]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:46:18 ifi-zen-stream3 sudo[2695]: pam_unix(sudo:session): session closed for user root Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: MPD Permissions set Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: Starting RoonReady Sync Dec 11 11:46:18 ifi-zen-stream3 sudo[2715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Dec 11 11:46:18 ifi-zen-stream3 sudo[2715]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:46:18 ifi-zen-stream3 volumio[1396]: info: Starting RoonReady Sync Dec 11 11:46:18 ifi-zen-stream3 sudo[2717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Dec 11 11:46:18 ifi-zen-stream3 sudo[2717]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:46:18 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Qobuz Connect Service... Dec 11 11:46:18 ifi-zen-stream3 node[504]: ConvSwitch: Drop client qobuz-connect Dec 11 11:46:18 ifi-zen-stream3 node[487]: Closing connection with the client qobuz-connect Dec 11 11:46:18 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 11 11:46:18 ifi-zen-stream3 sudo[2720]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Dec 11 11:46:18 ifi-zen-stream3 sudo[2720]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded. Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Qobuz Connect Service. Dec 11 11:46:19 ifi-zen-stream3 sudo[2723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Dec 11 11:46:19 ifi-zen-stream3 sudo[2723]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:46:19 ifi-zen-stream3 sudo[2715]: pam_unix(sudo:session): session closed for user root Dec 11 11:46:19 ifi-zen-stream3 node[504]: ConvSwitch: Drop client roon-ready Dec 11 11:46:19 ifi-zen-stream3 node[487]: Closing connection with the client roon-ready Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Roon Ready Service... Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Succeeded. Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Roon Ready Service. Dec 11 11:46:19 ifi-zen-stream3 sudo[2720]: pam_unix(sudo:session): session closed for user root Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: Started iFi Streamer Roon Ready Service. Dec 11 11:46:19 ifi-zen-stream3 sudo[2717]: pam_unix(sudo:session): session closed for user root Dec 11 11:46:19 ifi-zen-stream3 sudo[2723]: pam_unix(sudo:session): session closed for user root Dec 11 11:46:19 ifi-zen-stream3 volumio[1396]: info: RoonReady Started Dec 11 11:46:19 ifi-zen-stream3 volumio[1396]: info: RoonReady Started Dec 11 11:46:19 ifi-zen-stream3 play[2739]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 11 11:46:19 ifi-zen-stream3 node[504]: ConvSwitch: Add client roon-ready Dec 11 11:46:19 ifi-zen-stream3 volumio[1396]: info: ConvSwitch: Get message: request:pause Dec 11 11:46:19 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:46:19 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:46:19 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::serviceStop Dec 11 11:46:19 ifi-zen-stream3 volumio[1396]: info: Received STOP, but no service to execute it Dec 11 11:46:19 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:19 ifi-zen-stream3 volumio[1396]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Dec 11 11:46:19 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Dec 11 11:46:19 ifi-zen-stream3 volumio[1396]: info: Roon Ready playback start Dec 11 11:46:19 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:46:19 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:46:19 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:46:19 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:46:19 ifi-zen-stream3 volumio[1396]: info: Roon Ready metadata receiver is on Dec 11 11:46:19 ifi-zen-stream3 sudo[2787]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Dec 11 11:46:19 ifi-zen-stream3 sudo[2787]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Dec 11 11:46:19 ifi-zen-stream3 node[487]: Closing connection with the client tidal-connect Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service... Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Dec 11 11:46:19 ifi-zen-stream3 node[504]: ConvSwitch: Drop client tidal Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service. Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service. Dec 11 11:46:19 ifi-zen-stream3 sudo[2787]: pam_unix(sudo:session): session closed for user root Dec 11 11:46:19 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service. Dec 11 11:46:19 ifi-zen-stream3 sudo[2794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Dec 11 11:46:19 ifi-zen-stream3 sudo[2794]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:46:19 ifi-zen-stream3 volumio[1396]: info: Tidal Connect Service Started Dec 11 11:46:20 ifi-zen-stream3 node[487]: A new connection has been established. Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Dec 11 11:46:20 ifi-zen-stream3 node[487]: Closing connection with the client tidal-connect Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service... Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service. Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service. Dec 11 11:46:20 ifi-zen-stream3 sudo[2794]: pam_unix(sudo:session): session closed for user root Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service. Dec 11 11:46:20 ifi-zen-stream3 volumio[1396]: info: Tidal Connect Service Started Dec 11 11:46:20 ifi-zen-stream3 node[487]: A new connection has been established. Dec 11 11:46:20 ifi-zen-stream3 sudo[2810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Dec 11 11:46:20 ifi-zen-stream3 sudo[2810]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: Started iFi Streamer Qobuz Connect Service. Dec 11 11:46:20 ifi-zen-stream3 sudo[2810]: pam_unix(sudo:session): session closed for user root Dec 11 11:46:20 ifi-zen-stream3 volumio[1396]: info: Qobuz Connect Service Started Dec 11 11:46:20 ifi-zen-stream3 sudo[2818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Dec 11 11:46:20 ifi-zen-stream3 sudo[2818]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:46:20 ifi-zen-stream3 sudo[2818]: pam_unix(sudo:session): session closed for user root Dec 11 11:46:20 ifi-zen-stream3 volumio[1396]: info: Qobuz Connect Service Started Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.321 [2836.2836] DEBUG SampleApp: Starting sample application Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.322 [2836.2836] DEBUG SampleApp: Device Name: ZEN Stream3 Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.322 [2836.2836] DEBUG SampleApp: Manufacturer: Sample manufacturer Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.322 [2836.2836] DEBUG SampleApp: Model: iFi Streamer Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.322 [2836.2836] DEBUG SampleApp: Serial Number: ifi:32:b5:8a:ca:11:71 Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.322 [2836.2836] DEBUG SampleApp: Audio output device: volumio Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.322 [2836.2836] DEBUG SampleApp: Volume control device: default Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.322 [2836.2836] DEBUG SampleApp: Volume control element: Master Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.322 [2836.2836] DEBUG SampleApp: Local config server port: 8000 Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.327 [2836.2836] ERROR SampleApp: Unable to find ALSA mixer element 'Master' on index 0 Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.327 [2836.2836] DEBUG SampleApp: Maximum supported audio quality: HIRES_L3 Dec 11 11:46:20 ifi-zen-stream3 play[2817]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 11 11:46:20 ifi-zen-stream3 node[487]: A new connection has been established. Dec 11 11:46:20 ifi-zen-stream3 play[2817]: [Info] MetaClient: MetaClientInit Dec 11 11:46:20 ifi-zen-stream3 play[2817]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Dec 11 11:46:20 ifi-zen-stream3 node[504]: ConvSwitch: Add client qobuz-connect Dec 11 11:46:20 ifi-zen-stream3 sudo[2840]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Dec 11 11:46:20 ifi-zen-stream3 sudo[2840]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:46:20 ifi-zen-stream3 play[2817]: [Info] ConvSwitch: ConvSwitchInit Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.434 [2836.2836] DEBUG ActiveStateManager: [0xaae95030]: Creating new Active State Manager Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.434 [2836.2836] DEBUG NetworkActivityTracker: [0xaae950a0]: Creating new Network Activity Tracker Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.435 [2836.2836] DEBUG EndpointManager: [0xaae96018]: Creating Endpoint Manager Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.435 [2836.2836] DEBUG PlaybackSessionManager: [0xaae96408]: Creating Playback Session Manager Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.435 [2836.2836] DEBUG BackoffTimer: [0xaae96580]: Creating Backoff Timer Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.435 [2836.2836] DEBUG MediaEngine: [0xaae966a0]: Creating new Media Engine Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.435 [2836.2836] DEBUG AudioRenderer: [0xaae968c0]: Creating Audio Renderer Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.435 [2836.2836] TRACE MediaEngineCommandSequencer: [0xaae96a18]: Creating Media Engine Command Sequencer Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.435 [2836.2836] DEBUG PlaybackControlsManager: [0xaae96a78]: Creating new Playback Controls Manager Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.435 [2836.2836] DEBUG VolumeManager: [0xaae96b08]: Creating new Volume Manager Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.435 [2836.2836] DEBUG ProtocolHandler: [0xaae96de0]: Creating Protocol Handler Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.435 [2836.2836] DEBUG MessageReceiver: [0xaae96e80]: Creating Message Receiver Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.435 [2836.2836] DEBUG RendererActivationController: [0xaae96ff8]: Creating new Renderer Activation Controller Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.435 [2836.2836] TRACE RendererActivationCommandSequencer: [0xaae970a0]: Creating Renderer Activation Command Sequencer Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.435 [2836.2836] DEBUG ReportingManager: [0xaae971b0]: Creating new Reporting Manager Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.435 [2836.2836] DEBUG StreamingEventReporter: [0xaae971f8]: Creating Streaming Event Reporter Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.435 [2836.2836] DEBUG BackoffTimer: [0xaae972d8]: Creating Backoff Timer Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.435 [2836.2836] DEBUG TokenExpiryController: [0xaae973e8]: Creating Token Expiry Controller Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.435 [2836.2836] DEBUG UserInactivityManager: [0xaae97438]: Creating new User Inactivity Manager Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.436 [2836.2836] INFO VolumeManager: [0xaae96b08]: Setting new playback volume: 100 Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.436 [2836.2836] INFO VolumeManager: [0xaae96b08]: Setting new mute state: 1 Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.436 [2836.2836] DEBUG SampleApp: Qobuz Connect has been initialized Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.436 [2836.2836] TRACE SampleApp: Running event loop Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.436 [2836.2836] INFO QobuzConnect: [0xaae974d8]: Client initialized! Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.436 [2836.2836] INFO SampleApp: Starting Avahi advertising, name: ZEN Stream3, service name: _qobuz-connect._tcp Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.456 [2836.2836] DEBUG SampleApp: Avahi client state changed: RUNNING Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.460 [2836.2836] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED Dec 11 11:46:20 ifi-zen-stream3 sudo[2843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Dec 11 11:46:20 ifi-zen-stream3 sudo[2843]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: mpd.socket: Succeeded. Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: Closed mpd.socket. Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.469 [2836.2836] INFO LocalConfigManager: [0xaae963e8]: Starting Local Configuration server Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.469 [2836.2836] INFO SampleApp: Starting Local configuration server Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.471 [2836.2836] INFO SampleApp: Playback mute state changed: 1 Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.471 [2836.2836] ERROR SampleApp: Unable to set mute state, no ALSA volume element Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.471 [2836.2836] DEBUG SampleApp: Avahi entry group state changed: REGISTERING Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.472 [2836.2836] INFO SampleApp: Playback volume changed: 100 Dec 11 11:46:20 ifi-zen-stream3 play[2817]: 20251211 11:46:20.473 [2836.2836] ERROR SampleApp: Unable to set volume, no ALSA volume element Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: Stopping Music Player Daemon... Dec 11 11:46:20 ifi-zen-stream3 volumio[1396]: MPD server connection closed Dec 11 11:46:20 ifi-zen-stream3 volumio[1396]: MPD server connection closed Dec 11 11:46:20 ifi-zen-stream3 volumio[1396]: Connection closed by client Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: mpd.service: Succeeded. Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: Stopped Music Player Daemon. Dec 11 11:46:20 ifi-zen-stream3 sudo[2840]: pam_unix(sudo:session): session closed for user root Dec 11 11:46:20 ifi-zen-stream3 sudo[2843]: pam_unix(sudo:session): session closed for user root Dec 11 11:46:20 ifi-zen-stream3 sudo[2848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Dec 11 11:46:20 ifi-zen-stream3 sudo[2848]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:46:20 ifi-zen-stream3 sudo[2850]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Dec 11 11:46:20 ifi-zen-stream3 sudo[2850]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: Listening on mpd.socket. Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: Starting Music Player Daemon... Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: mpd.socket: Succeeded. Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: Closed mpd.socket. Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: Stopping mpd.socket. Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: mpd.socket: Socket service mpd.service already active, refusing. Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: Failed to listen on mpd.socket. Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: mpd.service: Succeeded. Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: Stopped Music Player Daemon. Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: Listening on mpd.socket. Dec 11 11:46:20 ifi-zen-stream3 systemd[1]: Starting Music Player Daemon... Dec 11 11:46:20 ifi-zen-stream3 sudo[2854]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 11 11:46:20 ifi-zen-stream3 sudo[2854]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:46:20 ifi-zen-stream3 sudo[2854]: pam_unix(sudo:session): session closed for user root Dec 11 11:46:20 ifi-zen-stream3 node[487]: A new connection has been established. Dec 11 11:46:21 ifi-zen-stream3 play[2817]: 20251211 11:46:21.344 [2836.2836] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED Dec 11 11:46:21 ifi-zen-stream3 sudo[2891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Dec 11 11:46:21 ifi-zen-stream3 sudo[2891]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:46:22 ifi-zen-stream3 play[1964]: 2025-12-11 11:46:21.997 E esdk select error: 4 -> Interrupted system call Dec 11 11:46:22 ifi-zen-stream3 play[1964]: 2025-12-11 11:46:21.998 I app Exiting with error = 0 Dec 11 11:46:22 ifi-zen-stream3 play[1964]: 2025-12-11 11:46:21.998 I api SpFree() Dec 11 11:46:22 ifi-zen-stream3 play[1964]: 2025-12-11 11:46:21.998 I api SpFree [returned value: 0] Dec 11 11:46:22 ifi-zen-stream3 play[1964]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Dec 11 11:46:22 ifi-zen-stream3 play[1964]: [Info] ConvSwitch: ConvSwitchInit Dec 11 11:46:22 ifi-zen-stream3 play[1964]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 11 11:46:22 ifi-zen-stream3 play[1964]: [Info] MetaClient: MetaClientInit Dec 11 11:46:22 ifi-zen-stream3 play[1964]: [Info] ConvSwitch: ConvSwitchExit Dec 11 11:46:22 ifi-zen-stream3 play[1964]: [Info] MetaClient: MetaClientExit Dec 11 11:46:22 ifi-zen-stream3 node[487]: Closing connection with the client spotify Dec 11 11:46:22 ifi-zen-stream3 node[504]: ConvSwitch: Drop client spotify Dec 11 11:46:22 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service... Dec 11 11:46:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 11 11:46:22 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::getcurrentVolume Dec 11 11:46:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioRetrievevolume Dec 11 11:46:22 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Dec 11 11:46:22 ifi-zen-stream3 sudo[2894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Dec 11 11:46:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Dec 11 11:46:22 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:46:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:46:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:22 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Dec 11 11:46:22 ifi-zen-stream3 sudo[2894]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 11:46:22 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service. Dec 11 11:46:22 ifi-zen-stream3 sudo[2891]: pam_unix(sudo:session): session closed for user root Dec 11 11:46:22 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service. Dec 11 11:46:22 ifi-zen-stream3 volumio[1396]: info: Spotify Connect Service Started Dec 11 11:46:22 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service... Dec 11 11:46:22 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Dec 11 11:46:22 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Dec 11 11:46:22 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service. Dec 11 11:46:22 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service. Dec 11 11:46:22 ifi-zen-stream3 sudo[2894]: pam_unix(sudo:session): session closed for user root Dec 11 11:46:22 ifi-zen-stream3 volumio[1396]: info: Spotify Connect Service Started Dec 11 11:46:22 ifi-zen-stream3 play[2900]: output: volumio mixer: hw:5 Dec 11 11:46:22 ifi-zen-stream3 node[504]: ConvSwitch: Add client spotify Dec 11 11:46:22 ifi-zen-stream3 node[487]: A new connection has been established. Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.349 I api SpRegisterDebugCallbacks [returned value: 0] Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.349 I api SpInit(0xff8cfe10, API v66) Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.349 I esdk eSDK version: HEAD-v3.166.69-g24821f73 Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.350 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 Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.350 I esdk Successfully registered dns callback: dns_lookup_callback Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.350 I download Using 128 kB for cache buffer Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.350 I download Using 621 kB for compressed audio buffer Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.350 I esdk Successfully registered error callback Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.362 I esdk Creating IPv4 socket (domain 2) Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.362 I zc webserver: service port 5566 (5566-5576) buffer size 4444 Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.362 I zc Started ZeroConf service on port 5566 path /zc alias count 0 Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.362 I esdk Creating IPv4 socket (domain 2) Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.363 I api SpInit [returned value: 0] Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.363 I api SpRegisterConnectionCallbacks(0xff8cfdf8, (nil)) Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.363 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.363 I api SpRegisterConnectionCallbacks [returned value: 0] Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.363 I api SpRegisterPlaybackCallbacks(0xff8cfde0, (nil)) Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.363 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, - Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.363 I api SpRegisterPlaybackCallbacks [returned value: 0] Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.369 W app Couldn't find mixer for volume controls. (tried , SoftMaster) Dec 11 11:46:22 ifi-zen-stream3 play[2900]: 2025-12-11 11:46:22.369 I app Initialized! Dec 11 11:46:22 ifi-zen-stream3 volumio[1396]: info: VolumeController::SetAlsaVolume100 Dec 11 11:46:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Dec 11 11:46:22 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:46:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:46:22 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:22 ifi-zen-stream3 node[504]: ConvSwitch: Add client tidal Dec 11 11:46:22 ifi-zen-stream3 tidal_connect_application[2912]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi. Dec 11 11:46:22 ifi-zen-stream3 tidal_connect_application[2912]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 11 11:46:22 ifi-zen-stream3 tidal_connect_application[2912]: *** WARNING *** For more information see Dec 11 11:46:22 ifi-zen-stream3 ifi_metadata[2804]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 11 11:46:22 ifi-zen-stream3 ifi_metadata[2804]: [Info] MetaClient: MetaClientInit Dec 11 11:46:22 ifi-zen-stream3 ifi_metadata[2804]: Connected Dec 11 11:46:23 ifi-zen-stream3 mpd[2856]: Dec 11 11:46 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 11 11:46:23 ifi-zen-stream3 systemd[1]: Started Music Player Daemon. Dec 11 11:46:23 ifi-zen-stream3 sudo[2848]: pam_unix(sudo:session): session closed for user root Dec 11 11:46:23 ifi-zen-stream3 sudo[2850]: pam_unix(sudo:session): session closed for user root Dec 11 11:46:23 ifi-zen-stream3 volumio[1396]: info: Restarted MPD. Dec 11 11:46:23 ifi-zen-stream3 volumio[1396]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.socket mpd.service Dec 11 11:46:23 ifi-zen-stream3 volumio[1396]: Job for mpd.socket failed. Dec 11 11:46:23 ifi-zen-stream3 volumio[1396]: See "systemctl status mpd.socket" and "journalctl -xe" for details. Dec 11 11:46:23 ifi-zen-stream3 volumio[1396]: error: MPD error: The expression evaluated to a falsy value: Dec 11 11:46:23 ifi-zen-stream3 volumio[1396]: assert.ok(self.idling) Dec 11 11:46:23 ifi-zen-stream3 volumio[1396]: error: The expression evaluated to a falsy value: Dec 11 11:46:23 ifi-zen-stream3 volumio[1396]: assert.ok(self.idling) Dec 11 11:46:23 ifi-zen-stream3 volumio[1396]: error: updateQueue error: null Dec 11 11:46:24 ifi-zen-stream3 volumio[1396]: info: Volumio called home Dec 11 11:46:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:46:24 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:46:24 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::serviceStop Dec 11 11:46:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::serviceStop Dec 11 11:46:24 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioStop Dec 11 11:46:24 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:46:24 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:46:24 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:46:24 ifi-zen-stream3 volumio[1396]: info: Roon Ready Stop Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ++++--++++ playItemsList: {"item":{"service":"mpd","type":"song","title":"(48kHz)Divertimento 48-24.flac","artist":"","album":"","uri":"music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac","albumart":"/albumart?cacheid=183_1765453573344&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},"list":[{"service":"mpd","type":"song","title":"(352kHz)Divertimento 352.8-24","artist":"","album":"","uri":"music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac","albumart":"/albumart?cacheid=183_1765453573344&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"(48kHz)Divertimento 48-24.flac","artist":"","album":"","uri":"music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac","albumart":"/albumart?cacheid=183_1765453573344&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac","artist":"","album":"","uri":"music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac","albumart":"/albumart?cacheid=183_1765453573344&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Simple Symphony op. 4 - Boisterous Bourree 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac","albumart":"/albumart?cacheid=183_1765453573345&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Simple Symphony op. 4 - Boisterous Bourree 96kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac","albumart":"/albumart?cacheid=183_1765453573345&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Simple Symphony op. 4 - Boisterous Bourree 48kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac","albumart":"/albumart?cacheid=183_1765453573345&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Simple Symphony op. 4 - Boisterous Bourree (192 kHz)","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac","albumart":"/albumart?cacheid=183_1765453573345&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Simple Symphony op. 4 - Boisterous Bourree 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac","albumart":"/albumart?cacheid=183_1765453573345&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Hopak [TCHAIKOVSKY: Mazeppa] 176kHz","artist":"Minnesota Orchestra, Eiji Oue","album":"Exotic Dances From The Opera","uri":"music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac","albumart":"/albumart?cacheid=183_1765453573345&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Carmen 44kHz","artist":"Carmen","album":"RMAF 2010","uri":"music-library/USB/Samsung_USB/歌曲/Carmen 44.flac","albumart":"/albumart?cacheid=183_1765453573345&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"}],"index":1} Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Preload queue cleared Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::ClearQueue Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::clearPlayQueue Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::saveQueue Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushQueue Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::addQueueItems Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::addQueueItems Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Preload queue cleared Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushQueue Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::saveQueue Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::updateTrackBlock Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrackBlock Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ConvSwitch: Sent Play Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPlay Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::play index 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::addQueueItems Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::addQueueItems Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Preload queue cleared Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushQueue Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::saveQueue Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::play index undefined Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::updateTrackBlock Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrackBlock Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::startPlaybackTimer Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::clearAddPlayTracks USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand stop Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ConvSwitch: Get message: success Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand stop took 10 milliseconds Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand clear Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces system playlist update Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Ignoring MPD Status Update Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand clear took 5 milliseconds Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand add "USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac" Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces system playlist update Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Ignoring MPD Status Update Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: error: updateQueue error: null Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces system playlist update Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Ignoring MPD Status Update Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 14ms Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand add "USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac" took 11 milliseconds Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 10ms Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand play Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces system playlist update Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Ignoring MPD Status Update Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces state update: player Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 23ms Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand play took 17 milliseconds Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::getState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand status Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 22ms Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces state update: player Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::getState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand status Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand status took 239 milliseconds Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces state update: player Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::getState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand status Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand status took 247 milliseconds Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand playlistinfo took 7 milliseconds Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseTrackInfo Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::pushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::servicePushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"737 Kbps","isStreaming":false,"title":"(48kHz)Divertimento 48-24.flac","artist":null,"album":null,"uri":"USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac","trackType":"flac"} Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: CURRENT POSITION 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::syncState stateService play Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::syncState currentStatus stop Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 286ms Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces state update: player Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::getState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand status Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand status took 26 milliseconds Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand playlistinfo took 19 milliseconds Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand status took 5 milliseconds Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseTrackInfo Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::pushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::servicePushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: STATE SERVICE {"status":"play","position":0,"seek":483,"duration":182,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"767 Kbps","isStreaming":false,"title":"(48kHz)Divertimento 48-24.flac","artist":null,"album":null,"uri":"USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac","trackType":"flac"} Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: CURRENT POSITION 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::syncState stateService play Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::syncState currentStatus play Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Received an update from plugin. extracting info from payload Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 325ms Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand playlistinfo took 45 milliseconds Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand playlistinfo took 41 milliseconds Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseTrackInfo Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseTrackInfo Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::pushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::servicePushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":182,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"802 Kbps","isStreaming":false,"title":"(48kHz)Divertimento 48-24.flac","artist":null,"album":null,"uri":"USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac","trackType":"flac"} Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: CURRENT POSITION 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::syncState stateService play Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::syncState currentStatus play Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Received an update from plugin. extracting info from payload Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::pushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::servicePushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":182,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"802 Kbps","isStreaming":false,"title":"(48kHz)Divertimento 48-24.flac","artist":null,"album":null,"uri":"USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac","trackType":"flac"} Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: verbose: CURRENT POSITION 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::syncState stateService play Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::syncState currentStatus play Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: Received an update from plugin. extracting info from payload Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 1 Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 185ms Dec 11 11:46:31 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 164ms Dec 11 11:46:32 ifi-zen-stream3 volumio[1396]: info: MetaClient: Sent Meta Dec 11 11:46:32 ifi-zen-stream3 volumio[1396]: info: MetaClient: Get message: success Dec 11 11:46:38 ifi-zen-stream3 volumiologrotate[496]: ls: cannot access '/var/log/samba/log.wb-ZEN': No such file or directory Dec 11 11:46:38 ifi-zen-stream3 volumiologrotate[496]: ls: cannot access 'STREAM3': No such file or directory Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ++++--++++ playItemsList: {"item":{"service":"mpd","type":"song","title":"Simple Symphony op. 4 - Boisterous Bourree 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac","albumart":"/albumart?cacheid=183_1765453573345&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},"list":[{"service":"mpd","type":"song","title":"(352kHz)Divertimento 352.8-24","artist":"","album":"","uri":"music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac","albumart":"/albumart?cacheid=183_1765453573344&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"(48kHz)Divertimento 48-24.flac","artist":"","album":"","uri":"music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac","albumart":"/albumart?cacheid=183_1765453573344&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac","artist":"","album":"","uri":"music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac","albumart":"/albumart?cacheid=183_1765453573344&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Simple Symphony op. 4 - Boisterous Bourree 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac","albumart":"/albumart?cacheid=183_1765453573345&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Simple Symphony op. 4 - Boisterous Bourree 96kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac","albumart":"/albumart?cacheid=183_1765453573345&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Simple Symphony op. 4 - Boisterous Bourree 48kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac","albumart":"/albumart?cacheid=183_1765453573345&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Simple Symphony op. 4 - Boisterous Bourree (192 kHz)","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac","albumart":"/albumart?cacheid=183_1765453573345&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Simple Symphony op. 4 - Boisterous Bourree 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac","albumart":"/albumart?cacheid=183_1765453573345&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Hopak [TCHAIKOVSKY: Mazeppa] 176kHz","artist":"Minnesota Orchestra, Eiji Oue","album":"Exotic Dances From The Opera","uri":"music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac","albumart":"/albumart?cacheid=183_1765453573345&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"},{"service":"mpd","type":"song","title":"Carmen 44kHz","artist":"Carmen","album":"RMAF 2010","uri":"music-library/USB/Samsung_USB/歌曲/Carmen 44.flac","albumart":"/albumart?cacheid=183_1765453573345&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"}],"index":3} Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Preload queue cleared Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::ClearQueue Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stPlaybackTimer Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::updateTrackBlock Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrackBlock Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 1 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::serviceStop Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 1 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::serviceStop Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::stop Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand stop Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::clearPlayQueue Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::saveQueue Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushQueue Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::addQueueItems Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::addQueueItems Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Preload queue cleared Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushQueue Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::saveQueue Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::updateTrackBlock Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrackBlock Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ConvSwitch: Sent Play Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPlay Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::play index 3 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::addQueueItems Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::addQueueItems Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Preload queue cleared Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::stop Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushQueue Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::saveQueue Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::play index undefined Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::updateTrackBlock Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrackBlock Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::startPlaybackTimer Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::clearAddPlayTracks USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand stop Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces state update: player Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand stop took 72 milliseconds Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::getState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand status Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand stop took 10 milliseconds Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand clear Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ConvSwitch: Get message: success Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces state update: player Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::getState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand status Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces system playlist update Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Ignoring MPD Status Update Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand status took 17 milliseconds Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand clear took 15 milliseconds Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand status took 12 milliseconds Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand add "USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac" Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::pushState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::servicePushState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: CURRENT POSITION 3 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 46ms Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces system playlist update Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Ignoring MPD Status Update Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: error: updateQueue error: null Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces system playlist update Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Ignoring MPD Status Update Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 46ms Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand playlistinfo took 38 milliseconds Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand add "USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac" took 38 milliseconds Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 11ms Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseTrackInfo Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand play Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 73ms Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces system playlist update Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Ignoring MPD Status Update Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces state update: player Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 28ms Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand play took 21 milliseconds Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::getState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand status Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 20ms Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces state update: player Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::getState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand status Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces state update: player Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand status took 224 milliseconds Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::getState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand status Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand status took 220 milliseconds Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: ---------------------------- MPD announces state update: player Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::getState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand status Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand status took 25 milliseconds Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand playlistinfo took 20 milliseconds Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand status took 10 milliseconds Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseTrackInfo Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseTrackInfo Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioGetState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::pushState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::servicePushState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1240 Kbps","isStreaming":false,"title":"Simple Symphony op. 4 - Boisterous Bourree 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac","trackType":"flac"} Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: CURRENT POSITION 3 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::syncState stateService play Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::syncState currentStatus stop Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::pushState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::servicePushState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: STATE SERVICE {"status":"play","position":0,"seek":262,"duration":182,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1295 Kbps","isStreaming":false,"title":"Simple Symphony op. 4 - Boisterous Bourree 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac","trackType":"flac"} Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: verbose: CURRENT POSITION 3 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::syncState stateService play Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::syncState currentStatus play Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: Received an update from plugin. extracting info from payload Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 306ms Dec 11 11:46:39 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 305ms Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand playlistinfo took 53 milliseconds Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: sendMpdCommand playlistinfo took 48 milliseconds Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseTrackInfo Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: verbose: ControllerMpd::parseTrackInfo Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::pushState Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::servicePushState Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: verbose: STATE SERVICE {"status":"play","position":0,"seek":988,"duration":182,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1387 Kbps","isStreaming":false,"title":"Simple Symphony op. 4 - Boisterous Bourree 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac","trackType":"flac"} Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: verbose: CURRENT POSITION 3 Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::syncState stateService play Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::syncState currentStatus play Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: Received an update from plugin. extracting info from payload Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: ControllerMpd::pushState Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::servicePushState Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: verbose: STATE SERVICE {"status":"play","position":0,"seek":988,"duration":182,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1387 Kbps","isStreaming":false,"title":"Simple Symphony op. 4 - Boisterous Bourree 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac","trackType":"flac"} Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: verbose: CURRENT POSITION 3 Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::syncState stateService play Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::syncState currentStatus play Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: Received an update from plugin. extracting info from payload Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreStateMachine::pushState Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CorePlayQueue::getTrack 3 Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::volumioPushState Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 169ms Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: info: ------------------------------ 148ms Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: Error: connect ECONNREFUSED 67.230.169.182:443 Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: errno: -111, Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: code: 'ECONNREFUSED', Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: syscall: 'connect', Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: address: '67.230.169.182', Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: port: 443 Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: } Dec 11 11:46:40 ifi-zen-stream3 volumio[1396]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 11 11:46:41 ifi-zen-stream3 sudo[3142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-11 11:45 Dec 11 11:46:41 ifi-zen-stream3 sudo[3142]: 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="45aad196ab181636cec04ab79f52572f8ba3c549" VOLUMIO_FE_VERSION="8a7c1663e5becc06293ef92fd46324fc2cb9ce6e" VOLUMIO_FE3_VERSION="c5cad6acce062070373bc18affd0d2a1a9956a16" VOLUMIO_BE_VERSION="0fad662d4c47d7729fc677cd069fd5e675bebf9c" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="ifi" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Nov 15 15:45:37 CST 2025" VOLUMIO_VERSION="0.00.7" VOLUMIO_HARDWARE="zen-stream3" VOLUMIO_DEVICENAME="ZEN Stream3" VOLUMIO_HASH="3350ed41a04d50b70f39bebb8e49f746"