-- Logs begin at Thu 2026-04-23 08:04:08 UTC, end at Sat 2026-10-17 03:09:32 UTC. -- Oct 17 03:09:07 ifi-idsd-phantom sudo[1110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 17 03:09:07 ifi-idsd-phantom sudo[1110]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:07 ifi-idsd-phantom sudo[1110]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:07 ifi-idsd-phantom systemd[1]: Starting Daily apt download activities... Oct 17 03:09:07 ifi-idsd-phantom ntpd[977]: receive: Unexpected origin timestamp 0xed945110.847310c3 does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xee7d6553.57a83c6c Oct 17 03:09:07 ifi-idsd-phantom ntpd[977]: receive: Unexpected origin timestamp 0xed945110.848194ef does not match aorg 0000000000.00000000 from server@193.182.111.141 xmt 0xee7d6553.65d05354 Oct 17 03:09:08 ifi-idsd-phantom wireless.js[450]: trying... Oct 17 03:09:08 ifi-idsd-phantom systemd[1]: apt-daily.service: Succeeded. Oct 17 03:09:08 ifi-idsd-phantom systemd[1]: Started Daily apt download activities. Oct 17 03:09:08 ifi-idsd-phantom sudo[1169]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 17 03:09:08 ifi-idsd-phantom sudo[1169]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:08 ifi-idsd-phantom sudo[1169]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:08 ifi-idsd-phantom systemd[1]: Starting Daily apt upgrade and clean activities... Oct 17 03:09:09 ifi-idsd-phantom systemd[1]: apt-daily-upgrade.service: Succeeded. Oct 17 03:09:09 ifi-idsd-phantom systemd[1]: Started Daily apt upgrade and clean activities. Oct 17 03:09:09 ifi-idsd-phantom wireless.js[450]: trying... Oct 17 03:09:09 ifi-idsd-phantom sudo[1221]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 17 03:09:09 ifi-idsd-phantom sudo[1221]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:09 ifi-idsd-phantom sudo[1221]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:10 ifi-idsd-phantom wireless.js[450]: trying... Oct 17 03:09:10 ifi-idsd-phantom sudo[1235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 17 03:09:10 ifi-idsd-phantom sudo[1235]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:10 ifi-idsd-phantom sudo[1235]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:11 ifi-idsd-phantom wireless.js[450]: trying... Oct 17 03:09:11 ifi-idsd-phantom sudo[1238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 17 03:09:11 ifi-idsd-phantom sudo[1238]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:11 ifi-idsd-phantom sudo[1238]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:12 ifi-idsd-phantom wireless.js[450]: trying... Oct 17 03:09:12 ifi-idsd-phantom sudo[1250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 17 03:09:12 ifi-idsd-phantom sudo[1250]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:12 ifi-idsd-phantom sudo[1250]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:13 ifi-idsd-phantom wireless.js[450]: Overtime, starting plan B Oct 17 03:09:13 ifi-idsd-phantom wireless.js[450]: STARTING HOTSPOT Oct 17 03:09:13 ifi-idsd-phantom wpa_supplicant[838]: nl80211: Failed to open /proc/sys/net/ipv4/conf/wlan0/drop_unicast_in_l2_multicast: No such file or directory Oct 17 03:09:13 ifi-idsd-phantom wpa_supplicant[838]: nl80211: Failed to set IPv4 unicast in multicast filter Oct 17 03:09:13 ifi-idsd-phantom wpa_supplicant[838]: nl80211: Failed to open /proc/sys/net/ipv4/conf/wlan0/drop_unicast_in_l2_multicast: No such file or directory Oct 17 03:09:13 ifi-idsd-phantom wpa_supplicant[838]: nl80211: Failed to set IPv4 unicast in multicast filter Oct 17 03:09:13 ifi-idsd-phantom wpa_supplicant[838]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Oct 17 03:09:13 ifi-idsd-phantom wpa_supplicant[838]: wlan0: CTRL-EVENT-TERMINATING Oct 17 03:09:16 ifi-idsd-phantom sudo[1300]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Oct 17 03:09:16 ifi-idsd-phantom sudo[1300]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:16 ifi-idsd-phantom sudo[1300]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:16 ifi-idsd-phantom sudo[1302]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Oct 17 03:09:16 ifi-idsd-phantom sudo[1302]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:16 ifi-idsd-phantom sudo[1302]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:16 ifi-idsd-phantom wireless.js[450]: Hotspot is disabled, not starting it Oct 17 03:09:16 ifi-idsd-phantom iwconfig[1307]: Error for wireless request "Set Power Management" (8B2C) : Oct 17 03:09:16 ifi-idsd-phantom iwconfig[1307]: SET failed on device wlan0 ; Operation not permitted. Oct 17 03:09:16 ifi-idsd-phantom systemd[1]: wireless.service: Succeeded. Oct 17 03:09:16 ifi-idsd-phantom systemd[1]: Started Wireless Services. Oct 17 03:09:16 ifi-idsd-phantom systemd[1]: Started Volumio Backend Module. Oct 17 03:09:16 ifi-idsd-phantom systemd[1]: Started Volumio Cpu Tweaker. Oct 17 03:09:16 ifi-idsd-phantom systemd[1]: Reached target Multi-User System. Oct 17 03:09:16 ifi-idsd-phantom systemd[1]: Reached target Graphical Interface. Oct 17 03:09:16 ifi-idsd-phantom systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 17 03:09:16 ifi-idsd-phantom node[469]: Success: init system mode AIO Oct 17 03:09:16 ifi-idsd-phantom volumio-cpu-tweak[1309]: Setting RT Priority for mpd Oct 17 03:09:16 ifi-idsd-phantom volumio-cpu-tweak[1309]: Setting MPD Affinity Oct 17 03:09:16 ifi-idsd-phantom volumio-cpu-tweak[1309]: pid 745's current affinity mask: f Oct 17 03:09:16 ifi-idsd-phantom volumio-cpu-tweak[1309]: pid 745's new affinity mask: 3 Oct 17 03:09:16 ifi-idsd-phantom systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Oct 17 03:09:16 ifi-idsd-phantom volumio-cpu-tweak[1309]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Oct 17 03:09:16 ifi-idsd-phantom systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 17 03:09:16 ifi-idsd-phantom volumio-cpu-tweak[1309]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Oct 17 03:09:16 ifi-idsd-phantom systemd[1]: Startup finished in 3.359s (kernel) + 34.729s (userspace) = 38.089s. Oct 17 03:09:16 ifi-idsd-phantom systemd[1]: volumio_cpu_tweak.service: Succeeded. Oct 17 03:09:19 ifi-idsd-phantom volumio[1308]: info: ------------------------------------------- Oct 17 03:09:19 ifi-idsd-phantom volumio[1308]: info: ----- Volumio3 ---- Oct 17 03:09:19 ifi-idsd-phantom volumio[1308]: info: ------------------------------------------- Oct 17 03:09:19 ifi-idsd-phantom volumio[1308]: info: ----- System startup ---- Oct 17 03:09:19 ifi-idsd-phantom volumio[1308]: info: ------------------------------------------- Oct 17 03:09:19 ifi-idsd-phantom volumio[1308]: info: ConvSwitch: Client Start Oct 17 03:09:19 ifi-idsd-phantom volumio[1308]: info: MetaClient: Client Start Oct 17 03:09:19 ifi-idsd-phantom node[469]: A new connection has been established. Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Plugin folders cleanup Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Scanning into folder /volumio/app/plugins/ Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Scanning category audio_interface Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Scanning category miscellanea Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Scanning category music_service Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Scanning category plugins.json Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Scanning category system_controller Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Scanning category user_interface Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Scanning into folder /data/plugins/ Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Scanning category music_service Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Plugin folders cleanup completed Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: ------------------------------------------- Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: ----- Core plugins startup ---- Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: ------------------------------------------- Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Loading plugins from folder /volumio/app/plugins/ Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Adding plugin networkaudiod to MyMusic Plugins Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Adding plugin qobuz_connect to MyMusic Plugins Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Adding plugin spotify_connect to MyMusic Plugins Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Adding plugin tidal_connect to MyMusic Plugins Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Adding plugin upnp to MyMusic Plugins Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Adding plugin airplay1_switch to MyMusic Plugins Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Adding plugin airplay2_switch to MyMusic Plugins Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Adding plugin roon_ready to MyMusic Plugins Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Loading plugins from folder /data/plugins/ Oct 17 03:09:20 ifi-idsd-phantom volumio[1308]: info: Loading plugin "system"... Oct 17 03:09:21 ifi-idsd-phantom volumio[1308]: info: Loading plugin "appearance"... Oct 17 03:09:22 ifi-idsd-phantom volumio[1308]: info: Loading plugin "network"... Oct 17 03:09:22 ifi-idsd-phantom volumio[1308]: info: Refreshing Cached IP Addresses Oct 17 03:09:22 ifi-idsd-phantom sudo[1391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 17 03:09:22 ifi-idsd-phantom sudo[1391]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:22 ifi-idsd-phantom sudo[1391]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:22 ifi-idsd-phantom sudo[1393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 17 03:09:22 ifi-idsd-phantom sudo[1393]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:23 ifi-idsd-phantom sudo[1393]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:23 ifi-idsd-phantom volumio[1308]: info: Loading plugin "services"... Oct 17 03:09:23 ifi-idsd-phantom volumio[1308]: info: Loading plugin "alsa_controller"... Oct 17 03:09:23 ifi-idsd-phantom sudo[1406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 17 03:09:23 ifi-idsd-phantom sudo[1406]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:23 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 03:09:23 ifi-idsd-phantom volumio[1308]: info: Loading plugin "wizard"... Oct 17 03:09:23 ifi-idsd-phantom volumio[1308]: info: Loading plugin "networkfs"... Oct 17 03:09:23 ifi-idsd-phantom volumio[1308]: info: Starting Udev Watcher for removable devices Oct 17 03:09:23 ifi-idsd-phantom volumio[1308]: error: Cannot associate FS Label, not mounting Oct 17 03:09:23 ifi-idsd-phantom volumio[1308]: error: Cannot associate FS Label, not mounting Oct 17 03:09:23 ifi-idsd-phantom volumio[1308]: info: Ignoring mount for partition: BOOT Oct 17 03:09:23 ifi-idsd-phantom volumio[1308]: info: Ignoring mount for partition: archivefs Oct 17 03:09:23 ifi-idsd-phantom volumio[1308]: info: Ignoring mount for partition: rootfs Oct 17 03:09:23 ifi-idsd-phantom volumio[1308]: info: Mounting Device C1_摄影_备_2T Oct 17 03:09:23 ifi-idsd-phantom kernel: start_addr=(0x8000), end_addr=(0x10000), buffer_size=(0x8000), smp_number_max=(4096) Oct 17 03:09:24 ifi-idsd-phantom sudo[1429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/C1_摄影_备_2T -o noatime Oct 17 03:09:24 ifi-idsd-phantom sudo[1429]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:24 ifi-idsd-phantom mount.exfat[1439]: volume was not unmounted cleanly Oct 17 03:09:24 ifi-idsd-phantom sudo[1429]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:24 ifi-idsd-phantom volumio[1308]: WARN: volume was not unmounted cleanly. Oct 17 03:09:24 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 17 03:09:24 ifi-idsd-phantom volumio[1308]: info: Loading plugin "volumio_command_line_client"... Oct 17 03:09:24 ifi-idsd-phantom volumio[1308]: info: Loading plugin "networkaudiod"... Oct 17 03:09:24 ifi-idsd-phantom volumio[1308]: info: [1792206564300] Starting NAA Service Oct 17 03:09:24 ifi-idsd-phantom volumio[1308]: info: Loading plugin "tidal_connect"... Oct 17 03:09:24 ifi-idsd-phantom volumio[1308]: info: [1792206564326] Starting Tidal Connect Service Oct 17 03:09:24 ifi-idsd-phantom volumio[1308]: info: Loading plugin "upnp"... Oct 17 03:09:24 ifi-idsd-phantom sudo[1443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart networkaudiod.service Oct 17 03:09:24 ifi-idsd-phantom sudo[1443]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:24 ifi-idsd-phantom volumio[1308]: info: [1792206564340] Starting Upmpd Daemon Oct 17 03:09:24 ifi-idsd-phantom volumio[1308]: info: Starting Upmpd Daemon Oct 17 03:09:24 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 17 03:09:24 ifi-idsd-phantom volumio[1308]: error: ATTENTION!!!: Plugin upnp does not return adequate promise from onVolumioStart: please update! Oct 17 03:09:24 ifi-idsd-phantom volumio[1308]: info: Loading plugin "my_music"... Oct 17 03:09:24 ifi-idsd-phantom volumio[1308]: info: Loading plugin "mpd"... Oct 17 03:09:24 ifi-idsd-phantom systemd[1]: Stopping Network Audio Adapter daemon... Oct 17 03:09:24 ifi-idsd-phantom systemd[1]: networkaudiod.service: Succeeded. Oct 17 03:09:24 ifi-idsd-phantom systemd[1]: Stopped Network Audio Adapter daemon. Oct 17 03:09:24 ifi-idsd-phantom systemd[1]: Started Network Audio Adapter daemon. Oct 17 03:09:24 ifi-idsd-phantom sudo[1443]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:24 ifi-idsd-phantom networkaudiod[1445]: [/usr/sbin/networkaudiod] (1445): networkaudiod Copyright (C) 2011-2020 Jussi Laako / Signalyst. All rights reserved. Oct 17 03:09:24 ifi-idsd-phantom networkaudiod[1445]: [/usr/sbin/networkaudiod] (1445): create alsa engine Oct 17 03:09:24 ifi-idsd-phantom networkaudiod[1445]: [/usr/sbin/networkaudiod] (1445): listen discovery on :: Oct 17 03:09:24 ifi-idsd-phantom networkaudiod[1445]: [/usr/sbin/networkaudiod] (1445): clSocket::SetOption(): setsockopt(..., 41,20, ...): No such device Oct 17 03:09:24 ifi-idsd-phantom networkaudiod[1445]: [/usr/sbin/networkaudiod] (1445): Socket failure, falling back to IPv4-only! Oct 17 03:09:25 ifi-idsd-phantom volumio[1308]: info: Loading plugin "upnp_browser"... Oct 17 03:09:25 ifi-idsd-phantom networkaudiod[1445]: [/usr/sbin/networkaudiod] (1445): listen discovery on 0.0.0.0 Oct 17 03:09:25 ifi-idsd-phantom volumio[1308]: info: Loading plugin "qobuz_connect"... Oct 17 03:09:25 ifi-idsd-phantom volumio[1308]: info: [1792206565533] Starting Qobuz Connect Service Oct 17 03:09:25 ifi-idsd-phantom volumio[1308]: info: Loading plugin "alarm-clock"... Oct 17 03:09:25 ifi-idsd-phantom volumio[1308]: info: Loading plugin "last_100"... Oct 17 03:09:25 ifi-idsd-phantom volumio[1308]: info: Loading plugin "roon_ready"... Oct 17 03:09:25 ifi-idsd-phantom volumio[1308]: info: Starting RoonReady Sync Oct 17 03:09:25 ifi-idsd-phantom volumio[1308]: info: Loading plugin "webradio"... Oct 17 03:09:25 ifi-idsd-phantom volumio[1308]: info: Loading plugin "i2s_dacs"... Oct 17 03:09:25 ifi-idsd-phantom volumio[1308]: info: I2S DAC not set, start Auto-detection Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: Loading plugin "volumiodiscovery"... Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: *** WARNING *** For more information see Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 17 03:09:26 ifi-idsd-phantom node[1308]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: *** WARNING *** For more information see Oct 17 03:09:26 ifi-idsd-phantom node[1308]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 17 03:09:26 ifi-idsd-phantom node[1308]: *** WARNING *** For more information see Oct 17 03:09:26 ifi-idsd-phantom node[1308]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 17 03:09:26 ifi-idsd-phantom node[1308]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 17 03:09:26 ifi-idsd-phantom node[1308]: *** WARNING *** For more information see Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: Loading plugin "spotify_connect"... Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: [1792206566143] Starting Spotify Connect Service Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: Plugin airplay1_switch is not enabled Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: Loading plugin "airplay2_switch"... Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: Loading plugin "airplay_emulation"... Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: Starting Shairport Sync Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: Loading plugin "outputs"... Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: Loading plugin "albumart"... Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: Plugin example_plugin is not enabled Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: Loading plugin "inputs"... Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: Loading plugin "updater_comm"... Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: Plugin mpdemulation is not enabled Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: Loading plugin "rest_api"... Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: Loading plugin "websocket"... Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: Starting Socket.io Server version 2.3.0 Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: Plugin ifi-cdplayer is not enabled Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: Loading i18n strings for locale en Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: Updating browse sources language Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 03:09:26 ifi-idsd-phantom volumio[1308]: Forking 3 albumart workers Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::initPlayerControls Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: Express server listening on port 3000 Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: [Metrics] WebUI: 8s 835.02ms Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: Meta server listening Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreStateMachine::resetVolumioState Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreStateMachine::getcurrentVolume Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioRetrievevolume Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreStateMachine::pushState Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CorePlayQueue::getTrack 0 Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioPushState Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: Server listening on port 6599 Oct 17 03:09:27 ifi-idsd-phantom sudo[1502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Oct 17 03:09:27 ifi-idsd-phantom sudo[1502]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: Completed loading Core Plugins Oct 17 03:09:27 ifi-idsd-phantom sudo[1503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Oct 17 03:09:27 ifi-idsd-phantom sudo[1503]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: Preparing to generate the ALSA configuration file Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: ConvSwitch: Connected to server Oct 17 03:09:27 ifi-idsd-phantom node[456]: ConvSwitch: Add client volumio Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: MetaClient: Connected to server Oct 17 03:09:27 ifi-idsd-phantom systemd[1]: Started iFi Streamer Qobuz Connect Service. Oct 17 03:09:27 ifi-idsd-phantom sudo[1503]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:27 ifi-idsd-phantom systemd[1]: Started iFi Streamer Tidal Connect Service. Oct 17 03:09:27 ifi-idsd-phantom sudo[1502]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: Volumio Network Manager: Network status updated: 1 Oct 17 03:09:27 ifi-idsd-phantom systemd[1]: Started iFi Streamer Tidal Metadata Service. Oct 17 03:09:27 ifi-idsd-phantom volumio[1308]: info: NAA Service Started Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 17 03:09:28 ifi-idsd-phantom node[456]: ConvSwitch: Add client tidal Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: ConvSwitch: Get message: success Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: MetaClient: Get message: success Oct 17 03:09:28 ifi-idsd-phantom node[469]: A new connection has been established. Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: Tidal Connect Service Started Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: Qobuz Connect Service Started Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.367 [1542.1542] DEBUG SampleApp: Starting sample application Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.367 [1542.1542] DEBUG SampleApp: Device Name: iDSD PHANTOM Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.367 [1542.1542] DEBUG SampleApp: Manufacturer: Sample manufacturer Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.367 [1542.1542] DEBUG SampleApp: Model: iFi Streamer Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.367 [1542.1542] DEBUG SampleApp: Serial Number: ifi:76:d3:fd:f3:ca:c3 Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.367 [1542.1542] DEBUG SampleApp: Audio output device: volumio Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.368 [1542.1542] DEBUG SampleApp: Volume control device: default Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.368 [1542.1542] DEBUG SampleApp: Volume control element: Master Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.368 [1542.1542] DEBUG SampleApp: Local config server port: 8000 Oct 17 03:09:28 ifi-idsd-phantom play[1508]: [Info] MetaClient: MetaClient SDK -- v1.03 Oct 17 03:09:28 ifi-idsd-phantom node[469]: A new connection has been established. Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: Reloading queue from file Oct 17 03:09:28 ifi-idsd-phantom play[1508]: [Info] MetaClient: MetaClientInit Oct 17 03:09:28 ifi-idsd-phantom play[1508]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Oct 17 03:09:28 ifi-idsd-phantom node[456]: ConvSwitch: Add client qobuz-connect Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: Asound.conf file unchanged, so no further update is needed Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: Tidal connect: Output device has changed Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: Output device has changed, restarting MPD Oct 17 03:09:28 ifi-idsd-phantom play[1508]: [Info] ConvSwitch: ConvSwitchInit Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.486 [1542.1542] ERROR SampleApp: Unable to find ALSA mixer element 'Master' on index 0 Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.488 [1542.1542] DEBUG SampleApp: Maximum supported audio quality: HIRES_L3 Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: Qobuz connect: Output device has changed Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: Roon Ready: Output device has changed Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: Spotify: Output device has changed Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.534 [1542.1542] DEBUG ActiveStateManager: [0xab1cd9a0]: Creating new Active State Manager Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.534 [1542.1542] DEBUG NetworkActivityTracker: [0xab1cda10]: Creating new Network Activity Tracker Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: ___________ START PLUGINS ___________ Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.541 [1542.1542] DEBUG EndpointManager: [0xab1ce988]: Creating Endpoint Manager Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.541 [1542.1542] DEBUG PlaybackSessionManager: [0xab1ced78]: Creating Playback Session Manager Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] DEBUG BackoffTimer: [0xab1ceef0]: Creating Backoff Timer Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] DEBUG MediaEngine: [0xab1cf010]: Creating new Media Engine Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] DEBUG AudioRenderer: [0xab1cf230]: Creating Audio Renderer Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] TRACE MediaEngineCommandSequencer: [0xab1cf388]: Creating Media Engine Command Sequencer Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] DEBUG PlaybackControlsManager: [0xab1cf3e8]: Creating new Playback Controls Manager Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] DEBUG VolumeManager: [0xab1cf478]: Creating new Volume Manager Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] DEBUG ProtocolHandler: [0xab1cf750]: Creating Protocol Handler Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] DEBUG MessageReceiver: [0xab1cf7f0]: Creating Message Receiver Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] DEBUG RendererActivationController: [0xab1cf968]: Creating new Renderer Activation Controller Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] TRACE RendererActivationCommandSequencer: [0xab1cfa10]: Creating Renderer Activation Command Sequencer Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] DEBUG ReportingManager: [0xab1cfb20]: Creating new Reporting Manager Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] DEBUG StreamingEventReporter: [0xab1cfb68]: Creating Streaming Event Reporter Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] DEBUG BackoffTimer: [0xab1cfc48]: Creating Backoff Timer Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] DEBUG TokenExpiryController: [0xab1cfd58]: Creating Token Expiry Controller Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] DEBUG UserInactivityManager: [0xab1cfda8]: Creating new User Inactivity Manager Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] INFO VolumeManager: [0xab1cf478]: Setting new playback volume: 100 Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] INFO VolumeManager: [0xab1cf478]: Setting new mute state: 0 Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] DEBUG SampleApp: Qobuz Connect has been initialized Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] TRACE SampleApp: Running event loop Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] INFO QobuzConnect: [0xab1cfe48]: Client initialized! Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.542 [1542.1542] INFO SampleApp: Starting Avahi advertising, name: iDSD PHANTOM, service name: _qobuz-connect._tcp Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.564 [1542.1542] DEBUG SampleApp: Avahi client state changed: RUNNING Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.569 [1542.1542] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.577 [1542.1542] INFO LocalConfigManager: [0xab1ced58]: Starting Local Configuration server Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.578 [1542.1542] INFO SampleApp: Starting Local configuration server Oct 17 03:09:28 ifi-idsd-phantom sudo[1551]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.579 [1542.1542] DEBUG SampleApp: Avahi entry group state changed: REGISTERING Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: ControllerMpd::onStart: Initializing MPD Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: Creating MPD Configuration file Oct 17 03:09:28 ifi-idsd-phantom sudo[1551]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:28 ifi-idsd-phantom sudo[1406]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.621 [1542.1542] INFO SampleApp: Playback volume changed: 100 Oct 17 03:09:28 ifi-idsd-phantom play[1508]: 20261017 03:09:28.621 [1542.1542] ERROR SampleApp: Unable to set volume, no ALSA volume element Oct 17 03:09:28 ifi-idsd-phantom sudo[1551]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: [1792206568679] CoreMusicLibrary::Adding element Media Servers Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 03:09:28 ifi-idsd-phantom sudo[1557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 03:09:28 ifi-idsd-phantom sudo[1557]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:28 ifi-idsd-phantom sudo[1557]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:28 ifi-idsd-phantom sudo[1558]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Oct 17 03:09:28 ifi-idsd-phantom sudo[1558]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: [1792206568782] CoreMusicLibrary::Adding element Last_100 Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: Starting RoonReady Sync Oct 17 03:09:28 ifi-idsd-phantom systemd[1]: mpd.socket: Succeeded. Oct 17 03:09:28 ifi-idsd-phantom systemd[1]: Closed mpd.socket. Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: [1792206568823] CoreMusicLibrary::Adding element Webradio Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 03:09:28 ifi-idsd-phantom systemd[1]: Stopping Music Player Daemon... Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: info: Initializing BBC Radios Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: Starting albumart workers Oct 17 03:09:28 ifi-idsd-phantom sudo[1562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Oct 17 03:09:28 ifi-idsd-phantom sudo[1562]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:28 ifi-idsd-phantom volumio[1308]: Starting albumart workers Oct 17 03:09:28 ifi-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Oct 17 03:09:28 ifi-idsd-phantom sudo[1562]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:28 ifi-idsd-phantom systemd[1]: mpd.service: Succeeded. Oct 17 03:09:29 ifi-idsd-phantom systemd[1]: Stopped Music Player Daemon. Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 03:09:29 ifi-idsd-phantom play[1566]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 03:09:29 ifi-idsd-phantom sudo[1558]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: Starting albumart workers Oct 17 03:09:29 ifi-idsd-phantom sudo[1579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -snf /usr/local/bin/airplay2 /usr/local/bin/shairport-sync Oct 17 03:09:29 ifi-idsd-phantom sudo[1579]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:29 ifi-idsd-phantom sudo[1579]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 03:09:29 ifi-idsd-phantom play[1508]: 20261017 03:09:29.500 [1542.1542] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: CoreStateMachine::setRepeat true single undefined Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: CoreStateMachine::pushState Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: CorePlayQueue::getTrack 0 Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioPushState Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: CoreStateMachine::setRandom null Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: CoreStateMachine::pushState Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: CorePlayQueue::getTrack 0 Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioPushState Oct 17 03:09:29 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 03:09:29 ifi-idsd-phantom node[456]: ConvSwitch: Add client roon-ready Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: Starting RoonReady Sync Oct 17 03:09:30 ifi-idsd-phantom sudo[1640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Oct 17 03:09:30 ifi-idsd-phantom sudo[1640]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: ConvSwitch: Get message: request:pause Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioStop Oct 17 03:09:30 ifi-idsd-phantom sudo[1644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Oct 17 03:09:30 ifi-idsd-phantom sudo[1644]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: CoreStateMachine::stop Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 03:09:30 ifi-idsd-phantom systemd[1]: Stopping iFi Streamer Roon Ready Service... Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: hid-generic 0003:20B1:3008.0003: hiddev0,hidraw0: USB HID v1.10 Device [iFi (by AMR) iDSD PHANTOM] on usb-xhci-hcd.0.auto-1.2/input3 Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:30 ifi-idsd-phantom kernel: input: iFi (by AMR) iDSD PHANTOM as /devices/platform/usb@ff600000/ff600000.dwc3/xhci-hcd.0.auto/usb4/4-1/4-1.2/4-1.2:1.4/0003:20B1:3008.0004/input/input4 Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: hid-generic 0003:20B1:3008.0004: input,hidraw1: USB HID v1.11 Device [iFi (by AMR) iDSD PHANTOM] on usb-xhci-hcd.0.auto-1.2/input4 Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom node[456]: ConvSwitch: Drop client roon-ready Oct 17 03:09:30 ifi-idsd-phantom node[456]: ConvSwitch: Drop client qobuz-connect Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioStop Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: CoreStateMachine::stop Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: Airplay2 Started Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: error: Could not retrieve plugin music_service airplay1_switch Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: Disabling plugin airplay1_switch Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: Done. Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: RoonReady Started Oct 17 03:09:30 ifi-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM Oct 17 03:09:30 ifi-idsd-phantom sudo[1646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Oct 17 03:09:30 ifi-idsd-phantom node[469]: Closing connection with the client qobuz-connect Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: MPD Permissions set Oct 17 03:09:30 ifi-idsd-phantom systemd[1]: ifi-streamer-roon-ready.service: Succeeded. Oct 17 03:09:30 ifi-idsd-phantom sudo[1646]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:30 ifi-idsd-phantom systemd[1]: Stopped iFi Streamer Roon Ready Service. Oct 17 03:09:30 ifi-idsd-phantom sudo[1640]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:30 ifi-idsd-phantom systemd[1]: Stopping iFi Streamer Qobuz Connect Service... Oct 17 03:09:30 ifi-idsd-phantom systemd[1]: Started iFi Streamer Roon Ready Service. Oct 17 03:09:30 ifi-idsd-phantom systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM Oct 17 03:09:30 ifi-idsd-phantom systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded. Oct 17 03:09:30 ifi-idsd-phantom systemd[1]: Stopped iFi Streamer Qobuz Connect Service. Oct 17 03:09:30 ifi-idsd-phantom sudo[1662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Oct 17 03:09:30 ifi-idsd-phantom sudo[1662]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:30 ifi-idsd-phantom systemd-udevd[1650]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom play[1660]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Oct 17 03:09:30 ifi-idsd-phantom sudo[1673]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Oct 17 03:09:30 ifi-idsd-phantom sudo[1673]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:30 ifi-idsd-phantom sudo[1644]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom sudo[1694]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Oct 17 03:09:30 ifi-idsd-phantom sudo[1694]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: verbose: New Socket.io Connection to 192.168.0.120 from 192.168.0.113 UA: unknown Engine version: 3 Transport: websocket Total Clients: 1 Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: RoonReady Started Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: Roon Ready playback start Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioStop Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: CoreStateMachine::stop Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 03:09:30 ifi-idsd-phantom sudo[1673]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: info: Starting Roon Ready metadata receiver Oct 17 03:09:30 ifi-idsd-phantom volumio[1308]: Error adding Membership: Error: addMembership EINVAL Oct 17 03:09:30 ifi-idsd-phantom sudo[1694]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:30 ifi-idsd-phantom systemd[1]: Listening on mpd.socket. Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:30 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 17 03:09:30 ifi-idsd-phantom systemd[1]: Started iFi Streamer Spotify Connect Service. Oct 17 03:09:30 ifi-idsd-phantom sudo[1646]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:31 ifi-idsd-phantom sudo[1662]: pam_unix(sudo:session): session closed for user root Oct 17 03:09:31 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:31 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:31 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:31 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:31 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom play[1717]: iDSD_PHANTOM Oct 17 03:09:31 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:31 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:31 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom ifi_metadata[1511]: [Info] MetaClient: MetaClient SDK -- v1.03 Oct 17 03:09:31 ifi-idsd-phantom ifi_metadata[1511]: [Info] MetaClient: MetaClientInit Oct 17 03:09:31 ifi-idsd-phantom ifi_metadata[1511]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Oct 17 03:09:31 ifi-idsd-phantom ifi_metadata[1511]: [Info] ConvSwitch: ConvSwitchInit Oct 17 03:09:31 ifi-idsd-phantom ifi_metadata[1511]: Could not connect: Reason::CONNECTION_ERROR Oct 17 03:09:31 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:31 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Oct 17 03:09:31 ifi-idsd-phantom kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Oct 17 03:09:31 ifi-idsd-phantom play[1717]: output: volumio mixer: hw:0 Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioGetState Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CorePlayQueue::getTrack 0 Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioGetQueue Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreStateMachine::getQueue Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CorePlayQueue::getQueue Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioGetVisibleSources Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 03:09:31 ifi-idsd-phantom node[456]: ConvSwitch: Add client roon-ready Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 17 03:09:31 ifi-idsd-phantom node[456]: ConvSwitch: Add client spotify Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CURURI: music-library/USB Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: error: Failed to execute browseSource, failure: TypeError: Cannot read property 'then' of undefined Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioGetState Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CorePlayQueue::getTrack 0 Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioGetState Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CorePlayQueue::getTrack 0 Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioGetState Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CorePlayQueue::getTrack 0 Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioGetState Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CorePlayQueue::getTrack 0 Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioGetState Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CorePlayQueue::getTrack 0 Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioGetState Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CorePlayQueue::getTrack 0 Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioGetState Oct 17 03:09:31 ifi-idsd-phantom node[469]: A new connection has been established. Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CorePlayQueue::getTrack 0 Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioGetState Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CorePlayQueue::getTrack 0 Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioGetState Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CorePlayQueue::getTrack 0 Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioGetState Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CorePlayQueue::getTrack 0 Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioGetState Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CorePlayQueue::getTrack 0 Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::volumioGetState Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CorePlayQueue::getTrack 0 Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: verbose: ControllerMpd::sendMpdCommand update Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: TypeError: Cannot read property 'then' of undefined Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:336:6) Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: at ControllerMpd.updateDb (/volumio/app/plugins/music_service/mpd/index.js:2269:15) Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1228:32) Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1513:26) Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: at Socket.emit (events.js:400:28) Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Oct 17 03:09:31 ifi-idsd-phantom volumio[1308]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.334 I api :141 SpRegisterDebugCallbacks SpRegisterDebugCallbacks [returned value: 0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.335 I api :57 SpInit SpInit(0xff93d560, API v85) Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.335 I esdk :1740 esdkSpInit eSDK version: esdk-v3.211-v3.211.126-g38bc1087 Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.338 T esdk :256 sp_korn_request_memory_block Module requested 600 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.338 T esdk :256 sp_korn_request_memory_block Module requested 184 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.338 T esdk :256 sp_korn_request_memory_block Module requested 200 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.338 T esdk :358 sp_korn_init_module Initializing module SocketManager Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.338 T esdk :256 sp_korn_request_memory_block Module requested 112 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.338 T esdk :358 sp_korn_init_module Initializing module API Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.338 T esdk :256 sp_korn_request_memory_block Module requested 3560 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.338 T esdk api :358 sp_korn_init_module Initializing module MediaOut Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.338 T esdk api :256 sp_korn_request_memory_block Module requested 136 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.338 T esdk api :256 sp_korn_request_memory_block Module requested 2344 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.338 T esdk api :256 sp_korn_request_memory_block Module requested 40 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.338 T esdk api :256 sp_korn_request_memory_block Module requested 976 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.338 D esdk api :2005 sp_module_media_out_init raise EXTERNAL_STUTTERS_POINTER Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.338 D esdk api :2007 sp_module_media_out_init raise PREVIOUS_POSITION Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.338 T esdk api :358 sp_korn_init_module Initializing module APConn Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.338 T esdk api :256 sp_korn_request_memory_block Module requested 26784 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.338 T esdk api :256 sp_korn_request_memory_block Module requested 25160 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.339 T esdk api :256 sp_korn_request_memory_block Module requested 56 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.339 T esdk api :256 sp_korn_request_memory_block Module requested 1040 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.339 D esdk api :1140 sp_module_ap_conn_init raise AP_CREATED Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.339 T esdk api :358 sp_korn_init_module Initializing module Streamer Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.339 T esdk api :256 sp_korn_request_memory_block Module requested 8472 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.339 D esdk api :1419 sp_module_streamer_init raise STREAMER_TRACK_PERCENTAGE Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.339 T esdk api :358 sp_korn_init_module Initializing module TrackPlayback Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.339 T esdk api :256 sp_korn_request_memory_block Module requested 214848 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.339 D esdk api :3390 sp_module_track_playback_init raise TPAPI_SHARED_STATE_POINTER Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.340 T esdk api :358 sp_korn_init_module Initializing module mDNS Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.340 T zc api :39 sp_module_mdns_init Request memory block of 1 KiB for mDNS module Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.340 T esdk api :256 sp_korn_request_memory_block Module requested 1536 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.340 T esdk api :358 sp_korn_init_module Initializing module WebServer Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.340 T zc api :34 sp_module_webserver_init Request memory block of 2 KiB for webserver module Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.340 T esdk api :256 sp_korn_request_memory_block Module requested 2048 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.340 T esdk api :358 sp_korn_init_module Initializing module ZeroConfServer Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.340 T zc api :21 sp_module_zeroconf_init Request memory block of 0 KiB for zeroconf module Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.340 T esdk api :256 sp_korn_request_memory_block Module requested 8 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.340 I esdk api :353 register_socket_callbacks 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 Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.340 I esdk api :333 register_dns_callbacks Successfully registered dns callback: dns_lookup_callback Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.340 D esdk event:EXTERNAL_STUTTERS_POINTER :466 sp_korn_dispatch_event [0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.341 D esdk event:PREVIOUS_POSITION :466 sp_korn_dispatch_event [0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.341 D esdk event:AP_CREATED :466 sp_korn_dispatch_event [0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.341 D esdk event:STREAMER_TRACK_PERCENTAGE :466 sp_korn_dispatch_event [0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.341 D esdk event:TPAPI_SHARED_STATE_POINTE :466 sp_korn_dispatch_event [0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.341 D esdk event:KORN_INITIALIZED :466 sp_korn_dispatch_event [0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.341 I download event:KORN_INITIALIZED :211 alloc_circular_buffer Using 128 kB for cache buffer Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.341 T esdk event:KORN_INITIALIZED :256 sp_korn_request_memory_block Module requested 131072 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.342 I download event:KORN_INITIALIZED :211 alloc_circular_buffer Using 606 kB for compressed audio buffer Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.342 T esdk event:KORN_INITIALIZED :256 sp_korn_request_memory_block Module requested 621104 bytes Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.342 I api api :1295 SpGetDefaultSocketHALCallbacks SpGetDefaultSocketHALCallbacks() Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.342 I api api :1297 SpGetDefaultSocketHALCallbacks SpGetDefaultSocketHALCallbacks [returned value: 0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.351 D esdk api :1798 esdkSpInit raise REDELIVER_AUDIO_AT_RESUME Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.351 I esdk api :445 register_error_callbacks Successfully registered error callback Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.351 D esdk api :1809 esdkSpInit raise SET_VOLUME Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.351 D esdk api :1812 esdkSpInit raise VOLUME_STEPS Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.351 D esdk api :3510 esdkSpSetDisplayName raise CONNECT_NAME Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.351 D esdk api :1519 save_session_config raise GROUP_STATE Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.351 D esdk api :1845 esdkSpInit raise UPDATE_CAPABILITIES Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.352 D esdk api :1866 esdkSpInit raise CONNECTIVITY Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.364 D esdk api :1889 esdkSpInit raise HOSTNAME Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk api :1897 esdkSpInit raise UPDATE_ALIASES Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk api :1899 esdkSpInit raise ZEROCONF_START Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk api :1921 esdkSpInit raise REQUEST_BITRATE Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk api :1924 esdkSpInit raise DISABLE_CONNECT Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk api :1927 esdkSpInit raise INIT_DONE Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk event:REDELIVER_AUDIO_AT_RESUME :466 sp_korn_dispatch_event [0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk event:SET_VOLUME :466 sp_korn_dispatch_event [32768] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk event:VOLUME_STEPS :466 sp_korn_dispatch_event [16] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk event:CONNECT_NAME :466 sp_korn_dispatch_event [0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk event:GROUP_STATE :466 sp_korn_dispatch_event [0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk event:UPDATE_CAPABILITIES :466 sp_korn_dispatch_event [0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 I esdk event:UPDATE_CAPABILITIES :2921 track_playback_event Updated capabilities = 1, updated formats = 1 Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk event:CONNECTIVITY :466 sp_korn_dispatch_event [1] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk event:CONNECTIVITY :1088 ap_conn_event raise CONNECTION_STATE_CHANGED Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk event:HOSTNAME :466 sp_korn_dispatch_event [17] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk event:UPDATE_ALIASES :466 sp_korn_dispatch_event [0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk event:ZEROCONF_START :466 sp_korn_dispatch_event [364773376] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk event:ZEROCONF_START :48 zeroconf_mod_event raise WEBSERVER_START Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk event:REQUEST_BITRATE :466 sp_korn_dispatch_event [3] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 T audio event:REQUEST_BITRATE :54 get_pos_from_integration track_id 0, provided_to_integration 0, is_seeking 0 Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk event:DISABLE_CONNECT :466 sp_korn_dispatch_event [0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.365 D esdk event:INIT_DONE :466 sp_korn_dispatch_event [0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.366 D esdk event:CONNECTION_STATE_CHANGED :466 sp_korn_dispatch_event [1] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.366 I esdk event:CONNECTION_STATE_CHANGED :569 handle_connection_state_change Connection state changed: 1 -> 1 Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.366 D esdk event:CONNECTION_STATE_CHANGED :125 webserver_mod_event raise WEBSERVER_UPDATED Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.366 D esdk event:WEBSERVER_START :466 sp_korn_dispatch_event [364773376] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.366 I esdk event:WEBSERVER_START :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.366 I zc event:WEBSERVER_START :484 webserver_initialize webserver: service port 5566 (5566-5566) buffer size 1880 Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.366 T zc event:WEBSERVER_START :60 webserver_mod_start webserver_initialize() = 0xf5cdade8 Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.366 D esdk event:WEBSERVER_START :63 webserver_mod_start raise WEBSERVER_STARTED Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.366 D esdk event:WEBSERVER_UPDATED :466 sp_korn_dispatch_event [0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.366 D esdk event:WEBSERVER_STARTED :466 sp_korn_dispatch_event [5566] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.366 D zc event:WEBSERVER_STARTED :583 webserver_bind bound path "/zc" Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.366 I zc event:WEBSERVER_STARTED :54 zeroconf_mod_event Started ZeroConf service on port 5566 path /zc Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.366 D esdk event:WEBSERVER_STARTED :59 zeroconf_mod_event raise MDNS_START Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.366 D esdk event:MDNS_START :466 sp_korn_dispatch_event [5566] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.366 I esdk event:MDNS_START :95 CallbackSocketCreate Creating IPv4 socket (domain 2) Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.367 D zc event:MDNS_START :928 mdns_initialize mDNS: service port 5566 path /zc buffer size 1264 Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.367 T zc event:MDNS_START :69 mdns_mod_start mdns_initialize() = 0xf5cda7f0 Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.367 I api api :59 SpInit SpInit [returned value: 0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.367 I api api :91 SpRegisterConnectionCallbacks SpRegisterConnectionCallbacks(0xff93d554, (nil)) Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.367 I esdk api :271 register_connection_callbacks Successfully registered connection callbacks: on_notify, on_message, - Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.367 I api api :93 SpRegisterConnectionCallbacks SpRegisterConnectionCallbacks [returned value: 0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.367 I api api :115 SpRegisterPlaybackCallbacks SpRegisterPlaybackCallbacks(0xff93d544, (nil)) Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.367 I esdk api :184 register_playback_callbacks Successfully registered playback callbacks: on_notify, -, on_apply_volume Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.367 I api api :117 SpRegisterPlaybackCallbacks SpRegisterPlaybackCallbacks [returned value: 0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.375 W app api /usr/src/app/volumio3/spotify/spotify-connect/examples/common/audio/linux_alsa.c:471 audio_init Couldn't find mixer for volume controls. (tried Master, PCM, Digital) Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.375 I api api :127 SpRegisterStreamCallbacks SpRegisterStreamCallbacks(0xff93c590, 0x368a0) Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.375 I esdk api :203 register_stream_callbacks Successfully registered delivery callbacks: on_start, on_data, on_pos, on_seek, on_flush, on_end Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.375 I api api :129 SpRegisterStreamCallbacks SpRegisterStreamCallbacks [returned value: 0] Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.375 I app api /usr/src/app/volumio3/spotify/spotify-connect/examples/example_delivery.c:273 main Initialized! Oct 17 03:09:31 ifi-idsd-phantom tidal_connect_application[1758]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi. Oct 17 03:09:31 ifi-idsd-phantom tidal_connect_application[1758]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 17 03:09:31 ifi-idsd-phantom tidal_connect_application[1758]: *** WARNING *** For more information see Oct 17 03:09:31 ifi-idsd-phantom ifi_metadata[1511]: Connected Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.823 D zc pump:mDNS :963 mdns_pump mDNS: Read 215 bytes from socket Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.824 D zc pump:mDNS :343 mdns_parse_questions read packet with question 1 flags 0x0 Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.824 D zc pump:mDNS :377 mdns_parse_questions read question for iFi Streamer-dc9883d1ab43f308817bf8aa01c33f3a._tidalconnect._tcp.local. (0xff) Oct 17 03:09:31 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:31.824 D zc pump:mDNS :383 mdns_parse_questions ignored, unrecognized question type ff Oct 17 03:09:32 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:32.074 D zc pump:mDNS :963 mdns_pump mDNS: Read 215 bytes from socket Oct 17 03:09:32 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:32.074 D zc pump:mDNS :343 mdns_parse_questions read packet with question 1 flags 0x0 Oct 17 03:09:32 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:32.074 D zc pump:mDNS :377 mdns_parse_questions read question for iFi Streamer-dc9883d1ab43f308817bf8aa01c33f3a._tidalconnect._tcp.local. (0xff) Oct 17 03:09:32 ifi-idsd-phantom play[1717]: 2026-10-17 03:09:32.074 D zc pump:mDNS :383 mdns_parse_questions ignored, unrecognized question type ff Oct 17 03:09:32 ifi-idsd-phantom sudo[1795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-17 03:08 Oct 17 03:09:32 ifi-idsd-phantom sudo[1795]: 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="88e690d6ca5d6a2e79f6a44738742624d952a43a" VOLUMIO_FE_VERSION="54aae9b0cae30f0ee38854e39b8ffa94a10c6061" VOLUMIO_FE3_VERSION="3455c2f8b3002f05c48a603a2e136bbb2d6d8a01" VOLUMIO_BE_VERSION="4520fceff198b992cfeeced04a97e9c8db23e62d" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="ifi" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Apr 23 16:08:18 CST 2026" VOLUMIO_VERSION="2.03.4" VOLUMIO_HARDWARE="idsd-phantom" VOLUMIO_DEVICENAME="iDSD PHANTOM" VOLUMIO_HASH="7939bd38f2009022f84d72d48dbcb3a0"