-- Logs begin at Sat 2025-11-15 07:41:13 UTC, end at Mon 2025-12-22 05:32:04 UTC. -- Dec 22 05:31:11 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 22 05:31:19 ifi-zen-stream3 volumiologrotate[494]: ls: cannot access '/var/log/samba/log.wb-ZEN': No such file or directory Dec 22 05:31:19 ifi-zen-stream3 volumiologrotate[494]: ls: cannot access 'STREAM3': No such file or directory Dec 22 05:31:20 ifi-zen-stream3 kernel: usb 4-1.1: USB disconnect, device number 5 Dec 22 05:31:20 ifi-zen-stream3 volumio[1261]: info: Dec 22 05:31:20 ifi-zen-stream3 volumio[1261]: ---------------------------- USB Audio Device Detached Dec 22 05:31:20 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::Close All Modals sent Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Preparing to save Alsa Options, stopping services first Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioGetState Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioPause Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::pause Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Saving Audio Output to: {"disallowPush":false,"output_device":{"value":"0,0","label":"SPDIF"}} Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , forceDoP Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Found match in Cards Database: setting mixer for card SPDIF Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Ignoring Mixers Options Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Device 0,0 does not have any Mixer Control Available Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Restoring Previous Volume level: 100 false false Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Updating Volume Controller Parameters: Device: 0,0 Name: SPDIF Mixer: None Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::pushState Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioPushState Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Preparing to generate the ALSA configuration file Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: wizard , refreshWizarOutputDevices Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Asound.conf file written Dec 22 05:31:21 ifi-zen-stream3 sudo[4179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 22 05:31:21 ifi-zen-stream3 kernel: usb 5-1.3: USB disconnect, device number 3 Dec 22 05:31:21 ifi-zen-stream3 sudo[4179]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:21 ifi-zen-stream3 sudo[4179]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: No state is present for card rkifispdif Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: Found hardware: "rk-ifi-spdif" "" "" "" "" Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: Hardware is initialized using a generic method Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: No state is present for card rkifispdif Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Tidal connect: Output device has changed Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Output device has changed, restarting MPD Dec 22 05:31:21 ifi-zen-stream3 kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Dec 22 05:31:21 ifi-zen-stream3 kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=0x00 Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Qobuz connect: Output device has changed Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Roon Ready: Output device has changed Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Spotify: Output device has changed Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Tidal connect: Output device has changed Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Output device has changed, restarting MPD Dec 22 05:31:21 ifi-zen-stream3 sudo[4188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 22 05:31:21 ifi-zen-stream3 sudo[4188]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:21 ifi-zen-stream3 sudo[4188]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Qobuz connect: Output device has changed Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Roon Ready: Output device has changed Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Spotify: Output device has changed Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Partition removed: {"syspath":"/sys/devices/platform/usb@ff600000/ff600000.dwc3/xhci-hcd.0.auto/usb5/5-1/5-1.3/5-1.3:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-Samsung_Flash_Drive_0362025080001663-0:0-part1 /dev/disk/by-uuid/82C0-08B6 /dev/disk/by-path/platform-xhci-hcd.0.auto-usb-0:1.3:1.0-scsi-0:0:0:0-part1 /dev/disk/by-label/Samsung\\x20USB /dev/disk/by-partuuid/099428c9-01","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/usb@ff600000/ff600000.dwc3/xhci-hcd.0.auto/usb5/5-1/5-1.3/5-1.3:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","ID_BUS":"usb","ID_FS_LABEL":"Samsung_USB","ID_FS_LABEL_ENC":"Samsung\\x20USB","ID_FS_TYPE":"exfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"82C0-08B6","ID_FS_UUID_ENC":"82C0-08B6","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"Flash_Drive","ID_MODEL_ENC":"Flash\\x20Drive\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"6300","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"128","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"125313123","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"099428c9-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"099428c9","ID_PATH":"platform-xhci-hcd.0.auto-usb-0:1.3:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-xhci-hcd_0_auto-usb-0_1_3_1_0-scsi-0_0_0_0","ID_REVISION":"1100","ID_SERIAL":"Samsung_Flash_Drive_0362025080001663-0:0","ID_SERIAL_SHORT":"0362025080001663","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Samsung","ID_VENDOR_ENC":"Samsung\\x20","ID_VENDOR_ID":"04e8","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"1754","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"6901213"} Dec 22 05:31:21 ifi-zen-stream3 sudo[4191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 22 05:31:21 ifi-zen-stream3 sudo[4191]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:21 ifi-zen-stream3 sudo[4191]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:21 ifi-zen-stream3 sudo[4194]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -lf /dev/sda1 Dec 22 05:31:21 ifi-zen-stream3 sudo[4194]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:21 ifi-zen-stream3 mount.exfat[1389]: non-zero reference counter (1) for '01 - Divertimento 48-24.flac' Dec 22 05:31:21 ifi-zen-stream3 systemd[1]: media-Samsung_USB.mount: Succeeded. Dec 22 05:31:21 ifi-zen-stream3 mount.exfat[1389]: failed to write super block Dec 22 05:31:21 ifi-zen-stream3 sudo[4194]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: MPD Permissions set Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: MPD Permissions set Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:21 ifi-zen-stream3 volumio[1261]: info: Starting RoonReady Sync Dec 22 05:31:22 ifi-zen-stream3 sudo[4211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Dec 22 05:31:22 ifi-zen-stream3 sudo[4210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: Starting RoonReady Sync Dec 22 05:31:22 ifi-zen-stream3 sudo[4210]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:22 ifi-zen-stream3 sudo[4211]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:22 ifi-zen-stream3 sudo[4214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Dec 22 05:31:22 ifi-zen-stream3 sudo[4214]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:22 ifi-zen-stream3 node[498]: Closing connection with the client roon-ready Dec 22 05:31:22 ifi-zen-stream3 sudo[4221]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Dec 22 05:31:22 ifi-zen-stream3 node[528]: ConvSwitch: Drop client roon-ready Dec 22 05:31:22 ifi-zen-stream3 node[528]: ConvSwitch: Drop client qobuz-connect Dec 22 05:31:22 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Roon Ready Service... Dec 22 05:31:22 ifi-zen-stream3 node[498]: Closing connection with the client qobuz-connect Dec 22 05:31:22 ifi-zen-stream3 sudo[4221]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:22 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Qobuz Connect Service... Dec 22 05:31:22 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM Dec 22 05:31:22 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Succeeded. Dec 22 05:31:22 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Roon Ready Service. Dec 22 05:31:22 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM Dec 22 05:31:22 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded. Dec 22 05:31:22 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Qobuz Connect Service. Dec 22 05:31:22 ifi-zen-stream3 sudo[4210]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:22 ifi-zen-stream3 sudo[4214]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:22 ifi-zen-stream3 systemd[1]: Started iFi Streamer Roon Ready Service. Dec 22 05:31:22 ifi-zen-stream3 sudo[4211]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: RoonReady Started Dec 22 05:31:22 ifi-zen-stream3 sudo[4221]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: RoonReady Started Dec 22 05:31:22 ifi-zen-stream3 play[4223]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Dec 22 05:31:22 ifi-zen-stream3 node[528]: ConvSwitch: Add client roon-ready Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: ConvSwitch: Get message: request:pause Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioStop Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::stop Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::updateTrackBlock Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrackBlock Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::stPlaybackTimer Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::pushState Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioPushState Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::serviceStop Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::serviceStop Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: ControllerMpd::stop Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: verbose: ControllerMpd::sendMpdCommand stop Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioStop Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::stop Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: ---------------------------- MPD announces state update: player Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: sendMpdCommand stop took 19 milliseconds Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: ControllerMpd::getState Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: verbose: ControllerMpd::sendMpdCommand status Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: ---------------------------- MPD announces state update: player Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: ControllerMpd::getState Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: verbose: ControllerMpd::sendMpdCommand status Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: Roon Ready playback start Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioStop Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::stop Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: Roon Ready metadata receiver is on Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: sendMpdCommand status took 19 milliseconds Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: sendMpdCommand status took 16 milliseconds Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: verbose: ControllerMpd::parseState Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioGetState Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: verbose: ControllerMpd::parseState Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioGetState Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: sendMpdCommand playlistinfo took 8 milliseconds Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: verbose: ControllerMpd::parseTrackInfo Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: verbose: ControllerMpd::parseTrackInfo Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: ControllerMpd::pushState Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::servicePushState Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::pushState Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioPushState Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Simple Symphony op. 4 - Boisterous Bourree 48kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac","trackType":"flac"} Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: verbose: CURRENT POSITION 5 Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: ControllerMpd::pushState Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::servicePushState Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::pushState Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioPushState Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Simple Symphony op. 4 - Boisterous Bourree 48kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac","trackType":"flac"} Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: verbose: CURRENT POSITION 5 Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: ------------------------------ 105ms Dec 22 05:31:22 ifi-zen-stream3 volumio[1261]: info: ------------------------------ 101ms Dec 22 05:31:22 ifi-zen-stream3 kernel: usb 4-1.3: new full-speed USB device number 6 using xhci-hcd Dec 22 05:31:22 ifi-zen-stream3 sudo[4283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Dec 22 05:31:22 ifi-zen-stream3 sudo[4283]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Dec 22 05:31:23 ifi-zen-stream3 node[498]: Closing connection with the client tidal-connect Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service... Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Dec 22 05:31:23 ifi-zen-stream3 node[528]: ConvSwitch: Drop client tidal Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service. Dec 22 05:31:23 ifi-zen-stream3 kernel: usb 4-1.3: not running at top speed; connect to a high speed hub Dec 22 05:31:23 ifi-zen-stream3 kernel: usb 4-1.3: New USB device found, idVendor=20b1, idProduct=0010 Dec 22 05:31:23 ifi-zen-stream3 kernel: usb 4-1.3: New USB device strings: Mfr=1, Product=8, SerialNumber=2 Dec 22 05:31:23 ifi-zen-stream3 kernel: usb 4-1.3: Product: ZEN DAC 3 (UCA1) Dec 22 05:31:23 ifi-zen-stream3 kernel: usb 4-1.3: Manufacturer: iFi (by AMR) Dec 22 05:31:23 ifi-zen-stream3 kernel: usb 4-1.3: SerialNumber: 005A Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service. Dec 22 05:31:23 ifi-zen-stream3 sudo[4283]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:23 ifi-zen-stream3 volumio[1261]: info: Tidal Connect Service Started Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service. Dec 22 05:31:23 ifi-zen-stream3 sudo[4290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Dec 22 05:31:23 ifi-zen-stream3 sudo[4290]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:23 ifi-zen-stream3 node[498]: A new connection has been established. Dec 22 05:31:23 ifi-zen-stream3 node[498]: Closing connection with the client tidal-connect Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service... Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service. Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service. Dec 22 05:31:23 ifi-zen-stream3 sudo[4290]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service. Dec 22 05:31:23 ifi-zen-stream3 volumio[1261]: info: Tidal Connect Service Started Dec 22 05:31:23 ifi-zen-stream3 node[498]: A new connection has been established. Dec 22 05:31:23 ifi-zen-stream3 sudo[4312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Dec 22 05:31:23 ifi-zen-stream3 sudo[4312]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:23 ifi-zen-stream3 sudo[4313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Dec 22 05:31:23 ifi-zen-stream3 sudo[4313]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Started iFi Streamer Qobuz Connect Service. Dec 22 05:31:23 ifi-zen-stream3 sudo[4312]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:23 ifi-zen-stream3 volumio[1261]: info: Qobuz Connect Service Started Dec 22 05:31:23 ifi-zen-stream3 sudo[4313]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:23 ifi-zen-stream3 volumio[1261]: info: Qobuz Connect Service Started Dec 22 05:31:23 ifi-zen-stream3 kernel: usb 4-1.3: Warning! Unlikely big volume range (=32512), cval->res is probably wrong. Dec 22 05:31:23 ifi-zen-stream3 kernel: usb 4-1.3: [10] FU [ZEN DAC 3 (UCA1) Playback Volume] ch = 1, val = -32512/0/1 Dec 22 05:31:23 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Dec 22 05:31:23 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc4-supply from device tree Dec 22 05:31:23 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Dec 22 05:31:23 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Dec 22 05:31:23 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc5-supply from device tree Dec 22 05:31:23 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Dec 22 05:31:23 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Dec 22 05:31:23 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Dec 22 05:31:23 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc4-supply from device tree Dec 22 05:31:23 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Dec 22 05:31:23 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Dec 22 05:31:23 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc5-supply from device tree Dec 22 05:31:23 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Dec 22 05:31:23 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Dec 22 05:31:23 ifi-zen-stream3 systemd-udevd[4156]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 5' failed with exit code 99. Dec 22 05:31:23 ifi-zen-stream3 volumio[1261]: info: Dec 22 05:31:23 ifi-zen-stream3 volumio[1261]: ---------------------------- USB Audio Device Attached Dec 22 05:31:23 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.464 [4336.4336] DEBUG SampleApp: Starting sample application Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.465 [4336.4336] DEBUG SampleApp: Device Name: ZEN Stream3 Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.465 [4336.4336] DEBUG SampleApp: Manufacturer: Sample manufacturer Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.465 [4336.4336] DEBUG SampleApp: Model: iFi Streamer Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.465 [4336.4336] DEBUG SampleApp: Serial Number: ifi:1e:d5:d8:fd:fe:f8 Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.465 [4336.4336] DEBUG SampleApp: Audio output device: volumio Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.465 [4336.4336] DEBUG SampleApp: Volume control device: default Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.465 [4336.4336] DEBUG SampleApp: Volume control element: Master Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.465 [4336.4336] DEBUG SampleApp: Local config server port: 8000 Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.470 [4336.4336] ERROR SampleApp: Unable to find ALSA mixer element 'Master' on index 0 Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.471 [4336.4336] DEBUG SampleApp: Maximum supported audio quality: HIRES_L3 Dec 22 05:31:23 ifi-zen-stream3 play[4316]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 22 05:31:23 ifi-zen-stream3 node[498]: A new connection has been established. Dec 22 05:31:23 ifi-zen-stream3 sudo[4342]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Dec 22 05:31:23 ifi-zen-stream3 sudo[4342]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:23 ifi-zen-stream3 play[4316]: [Info] MetaClient: MetaClientInit Dec 22 05:31:23 ifi-zen-stream3 play[4316]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Dec 22 05:31:23 ifi-zen-stream3 node[528]: ConvSwitch: Add client qobuz-connect Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: mpd.socket: Succeeded. Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Closed mpd.socket. Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Stopping Music Player Daemon... Dec 22 05:31:23 ifi-zen-stream3 sudo[4347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Dec 22 05:31:23 ifi-zen-stream3 sudo[4347]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:23 ifi-zen-stream3 play[4316]: [Info] ConvSwitch: ConvSwitchInit Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.578 [4336.4336] DEBUG ActiveStateManager: [0xaafbf098]: Creating new Active State Manager Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.578 [4336.4336] DEBUG NetworkActivityTracker: [0xaafbf108]: Creating new Network Activity Tracker Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] DEBUG EndpointManager: [0xaafc0080]: Creating Endpoint Manager Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] DEBUG PlaybackSessionManager: [0xaafc0470]: Creating Playback Session Manager Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] DEBUG BackoffTimer: [0xaafc05e8]: Creating Backoff Timer Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] DEBUG MediaEngine: [0xaafc0708]: Creating new Media Engine Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] DEBUG AudioRenderer: [0xaafc0928]: Creating Audio Renderer Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] TRACE MediaEngineCommandSequencer: [0xaafc0a80]: Creating Media Engine Command Sequencer Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] DEBUG PlaybackControlsManager: [0xaafc0ae0]: Creating new Playback Controls Manager Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] DEBUG VolumeManager: [0xaafc0b70]: Creating new Volume Manager Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] DEBUG ProtocolHandler: [0xaafc0e48]: Creating Protocol Handler Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] DEBUG MessageReceiver: [0xaafc0ee8]: Creating Message Receiver Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] DEBUG RendererActivationController: [0xaafc1060]: Creating new Renderer Activation Controller Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] TRACE RendererActivationCommandSequencer: [0xaafc1108]: Creating Renderer Activation Command Sequencer Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] DEBUG ReportingManager: [0xaafc1218]: Creating new Reporting Manager Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] DEBUG StreamingEventReporter: [0xaafc1260]: Creating Streaming Event Reporter Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] DEBUG BackoffTimer: [0xaafc1340]: Creating Backoff Timer Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] DEBUG TokenExpiryController: [0xaafc1450]: Creating Token Expiry Controller Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] DEBUG UserInactivityManager: [0xaafc14a0]: Creating new User Inactivity Manager Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] INFO VolumeManager: [0xaafc0b70]: Setting new playback volume: 100 Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] INFO VolumeManager: [0xaafc0b70]: Setting new mute state: 1 Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] DEBUG SampleApp: Qobuz Connect has been initialized Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.579 [4336.4336] TRACE SampleApp: Running event loop Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.580 [4336.4336] INFO QobuzConnect: [0xaafc1540]: Client initialized! Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.580 [4336.4336] INFO SampleApp: Starting Avahi advertising, name: ZEN Stream3, service name: _qobuz-connect._tcp Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.593 [4336.4336] DEBUG SampleApp: Avahi client state changed: RUNNING Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.595 [4336.4336] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: mpd.service: Succeeded. Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Stopped Music Player Daemon. Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.602 [4336.4336] INFO LocalConfigManager: [0xaafc0450]: Starting Local Configuration server Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.602 [4336.4336] INFO SampleApp: Starting Local configuration server Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.603 [4336.4336] INFO SampleApp: Playback mute state changed: 1 Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.603 [4336.4336] ERROR SampleApp: Unable to set mute state, no ALSA volume element Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.604 [4336.4336] DEBUG SampleApp: Avahi entry group state changed: REGISTERING Dec 22 05:31:23 ifi-zen-stream3 sudo[4342]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.616 [4336.4336] INFO SampleApp: Playback volume changed: 100 Dec 22 05:31:23 ifi-zen-stream3 play[4316]: 20251222 05:31:23.618 [4336.4336] ERROR SampleApp: Unable to set volume, no ALSA volume element Dec 22 05:31:23 ifi-zen-stream3 sudo[4352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Dec 22 05:31:23 ifi-zen-stream3 sudo[4347]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:23 ifi-zen-stream3 sudo[4352]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Listening on mpd.socket. Dec 22 05:31:23 ifi-zen-stream3 sudo[4355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Starting Music Player Daemon... Dec 22 05:31:23 ifi-zen-stream3 sudo[4355]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: mpd.socket: Succeeded. Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Closed mpd.socket. Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Stopping mpd.socket. Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: mpd.socket: Socket service mpd.service already active, refusing. Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Failed to listen on mpd.socket. Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: mpd.service: Succeeded. Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Stopped Music Player Daemon. Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Listening on mpd.socket. Dec 22 05:31:23 ifi-zen-stream3 systemd[1]: Starting Music Player Daemon... Dec 22 05:31:23 ifi-zen-stream3 sudo[4358]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 22 05:31:23 ifi-zen-stream3 sudo[4358]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:23 ifi-zen-stream3 sudo[4358]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:24 ifi-zen-stream3 node[498]: A new connection has been established. Dec 22 05:31:24 ifi-zen-stream3 play[4316]: 20251222 05:31:24.399 [4336.4336] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED Dec 22 05:31:24 ifi-zen-stream3 kernel: usb 5-1.1: new SuperSpeed USB device number 4 using xhci-hcd Dec 22 05:31:25 ifi-zen-stream3 kernel: usb 5-1.1: New USB device found, idVendor=04e8, idProduct=6300 Dec 22 05:31:25 ifi-zen-stream3 kernel: usb 5-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Dec 22 05:31:25 ifi-zen-stream3 kernel: usb 5-1.1: Product: Flash Drive Dec 22 05:31:25 ifi-zen-stream3 kernel: usb 5-1.1: Manufacturer: Samsung Dec 22 05:31:25 ifi-zen-stream3 kernel: usb 5-1.1: SerialNumber: 0362025080001663 Dec 22 05:31:25 ifi-zen-stream3 kernel: usb-storage 5-1.1:1.0: USB Mass Storage device detected Dec 22 05:31:25 ifi-zen-stream3 kernel: scsi host1: usb-storage 5-1.1:1.0 Dec 22 05:31:25 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Dec 22 05:31:25 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc4-supply from device tree Dec 22 05:31:25 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Dec 22 05:31:25 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Dec 22 05:31:25 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc5-supply from device tree Dec 22 05:31:25 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Dec 22 05:31:25 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Dec 22 05:31:25 ifi-zen-stream3 sudo[4376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Dec 22 05:31:25 ifi-zen-stream3 sudo[4376]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:25 ifi-zen-stream3 play[2893]: 2025-12-22 05:31:25.092 E esdk select error: 4 -> Interrupted system call Dec 22 05:31:25 ifi-zen-stream3 play[2893]: 2025-12-22 05:31:25.094 I app Exiting with error = 0 Dec 22 05:31:25 ifi-zen-stream3 play[2893]: 2025-12-22 05:31:25.094 I api SpFree() Dec 22 05:31:25 ifi-zen-stream3 play[2893]: 2025-12-22 05:31:25.094 I api SpFree [returned value: 0] Dec 22 05:31:25 ifi-zen-stream3 play[2893]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Dec 22 05:31:25 ifi-zen-stream3 play[2893]: [Info] ConvSwitch: ConvSwitchInit Dec 22 05:31:25 ifi-zen-stream3 play[2893]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 22 05:31:25 ifi-zen-stream3 play[2893]: [Info] MetaClient: MetaClientInit Dec 22 05:31:25 ifi-zen-stream3 play[2893]: [Info] ConvSwitch: ConvSwitchExit Dec 22 05:31:25 ifi-zen-stream3 play[2893]: [Info] MetaClient: MetaClientExit Dec 22 05:31:25 ifi-zen-stream3 node[528]: ConvSwitch: Drop client spotify Dec 22 05:31:25 ifi-zen-stream3 node[498]: Closing connection with the client spotify Dec 22 05:31:25 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service... Dec 22 05:31:25 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Dec 22 05:31:25 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Dec 22 05:31:25 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service. Dec 22 05:31:25 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 22 05:31:25 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::getcurrentVolume Dec 22 05:31:25 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioRetrievevolume Dec 22 05:31:25 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Dec 22 05:31:25 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::pushState Dec 22 05:31:25 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:31:25 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioPushState Dec 22 05:31:25 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:31:25 ifi-zen-stream3 sudo[4379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Dec 22 05:31:25 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service. Dec 22 05:31:25 ifi-zen-stream3 sudo[4379]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:25 ifi-zen-stream3 sudo[4376]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:25 ifi-zen-stream3 volumio[1261]: info: Spotify Connect Service Started Dec 22 05:31:25 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service... Dec 22 05:31:25 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Dec 22 05:31:25 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Dec 22 05:31:25 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service. Dec 22 05:31:25 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service. Dec 22 05:31:25 ifi-zen-stream3 sudo[4379]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:25 ifi-zen-stream3 volumio[1261]: info: Spotify Connect Service Started Dec 22 05:31:25 ifi-zen-stream3 play[4385]: output: volumio mixer: hw:5 Dec 22 05:31:25 ifi-zen-stream3 node[528]: ConvSwitch: Add client spotify Dec 22 05:31:25 ifi-zen-stream3 node[498]: A new connection has been established. Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.456 I api SpRegisterDebugCallbacks [returned value: 0] Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.457 I api SpInit(0xff830f10, API v66) Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.457 I esdk eSDK version: HEAD-v3.166.69-g24821f73 Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.457 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 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.458 I esdk Successfully registered dns callback: dns_lookup_callback Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.458 I download Using 128 kB for cache buffer Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.458 I download Using 621 kB for compressed audio buffer Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.458 I esdk Successfully registered error callback Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.470 I esdk Creating IPv4 socket (domain 2) Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.470 I zc webserver: service port 5566 (5566-5576) buffer size 4444 Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.470 I zc Started ZeroConf service on port 5566 path /zc alias count 0 Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.470 I esdk Creating IPv4 socket (domain 2) Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.471 I api SpInit [returned value: 0] Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.471 I api SpRegisterConnectionCallbacks(0xff830ef8, (nil)) Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.471 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.471 I api SpRegisterConnectionCallbacks [returned value: 0] Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.471 I api SpRegisterPlaybackCallbacks(0xff830ee0, (nil)) Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.471 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, - Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.471 I api SpRegisterPlaybackCallbacks [returned value: 0] Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.478 W app Couldn't find mixer for volume controls. (tried , SoftMaster) Dec 22 05:31:25 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:25.478 I app Initialized! Dec 22 05:31:25 ifi-zen-stream3 volumio[1261]: info: VolumeController::SetAlsaVolume100 Dec 22 05:31:25 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Dec 22 05:31:25 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::pushState Dec 22 05:31:25 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioPushState Dec 22 05:31:25 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:31:25 ifi-zen-stream3 volumio[1261]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/Samsung_USB Dec 22 05:31:25 ifi-zen-stream3 node[528]: ConvSwitch: Add client tidal Dec 22 05:31:25 ifi-zen-stream3 tidal_connect_application[4396]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi. Dec 22 05:31:25 ifi-zen-stream3 tidal_connect_application[4396]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 22 05:31:25 ifi-zen-stream3 tidal_connect_application[4396]: *** WARNING *** For more information see Dec 22 05:31:25 ifi-zen-stream3 ifi_metadata[4300]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 22 05:31:25 ifi-zen-stream3 ifi_metadata[4300]: [Info] MetaClient: MetaClientInit Dec 22 05:31:25 ifi-zen-stream3 ifi_metadata[4300]: Connected Dec 22 05:31:26 ifi-zen-stream3 kernel: scsi 1:0:0:0: Direct-Access Samsung Flash Drive 1100 PQ: 0 ANSI: 6 Dec 22 05:31:26 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Dec 22 05:31:26 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc4-supply from device tree Dec 22 05:31:26 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Dec 22 05:31:26 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Dec 22 05:31:26 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc5-supply from device tree Dec 22 05:31:26 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Dec 22 05:31:26 ifi-zen-stream3 kernel: sd 1:0:0:0: [sda] 125313283 512-byte logical blocks: (64.2 GB/59.8 GiB) Dec 22 05:31:26 ifi-zen-stream3 kernel: sd 1:0:0:0: [sda] Write Protect is off Dec 22 05:31:26 ifi-zen-stream3 kernel: sd 1:0:0:0: [sda] Mode Sense: 43 00 00 00 Dec 22 05:31:26 ifi-zen-stream3 kernel: sd 1:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Dec 22 05:31:26 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Dec 22 05:31:26 ifi-zen-stream3 kernel: sda: sda1 Dec 22 05:31:26 ifi-zen-stream3 kernel: sd 1:0:0:0: [sda] Attached SCSI removable disk Dec 22 05:31:26 ifi-zen-stream3 volumio[1261]: info: Mounting Device Samsung_USB Dec 22 05:31:26 ifi-zen-stream3 sudo[4429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Samsung_USB -o noatime Dec 22 05:31:26 ifi-zen-stream3 sudo[4429]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:26 ifi-zen-stream3 mount.exfat[4431]: volume was not unmounted cleanly Dec 22 05:31:26 ifi-zen-stream3 sudo[4429]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:26 ifi-zen-stream3 volumio[1261]: WARN: volume was not unmounted cleanly. Dec 22 05:31:26 ifi-zen-stream3 mpd[4360]: Dec 22 05:31 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 22 05:31:26 ifi-zen-stream3 systemd[1]: Started Music Player Daemon. Dec 22 05:31:26 ifi-zen-stream3 sudo[4352]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:26 ifi-zen-stream3 sudo[4355]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:26 ifi-zen-stream3 volumio[1261]: info: Scanning removed location : "USB/Samsung_USB" Dec 22 05:31:26 ifi-zen-stream3 volumio[1261]: info: Restarted MPD. Dec 22 05:31:26 ifi-zen-stream3 volumio[1261]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.socket mpd.service Dec 22 05:31:26 ifi-zen-stream3 volumio[1261]: Job for mpd.socket failed. Dec 22 05:31:26 ifi-zen-stream3 volumio[1261]: See "systemctl status mpd.socket" and "journalctl -xe" for details. Dec 22 05:31:26 ifi-zen-stream3 volumio[1261]: error: MPD error: The expression evaluated to a falsy value: Dec 22 05:31:26 ifi-zen-stream3 volumio[1261]: assert.ok(self.idling) Dec 22 05:31:26 ifi-zen-stream3 volumio[1261]: error: The expression evaluated to a falsy value: Dec 22 05:31:26 ifi-zen-stream3 volumio[1261]: assert.ok(self.idling) Dec 22 05:31:26 ifi-zen-stream3 volumio[1261]: error: updateQueue error: null Dec 22 05:31:27 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioStop Dec 22 05:31:27 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::stop Dec 22 05:31:27 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::serviceStop Dec 22 05:31:27 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::serviceStop Dec 22 05:31:27 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioStop Dec 22 05:31:27 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::stop Dec 22 05:31:27 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 05:31:27 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 05:31:27 ifi-zen-stream3 volumio[1261]: info: Roon Ready Stop Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: verbose: ControllerMpd::sendMpdCommand status Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: ---------------------------- MPD announces state update: update Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: ControllerMpd::getState Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: verbose: ControllerMpd::sendMpdCommand status Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: verbose: ControllerMpd::sendMpdCommand status Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: ---------------------------- MPD announces state update: update Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: ControllerMpd::getState Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: verbose: ControllerMpd::sendMpdCommand status Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: sendMpdCommand status took 13 milliseconds Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: sendMpdCommand status took 10 milliseconds Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: sendMpdCommand status took 13 milliseconds Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: sendMpdCommand status took 10 milliseconds Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: verbose: ControllerMpd::parseState Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioGetState Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: Command Router : Notfying DB Updatefalse Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: verbose: ControllerMpd::parseState Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioGetState Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: verbose: ControllerMpd::parseState Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioGetState Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: Command Router : Notfying DB Updatefalse Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: verbose: ControllerMpd::parseState Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioGetState Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: ControllerMpd::pushState Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::servicePushState Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::pushState Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioPushState Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: 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 22 05:31:29 ifi-zen-stream3 volumio[1261]: verbose: CURRENT POSITION 5 Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: ControllerMpd::pushState Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::servicePushState Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::pushState Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioPushState Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: 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 22 05:31:29 ifi-zen-stream3 volumio[1261]: verbose: CURRENT POSITION 5 Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: ------------------------------ 154ms Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: info: ------------------------------ 148ms Dec 22 05:31:29 ifi-zen-stream3 volumio[1261]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/TrondheimSolistene/DIVERTIMENTI/e8e64ea0-a38e-4624-ba4c-e7fd97402373.jpg' Dec 22 05:31:33 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 22 05:31:33 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 22 05:31:33 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 22 05:31:33 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 22 05:31:33 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 22 05:31:37 ifi-zen-stream3 volumio[1261]: info: ++++--++++ getMenuItems Dec 22 05:31:37 ifi-zen-stream3 volumio[1261]: info: ++++--++++ getMenuItems Dec 22 05:31:39 ifi-zen-stream3 volumio[1261]: info: ++++--++++ getUiConfig: {"page":"audio_interface/alsa_controller"} Dec 22 05:31:39 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 05:31:39 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 22 05:31:39 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 05:31:39 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 22 05:31:39 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:39 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:39 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:39 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:39 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:39 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:39 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:39 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 22 05:31:39 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: ++++--++++ callMethod: {"type":"controller","endpoint":"audio_interface/alsa_controller","method":"saveAlsaOptions","data":{"output_device":{"value":"5","label":"ZEN DAC 3 (UCA1)"}}} Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: Preparing to save Alsa Options, stopping services first Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioGetState Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioPause Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::pause Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"ZEN DAC 3 (UCA1)"}} Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , forceDoP Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: ZEN DAC 3 (UCA1): Does not support DSD Native. Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: Ignoring Mixers Options Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: Device 5 does not have any Mixer Control Available Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: Restoring Previous Volume level: 100 false false Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: Updating Volume Controller Parameters: Device: 5 Name: ZEN DAC 3 (UCA1) Mixer: None Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreStateMachine::pushState Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CorePlayQueue::getTrack 5 Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::volumioPushState Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: Preparing to generate the ALSA configuration file Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: wizard , refreshWizarOutputDevices Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: Asound.conf file written Dec 22 05:31:42 ifi-zen-stream3 sudo[4628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 22 05:31:42 ifi-zen-stream3 sudo[4628]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:42 ifi-zen-stream3 sudo[4628]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: No state is present for card rkifispdif Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: Found hardware: "rk-ifi-spdif" "" "" "" "" Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: Hardware is initialized using a generic method Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: No state is present for card rkifispdif Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: No state is present for card Z3UCA1 Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: Found hardware: "USB-Audio" "USB Mixer" "USB20b1:0010" "" "" Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: Hardware is initialized using a generic method Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: No state is present for card Z3UCA1 Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: Tidal connect: Output device has changed Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: Output device has changed, restarting MPD Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: Qobuz connect: Output device has changed Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: Roon Ready: Output device has changed Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: Spotify: Output device has changed Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: Tidal connect: Output device has changed Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: Output device has changed, restarting MPD Dec 22 05:31:42 ifi-zen-stream3 sudo[4633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 22 05:31:42 ifi-zen-stream3 sudo[4633]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:42 ifi-zen-stream3 sudo[4633]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: Qobuz connect: Output device has changed Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: Roon Ready: Output device has changed Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: Spotify: Output device has changed Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: MPD Permissions set Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 sudo[4645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 sudo[4645]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:42 ifi-zen-stream3 sudo[4645]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:42 ifi-zen-stream3 volumio[1261]: info: MPD Permissions set Dec 22 05:31:43 ifi-zen-stream3 volumio[1261]: info: Starting RoonReady Sync Dec 22 05:31:43 ifi-zen-stream3 sudo[4682]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Dec 22 05:31:43 ifi-zen-stream3 sudo[4682]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:43 ifi-zen-stream3 volumio[1261]: info: Starting RoonReady Sync Dec 22 05:31:43 ifi-zen-stream3 sudo[4683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Dec 22 05:31:43 ifi-zen-stream3 sudo[4683]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:43 ifi-zen-stream3 sudo[4686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Dec 22 05:31:43 ifi-zen-stream3 sudo[4686]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:43 ifi-zen-stream3 node[498]: Closing connection with the client roon-ready Dec 22 05:31:43 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Roon Ready Service... Dec 22 05:31:43 ifi-zen-stream3 node[528]: ConvSwitch: Drop client roon-ready Dec 22 05:31:43 ifi-zen-stream3 node[528]: ConvSwitch: Drop client qobuz-connect Dec 22 05:31:43 ifi-zen-stream3 sudo[4689]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Dec 22 05:31:43 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Qobuz Connect Service... Dec 22 05:31:43 ifi-zen-stream3 node[498]: Closing connection with the client qobuz-connect Dec 22 05:31:43 ifi-zen-stream3 sudo[4689]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:43 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 22 05:31:43 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM Dec 22 05:31:43 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Succeeded. Dec 22 05:31:43 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Roon Ready Service. Dec 22 05:31:43 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM Dec 22 05:31:43 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded. Dec 22 05:31:43 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Qobuz Connect Service. Dec 22 05:31:43 ifi-zen-stream3 volumio[1261]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 22 05:31:43 ifi-zen-stream3 sudo[4682]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:43 ifi-zen-stream3 volumio[1261]: Error: connect ETIMEDOUT 59.24.3.173:443 Dec 22 05:31:43 ifi-zen-stream3 volumio[1261]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Dec 22 05:31:43 ifi-zen-stream3 volumio[1261]: errno: -110, Dec 22 05:31:43 ifi-zen-stream3 volumio[1261]: code: 'ETIMEDOUT', Dec 22 05:31:43 ifi-zen-stream3 volumio[1261]: syscall: 'connect', Dec 22 05:31:43 ifi-zen-stream3 volumio[1261]: address: '59.24.3.173', Dec 22 05:31:43 ifi-zen-stream3 volumio[1261]: port: 443 Dec 22 05:31:43 ifi-zen-stream3 volumio[1261]: } Dec 22 05:31:43 ifi-zen-stream3 volumio[1261]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 22 05:31:43 ifi-zen-stream3 systemd[1]: Started iFi Streamer Roon Ready Service. Dec 22 05:31:43 ifi-zen-stream3 sudo[4683]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:43 ifi-zen-stream3 sudo[4689]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:43 ifi-zen-stream3 play[4706]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Dec 22 05:31:43 ifi-zen-stream3 sudo[4686]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:43 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 22 05:31:43 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 22 05:31:43 ifi-zen-stream3 node[528]: ConvSwitch: Add client roon-ready Dec 22 05:31:44 ifi-zen-stream3 sudo[4765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-22 05:30 Dec 22 05:31:44 ifi-zen-stream3 sudo[4765]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:44 ifi-zen-stream3 sudo[4765]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:45 ifi-zen-stream3 node[498]: A new connection has been established. Dec 22 05:31:46 ifi-zen-stream3 node[528]: ConvSwitch: Error: Cannot set startRoonReadyPlayback Dec 22 05:31:47 ifi-zen-stream3 node[498]: Closing connection with the client volumio Dec 22 05:31:47 ifi-zen-stream3 node[528]: ConvSwitch: Error: Error: read ECONNRESET Dec 22 05:31:47 ifi-zen-stream3 systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Dec 22 05:31:47 ifi-zen-stream3 systemd[1]: media-Samsung_USB.mount: Succeeded. Dec 22 05:31:47 ifi-zen-stream3 systemd[1]: volumio.service: Failed with result 'exit-code'. Dec 22 05:31:47 ifi-zen-stream3 systemd[1]: Started dynamicswap service. Dec 22 05:31:47 ifi-zen-stream3 systemd[1]: dynamicswap.service: Succeeded. Dec 22 05:31:47 ifi-zen-stream3 systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Dec 22 05:31:47 ifi-zen-stream3 systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Dec 22 05:31:47 ifi-zen-stream3 systemd[1]: Stopped Volumio Backend Module. Dec 22 05:31:47 ifi-zen-stream3 systemd[1]: Started Volumio Backend Module. Dec 22 05:31:47 ifi-zen-stream3 systemd[1]: Started dynamicswap service. Dec 22 05:31:47 ifi-zen-stream3 systemd[1]: dynamicswap.service: Succeeded. Dec 22 05:31:50 ifi-zen-stream3 volumio[4798]: info: ------------------------------------------- Dec 22 05:31:50 ifi-zen-stream3 volumio[4798]: info: ----- Volumio3 ---- Dec 22 05:31:50 ifi-zen-stream3 volumio[4798]: info: ------------------------------------------- Dec 22 05:31:50 ifi-zen-stream3 volumio[4798]: info: ----- System startup ---- Dec 22 05:31:50 ifi-zen-stream3 volumio[4798]: info: ------------------------------------------- Dec 22 05:31:50 ifi-zen-stream3 volumio[4798]: info: ConvSwitch: Client Start Dec 22 05:31:50 ifi-zen-stream3 volumio[4798]: info: MetaClient: Client Start Dec 22 05:31:50 ifi-zen-stream3 node[498]: A new connection has been established. Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Plugin folders cleanup Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Scanning into folder /volumio/app/plugins/ Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Scanning category audio_interface Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Scanning category miscellanea Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Scanning category music_service Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Scanning category plugins.json Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Scanning category system_controller Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Scanning category user_interface Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Scanning into folder /data/plugins/ Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Scanning category music_service Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Plugin folders cleanup completed Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: ------------------------------------------- Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: ----- Core plugins startup ---- Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: ------------------------------------------- Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Loading plugins from folder /volumio/app/plugins/ Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Adding plugin networkaudiod to MyMusic Plugins Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Adding plugin qobuz_connect to MyMusic Plugins Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Adding plugin spotify_connect to MyMusic Plugins Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Adding plugin tidal_connect to MyMusic Plugins Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Adding plugin upnp to MyMusic Plugins Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Adding plugin airplay1_switch to MyMusic Plugins Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Adding plugin airplay2_switch to MyMusic Plugins Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Adding plugin roon_ready to MyMusic Plugins Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Loading plugins from folder /data/plugins/ Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Loading plugin "system"... Dec 22 05:31:51 ifi-zen-stream3 volumio[4798]: info: Loading plugin "appearance"... Dec 22 05:31:52 ifi-zen-stream3 volumio[4798]: info: Loading plugin "network"... Dec 22 05:31:52 ifi-zen-stream3 volumio[4798]: info: Refreshing Cached IP Addresses Dec 22 05:31:52 ifi-zen-stream3 sudo[4855]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 22 05:31:52 ifi-zen-stream3 sudo[4855]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:52 ifi-zen-stream3 sudo[4855]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:52 ifi-zen-stream3 sudo[4857]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 22 05:31:52 ifi-zen-stream3 sudo[4857]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:52 ifi-zen-stream3 sudo[4857]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:52 ifi-zen-stream3 volumio[4798]: info: Loading plugin "services"... Dec 22 05:31:52 ifi-zen-stream3 volumio[4798]: info: Loading plugin "alsa_controller"... Dec 22 05:31:52 ifi-zen-stream3 sudo[4872]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 22 05:31:52 ifi-zen-stream3 sudo[4872]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:53 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 22 05:31:53 ifi-zen-stream3 volumio[4798]: info: Loading plugin "wizard"... Dec 22 05:31:53 ifi-zen-stream3 volumio[4798]: info: Loading plugin "networkfs"... Dec 22 05:31:53 ifi-zen-stream3 volumio[4798]: info: Starting Udev Watcher for removable devices Dec 22 05:31:53 ifi-zen-stream3 volumio[4798]: error: Cannot associate FS Label, not mounting Dec 22 05:31:53 ifi-zen-stream3 volumio[4798]: error: Cannot associate FS Label, not mounting Dec 22 05:31:53 ifi-zen-stream3 volumio[4798]: info: Ignoring mount for partition: BOOT Dec 22 05:31:53 ifi-zen-stream3 volumio[4798]: info: Ignoring mount for partition: archivefs Dec 22 05:31:53 ifi-zen-stream3 volumio[4798]: info: Ignoring mount for partition: rootfs Dec 22 05:31:53 ifi-zen-stream3 volumio[4798]: info: Mounting Device Samsung_USB Dec 22 05:31:53 ifi-zen-stream3 kernel: start_addr=(0x8000), end_addr=(0x10000), buffer_size=(0x8000), smp_number_max=(4096) Dec 22 05:31:53 ifi-zen-stream3 sudo[4916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Samsung_USB -o noatime Dec 22 05:31:54 ifi-zen-stream3 sudo[4916]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:54 ifi-zen-stream3 sudo[4916]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:54 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 22 05:31:54 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 22 05:31:54 ifi-zen-stream3 volumio[4798]: info: Loading plugin "volumio_command_line_client"... Dec 22 05:31:54 ifi-zen-stream3 volumio[4798]: info: Loading plugin "networkaudiod"... Dec 22 05:31:54 ifi-zen-stream3 volumio[4798]: info: [1766381514104] Starting NAA Service Dec 22 05:31:54 ifi-zen-stream3 volumio[4798]: info: Loading plugin "tidal_connect"... Dec 22 05:31:54 ifi-zen-stream3 volumio[4798]: info: [1766381514133] Starting Tidal Connect Service Dec 22 05:31:54 ifi-zen-stream3 volumio[4798]: info: Loading plugin "upnp"... Dec 22 05:31:54 ifi-zen-stream3 volumio[4798]: info: [1766381514149] Starting Upmpd Daemon Dec 22 05:31:54 ifi-zen-stream3 sudo[4932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart networkaudiod.service Dec 22 05:31:54 ifi-zen-stream3 volumio[4798]: info: Starting Upmpd Daemon Dec 22 05:31:54 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 22 05:31:54 ifi-zen-stream3 sudo[4932]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:54 ifi-zen-stream3 volumio[4798]: error: ATTENTION!!!: Plugin upnp does not return adequate promise from onVolumioStart: please update! Dec 22 05:31:54 ifi-zen-stream3 volumio[4798]: info: Loading plugin "my_music"... Dec 22 05:31:54 ifi-zen-stream3 volumio[4798]: info: Loading plugin "mpd"... Dec 22 05:31:54 ifi-zen-stream3 systemd[1]: Stopping Network Audio Adapter daemon... Dec 22 05:31:54 ifi-zen-stream3 systemd[1]: networkaudiod.service: Succeeded. Dec 22 05:31:54 ifi-zen-stream3 systemd[1]: Stopped Network Audio Adapter daemon. Dec 22 05:31:54 ifi-zen-stream3 systemd[1]: Started Network Audio Adapter daemon. Dec 22 05:31:54 ifi-zen-stream3 sudo[4932]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:54 ifi-zen-stream3 networkaudiod[4946]: [/usr/sbin/networkaudiod] (4946): networkaudiod Copyright (C) 2011-2020 Jussi Laako / Signalyst. All rights reserved. Dec 22 05:31:54 ifi-zen-stream3 networkaudiod[4946]: [/usr/sbin/networkaudiod] (4946): create alsa engine Dec 22 05:31:54 ifi-zen-stream3 networkaudiod[4946]: [/usr/sbin/networkaudiod] (4946): listen discovery on :: Dec 22 05:31:54 ifi-zen-stream3 networkaudiod[4946]: [/usr/sbin/networkaudiod] (4946): clSocket::SetOption(): setsockopt(..., 41,20, ...): No such device Dec 22 05:31:54 ifi-zen-stream3 networkaudiod[4946]: [/usr/sbin/networkaudiod] (4946): Socket failure, falling back to IPv4-only! Dec 22 05:31:54 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 22 05:31:54 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 22 05:31:54 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:54 ifi-zen-stream3 volumio[4798]: info: Loading plugin "upnp_browser"... Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Loading plugin "qobuz_connect"... Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: [1766381515151] Starting Qobuz Connect Service Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Loading plugin "alarm-clock"... Dec 22 05:31:55 ifi-zen-stream3 networkaudiod[4946]: [/usr/sbin/networkaudiod] (4946): listen discovery on 0.0.0.0 Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Loading plugin "last_100"... Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Loading plugin "roon_ready"... Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Starting RoonReady Sync Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Loading plugin "webradio"... Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Loading plugin "i2s_dacs"... Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: I2S DAC not set, start Auto-detection Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Loading plugin "volumiodiscovery"... Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: *** WARNING *** For more information see Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 22 05:31:55 ifi-zen-stream3 node[4798]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: *** WARNING *** For more information see Dec 22 05:31:55 ifi-zen-stream3 node[4798]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 22 05:31:55 ifi-zen-stream3 node[4798]: *** WARNING *** For more information see Dec 22 05:31:55 ifi-zen-stream3 node[4798]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 22 05:31:55 ifi-zen-stream3 node[4798]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 22 05:31:55 ifi-zen-stream3 node[4798]: *** WARNING *** For more information see Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Loading plugin "spotify_connect"... Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: [1766381515639] Starting Spotify Connect Service Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Plugin airplay1_switch is not enabled Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Loading plugin "airplay2_switch"... Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Loading plugin "airplay_emulation"... Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Starting Shairport Sync Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Loading plugin "outputs"... Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Loading plugin "albumart"... Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Plugin example_plugin is not enabled Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Loading plugin "inputs"... Dec 22 05:31:55 ifi-zen-stream3 volumio[4798]: info: Loading plugin "updater_comm"... Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: Plugin mpdemulation is not enabled Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: Loading plugin "rest_api"... Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: Loading plugin "websocket"... Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: Starting Socket.io Server version 2.3.0 Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: Plugin ifi-cdplayer is not enabled Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: Loading i18n strings for locale en Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: Updating browse sources language Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: Forking 3 albumart workers Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::initPlayerControls Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: Removing existing socket file at /tmp/meta.sock Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: Express server listening on port 3000 Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: [Metrics] WebUI: 7s 455.58ms Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreStateMachine::resetVolumioState Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreStateMachine::getcurrentVolume Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::volumioRetrievevolume Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: Meta server listening Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreStateMachine::pushState Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CorePlayQueue::getTrack 0 Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::volumioPushState Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: Server listening on port 6599 Dec 22 05:31:56 ifi-zen-stream3 sudo[5009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Dec 22 05:31:56 ifi-zen-stream3 sudo[5009]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 22 05:31:56 ifi-zen-stream3 sudo[5011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Dec 22 05:31:56 ifi-zen-stream3 sudo[5011]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: Completed loading Core Plugins Dec 22 05:31:56 ifi-zen-stream3 volumio[4798]: info: Preparing to generate the ALSA configuration file Dec 22 05:31:56 ifi-zen-stream3 node[498]: Closing connection with the client tidal-connect Dec 22 05:31:57 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Dec 22 05:31:57 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Dec 22 05:31:57 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Dec 22 05:31:57 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: ConvSwitch: Connected to server Dec 22 05:31:57 ifi-zen-stream3 systemd[1]: Started iFi Streamer Qobuz Connect Service. Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: MetaClient: Connected to server Dec 22 05:31:57 ifi-zen-stream3 node[528]: ConvSwitch: Drop client tidal Dec 22 05:31:57 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service... Dec 22 05:31:57 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Dec 22 05:31:57 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Dec 22 05:31:57 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service. Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: Volumio Network Manager: Network status updated: 1 Dec 22 05:31:57 ifi-zen-stream3 sudo[5011]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:57 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service. Dec 22 05:31:57 ifi-zen-stream3 sudo[5009]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: NAA Service Started Dec 22 05:31:57 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service. Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Dec 22 05:31:57 ifi-zen-stream3 node[498]: A new connection has been established. Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: ConvSwitch: Get message: success Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: MetaClient: Get message: success Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: verbose: New Socket.io Connection to 192.168.3.153 from 192.168.3.152 UA: Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/97.0.4692.99 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: verbose: New Socket.io Connection to 192.168.3.153 from 192.168.3.152 UA: Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/97.0.4692.99 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.543 [5045.5045] DEBUG SampleApp: Starting sample application Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.547 [5045.5045] DEBUG SampleApp: Device Name: ZEN Stream3 Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.549 [5045.5045] DEBUG SampleApp: Manufacturer: Sample manufacturer Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.550 [5045.5045] DEBUG SampleApp: Model: iFi Streamer Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.551 [5045.5045] DEBUG SampleApp: Serial Number: ifi:1e:d5:d8:fd:fe:f8 Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.552 [5045.5045] DEBUG SampleApp: Audio output device: volumio Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: verbose: New Socket.io Connection to 192.168.3.153 from 192.168.3.152 UA: Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/97.0.4692.99 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.554 [5045.5045] DEBUG SampleApp: Volume control device: default Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.554 [5045.5045] DEBUG SampleApp: Volume control element: Master Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.554 [5045.5045] DEBUG SampleApp: Local config server port: 8000 Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: Tidal Connect Service Started Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: Qobuz Connect Service Started Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.572 [5045.5045] ERROR SampleApp: Unable to find ALSA mixer element 'Master' on index 0 Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.573 [5045.5045] DEBUG SampleApp: Maximum supported audio quality: HIRES_L3 Dec 22 05:31:57 ifi-zen-stream3 play[5014]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 22 05:31:57 ifi-zen-stream3 node[498]: A new connection has been established. Dec 22 05:31:57 ifi-zen-stream3 play[5014]: [Info] MetaClient: MetaClientInit Dec 22 05:31:57 ifi-zen-stream3 play[5014]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: Scanning new location : "USB/Samsung_USB" Dec 22 05:31:57 ifi-zen-stream3 node[528]: ConvSwitch: Add client qobuz-connect Dec 22 05:31:57 ifi-zen-stream3 play[5014]: [Info] ConvSwitch: ConvSwitchInit Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.681 [5045.5045] DEBUG ActiveStateManager: [0xaadcc030]: Creating new Active State Manager Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.681 [5045.5045] DEBUG NetworkActivityTracker: [0xaadcc0a0]: Creating new Network Activity Tracker Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.682 [5045.5045] DEBUG EndpointManager: [0xaadcd018]: Creating Endpoint Manager Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.682 [5045.5045] DEBUG PlaybackSessionManager: [0xaadcd408]: Creating Playback Session Manager Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.682 [5045.5045] DEBUG BackoffTimer: [0xaadcd580]: Creating Backoff Timer Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.682 [5045.5045] DEBUG MediaEngine: [0xaadcd6a0]: Creating new Media Engine Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.682 [5045.5045] DEBUG AudioRenderer: [0xaadcd8c0]: Creating Audio Renderer Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.682 [5045.5045] TRACE MediaEngineCommandSequencer: [0xaadcda18]: Creating Media Engine Command Sequencer Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.682 [5045.5045] DEBUG PlaybackControlsManager: [0xaadcda78]: Creating new Playback Controls Manager Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.682 [5045.5045] DEBUG VolumeManager: [0xaadcdb08]: Creating new Volume Manager Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.682 [5045.5045] DEBUG ProtocolHandler: [0xaadcdde0]: Creating Protocol Handler Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.682 [5045.5045] DEBUG MessageReceiver: [0xaadcde80]: Creating Message Receiver Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.682 [5045.5045] DEBUG RendererActivationController: [0xaadcdff8]: Creating new Renderer Activation Controller Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.682 [5045.5045] TRACE RendererActivationCommandSequencer: [0xaadce0a0]: Creating Renderer Activation Command Sequencer Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.682 [5045.5045] DEBUG ReportingManager: [0xaadce1b0]: Creating new Reporting Manager Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.682 [5045.5045] DEBUG StreamingEventReporter: [0xaadce1f8]: Creating Streaming Event Reporter Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.682 [5045.5045] DEBUG BackoffTimer: [0xaadce2d8]: Creating Backoff Timer Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.682 [5045.5045] DEBUG TokenExpiryController: [0xaadce3e8]: Creating Token Expiry Controller Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.682 [5045.5045] DEBUG UserInactivityManager: [0xaadce438]: Creating new User Inactivity Manager Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.683 [5045.5045] INFO VolumeManager: [0xaadcdb08]: Setting new playback volume: 100 Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.683 [5045.5045] INFO VolumeManager: [0xaadcdb08]: Setting new mute state: 1 Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.683 [5045.5045] DEBUG SampleApp: Qobuz Connect has been initialized Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.683 [5045.5045] TRACE SampleApp: Running event loop Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.683 [5045.5045] INFO QobuzConnect: [0xaadce4d8]: Client initialized! Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.683 [5045.5045] INFO SampleApp: Starting Avahi advertising, name: ZEN Stream3, service name: _qobuz-connect._tcp Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.712 [5045.5045] DEBUG SampleApp: Avahi client state changed: RUNNING Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: Reloading queue from file Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.720 [5045.5045] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: Asound.conf file unchanged, so no further update is needed Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.731 [5045.5045] INFO LocalConfigManager: [0xaadcd3e8]: Starting Local Configuration server Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.731 [5045.5045] INFO SampleApp: Starting Local configuration server Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.732 [5045.5045] INFO SampleApp: Playback mute state changed: 1 Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.732 [5045.5045] ERROR SampleApp: Unable to set mute state, no ALSA volume element Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.733 [5045.5045] DEBUG SampleApp: Avahi entry group state changed: REGISTERING Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.733 [5045.5045] INFO SampleApp: Playback volume changed: 100 Dec 22 05:31:57 ifi-zen-stream3 play[5014]: 20251222 05:31:57.733 [5045.5045] ERROR SampleApp: Unable to set volume, no ALSA volume element Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: Tidal connect: Output device has changed Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: Output device has changed, restarting MPD Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: Qobuz connect: Output device has changed Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: Roon Ready: Output device has changed Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: Spotify: Output device has changed Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: ___________ START PLUGINS ___________ Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: ControllerMpd::onStart: Initializing MPD Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: Creating MPD Configuration file Dec 22 05:31:57 ifi-zen-stream3 sudo[5058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 22 05:31:57 ifi-zen-stream3 sudo[5058]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:57 ifi-zen-stream3 sudo[5058]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: [1766381517938] CoreMusicLibrary::Adding element Media Servers Dec 22 05:31:57 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 22 05:31:57 ifi-zen-stream3 sudo[5065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 22 05:31:57 ifi-zen-stream3 sudo[5065]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:57 ifi-zen-stream3 sudo[5065]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:57 ifi-zen-stream3 sudo[5067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Dec 22 05:31:58 ifi-zen-stream3 sudo[5067]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:58 ifi-zen-stream3 systemd[1]: mpd.socket: Succeeded. Dec 22 05:31:58 ifi-zen-stream3 systemd[1]: Closed mpd.socket. Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: info: [1766381518073] CoreMusicLibrary::Adding element Last_100 Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 22 05:31:58 ifi-zen-stream3 systemd[1]: Stopping Music Player Daemon... Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: info: Starting RoonReady Sync Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: info: [1766381518130] CoreMusicLibrary::Adding element Webradio Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: info: Initializing BBC Radios Dec 22 05:31:58 ifi-zen-stream3 sudo[5071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Dec 22 05:31:58 ifi-zen-stream3 sudo[5071]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:58 ifi-zen-stream3 node[528]: ConvSwitch: Drop client roon-ready Dec 22 05:31:58 ifi-zen-stream3 node[498]: Closing connection with the client roon-ready Dec 22 05:31:58 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Roon Ready Service... Dec 22 05:31:58 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM Dec 22 05:31:58 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Succeeded. Dec 22 05:31:58 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Roon Ready Service. Dec 22 05:31:58 ifi-zen-stream3 systemd[1]: Started iFi Streamer Roon Ready Service. Dec 22 05:31:58 ifi-zen-stream3 sudo[5071]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:58 ifi-zen-stream3 play[5082]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 05:31:58 ifi-zen-stream3 play[5014]: 20251222 05:31:58.532 [5045.5045] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 05:31:58 ifi-zen-stream3 sudo[4872]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: Starting albumart workers Dec 22 05:31:58 ifi-zen-stream3 sudo[5095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -snf /usr/local/bin/airplay2 /usr/local/bin/shairport-sync Dec 22 05:31:58 ifi-zen-stream3 sudo[5095]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: Starting albumart workers Dec 22 05:31:58 ifi-zen-stream3 sudo[5095]: pam_unix(sudo:session): session closed for user root Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: Starting albumart workers Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 22 05:31:58 ifi-zen-stream3 volumio[4798]: info: Volumio Calling Home Dec 22 05:31:59 ifi-zen-stream3 node[528]: ConvSwitch: Add client roon-ready Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: info: CoreStateMachine::setRepeat null single undefined Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: info: CoreStateMachine::pushState Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: info: CorePlayQueue::getTrack 0 Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::volumioPushState Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: info: CoreStateMachine::setRandom null Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: info: CoreStateMachine::pushState Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: info: CorePlayQueue::getTrack 0 Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::volumioPushState Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: info: Starting RoonReady Sync Dec 22 05:31:59 ifi-zen-stream3 sudo[5154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Dec 22 05:31:59 ifi-zen-stream3 sudo[5154]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:59 ifi-zen-stream3 sudo[5156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Dec 22 05:31:59 ifi-zen-stream3 sudo[5156]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:59 ifi-zen-stream3 sudo[5158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Dec 22 05:31:59 ifi-zen-stream3 sudo[5158]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: info: Airplay2 Started Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: error: Could not retrieve plugin music_service airplay1_switch Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: info: Disabling plugin airplay1_switch Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: info: Done. Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: info: RoonReady Started Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: info: MPD Permissions set Dec 22 05:31:59 ifi-zen-stream3 volumio[4798]: info: MPD Permissions set Dec 22 05:31:59 ifi-zen-stream3 sudo[5164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Dec 22 05:31:59 ifi-zen-stream3 sudo[5164]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:31:59 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:59.839 E esdk select error: 4 -> Interrupted system call Dec 22 05:31:59 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:59.840 I app Exiting with error = 0 Dec 22 05:31:59 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:59.840 I api SpFree() Dec 22 05:31:59 ifi-zen-stream3 play[4385]: 2025-12-22 05:31:59.841 I api SpFree [returned value: 0] Dec 22 05:31:59 ifi-zen-stream3 play[4385]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Dec 22 05:31:59 ifi-zen-stream3 play[4385]: [Info] ConvSwitch: ConvSwitchInit Dec 22 05:31:59 ifi-zen-stream3 play[4385]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 22 05:31:59 ifi-zen-stream3 play[4385]: [Info] MetaClient: MetaClientInit Dec 22 05:31:59 ifi-zen-stream3 play[4385]: [Info] ConvSwitch: ConvSwitchExit Dec 22 05:31:59 ifi-zen-stream3 play[4385]: [Info] MetaClient: MetaClientExit Dec 22 05:31:59 ifi-zen-stream3 node[528]: ConvSwitch: Drop client spotify Dec 22 05:31:59 ifi-zen-stream3 node[498]: Closing connection with the client spotify Dec 22 05:31:59 ifi-zen-stream3 node[528]: ConvSwitch: Drop client roon-ready Dec 22 05:31:59 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service... Dec 22 05:31:59 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Roon Ready Service... Dec 22 05:31:59 ifi-zen-stream3 node[498]: Closing connection with the client qobuz-connect Dec 22 05:31:59 ifi-zen-stream3 node[528]: ConvSwitch: Drop client qobuz-connect Dec 22 05:31:59 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Qobuz Connect Service... Dec 22 05:31:59 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 22 05:31:59 ifi-zen-stream3 sudo[5166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Dec 22 05:31:59 ifi-zen-stream3 sudo[5166]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: Roon Ready playback start Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::volumioStop Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreStateMachine::stop Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service. Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: Starting Roon Ready metadata receiver Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: Error adding Membership: Error: addMembership EINVAL Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded. Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Qobuz Connect Service. Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Succeeded. Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Roon Ready Service. Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: Volumio called home Dec 22 05:32:00 ifi-zen-stream3 sudo[5154]: pam_unix(sudo:session): session closed for user root Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: Started iFi Streamer Roon Ready Service. Dec 22 05:32:00 ifi-zen-stream3 sudo[5156]: pam_unix(sudo:session): session closed for user root Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service. Dec 22 05:32:00 ifi-zen-stream3 sudo[5158]: pam_unix(sudo:session): session closed for user root Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:32:00 ifi-zen-stream3 play[5211]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: shairport-sync.service: Succeeded. Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:32:00 ifi-zen-stream3 ifi_metadata[5019]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 22 05:32:00 ifi-zen-stream3 ifi_metadata[5019]: [Info] MetaClient: MetaClientInit Dec 22 05:32:00 ifi-zen-stream3 ifi_metadata[5019]: Could not connect: Reason::CONNECTION_ERROR Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 22 05:32:00 ifi-zen-stream3 sudo[5164]: pam_unix(sudo:session): session closed for user root Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 22 05:32:00 ifi-zen-stream3 node[528]: ConvSwitch: Add client tidal Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: mpd.service: Succeeded. Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: Stopped Music Player Daemon. Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 05:32:00 ifi-zen-stream3 tidal_connect_application[5159]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi. Dec 22 05:32:00 ifi-zen-stream3 tidal_connect_application[5159]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 22 05:32:00 ifi-zen-stream3 tidal_connect_application[5159]: *** WARNING *** For more information see Dec 22 05:32:00 ifi-zen-stream3 play[5215]: output: volumio mixer: hw:5 Dec 22 05:32:00 ifi-zen-stream3 node[528]: ConvSwitch: Add client spotify Dec 22 05:32:00 ifi-zen-stream3 sudo[5067]: pam_unix(sudo:session): session closed for user root Dec 22 05:32:00 ifi-zen-stream3 sudo[5166]: pam_unix(sudo:session): session closed for user root Dec 22 05:32:00 ifi-zen-stream3 node[498]: A new connection has been established. Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.702 I api SpRegisterDebugCallbacks [returned value: 0] Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.702 I api SpInit(0xff938ed0, API v66) Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.703 I esdk eSDK version: HEAD-v3.166.69-g24821f73 Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.703 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 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.703 I esdk Successfully registered dns callback: dns_lookup_callback Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.703 I download Using 128 kB for cache buffer Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.703 I download Using 621 kB for compressed audio buffer Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.703 I esdk Successfully registered error callback Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.716 I esdk Creating IPv4 socket (domain 2) Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.716 I zc webserver: service port 5566 (5566-5576) buffer size 4444 Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.716 I zc Started ZeroConf service on port 5566 path /zc alias count 0 Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.716 I esdk Creating IPv4 socket (domain 2) Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.716 I api SpInit [returned value: 0] Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.717 I api SpRegisterConnectionCallbacks(0xff938eb8, (nil)) Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.717 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.717 I api SpRegisterConnectionCallbacks [returned value: 0] Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.717 I api SpRegisterPlaybackCallbacks(0xff938ea0, (nil)) Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.717 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, - Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.717 I api SpRegisterPlaybackCallbacks [returned value: 0] Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.724 W app Couldn't find mixer for volume controls. (tried , SoftMaster) Dec 22 05:32:00 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:00.724 I app Initialized! Dec 22 05:32:00 ifi-zen-stream3 ifi_metadata[5019]: Connected Dec 22 05:32:00 ifi-zen-stream3 sudo[5296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Dec 22 05:32:00 ifi-zen-stream3 sudo[5296]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:32:00 ifi-zen-stream3 node[528]: ConvSwitch: Add client roon-ready Dec 22 05:32:00 ifi-zen-stream3 node[498]: Closing connection with the client tidal-connect Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: Shairport-Sync Stopped Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: Spotify Connect Service Started Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: RoonReady Started Dec 22 05:32:00 ifi-zen-stream3 sudo[5304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Dec 22 05:32:00 ifi-zen-stream3 sudo[5304]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:32:00 ifi-zen-stream3 node[528]: ConvSwitch: Drop client tidal Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service... Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service. Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: Starting Shairport Sync Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service. Dec 22 05:32:00 ifi-zen-stream3 sudo[5296]: pam_unix(sudo:session): session closed for user root Dec 22 05:32:00 ifi-zen-stream3 sudo[5307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Dec 22 05:32:00 ifi-zen-stream3 sudo[5307]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service. Dec 22 05:32:00 ifi-zen-stream3 node[498]: A new connection has been established. Dec 22 05:32:00 ifi-zen-stream3 volumio[4798]: info: Starting Shairport Sync Dec 22 05:32:00 ifi-zen-stream3 sudo[5316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 22 05:32:00 ifi-zen-stream3 sudo[5316]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:32:00 ifi-zen-stream3 systemd[1]: Listening on mpd.socket. Dec 22 05:32:01 ifi-zen-stream3 systemd[1]: Starting Music Player Daemon... Dec 22 05:32:01 ifi-zen-stream3 sudo[5320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 22 05:32:01 ifi-zen-stream3 sudo[5320]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: ++++--++++ getState Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::volumioGetState Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: CorePlayQueue::getTrack 0 Dec 22 05:32:01 ifi-zen-stream3 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 22 05:32:01 ifi-zen-stream3 sudo[5316]: pam_unix(sudo:session): session closed for user root Dec 22 05:32:01 ifi-zen-stream3 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 22 05:32:01 ifi-zen-stream3 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Dec 22 05:32:01 ifi-zen-stream3 systemd[1]: shairport-sync.service: Succeeded. Dec 22 05:32:01 ifi-zen-stream3 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 22 05:32:01 ifi-zen-stream3 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 22 05:32:01 ifi-zen-stream3 sudo[5320]: pam_unix(sudo:session): session closed for user root Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: Tidal Connect Service Started Dec 22 05:32:01 ifi-zen-stream3 sudo[5326]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 22 05:32:01 ifi-zen-stream3 sudo[5326]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:32:01 ifi-zen-stream3 sudo[5326]: pam_unix(sudo:session): session closed for user root Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: Shairport-Sync Started Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: Error adding Membership: Error: addMembership EINVAL Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: Shairport-Sync Started Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: Roon Ready playback start Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: Roon Ready metadata receiver is on Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: verbose: New Socket.io Connection to 192.168.3.153 from 192.168.3.152 UA: Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/97.0.4692.99 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: ++++--++++ getState Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::volumioGetState Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: CorePlayQueue::getTrack 0 Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: ++++--++++ getMultiRoomDevices: null Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: ++++--++++ getMultiroom: null Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: error: Could not retrieve plugin audio_interface multiroom Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: ++++--++++ getBrowseSources: null Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::volumioGetVisibleSources Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: ++++--++++ getMenuItems Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: ++++--++++ listPlaylist: null Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: Listing playlists Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: ++++--++++ getMenuItems Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: ++++--++++ getQueue Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::volumioGetQueue Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: CoreStateMachine::getQueue Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: CorePlayQueue::getQueue Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: ++++--++++ getMenuItems Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: ++++--++++ getMenuItems Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: ++++--++++ getMenuItems Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: ++++--++++ getMenuItems Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: Discovery: adding 24723455-183c-4edc-9467-8615328c9540 Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: Discovery: Found device ZEN Stream3 Dec 22 05:32:01 ifi-zen-stream3 sudo[5345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Dec 22 05:32:01 ifi-zen-stream3 sudo[5345]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::volumioGetState Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: info: CorePlayQueue::getTrack 0 Dec 22 05:32:01 ifi-zen-stream3 volumio[4798]: error: Could not retrieve plugin audio_interface multiroom Dec 22 05:32:02 ifi-zen-stream3 systemd[1]: Started iFi Streamer Qobuz Connect Service. Dec 22 05:32:02 ifi-zen-stream3 sudo[5345]: pam_unix(sudo:session): session closed for user root Dec 22 05:32:02 ifi-zen-stream3 volumio[4798]: info: Qobuz Connect Service Started Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.206 [5368.5368] DEBUG SampleApp: Starting sample application Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.207 [5368.5368] DEBUG SampleApp: Device Name: ZEN Stream3 Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.207 [5368.5368] DEBUG SampleApp: Manufacturer: Sample manufacturer Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.207 [5368.5368] DEBUG SampleApp: Model: iFi Streamer Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.207 [5368.5368] DEBUG SampleApp: Serial Number: ifi:1e:d5:d8:fd:fe:f8 Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.207 [5368.5368] DEBUG SampleApp: Audio output device: volumio Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.207 [5368.5368] DEBUG SampleApp: Volume control device: default Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.207 [5368.5368] DEBUG SampleApp: Volume control element: Master Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.207 [5368.5368] DEBUG SampleApp: Local config server port: 8000 Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.212 [5368.5368] ERROR SampleApp: Unable to find ALSA mixer element 'Master' on index 0 Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.213 [5368.5368] DEBUG SampleApp: Maximum supported audio quality: HIRES_L3 Dec 22 05:32:02 ifi-zen-stream3 play[5351]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 22 05:32:02 ifi-zen-stream3 node[498]: A new connection has been established. Dec 22 05:32:02 ifi-zen-stream3 play[5351]: [Info] MetaClient: MetaClientInit Dec 22 05:32:02 ifi-zen-stream3 play[5351]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Dec 22 05:32:02 ifi-zen-stream3 node[528]: ConvSwitch: Add client qobuz-connect Dec 22 05:32:02 ifi-zen-stream3 play[5351]: [Info] ConvSwitch: ConvSwitchInit Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.320 [5368.5368] DEBUG ActiveStateManager: [0xaae3b030]: Creating new Active State Manager Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.320 [5368.5368] DEBUG NetworkActivityTracker: [0xaae3b0a0]: Creating new Network Activity Tracker Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.321 [5368.5368] DEBUG EndpointManager: [0xaae3c018]: Creating Endpoint Manager Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.321 [5368.5368] DEBUG PlaybackSessionManager: [0xaae3c408]: Creating Playback Session Manager Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.321 [5368.5368] DEBUG BackoffTimer: [0xaae3c580]: Creating Backoff Timer Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.321 [5368.5368] DEBUG MediaEngine: [0xaae3c6a0]: Creating new Media Engine Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.321 [5368.5368] DEBUG AudioRenderer: [0xaae3c8c0]: Creating Audio Renderer Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.321 [5368.5368] TRACE MediaEngineCommandSequencer: [0xaae3ca18]: Creating Media Engine Command Sequencer Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.321 [5368.5368] DEBUG PlaybackControlsManager: [0xaae3ca78]: Creating new Playback Controls Manager Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.321 [5368.5368] DEBUG VolumeManager: [0xaae3cb08]: Creating new Volume Manager Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.321 [5368.5368] DEBUG ProtocolHandler: [0xaae3cde0]: Creating Protocol Handler Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.321 [5368.5368] DEBUG MessageReceiver: [0xaae3ce80]: Creating Message Receiver Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.321 [5368.5368] DEBUG RendererActivationController: [0xaae3cff8]: Creating new Renderer Activation Controller Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.321 [5368.5368] TRACE RendererActivationCommandSequencer: [0xaae3d0a0]: Creating Renderer Activation Command Sequencer Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.321 [5368.5368] DEBUG ReportingManager: [0xaae3d1b0]: Creating new Reporting Manager Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.321 [5368.5368] DEBUG StreamingEventReporter: [0xaae3d1f8]: Creating Streaming Event Reporter Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.321 [5368.5368] DEBUG BackoffTimer: [0xaae3d2d8]: Creating Backoff Timer Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.322 [5368.5368] DEBUG TokenExpiryController: [0xaae3d3e8]: Creating Token Expiry Controller Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.322 [5368.5368] DEBUG UserInactivityManager: [0xaae3d438]: Creating new User Inactivity Manager Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.322 [5368.5368] INFO VolumeManager: [0xaae3cb08]: Setting new playback volume: 100 Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.322 [5368.5368] INFO VolumeManager: [0xaae3cb08]: Setting new mute state: 1 Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.322 [5368.5368] DEBUG SampleApp: Qobuz Connect has been initialized Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.322 [5368.5368] TRACE SampleApp: Running event loop Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.322 [5368.5368] INFO QobuzConnect: [0xaae3d4d8]: Client initialized! Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.322 [5368.5368] INFO SampleApp: Starting Avahi advertising, name: ZEN Stream3, service name: _qobuz-connect._tcp Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.336 [5368.5368] DEBUG SampleApp: Avahi client state changed: RUNNING Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.340 [5368.5368] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.346 [5368.5368] INFO LocalConfigManager: [0xaae3c3e8]: Starting Local Configuration server Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.347 [5368.5368] INFO SampleApp: Starting Local configuration server Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.348 [5368.5368] INFO SampleApp: Playback mute state changed: 1 Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.348 [5368.5368] ERROR SampleApp: Unable to set mute state, no ALSA volume element Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.349 [5368.5368] DEBUG SampleApp: Avahi entry group state changed: REGISTERING Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.358 [5368.5368] INFO SampleApp: Playback volume changed: 100 Dec 22 05:32:02 ifi-zen-stream3 play[5351]: 20251222 05:32:02.358 [5368.5368] ERROR SampleApp: Unable to set volume, no ALSA volume element Dec 22 05:32:02 ifi-zen-stream3 node[498]: A new connection has been established. Dec 22 05:32:02 ifi-zen-stream3 sudo[5379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Dec 22 05:32:02 ifi-zen-stream3 sudo[5379]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 05:32:02 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:02.664 E esdk select error: 4 -> Interrupted system call Dec 22 05:32:02 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:02.665 I app Exiting with error = 0 Dec 22 05:32:02 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:02.665 I api SpFree() Dec 22 05:32:02 ifi-zen-stream3 play[5215]: 2025-12-22 05:32:02.666 I api SpFree [returned value: 0] Dec 22 05:32:02 ifi-zen-stream3 play[5215]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Dec 22 05:32:02 ifi-zen-stream3 play[5215]: [Info] ConvSwitch: ConvSwitchInit Dec 22 05:32:02 ifi-zen-stream3 play[5215]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 22 05:32:02 ifi-zen-stream3 play[5215]: [Info] MetaClient: MetaClientInit Dec 22 05:32:02 ifi-zen-stream3 play[5215]: [Info] ConvSwitch: ConvSwitchExit Dec 22 05:32:02 ifi-zen-stream3 play[5215]: [Info] MetaClient: MetaClientExit Dec 22 05:32:02 ifi-zen-stream3 node[498]: Closing connection with the client spotify Dec 22 05:32:02 ifi-zen-stream3 node[528]: ConvSwitch: Drop client spotify Dec 22 05:32:02 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service... Dec 22 05:32:02 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Dec 22 05:32:02 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Dec 22 05:32:02 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service. Dec 22 05:32:02 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service. Dec 22 05:32:02 ifi-zen-stream3 sudo[5379]: pam_unix(sudo:session): session closed for user root Dec 22 05:32:02 ifi-zen-stream3 volumio[4798]: info: Spotify Connect Service Started Dec 22 05:32:02 ifi-zen-stream3 play[5381]: output: volumio mixer: hw:5 Dec 22 05:32:02 ifi-zen-stream3 node[528]: ConvSwitch: Add client spotify Dec 22 05:32:02 ifi-zen-stream3 node[498]: A new connection has been established. Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.934 I api SpRegisterDebugCallbacks [returned value: 0] Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.934 I api SpInit(0xff9a44c0, API v66) Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.935 I esdk eSDK version: HEAD-v3.166.69-g24821f73 Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.935 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 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.935 I esdk Successfully registered dns callback: dns_lookup_callback Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.935 I download Using 128 kB for cache buffer Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.935 I download Using 621 kB for compressed audio buffer Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.936 I esdk Successfully registered error callback Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.947 I esdk Creating IPv4 socket (domain 2) Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.948 I zc webserver: service port 5566 (5566-5576) buffer size 4444 Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.948 I zc Started ZeroConf service on port 5566 path /zc alias count 0 Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.948 I esdk Creating IPv4 socket (domain 2) Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.948 I api SpInit [returned value: 0] Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.948 I api SpRegisterConnectionCallbacks(0xff9a44a8, (nil)) Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.948 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.949 I api SpRegisterConnectionCallbacks [returned value: 0] Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.949 I api SpRegisterPlaybackCallbacks(0xff9a4490, (nil)) Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.949 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, - Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.949 I api SpRegisterPlaybackCallbacks [returned value: 0] Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.955 W app Couldn't find mixer for volume controls. (tried , SoftMaster) Dec 22 05:32:02 ifi-zen-stream3 play[5381]: 2025-12-22 05:32:02.955 I app Initialized! Dec 22 05:32:03 ifi-zen-stream3 play[5351]: 20251222 05:32:03.142 [5368.5368] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: ++++--++++ playItemsList: {"item":{"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=635_1766381373153&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=635_1766381373152&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=635_1766381373152&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=635_1766381373152&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=635_1766381373153&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=635_1766381373153&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=635_1766381373153&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=635_1766381373153&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=635_1766381373153&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=635_1766381373153&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=635_1766381373153&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"}],"index":6} Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: Preload queue cleared Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: CoreStateMachine::ClearQueue Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: CoreStateMachine::stop Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: CoreStateMachine::serviceStop Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::serviceStop Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::volumioStop Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: CoreStateMachine::stop Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: Roon Ready Stop Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: CorePlayQueue::clearPlayQueue Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: CorePlayQueue::saveQueue Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: CoreCommandRouter::volumioPushQueue Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: CoreStateMachine::addQueueItems Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: CorePlayQueue::addQueueItems Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: Preload queue cleared Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: info: Exploding uri music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac in service mpd Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: TypeError: Cannot read property 'then' of undefined Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2887:19) Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2685:21) Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1528:16) Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:252:25) Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:628:25) Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:600:19) Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:156:33) Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: at Socket.emit (events.js:400:28) Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Dec 22 05:32:03 ifi-zen-stream3 volumio[4798]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 22 05:32:03 ifi-zen-stream3 node[528]: ConvSwitch: Add client tidal Dec 22 05:32:03 ifi-zen-stream3 tidal_connect_application[5415]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi. Dec 22 05:32:03 ifi-zen-stream3 tidal_connect_application[5415]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 22 05:32:03 ifi-zen-stream3 tidal_connect_application[5415]: *** WARNING *** For more information see Dec 22 05:32:03 ifi-zen-stream3 ifi_metadata[5311]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 22 05:32:03 ifi-zen-stream3 ifi_metadata[5311]: [Info] MetaClient: MetaClientInit Dec 22 05:32:03 ifi-zen-stream3 ifi_metadata[5311]: Connected Dec 22 05:32:04 ifi-zen-stream3 sudo[5473]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-22 05:31 Dec 22 05:32:04 ifi-zen-stream3 sudo[5473]: 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"