-- Logs begin at Sat 2025-11-15 07:41:13 UTC, end at Fri 2025-12-12 11:54:04 UTC. -- Dec 12 11:53:00 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 12 11:53:00 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 12 11:53:00 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 12 11:53:00 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 12 11:53:00 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 12 11:53:03 ifi-zen-stream3 kernel: usb 4-1.3: USB disconnect, device number 6 Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: ---------------------------- USB Audio Device Detached Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::Close All Modals sent Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: Preparing to save Alsa Options, stopping services first Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioGetState Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 4 Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioPause Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::pause Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: Saving Audio Output to: {"disallowPush":false,"output_device":{"value":"0,0","label":"SPDIF"}} Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: mpd , forceDoP Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: Found match in Cards Database: setting mixer for card SPDIF Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: Ignoring Mixers Options Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: Device 0,0 does not have any Mixer Control Available Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: Restoring Previous Volume level: 100 false false Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: Updating Volume Controller Parameters: Device: 0,0 Name: SPDIF Mixer: None Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 12 11:53:03 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::pushState Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 4 Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioPushState Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: Preparing to generate the ALSA configuration file Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: wizard , refreshWizarOutputDevices Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: Asound.conf file written Dec 12 11:53:04 ifi-zen-stream3 sudo[4825]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 12 11:53:04 ifi-zen-stream3 sudo[4825]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:04 ifi-zen-stream3 sudo[4825]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: No state is present for card rkifispdif Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: Found hardware: "rk-ifi-spdif" "" "" "" "" Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: Hardware is initialized using a generic method Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: No state is present for card rkifispdif Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: Tidal connect: Output device has changed Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: Output device has changed, restarting MPD Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: Qobuz connect: Output device has changed Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: Roon Ready: Output device has changed Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: Spotify: Output device has changed Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: Tidal connect: Output device has changed Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: Output device has changed, restarting MPD Dec 12 11:53:04 ifi-zen-stream3 sudo[4830]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 12 11:53:04 ifi-zen-stream3 sudo[4830]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:04 ifi-zen-stream3 sudo[4830]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: Qobuz connect: Output device has changed Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: Roon Ready: Output device has changed Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: Spotify: Output device has changed Dec 12 11:53:04 ifi-zen-stream3 sudo[4834]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: MPD Permissions set Dec 12 11:53:04 ifi-zen-stream3 sudo[4834]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 sudo[4834]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: MPD Permissions set Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: Starting RoonReady Sync Dec 12 11:53:04 ifi-zen-stream3 sudo[4850]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Dec 12 11:53:04 ifi-zen-stream3 sudo[4850]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:04 ifi-zen-stream3 sudo[4851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Dec 12 11:53:04 ifi-zen-stream3 sudo[4851]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:04 ifi-zen-stream3 volumio[1448]: info: Starting RoonReady Sync Dec 12 11:53:05 ifi-zen-stream3 node[479]: Closing connection with the client qobuz-connect Dec 12 11:53:05 ifi-zen-stream3 node[525]: ConvSwitch: Drop client qobuz-connect Dec 12 11:53:05 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Qobuz Connect Service... Dec 12 11:53:05 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM Dec 12 11:53:05 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded. Dec 12 11:53:05 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Qobuz Connect Service. Dec 12 11:53:05 ifi-zen-stream3 sudo[4856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Dec 12 11:53:05 ifi-zen-stream3 sudo[4856]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:05 ifi-zen-stream3 sudo[4857]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Dec 12 11:53:05 ifi-zen-stream3 sudo[4857]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:05 ifi-zen-stream3 sudo[4850]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:05 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Roon Ready Service... Dec 12 11:53:05 ifi-zen-stream3 node[525]: ConvSwitch: Drop client roon-ready Dec 12 11:53:05 ifi-zen-stream3 node[479]: Closing connection with the client roon-ready Dec 12 11:53:05 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM Dec 12 11:53:05 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Succeeded. Dec 12 11:53:05 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Roon Ready Service. Dec 12 11:53:05 ifi-zen-stream3 systemd[1]: Started iFi Streamer Roon Ready Service. Dec 12 11:53:05 ifi-zen-stream3 sudo[4857]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:05 ifi-zen-stream3 sudo[4851]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: RoonReady Started Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: RoonReady Started Dec 12 11:53:05 ifi-zen-stream3 play[4863]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Dec 12 11:53:05 ifi-zen-stream3 sudo[4856]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:05 ifi-zen-stream3 node[525]: ConvSwitch: Add client roon-ready Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: ConvSwitch: Get message: request:pause Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioStop Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::stop Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::updateTrackBlock Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrackBlock Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::stPlaybackTimer Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::pushState Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 4 Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioPushState Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::serviceStop Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 4 Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::serviceStop Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: ControllerMpd::stop Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::sendMpdCommand stop Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioStop Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::stop Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: ---------------------------- MPD announces state update: player Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: sendMpdCommand stop took 15 milliseconds Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: ControllerMpd::getState Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::sendMpdCommand status Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: sendMpdCommand status took 2 milliseconds Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::parseState Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioGetState Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 4 Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: ---------------------------- MPD announces state update: player Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: ControllerMpd::getState Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::sendMpdCommand status Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: sendMpdCommand playlistinfo took 10 milliseconds Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: sendMpdCommand status took 7 milliseconds Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::parseTrackInfo Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::parseState Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioGetState Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 4 Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: ControllerMpd::pushState Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::servicePushState Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::pushState Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 4 Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioPushState Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 4 Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: 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 96kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac","trackType":"flac"} Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: verbose: CURRENT POSITION 4 Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: ------------------------------ 46ms Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: Roon Ready playback start Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioStop Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::stop Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: Roon Ready metadata receiver is on Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: sendMpdCommand playlistinfo took 39 milliseconds Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::parseTrackInfo Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: ControllerMpd::pushState Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::servicePushState Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::pushState Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 4 Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioPushState Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 4 Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: 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 96kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac","trackType":"flac"} Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: verbose: CURRENT POSITION 4 Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Dec 12 11:53:05 ifi-zen-stream3 volumio[1448]: info: ------------------------------ 76ms Dec 12 11:53:05 ifi-zen-stream3 sudo[4902]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Dec 12 11:53:05 ifi-zen-stream3 sudo[4902]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:05 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 12 11:53:05 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Dec 12 11:53:05 ifi-zen-stream3 node[479]: Closing connection with the client tidal-connect Dec 12 11:53:05 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Dec 12 11:53:05 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Dec 12 11:53:05 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Dec 12 11:53:05 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service... Dec 12 11:53:05 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Dec 12 11:53:05 ifi-zen-stream3 node[525]: ConvSwitch: Drop client tidal Dec 12 11:53:05 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Dec 12 11:53:05 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service. Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service. Dec 12 11:53:06 ifi-zen-stream3 sudo[4902]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:06 ifi-zen-stream3 sudo[4906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Dec 12 11:53:06 ifi-zen-stream3 sudo[4906]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:06 ifi-zen-stream3 volumio[1448]: info: Tidal Connect Service Started Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service. Dec 12 11:53:06 ifi-zen-stream3 node[479]: A new connection has been established. Dec 12 11:53:06 ifi-zen-stream3 node[479]: Closing connection with the client tidal-connect Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service... Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service. Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service. Dec 12 11:53:06 ifi-zen-stream3 sudo[4906]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service. Dec 12 11:53:06 ifi-zen-stream3 volumio[1448]: info: Tidal Connect Service Started Dec 12 11:53:06 ifi-zen-stream3 sudo[4927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Dec 12 11:53:06 ifi-zen-stream3 sudo[4927]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:06 ifi-zen-stream3 node[479]: A new connection has been established. Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Started iFi Streamer Qobuz Connect Service. Dec 12 11:53:06 ifi-zen-stream3 sudo[4927]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:06 ifi-zen-stream3 volumio[1448]: info: Qobuz Connect Service Started Dec 12 11:53:06 ifi-zen-stream3 sudo[4943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Dec 12 11:53:06 ifi-zen-stream3 sudo[4943]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:06 ifi-zen-stream3 sudo[4943]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:06 ifi-zen-stream3 volumio[1448]: info: Qobuz Connect Service Started Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.342 [4967.4967] DEBUG SampleApp: Starting sample application Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.344 [4967.4967] DEBUG SampleApp: Device Name: ZEN Stream3 Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.345 [4967.4967] DEBUG SampleApp: Manufacturer: Sample manufacturer Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.346 [4967.4967] DEBUG SampleApp: Model: iFi Streamer Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.346 [4967.4967] DEBUG SampleApp: Serial Number: ifi:b6:8f:11:d4:21:f5 Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.346 [4967.4967] DEBUG SampleApp: Audio output device: volumio Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.347 [4967.4967] DEBUG SampleApp: Volume control device: default Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.347 [4967.4967] DEBUG SampleApp: Volume control element: Master Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.348 [4967.4967] DEBUG SampleApp: Local config server port: 8000 Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.353 [4967.4967] ERROR SampleApp: Unable to find ALSA mixer element 'Master' on index 0 Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.353 [4967.4967] DEBUG SampleApp: Maximum supported audio quality: HIRES_L3 Dec 12 11:53:06 ifi-zen-stream3 play[4935]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 12 11:53:06 ifi-zen-stream3 node[479]: A new connection has been established. Dec 12 11:53:06 ifi-zen-stream3 play[4935]: [Info] MetaClient: MetaClientInit Dec 12 11:53:06 ifi-zen-stream3 play[4935]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Dec 12 11:53:06 ifi-zen-stream3 node[525]: ConvSwitch: Add client qobuz-connect Dec 12 11:53:06 ifi-zen-stream3 sudo[4971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Dec 12 11:53:06 ifi-zen-stream3 sudo[4971]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:06 ifi-zen-stream3 play[4935]: [Info] ConvSwitch: ConvSwitchInit Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.462 [4967.4967] DEBUG ActiveStateManager: [0xaba15098]: Creating new Active State Manager Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.462 [4967.4967] DEBUG NetworkActivityTracker: [0xaba15108]: Creating new Network Activity Tracker Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.462 [4967.4967] DEBUG EndpointManager: [0xaba16080]: Creating Endpoint Manager Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.462 [4967.4967] DEBUG PlaybackSessionManager: [0xaba16470]: Creating Playback Session Manager Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.462 [4967.4967] DEBUG BackoffTimer: [0xaba165e8]: Creating Backoff Timer Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.462 [4967.4967] DEBUG MediaEngine: [0xaba16708]: Creating new Media Engine Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.462 [4967.4967] DEBUG AudioRenderer: [0xaba16928]: Creating Audio Renderer Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.462 [4967.4967] TRACE MediaEngineCommandSequencer: [0xaba16a80]: Creating Media Engine Command Sequencer Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.462 [4967.4967] DEBUG PlaybackControlsManager: [0xaba16ae0]: Creating new Playback Controls Manager Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.462 [4967.4967] DEBUG VolumeManager: [0xaba16b70]: Creating new Volume Manager Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.463 [4967.4967] DEBUG ProtocolHandler: [0xaba16e48]: Creating Protocol Handler Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.463 [4967.4967] DEBUG MessageReceiver: [0xaba16ee8]: Creating Message Receiver Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.463 [4967.4967] DEBUG RendererActivationController: [0xaba17060]: Creating new Renderer Activation Controller Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.463 [4967.4967] TRACE RendererActivationCommandSequencer: [0xaba17108]: Creating Renderer Activation Command Sequencer Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.463 [4967.4967] DEBUG ReportingManager: [0xaba17218]: Creating new Reporting Manager Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.463 [4967.4967] DEBUG StreamingEventReporter: [0xaba17260]: Creating Streaming Event Reporter Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.463 [4967.4967] DEBUG BackoffTimer: [0xaba17340]: Creating Backoff Timer Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.463 [4967.4967] DEBUG TokenExpiryController: [0xaba17450]: Creating Token Expiry Controller Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.463 [4967.4967] DEBUG UserInactivityManager: [0xaba174a0]: Creating new User Inactivity Manager Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: mpd.socket: Succeeded. Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Closed mpd.socket. Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.472 [4967.4967] INFO VolumeManager: [0xaba16b70]: Setting new playback volume: 100 Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.472 [4967.4967] INFO VolumeManager: [0xaba16b70]: Setting new mute state: 1 Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.473 [4967.4967] DEBUG SampleApp: Qobuz Connect has been initialized Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.473 [4967.4967] TRACE SampleApp: Running event loop Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.473 [4967.4967] INFO QobuzConnect: [0xaba17540]: Client initialized! Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.473 [4967.4967] INFO SampleApp: Starting Avahi advertising, name: ZEN Stream3, service name: _qobuz-connect._tcp Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Stopping Music Player Daemon... Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.492 [4967.4967] DEBUG SampleApp: Avahi client state changed: RUNNING Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.497 [4967.4967] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.505 [4967.4967] INFO LocalConfigManager: [0xaba16450]: Starting Local Configuration server Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.505 [4967.4967] INFO SampleApp: Starting Local configuration server Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.506 [4967.4967] INFO SampleApp: Playback mute state changed: 1 Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.507 [4967.4967] ERROR SampleApp: Unable to set mute state, no ALSA volume element Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.507 [4967.4967] DEBUG SampleApp: Avahi entry group state changed: REGISTERING Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.507 [4967.4967] INFO SampleApp: Playback volume changed: 100 Dec 12 11:53:06 ifi-zen-stream3 play[4935]: 20251212 11:53:06.507 [4967.4967] ERROR SampleApp: Unable to set volume, no ALSA volume element Dec 12 11:53:06 ifi-zen-stream3 sudo[4974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Dec 12 11:53:06 ifi-zen-stream3 sudo[4974]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: mpd.service: Succeeded. Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Stopped Music Player Daemon. Dec 12 11:53:06 ifi-zen-stream3 sudo[4971]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:06 ifi-zen-stream3 sudo[4979]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Dec 12 11:53:06 ifi-zen-stream3 sudo[4979]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:06 ifi-zen-stream3 sudo[4974]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Listening on mpd.socket. Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Starting Music Player Daemon... Dec 12 11:53:06 ifi-zen-stream3 sudo[4983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Dec 12 11:53:06 ifi-zen-stream3 sudo[4983]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: mpd.socket: Succeeded. Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Closed mpd.socket. Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Stopping mpd.socket. Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: mpd.socket: Socket service mpd.service already active, refusing. Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Failed to listen on mpd.socket. Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: mpd.service: Succeeded. Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Stopped Music Player Daemon. Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Listening on mpd.socket. Dec 12 11:53:06 ifi-zen-stream3 systemd[1]: Starting Music Player Daemon... Dec 12 11:53:06 ifi-zen-stream3 sudo[4985]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 12 11:53:06 ifi-zen-stream3 sudo[4985]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:06 ifi-zen-stream3 sudo[4985]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:06 ifi-zen-stream3 node[479]: A new connection has been established. Dec 12 11:53:07 ifi-zen-stream3 play[4935]: 20251212 11:53:07.293 [4967.4967] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED Dec 12 11:53:07 ifi-zen-stream3 sudo[5022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Dec 12 11:53:07 ifi-zen-stream3 sudo[5022]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:07 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Dec 12 11:53:08 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::getcurrentVolume Dec 12 11:53:08 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioRetrievevolume Dec 12 11:53:08 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Dec 12 11:53:08 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::pushState Dec 12 11:53:08 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:08 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioPushState Dec 12 11:53:08 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:08 ifi-zen-stream3 play[4440]: 2025-12-12 11:53:08.025 E esdk select error: 4 -> Interrupted system call Dec 12 11:53:08 ifi-zen-stream3 play[4440]: 2025-12-12 11:53:08.026 I app Exiting with error = 0 Dec 12 11:53:08 ifi-zen-stream3 play[4440]: 2025-12-12 11:53:08.026 I api SpFree() Dec 12 11:53:08 ifi-zen-stream3 play[4440]: 2025-12-12 11:53:08.027 I api SpFree [returned value: 0] Dec 12 11:53:08 ifi-zen-stream3 play[4440]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Dec 12 11:53:08 ifi-zen-stream3 play[4440]: [Info] ConvSwitch: ConvSwitchInit Dec 12 11:53:08 ifi-zen-stream3 play[4440]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 12 11:53:08 ifi-zen-stream3 play[4440]: [Info] MetaClient: MetaClientInit Dec 12 11:53:08 ifi-zen-stream3 play[4440]: [Info] ConvSwitch: ConvSwitchExit Dec 12 11:53:08 ifi-zen-stream3 play[4440]: [Info] MetaClient: MetaClientExit Dec 12 11:53:08 ifi-zen-stream3 node[479]: Closing connection with the client spotify Dec 12 11:53:08 ifi-zen-stream3 node[525]: ConvSwitch: Drop client spotify Dec 12 11:53:08 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service... Dec 12 11:53:08 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Dec 12 11:53:08 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Dec 12 11:53:08 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service. Dec 12 11:53:08 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service. Dec 12 11:53:08 ifi-zen-stream3 sudo[5022]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:08 ifi-zen-stream3 volumio[1448]: info: Spotify Connect Service Started Dec 12 11:53:08 ifi-zen-stream3 sudo[5025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Dec 12 11:53:08 ifi-zen-stream3 sudo[5025]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:08 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service... Dec 12 11:53:08 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Dec 12 11:53:08 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Dec 12 11:53:08 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service. Dec 12 11:53:08 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service. Dec 12 11:53:08 ifi-zen-stream3 sudo[5025]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:08 ifi-zen-stream3 volumio[1448]: info: Spotify Connect Service Started Dec 12 11:53:08 ifi-zen-stream3 play[5032]: output: volumio mixer: hw:0 Dec 12 11:53:08 ifi-zen-stream3 node[525]: ConvSwitch: Add client spotify Dec 12 11:53:08 ifi-zen-stream3 node[479]: A new connection has been established. Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.373 I api SpRegisterDebugCallbacks [returned value: 0] Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.374 I api SpInit(0xff7f8140, API v66) Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.374 I esdk eSDK version: HEAD-v3.166.69-g24821f73 Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.374 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 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.375 I esdk Successfully registered dns callback: dns_lookup_callback Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.375 I download Using 128 kB for cache buffer Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.375 I download Using 621 kB for compressed audio buffer Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.375 I esdk Successfully registered error callback Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.387 I esdk Creating IPv4 socket (domain 2) Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.387 I zc webserver: service port 5566 (5566-5576) buffer size 4444 Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.387 I zc Started ZeroConf service on port 5566 path /zc alias count 0 Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.387 I esdk Creating IPv4 socket (domain 2) Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.388 I api SpInit [returned value: 0] Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.388 I api SpRegisterConnectionCallbacks(0xff7f8128, (nil)) Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.388 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.388 I api SpRegisterConnectionCallbacks [returned value: 0] Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.388 I api SpRegisterPlaybackCallbacks(0xff7f8110, (nil)) Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.388 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, - Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.388 I api SpRegisterPlaybackCallbacks [returned value: 0] Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.394 W app Couldn't find mixer for volume controls. (tried , SoftMaster) Dec 12 11:53:08 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:08.394 I app Initialized! Dec 12 11:53:08 ifi-zen-stream3 volumio[1448]: info: VolumeController::SetAlsaVolume100 Dec 12 11:53:08 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Dec 12 11:53:08 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::pushState Dec 12 11:53:08 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioPushState Dec 12 11:53:08 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:08 ifi-zen-stream3 node[525]: ConvSwitch: Add client tidal Dec 12 11:53:08 ifi-zen-stream3 tidal_connect_application[5049]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi. Dec 12 11:53:08 ifi-zen-stream3 tidal_connect_application[5049]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 12 11:53:08 ifi-zen-stream3 tidal_connect_application[5049]: *** WARNING *** For more information see Dec 12 11:53:08 ifi-zen-stream3 ifi_metadata[4929]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 12 11:53:08 ifi-zen-stream3 ifi_metadata[4929]: [Info] MetaClient: MetaClientInit Dec 12 11:53:08 ifi-zen-stream3 ifi_metadata[4929]: Connected Dec 12 11:53:09 ifi-zen-stream3 mpd[4987]: Dec 12 11:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 12 11:53:09 ifi-zen-stream3 systemd[1]: Started Music Player Daemon. Dec 12 11:53:09 ifi-zen-stream3 sudo[4979]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:09 ifi-zen-stream3 sudo[4983]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:09 ifi-zen-stream3 volumio[1448]: info: Restarted MPD. Dec 12 11:53:09 ifi-zen-stream3 volumio[1448]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.socket mpd.service Dec 12 11:53:09 ifi-zen-stream3 volumio[1448]: Job for mpd.socket failed. Dec 12 11:53:09 ifi-zen-stream3 volumio[1448]: See "systemctl status mpd.socket" and "journalctl -xe" for details. Dec 12 11:53:09 ifi-zen-stream3 volumio[1448]: error: MPD error: The expression evaluated to a falsy value: Dec 12 11:53:09 ifi-zen-stream3 volumio[1448]: assert.ok(self.idling) Dec 12 11:53:09 ifi-zen-stream3 volumio[1448]: error: The expression evaluated to a falsy value: Dec 12 11:53:09 ifi-zen-stream3 volumio[1448]: assert.ok(self.idling) Dec 12 11:53:09 ifi-zen-stream3 volumio[1448]: error: updateQueue error: null Dec 12 11:53:10 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioStop Dec 12 11:53:10 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::stop Dec 12 11:53:10 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::serviceStop Dec 12 11:53:10 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::serviceStop Dec 12 11:53:10 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioStop Dec 12 11:53:10 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::stop Dec 12 11:53:10 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:10 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:10 ifi-zen-stream3 volumio[1448]: info: Roon Ready Stop Dec 12 11:53:23 ifi-zen-stream3 volumiologrotate[530]: ls: cannot access '/var/log/samba/log.wb-ZEN': No such file or directory Dec 12 11:53:23 ifi-zen-stream3 volumiologrotate[530]: ls: cannot access 'STREAM3': No such file or directory Dec 12 11:53:27 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 12 11:53:27 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 12 11:53:27 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ++++--++++ playItemsList: {"item":{"service":"mpd","type":"song","title":"Simple Symphony op. 4 - Boisterous Bourree 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac","albumart":"/albumart?cacheid=969_1765540282373&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=969_1765540282372&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=969_1765540282372&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=969_1765540282372&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=969_1765540282373&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=969_1765540282373&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=969_1765540282373&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=969_1765540282373&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=969_1765540282373&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=969_1765540282373&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=969_1765540282373&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"}],"index":7} Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Preload queue cleared Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::ClearQueue Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::stop Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::clearPlayQueue Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::saveQueue Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioPushQueue Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::addQueueItems Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::addQueueItems Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Preload queue cleared Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioPushQueue Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::saveQueue Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::updateTrackBlock Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrackBlock Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ConvSwitch: Sent Play Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioPlay Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::play index 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::addQueueItems Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::addQueueItems Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Preload queue cleared Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::stop Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioPushQueue Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::saveQueue Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::play index undefined Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::updateTrackBlock Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrackBlock Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::startPlaybackTimer Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::clearAddPlayTracks USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::sendMpdCommand stop Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ConvSwitch: Get message: success Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: sendMpdCommand stop took 7 milliseconds Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::sendMpdCommand clear Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: ---------------------------- MPD announces system playlist update Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Ignoring MPD Status Update Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: sendMpdCommand clear took 7 milliseconds Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::sendMpdCommand add "USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac" Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: ---------------------------- MPD announces system playlist update Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Ignoring MPD Status Update Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: error: updateQueue error: null Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: ---------------------------- MPD announces system playlist update Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Ignoring MPD Status Update Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ------------------------------ 16ms Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: sendMpdCommand add "USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac" took 9 milliseconds Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ------------------------------ 7ms Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::sendMpdCommand play Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: ---------------------------- MPD announces system playlist update Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Ignoring MPD Status Update Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: ---------------------------- MPD announces state update: player Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ------------------------------ 16ms Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: sendMpdCommand play took 11 milliseconds Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ControllerMpd::getState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::sendMpdCommand status Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ------------------------------ 12ms Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: ---------------------------- MPD announces state update: player Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ControllerMpd::getState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::sendMpdCommand status Dec 12 11:53:34 ifi-zen-stream3 kernel: wm8804 0-003b: wm8804_hw_params rate: 0x15888 format: 0x6 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: sendMpdCommand status took 15 milliseconds Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::parseState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioGetState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: ---------------------------- MPD announces state update: player Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ControllerMpd::getState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::sendMpdCommand status Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: sendMpdCommand status took 25 milliseconds Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: sendMpdCommand playlistinfo took 10 milliseconds Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::parseState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioGetState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::parseTrackInfo Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ControllerMpd::pushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::servicePushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Simple Symphony op. 4 - Boisterous Bourree 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac","trackType":"flac"} Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: CURRENT POSITION 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::syncState stateService play Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::syncState currentStatus stop Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ------------------------------ 55ms Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: ---------------------------- MPD announces state update: player Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ControllerMpd::getState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::sendMpdCommand status Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: sendMpdCommand status took 31 milliseconds Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: sendMpdCommand playlistinfo took 21 milliseconds Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: sendMpdCommand status took 7 milliseconds Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::parseState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioGetState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::parseTrackInfo Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::parseState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioGetState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ControllerMpd::pushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::servicePushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Simple Symphony op. 4 - Boisterous Bourree 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac","trackType":"flac"} Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: CURRENT POSITION 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::syncState stateService play Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::syncState currentStatus play Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Received an update from plugin. extracting info from payload Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::pushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioPushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::pushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioPushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ------------------------------ 104ms Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: sendMpdCommand playlistinfo took 41 milliseconds Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: sendMpdCommand playlistinfo took 38 milliseconds Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::parseTrackInfo Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: ControllerMpd::parseTrackInfo Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ControllerMpd::pushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::servicePushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":182,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1366 Kbps","isStreaming":false,"title":"Simple Symphony op. 4 - Boisterous Bourree 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac","trackType":"flac"} Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: CURRENT POSITION 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::syncState stateService play Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::syncState currentStatus play Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Received an update from plugin. extracting info from payload Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::pushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioPushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::pushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioPushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ControllerMpd::pushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::servicePushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":182,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1366 Kbps","isStreaming":false,"title":"Simple Symphony op. 4 - Boisterous Bourree 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac","trackType":"flac"} Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: verbose: CURRENT POSITION 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::syncState stateService play Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::syncState currentStatus play Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: Received an update from plugin. extracting info from payload Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::pushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioPushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreStateMachine::pushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CorePlayQueue::getTrack 7 Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::volumioPushState Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ------------------------------ 140ms Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: info: ------------------------------ 115ms Dec 12 11:53:34 ifi-zen-stream3 volumio[1448]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/TrondheimSolistene/DIVERTIMENTI/dad45c0a-7df5-4a9d-9feb-5661cf240483.jpg' Dec 12 11:53:35 ifi-zen-stream3 volumio[1448]: info: MetaClient: Sent Meta Dec 12 11:53:35 ifi-zen-stream3 volumio[1448]: info: MetaClient: Get message: success Dec 12 11:53:39 ifi-zen-stream3 volumio[1448]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 12 11:53:39 ifi-zen-stream3 volumio[1448]: Error: connect ETIMEDOUT 116.89.243.8:443 Dec 12 11:53:39 ifi-zen-stream3 volumio[1448]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Dec 12 11:53:39 ifi-zen-stream3 volumio[1448]: errno: -110, Dec 12 11:53:39 ifi-zen-stream3 volumio[1448]: code: 'ETIMEDOUT', Dec 12 11:53:39 ifi-zen-stream3 volumio[1448]: syscall: 'connect', Dec 12 11:53:39 ifi-zen-stream3 volumio[1448]: address: '116.89.243.8', Dec 12 11:53:39 ifi-zen-stream3 volumio[1448]: port: 443 Dec 12 11:53:39 ifi-zen-stream3 volumio[1448]: } Dec 12 11:53:39 ifi-zen-stream3 volumio[1448]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 12 11:53:40 ifi-zen-stream3 sudo[5396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-12 11:52 Dec 12 11:53:40 ifi-zen-stream3 sudo[5396]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:40 ifi-zen-stream3 sudo[5396]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:46 ifi-zen-stream3 node[525]: ConvSwitch: Drop client volumio Dec 12 11:53:46 ifi-zen-stream3 node[479]: Closing connection with the client volumio Dec 12 11:53:46 ifi-zen-stream3 systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Dec 12 11:53:46 ifi-zen-stream3 systemd[1]: media-Samsung_USB.mount: Succeeded. Dec 12 11:53:46 ifi-zen-stream3 mount.exfat[4090]: non-zero reference counter (1) for '02 - Divertimento 88-24.flac' Dec 12 11:53:46 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 12 11:53:46 ifi-zen-stream3 systemd[1]: volumio.service: Failed with result 'exit-code'. Dec 12 11:53:46 ifi-zen-stream3 systemd[1]: Started dynamicswap service. Dec 12 11:53:46 ifi-zen-stream3 systemd[1]: dynamicswap.service: Succeeded. Dec 12 11:53:46 ifi-zen-stream3 systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Dec 12 11:53:46 ifi-zen-stream3 systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Dec 12 11:53:46 ifi-zen-stream3 systemd[1]: Started dynamicswap service. Dec 12 11:53:46 ifi-zen-stream3 systemd[1]: Stopped Volumio Backend Module. Dec 12 11:53:46 ifi-zen-stream3 systemd[1]: Started Volumio Backend Module. Dec 12 11:53:46 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 12 11:53:46 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 12 11:53:46 ifi-zen-stream3 systemd[1]: dynamicswap.service: Succeeded. Dec 12 11:53:49 ifi-zen-stream3 volumio[5477]: info: ------------------------------------------- Dec 12 11:53:49 ifi-zen-stream3 volumio[5477]: info: ----- Volumio3 ---- Dec 12 11:53:49 ifi-zen-stream3 volumio[5477]: info: ------------------------------------------- Dec 12 11:53:49 ifi-zen-stream3 volumio[5477]: info: ----- System startup ---- Dec 12 11:53:49 ifi-zen-stream3 volumio[5477]: info: ------------------------------------------- Dec 12 11:53:49 ifi-zen-stream3 volumio[5477]: info: ConvSwitch: Client Start Dec 12 11:53:49 ifi-zen-stream3 volumio[5477]: info: MetaClient: Client Start Dec 12 11:53:49 ifi-zen-stream3 node[479]: A new connection has been established. Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Plugin folders cleanup Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Scanning into folder /volumio/app/plugins/ Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Scanning category audio_interface Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Scanning category miscellanea Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Scanning category music_service Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Scanning category plugins.json Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Scanning category system_controller Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Scanning category user_interface Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Scanning into folder /data/plugins/ Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Scanning category music_service Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Plugin folders cleanup completed Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: ------------------------------------------- Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: ----- Core plugins startup ---- Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: ------------------------------------------- Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Loading plugins from folder /volumio/app/plugins/ Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Adding plugin networkaudiod to MyMusic Plugins Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Adding plugin qobuz_connect to MyMusic Plugins Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Adding plugin spotify_connect to MyMusic Plugins Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Adding plugin tidal_connect to MyMusic Plugins Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Adding plugin upnp to MyMusic Plugins Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Adding plugin airplay1_switch to MyMusic Plugins Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Adding plugin airplay2_switch to MyMusic Plugins Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Adding plugin roon_ready to MyMusic Plugins Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Loading plugins from folder /data/plugins/ Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Loading plugin "system"... Dec 12 11:53:50 ifi-zen-stream3 volumio[5477]: info: Loading plugin "appearance"... Dec 12 11:53:51 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 12 11:53:51 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 12 11:53:51 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 12 11:53:51 ifi-zen-stream3 volumio[5477]: info: Loading plugin "network"... Dec 12 11:53:51 ifi-zen-stream3 volumio[5477]: info: Refreshing Cached IP Addresses Dec 12 11:53:52 ifi-zen-stream3 sudo[5575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 12 11:53:52 ifi-zen-stream3 sudo[5575]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:52 ifi-zen-stream3 sudo[5575]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:52 ifi-zen-stream3 sudo[5578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 12 11:53:52 ifi-zen-stream3 sudo[5578]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:52 ifi-zen-stream3 sudo[5578]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:52 ifi-zen-stream3 volumio[5477]: info: Loading plugin "services"... Dec 12 11:53:52 ifi-zen-stream3 volumio[5477]: info: Loading plugin "alsa_controller"... Dec 12 11:53:52 ifi-zen-stream3 sudo[5591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 12 11:53:52 ifi-zen-stream3 sudo[5591]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:52 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 12 11:53:52 ifi-zen-stream3 volumio[5477]: info: Loading plugin "wizard"... Dec 12 11:53:52 ifi-zen-stream3 volumio[5477]: info: Loading plugin "networkfs"... Dec 12 11:53:52 ifi-zen-stream3 volumio[5477]: info: Starting Udev Watcher for removable devices Dec 12 11:53:52 ifi-zen-stream3 volumio[5477]: error: Cannot associate FS Label, not mounting Dec 12 11:53:52 ifi-zen-stream3 volumio[5477]: error: Cannot associate FS Label, not mounting Dec 12 11:53:52 ifi-zen-stream3 volumio[5477]: info: Ignoring mount for partition: BOOT Dec 12 11:53:52 ifi-zen-stream3 volumio[5477]: info: Ignoring mount for partition: archivefs Dec 12 11:53:52 ifi-zen-stream3 volumio[5477]: info: Ignoring mount for partition: rootfs Dec 12 11:53:52 ifi-zen-stream3 volumio[5477]: info: Mounting Device Samsung_USB Dec 12 11:53:53 ifi-zen-stream3 kernel: start_addr=(0x8000), end_addr=(0x10000), buffer_size=(0x8000), smp_number_max=(4096) Dec 12 11:53:53 ifi-zen-stream3 sudo[5618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Samsung_USB -o noatime Dec 12 11:53:53 ifi-zen-stream3 sudo[5618]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:53 ifi-zen-stream3 sudo[5618]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:53 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 12 11:53:53 ifi-zen-stream3 volumio[5477]: info: Loading plugin "volumio_command_line_client"... Dec 12 11:53:53 ifi-zen-stream3 volumio[5477]: info: Loading plugin "networkaudiod"... Dec 12 11:53:53 ifi-zen-stream3 volumio[5477]: info: [1765540433184] Starting NAA Service Dec 12 11:53:53 ifi-zen-stream3 volumio[5477]: info: Loading plugin "tidal_connect"... Dec 12 11:53:53 ifi-zen-stream3 volumio[5477]: info: [1765540433210] Starting Tidal Connect Service Dec 12 11:53:53 ifi-zen-stream3 volumio[5477]: info: Loading plugin "upnp"... Dec 12 11:53:53 ifi-zen-stream3 sudo[5628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart networkaudiod.service Dec 12 11:53:53 ifi-zen-stream3 volumio[5477]: info: [1765540433222] Starting Upmpd Daemon Dec 12 11:53:53 ifi-zen-stream3 volumio[5477]: info: Starting Upmpd Daemon Dec 12 11:53:53 ifi-zen-stream3 sudo[5628]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:53 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 12 11:53:53 ifi-zen-stream3 volumio[5477]: error: ATTENTION!!!: Plugin upnp does not return adequate promise from onVolumioStart: please update! Dec 12 11:53:53 ifi-zen-stream3 volumio[5477]: info: Loading plugin "my_music"... Dec 12 11:53:53 ifi-zen-stream3 volumio[5477]: info: Loading plugin "mpd"... Dec 12 11:53:53 ifi-zen-stream3 systemd[1]: Stopping Network Audio Adapter daemon... Dec 12 11:53:53 ifi-zen-stream3 systemd[1]: networkaudiod.service: Succeeded. Dec 12 11:53:53 ifi-zen-stream3 systemd[1]: Stopped Network Audio Adapter daemon. Dec 12 11:53:53 ifi-zen-stream3 systemd[1]: Started Network Audio Adapter daemon. Dec 12 11:53:53 ifi-zen-stream3 sudo[5628]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:53 ifi-zen-stream3 networkaudiod[5630]: [/usr/sbin/networkaudiod] (5630): networkaudiod Copyright (C) 2011-2020 Jussi Laako / Signalyst. All rights reserved. Dec 12 11:53:53 ifi-zen-stream3 networkaudiod[5630]: [/usr/sbin/networkaudiod] (5630): create alsa engine Dec 12 11:53:53 ifi-zen-stream3 networkaudiod[5630]: [/usr/sbin/networkaudiod] (5630): listen discovery on :: Dec 12 11:53:53 ifi-zen-stream3 networkaudiod[5630]: [/usr/sbin/networkaudiod] (5630): clSocket::SetOption(): setsockopt(..., 41,20, ...): No such device Dec 12 11:53:53 ifi-zen-stream3 networkaudiod[5630]: [/usr/sbin/networkaudiod] (5630): Socket failure, falling back to IPv4-only! Dec 12 11:53:53 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:53 ifi-zen-stream3 volumio[5477]: info: Loading plugin "upnp_browser"... Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Loading plugin "qobuz_connect"... Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: [1765540434222] Starting Qobuz Connect Service Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Loading plugin "alarm-clock"... Dec 12 11:53:54 ifi-zen-stream3 networkaudiod[5630]: [/usr/sbin/networkaudiod] (5630): listen discovery on 0.0.0.0 Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Loading plugin "last_100"... Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Loading plugin "roon_ready"... Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Starting RoonReady Sync Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Loading plugin "webradio"... Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Loading plugin "i2s_dacs"... Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: I2S DAC not set, start Auto-detection Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Loading plugin "volumiodiscovery"... Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: *** WARNING *** For more information see Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 12 11:53:54 ifi-zen-stream3 node[5477]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: *** WARNING *** For more information see Dec 12 11:53:54 ifi-zen-stream3 node[5477]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 12 11:53:54 ifi-zen-stream3 node[5477]: *** WARNING *** For more information see Dec 12 11:53:54 ifi-zen-stream3 node[5477]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 12 11:53:54 ifi-zen-stream3 node[5477]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 12 11:53:54 ifi-zen-stream3 node[5477]: *** WARNING *** For more information see Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Loading plugin "spotify_connect"... Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: [1765540434748] Starting Spotify Connect Service Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Plugin airplay1_switch is not enabled Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Loading plugin "airplay2_switch"... Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Loading plugin "airplay_emulation"... Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Starting Shairport Sync Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Loading plugin "outputs"... Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Loading plugin "albumart"... Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Plugin example_plugin is not enabled Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Loading plugin "inputs"... Dec 12 11:53:54 ifi-zen-stream3 volumio[5477]: info: Loading plugin "updater_comm"... Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: Plugin mpdemulation is not enabled Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: Loading plugin "rest_api"... Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: Loading plugin "websocket"... Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: Starting Socket.io Server version 2.3.0 Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: Plugin ifi-cdplayer is not enabled Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: Loading i18n strings for locale en Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: Updating browse sources language Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: Forking 3 albumart workers Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::initPlayerControls Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: Removing existing socket file at /tmp/meta.sock Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: Express server listening on port 3000 Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: [Metrics] WebUI: 7s 510.26ms Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::resetVolumioState Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::getcurrentVolume Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioRetrievevolume Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: Meta server listening Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::pushState Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CorePlayQueue::getTrack 0 Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioPushState Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 12 11:53:55 ifi-zen-stream3 volumio[5477]: info: Server listening on port 6599 Dec 12 11:53:56 ifi-zen-stream3 sudo[5681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: info: Completed loading Core Plugins Dec 12 11:53:56 ifi-zen-stream3 sudo[5681]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: info: Preparing to generate the ALSA configuration file Dec 12 11:53:56 ifi-zen-stream3 sudo[5683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Dec 12 11:53:56 ifi-zen-stream3 sudo[5683]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:56 ifi-zen-stream3 node[479]: Closing connection with the client tidal-connect Dec 12 11:53:56 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Dec 12 11:53:56 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Dec 12 11:53:56 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Dec 12 11:53:56 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Dec 12 11:53:56 ifi-zen-stream3 sudo[5683]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: info: ConvSwitch: Connected to server Dec 12 11:53:56 ifi-zen-stream3 node[525]: ConvSwitch: Add client volumio Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: info: MetaClient: Connected to server Dec 12 11:53:56 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 12 11:53:56 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service... Dec 12 11:53:56 ifi-zen-stream3 node[525]: ConvSwitch: Drop client tidal Dec 12 11:53:56 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Dec 12 11:53:56 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Dec 12 11:53:56 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service. Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: info: Volumio Network Manager: Network status updated: 1 Dec 12 11:53:56 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service. Dec 12 11:53:56 ifi-zen-stream3 sudo[5681]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:56 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service. Dec 12 11:53:56 ifi-zen-stream3 node[479]: A new connection has been established. Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: info: NAA Service Started Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: info: ConvSwitch: Get message: success Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: info: MetaClient: Get message: success Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: verbose: New Socket.io Connection to 192.168.3.183 from 192.168.3.28 UA: Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: verbose: New Socket.io Connection to 192.168.3.183 from 192.168.3.28 UA: Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: verbose: New Socket.io Connection to 192.168.3.183 from 192.168.3.28 UA: Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: info: Tidal Connect Service Started Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: info: Qobuz Connect Service Started Dec 12 11:53:56 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 12 11:53:56 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: info: Scanning new location : "USB/Samsung_USB" Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: info: Reloading queue from file Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: info: Asound.conf file unchanged, so no further update is needed Dec 12 11:53:56 ifi-zen-stream3 volumio[5477]: info: Tidal connect: Output device has changed Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: Output device has changed, restarting MPD Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: Qobuz connect: Output device has changed Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: Roon Ready: Output device has changed Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: Spotify: Output device has changed Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: ___________ START PLUGINS ___________ Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: ControllerMpd::onStart: Initializing MPD Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: Creating MPD Configuration file Dec 12 11:53:57 ifi-zen-stream3 sudo[5729]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 12 11:53:57 ifi-zen-stream3 sudo[5729]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:57 ifi-zen-stream3 sudo[5729]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 12 11:53:57 ifi-zen-stream3 sudo[5735]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: [1765540437200] CoreMusicLibrary::Adding element Media Servers Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 12 11:53:57 ifi-zen-stream3 sudo[5735]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:57 ifi-zen-stream3 sudo[5735]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:57 ifi-zen-stream3 sudo[5736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Dec 12 11:53:57 ifi-zen-stream3 sudo[5736]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: [1765540437304] CoreMusicLibrary::Adding element Last_100 Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: Starting RoonReady Sync Dec 12 11:53:57 ifi-zen-stream3 systemd[1]: mpd.socket: Succeeded. Dec 12 11:53:57 ifi-zen-stream3 systemd[1]: Closed mpd.socket. Dec 12 11:53:57 ifi-zen-stream3 systemd[1]: Stopping Music Player Daemon... Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: [1765540437357] CoreMusicLibrary::Adding element Webradio Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: Starting albumart workers Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: Initializing BBC Radios Dec 12 11:53:57 ifi-zen-stream3 sudo[5740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Dec 12 11:53:57 ifi-zen-stream3 sudo[5740]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: Starting albumart workers Dec 12 11:53:57 ifi-zen-stream3 node[525]: ConvSwitch: Drop client roon-ready Dec 12 11:53:57 ifi-zen-stream3 node[479]: Closing connection with the client roon-ready Dec 12 11:53:57 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Roon Ready Service... Dec 12 11:53:57 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM Dec 12 11:53:57 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Succeeded. Dec 12 11:53:57 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Roon Ready Service. Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: Starting albumart workers Dec 12 11:53:57 ifi-zen-stream3 systemd[1]: Started iFi Streamer Roon Ready Service. Dec 12 11:53:57 ifi-zen-stream3 sudo[5740]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 12 11:53:57 ifi-zen-stream3 sudo[5591]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 12 11:53:57 ifi-zen-stream3 play[5748]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 12 11:53:57 ifi-zen-stream3 sudo[5766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -snf /usr/local/bin/airplay2 /usr/local/bin/shairport-sync Dec 12 11:53:57 ifi-zen-stream3 sudo[5766]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:57 ifi-zen-stream3 sudo[5766]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 12 11:53:57 ifi-zen-stream3 volumio[5477]: info: Volumio Calling Home Dec 12 11:53:58 ifi-zen-stream3 node[525]: ConvSwitch: Add client roon-ready Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::setRepeat null single undefined Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::pushState Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: CorePlayQueue::getTrack 0 Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioPushState Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::setRandom null Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::pushState Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: CorePlayQueue::getTrack 0 Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioPushState Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: Starting RoonReady Sync Dec 12 11:53:58 ifi-zen-stream3 systemd[1]: mpd.service: Succeeded. Dec 12 11:53:58 ifi-zen-stream3 systemd[1]: Stopped Music Player Daemon. Dec 12 11:53:58 ifi-zen-stream3 sudo[5829]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Dec 12 11:53:58 ifi-zen-stream3 sudo[5829]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:58 ifi-zen-stream3 sudo[5839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Dec 12 11:53:58 ifi-zen-stream3 sudo[5839]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: ConvSwitch: Get message: request:pause Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioStop Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::stop Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioStop Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::stop Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:58 ifi-zen-stream3 sudo[5843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Dec 12 11:53:58 ifi-zen-stream3 sudo[5843]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: Airplay2 Started Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: error: Could not retrieve plugin music_service airplay1_switch Dec 12 11:53:58 ifi-zen-stream3 sudo[5736]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: Disabling plugin airplay1_switch Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: Done. Dec 12 11:53:58 ifi-zen-stream3 volumio[5477]: info: RoonReady Started Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: MPD Permissions set Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: MPD Permissions set Dec 12 11:53:59 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:59.040 E esdk select error: 4 -> Interrupted system call Dec 12 11:53:59 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:59.041 I app Exiting with error = 0 Dec 12 11:53:59 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:59.041 I api SpFree() Dec 12 11:53:59 ifi-zen-stream3 play[5032]: 2025-12-12 11:53:59.047 I api SpFree [returned value: 0] Dec 12 11:53:59 ifi-zen-stream3 play[5032]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Dec 12 11:53:59 ifi-zen-stream3 play[5032]: [Info] ConvSwitch: ConvSwitchInit Dec 12 11:53:59 ifi-zen-stream3 play[5032]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 12 11:53:59 ifi-zen-stream3 play[5032]: [Info] MetaClient: MetaClientInit Dec 12 11:53:59 ifi-zen-stream3 play[5032]: [Info] ConvSwitch: ConvSwitchExit Dec 12 11:53:59 ifi-zen-stream3 play[5032]: [Info] MetaClient: MetaClientExit Dec 12 11:53:59 ifi-zen-stream3 node[479]: Closing connection with the client spotify Dec 12 11:53:59 ifi-zen-stream3 node[525]: ConvSwitch: Drop client spotify Dec 12 11:53:59 ifi-zen-stream3 node[525]: ConvSwitch: Drop client roon-ready Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service... Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Roon Ready Service... Dec 12 11:53:59 ifi-zen-stream3 sudo[5861]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Dec 12 11:53:59 ifi-zen-stream3 node[479]: Closing connection with the client qobuz-connect Dec 12 11:53:59 ifi-zen-stream3 node[525]: ConvSwitch: Drop client qobuz-connect Dec 12 11:53:59 ifi-zen-stream3 sudo[5861]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Qobuz Connect Service... Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded. Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Qobuz Connect Service. Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service. Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Succeeded. Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Roon Ready Service. Dec 12 11:53:59 ifi-zen-stream3 sudo[5869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Dec 12 11:53:59 ifi-zen-stream3 sudo[5869]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:59 ifi-zen-stream3 sudo[5829]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: Volumio called home Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 12 11:53:59 ifi-zen-stream3 sudo[5877]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Dec 12 11:53:59 ifi-zen-stream3 sudo[5877]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: Started iFi Streamer Roon Ready Service. Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: Roon Ready playback start Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioStop Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::stop Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: Starting Roon Ready metadata receiver Dec 12 11:53:59 ifi-zen-stream3 sudo[5839]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: Error adding Membership: Error: addMembership EINVAL Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service. Dec 12 11:53:59 ifi-zen-stream3 sudo[5843]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:59 ifi-zen-stream3 play[5878]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: shairport-sync.service: Succeeded. Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: 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 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:59 ifi-zen-stream3 node[525]: ConvSwitch: Add client tidal Dec 12 11:53:59 ifi-zen-stream3 sudo[5861]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 12 11:53:59 ifi-zen-stream3 sudo[5869]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: Listening on mpd.socket. Dec 12 11:53:59 ifi-zen-stream3 tidal_connect_application[5844]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi. Dec 12 11:53:59 ifi-zen-stream3 tidal_connect_application[5844]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 12 11:53:59 ifi-zen-stream3 tidal_connect_application[5844]: *** WARNING *** For more information see Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: Starting Music Player Daemon... Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:59 ifi-zen-stream3 play[5880]: output: volumio mixer: hw:0 Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:59 ifi-zen-stream3 node[525]: ConvSwitch: Add client spotify Dec 12 11:53:59 ifi-zen-stream3 ifi_metadata[5692]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 12 11:53:59 ifi-zen-stream3 ifi_metadata[5692]: [Info] MetaClient: MetaClientInit Dec 12 11:53:59 ifi-zen-stream3 ifi_metadata[5692]: Could not connect: Reason::CONNECTION_ERROR Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 12 11:53:59 ifi-zen-stream3 node[479]: A new connection has been established. Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.719 I api SpRegisterDebugCallbacks [returned value: 0] Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.719 I api SpInit(0xffabfef0, API v66) Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.719 I esdk eSDK version: HEAD-v3.166.69-g24821f73 Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.720 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 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.720 I esdk Successfully registered dns callback: dns_lookup_callback Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.720 I download Using 128 kB for cache buffer Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.720 I download Using 621 kB for compressed audio buffer Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.721 I esdk Successfully registered error callback Dec 12 11:53:59 ifi-zen-stream3 ifi_metadata[5692]: Connected Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.739 I esdk Creating IPv4 socket (domain 2) Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.739 I zc webserver: service port 5566 (5566-5576) buffer size 4444 Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.739 I zc Started ZeroConf service on port 5566 path /zc alias count 0 Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.739 I esdk Creating IPv4 socket (domain 2) Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.740 I api SpInit [returned value: 0] Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.740 I api SpRegisterConnectionCallbacks(0xffabfed8, (nil)) Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.740 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.740 I api SpRegisterConnectionCallbacks [returned value: 0] Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.740 I api SpRegisterPlaybackCallbacks(0xffabfec0, (nil)) Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.740 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, - Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.740 I api SpRegisterPlaybackCallbacks [returned value: 0] Dec 12 11:53:59 ifi-zen-stream3 sudo[5899]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.747 W app Couldn't find mixer for volume controls. (tried , SoftMaster) Dec 12 11:53:59 ifi-zen-stream3 play[5880]: 2025-12-12 11:53:59.747 I app Initialized! Dec 12 11:53:59 ifi-zen-stream3 sudo[5899]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:59 ifi-zen-stream3 sudo[5899]: pam_unix(sudo:session): session closed for user root Dec 12 11:53:59 ifi-zen-stream3 node[525]: ConvSwitch: Add client roon-ready Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: Spotify Connect Service Started Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: RoonReady Started Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: Discovery: adding f32c8f8d-99eb-4f72-be29-85bfdd4a36d3 Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: Discovery: Found device ZEN Stream3 Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioGetState Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CorePlayQueue::getTrack 0 Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: error: Could not retrieve plugin audio_interface multiroom Dec 12 11:53:59 ifi-zen-stream3 sudo[5957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Dec 12 11:53:59 ifi-zen-stream3 sudo[5957]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: ConvSwitch: Get message: request:pause Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioStop Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::stop Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioStop Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::stop Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:53:59 ifi-zen-stream3 node[479]: Closing connection with the client tidal-connect Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service... Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: Shairport-Sync Stopped Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Dec 12 11:53:59 ifi-zen-stream3 node[525]: ConvSwitch: Drop client tidal Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service. Dec 12 11:53:59 ifi-zen-stream3 sudo[5960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Dec 12 11:53:59 ifi-zen-stream3 volumio[5477]: info: Starting Shairport Sync Dec 12 11:53:59 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service. Dec 12 11:53:59 ifi-zen-stream3 sudo[5960]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:53:59 ifi-zen-stream3 sudo[5957]: pam_unix(sudo:session): session closed for user root Dec 12 11:54:00 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service. Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: Starting Shairport Sync Dec 12 11:54:00 ifi-zen-stream3 node[479]: A new connection has been established. Dec 12 11:54:00 ifi-zen-stream3 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Dec 12 11:54:00 ifi-zen-stream3 systemd[1]: mpd.service: Succeeded. Dec 12 11:54:00 ifi-zen-stream3 systemd[1]: Stopped Music Player Daemon. Dec 12 11:54:00 ifi-zen-stream3 sudo[5971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 12 11:54:00 ifi-zen-stream3 systemd[1]: mpd.socket: Succeeded. Dec 12 11:54:00 ifi-zen-stream3 sudo[5971]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Dec 12 11:54:00 ifi-zen-stream3 systemd[1]: Closed mpd.socket. Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Dec 12 11:54:00 ifi-zen-stream3 systemd[1]: Stopping mpd.socket. Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: Roon Ready playback start Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioStop Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::stop Dec 12 11:54:00 ifi-zen-stream3 systemd[1]: Listening on mpd.socket. Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: Roon Ready metadata receiver is on Dec 12 11:54:00 ifi-zen-stream3 systemd[1]: Starting Music Player Daemon... Dec 12 11:54:00 ifi-zen-stream3 sudo[5973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 12 11:54:00 ifi-zen-stream3 sudo[5973]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:54:00 ifi-zen-stream3 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 12 11:54:00 ifi-zen-stream3 sudo[5971]: pam_unix(sudo:session): session closed for user root Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: ++++--++++ getState Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioGetState Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: CorePlayQueue::getTrack 0 Dec 12 11:54:00 ifi-zen-stream3 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 12 11:54:00 ifi-zen-stream3 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Dec 12 11:54:00 ifi-zen-stream3 systemd[1]: shairport-sync.service: Succeeded. Dec 12 11:54:00 ifi-zen-stream3 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: verbose: New Socket.io Connection to 192.168.3.183 from 192.168.3.28 UA: Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 12 11:54:00 ifi-zen-stream3 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 12 11:54:00 ifi-zen-stream3 sudo[5973]: pam_unix(sudo:session): session closed for user root Dec 12 11:54:00 ifi-zen-stream3 sudo[5979]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 12 11:54:00 ifi-zen-stream3 sudo[5979]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:54:00 ifi-zen-stream3 sudo[5979]: pam_unix(sudo:session): session closed for user root Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: Shairport-Sync Started Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: Error adding Membership: Error: addMembership EINVAL Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: Tidal Connect Service Started Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: ++++--++++ getState Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioGetState Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: CorePlayQueue::getTrack 0 Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: Shairport-Sync Started Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: ++++--++++ getMultiRoomDevices: null Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: ++++--++++ getMultiroom: null Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: error: Could not retrieve plugin audio_interface multiroom Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: ++++--++++ getBrowseSources: null Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioGetVisibleSources Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: ++++--++++ getMenuItems Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: ++++--++++ listPlaylist: null Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: Listing playlists Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: ++++--++++ getMenuItems Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: ++++--++++ getQueue Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioGetQueue Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::getQueue Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: CorePlayQueue::getQueue Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: ++++--++++ getMenuItems Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: ++++--++++ getMenuItems Dec 12 11:54:00 ifi-zen-stream3 sudo[5990]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Dec 12 11:54:00 ifi-zen-stream3 sudo[5990]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:54:00 ifi-zen-stream3 systemd[1]: Started iFi Streamer Qobuz Connect Service. Dec 12 11:54:00 ifi-zen-stream3 sudo[5990]: pam_unix(sudo:session): session closed for user root Dec 12 11:54:00 ifi-zen-stream3 volumio[5477]: info: Qobuz Connect Service Started Dec 12 11:54:00 ifi-zen-stream3 play[5993]: 20251212 11:54:00.940 [6018.6018] DEBUG SampleApp: Starting sample application Dec 12 11:54:00 ifi-zen-stream3 play[5993]: 20251212 11:54:00.941 [6018.6018] DEBUG SampleApp: Device Name: ZEN Stream3 Dec 12 11:54:00 ifi-zen-stream3 play[5993]: 20251212 11:54:00.941 [6018.6018] DEBUG SampleApp: Manufacturer: Sample manufacturer Dec 12 11:54:00 ifi-zen-stream3 play[5993]: 20251212 11:54:00.941 [6018.6018] DEBUG SampleApp: Model: iFi Streamer Dec 12 11:54:00 ifi-zen-stream3 play[5993]: 20251212 11:54:00.941 [6018.6018] DEBUG SampleApp: Serial Number: ifi:b6:8f:11:d4:21:f5 Dec 12 11:54:00 ifi-zen-stream3 play[5993]: 20251212 11:54:00.941 [6018.6018] DEBUG SampleApp: Audio output device: volumio Dec 12 11:54:00 ifi-zen-stream3 play[5993]: 20251212 11:54:00.941 [6018.6018] DEBUG SampleApp: Volume control device: default Dec 12 11:54:00 ifi-zen-stream3 play[5993]: 20251212 11:54:00.941 [6018.6018] DEBUG SampleApp: Volume control element: Master Dec 12 11:54:00 ifi-zen-stream3 play[5993]: 20251212 11:54:00.941 [6018.6018] DEBUG SampleApp: Local config server port: 8000 Dec 12 11:54:00 ifi-zen-stream3 play[5993]: 20251212 11:54:00.947 [6018.6018] ERROR SampleApp: Unable to find ALSA mixer element 'Master' on index 0 Dec 12 11:54:00 ifi-zen-stream3 play[5993]: 20251212 11:54:00.947 [6018.6018] DEBUG SampleApp: Maximum supported audio quality: HIRES_L3 Dec 12 11:54:00 ifi-zen-stream3 play[5993]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 12 11:54:00 ifi-zen-stream3 node[479]: A new connection has been established. Dec 12 11:54:00 ifi-zen-stream3 play[5993]: [Info] MetaClient: MetaClientInit Dec 12 11:54:00 ifi-zen-stream3 play[5993]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Dec 12 11:54:01 ifi-zen-stream3 node[525]: ConvSwitch: Add client qobuz-connect Dec 12 11:54:01 ifi-zen-stream3 play[5993]: [Info] ConvSwitch: ConvSwitchInit Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.054 [6018.6018] DEBUG ActiveStateManager: [0xab6a1098]: Creating new Active State Manager Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.054 [6018.6018] DEBUG NetworkActivityTracker: [0xab6a1108]: Creating new Network Activity Tracker Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.055 [6018.6018] DEBUG EndpointManager: [0xab6a2080]: Creating Endpoint Manager Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.055 [6018.6018] DEBUG PlaybackSessionManager: [0xab6a2470]: Creating Playback Session Manager Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.055 [6018.6018] DEBUG BackoffTimer: [0xab6a25e8]: Creating Backoff Timer Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.055 [6018.6018] DEBUG MediaEngine: [0xab6a2708]: Creating new Media Engine Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.055 [6018.6018] DEBUG AudioRenderer: [0xab6a2928]: Creating Audio Renderer Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.055 [6018.6018] TRACE MediaEngineCommandSequencer: [0xab6a2a80]: Creating Media Engine Command Sequencer Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.055 [6018.6018] DEBUG PlaybackControlsManager: [0xab6a2ae0]: Creating new Playback Controls Manager Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.055 [6018.6018] DEBUG VolumeManager: [0xab6a2b70]: Creating new Volume Manager Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.055 [6018.6018] DEBUG ProtocolHandler: [0xab6a2e48]: Creating Protocol Handler Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.055 [6018.6018] DEBUG MessageReceiver: [0xab6a2ee8]: Creating Message Receiver Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.055 [6018.6018] DEBUG RendererActivationController: [0xab6a3060]: Creating new Renderer Activation Controller Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.055 [6018.6018] TRACE RendererActivationCommandSequencer: [0xab6a3108]: Creating Renderer Activation Command Sequencer Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.055 [6018.6018] DEBUG ReportingManager: [0xab6a3218]: Creating new Reporting Manager Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.055 [6018.6018] DEBUG StreamingEventReporter: [0xab6a3260]: Creating Streaming Event Reporter Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.056 [6018.6018] DEBUG BackoffTimer: [0xab6a3340]: Creating Backoff Timer Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.056 [6018.6018] DEBUG TokenExpiryController: [0xab6a3450]: Creating Token Expiry Controller Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.056 [6018.6018] DEBUG UserInactivityManager: [0xab6a34a0]: Creating new User Inactivity Manager Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.056 [6018.6018] INFO VolumeManager: [0xab6a2b70]: Setting new playback volume: 100 Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.056 [6018.6018] INFO VolumeManager: [0xab6a2b70]: Setting new mute state: 1 Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.056 [6018.6018] DEBUG SampleApp: Qobuz Connect has been initialized Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.056 [6018.6018] TRACE SampleApp: Running event loop Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.056 [6018.6018] INFO QobuzConnect: [0xab6a3540]: Client initialized! Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.056 [6018.6018] INFO SampleApp: Starting Avahi advertising, name: ZEN Stream3, service name: _qobuz-connect._tcp Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.070 [6018.6018] DEBUG SampleApp: Avahi client state changed: RUNNING Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.074 [6018.6018] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.081 [6018.6018] INFO LocalConfigManager: [0xab6a2450]: Starting Local Configuration server Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.081 [6018.6018] INFO SampleApp: Starting Local configuration server Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.082 [6018.6018] INFO SampleApp: Playback mute state changed: 1 Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.082 [6018.6018] ERROR SampleApp: Unable to set mute state, no ALSA volume element Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.082 [6018.6018] DEBUG SampleApp: Avahi entry group state changed: REGISTERING Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.092 [6018.6018] INFO SampleApp: Playback volume changed: 100 Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.092 [6018.6018] ERROR SampleApp: Unable to set volume, no ALSA volume element Dec 12 11:54:01 ifi-zen-stream3 node[479]: A new connection has been established. Dec 12 11:54:01 ifi-zen-stream3 sudo[6029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Dec 12 11:54:01 ifi-zen-stream3 sudo[6029]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:54:01 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Dec 12 11:54:01 ifi-zen-stream3 play[5880]: 2025-12-12 11:54:01.825 E esdk select error: 4 -> Interrupted system call Dec 12 11:54:01 ifi-zen-stream3 play[5880]: 2025-12-12 11:54:01.827 I app Exiting with error = 0 Dec 12 11:54:01 ifi-zen-stream3 play[5880]: 2025-12-12 11:54:01.827 I api SpFree() Dec 12 11:54:01 ifi-zen-stream3 play[5880]: 2025-12-12 11:54:01.827 I api SpFree [returned value: 0] Dec 12 11:54:01 ifi-zen-stream3 play[5880]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Dec 12 11:54:01 ifi-zen-stream3 play[5880]: [Info] ConvSwitch: ConvSwitchInit Dec 12 11:54:01 ifi-zen-stream3 play[5880]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 12 11:54:01 ifi-zen-stream3 play[5880]: [Info] MetaClient: MetaClientInit Dec 12 11:54:01 ifi-zen-stream3 play[5880]: [Info] ConvSwitch: ConvSwitchExit Dec 12 11:54:01 ifi-zen-stream3 play[5880]: [Info] MetaClient: MetaClientExit Dec 12 11:54:01 ifi-zen-stream3 node[525]: ConvSwitch: Drop client spotify Dec 12 11:54:01 ifi-zen-stream3 node[479]: Closing connection with the client spotify Dec 12 11:54:01 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service... Dec 12 11:54:01 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Dec 12 11:54:01 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Dec 12 11:54:01 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service. Dec 12 11:54:01 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service. Dec 12 11:54:01 ifi-zen-stream3 play[5993]: 20251212 11:54:01.881 [6018.6018] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED Dec 12 11:54:01 ifi-zen-stream3 sudo[6029]: pam_unix(sudo:session): session closed for user root Dec 12 11:54:01 ifi-zen-stream3 volumio[5477]: info: Spotify Connect Service Started Dec 12 11:54:02 ifi-zen-stream3 play[6037]: output: volumio mixer: hw:0 Dec 12 11:54:02 ifi-zen-stream3 node[525]: ConvSwitch: Add client spotify Dec 12 11:54:02 ifi-zen-stream3 node[479]: A new connection has been established. Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.157 I api SpRegisterDebugCallbacks [returned value: 0] Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.157 I api SpInit(0xfff26160, API v66) Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.157 I esdk eSDK version: HEAD-v3.166.69-g24821f73 Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.158 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 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.158 I esdk Successfully registered dns callback: dns_lookup_callback Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.158 I download Using 128 kB for cache buffer Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.158 I download Using 621 kB for compressed audio buffer Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.158 I esdk Successfully registered error callback Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.176 I esdk Creating IPv4 socket (domain 2) Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.176 I zc webserver: service port 5566 (5566-5576) buffer size 4444 Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.176 I zc Started ZeroConf service on port 5566 path /zc alias count 0 Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.176 I esdk Creating IPv4 socket (domain 2) Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.177 I api SpInit [returned value: 0] Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.177 I api SpRegisterConnectionCallbacks(0xfff26148, (nil)) Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.177 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.177 I api SpRegisterConnectionCallbacks [returned value: 0] Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.177 I api SpRegisterPlaybackCallbacks(0xfff26130, (nil)) Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.177 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, - Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.177 I api SpRegisterPlaybackCallbacks [returned value: 0] Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.184 W app Couldn't find mixer for volume controls. (tried , SoftMaster) Dec 12 11:54:02 ifi-zen-stream3 play[6037]: 2025-12-12 11:54:02.184 I app Initialized! Dec 12 11:54:02 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Dec 12 11:54:02 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Dec 12 11:54:02 ifi-zen-stream3 node[525]: ConvSwitch: Add client tidal Dec 12 11:54:02 ifi-zen-stream3 tidal_connect_application[6073]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi. Dec 12 11:54:02 ifi-zen-stream3 tidal_connect_application[6073]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 12 11:54:02 ifi-zen-stream3 tidal_connect_application[6073]: *** WARNING *** For more information see Dec 12 11:54:02 ifi-zen-stream3 ifi_metadata[5964]: [Info] MetaClient: MetaClient SDK -- v1.02 Dec 12 11:54:02 ifi-zen-stream3 ifi_metadata[5964]: [Info] MetaClient: MetaClientInit Dec 12 11:54:02 ifi-zen-stream3 ifi_metadata[5964]: Connected Dec 12 11:54:03 ifi-zen-stream3 sudo[6112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 12 11:54:03 ifi-zen-stream3 sudo[6112]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:54:03 ifi-zen-stream3 sudo[6112]: pam_unix(sudo:session): session closed for user root Dec 12 11:54:03 ifi-zen-stream3 sudo[6114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 12 11:54:03 ifi-zen-stream3 sudo[6114]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:54:03 ifi-zen-stream3 sudo[6114]: pam_unix(sudo:session): session closed for user root Dec 12 11:54:03 ifi-zen-stream3 sudo[6118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart upmpdcli.service Dec 12 11:54:03 ifi-zen-stream3 sudo[6118]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 12 11:54:03 ifi-zen-stream3 systemd[1]: Stopping UPnP Renderer front-end to MPD... Dec 12 11:54:03 ifi-zen-stream3 systemd[1]: upmpdcli.service: Succeeded. Dec 12 11:54:03 ifi-zen-stream3 systemd[1]: Stopped UPnP Renderer front-end to MPD. Dec 12 11:54:03 ifi-zen-stream3 systemd[1]: Starting UPnP Renderer front-end to MPD... Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: ++++--++++ playItemsList: {"item":{"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=969_1765540282373&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=969_1765540282372&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=969_1765540282372&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=969_1765540282372&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=969_1765540282373&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=969_1765540282373&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=969_1765540282373&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=969_1765540282373&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=969_1765540282373&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=969_1765540282373&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=969_1765540282373&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"}],"index":4} Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: Preload queue cleared Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::ClearQueue Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::stop Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::serviceStop Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::serviceStop Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioStop Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::stop Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: Roon Ready Stop Dec 12 11:54:03 ifi-zen-stream3 mpd[5984]: Dec 12 11:54 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 12 11:54:03 ifi-zen-stream3 systemd[1]: Started Music Player Daemon. Dec 12 11:54:03 ifi-zen-stream3 sudo[5960]: pam_unix(sudo:session): session closed for user root Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: CorePlayQueue::clearPlayQueue Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: CorePlayQueue::saveQueue Dec 12 11:54:03 ifi-zen-stream3 sudo[5877]: pam_unix(sudo:session): session closed for user root Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: CoreCommandRouter::volumioPushQueue Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: CoreStateMachine::addQueueItems Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: CorePlayQueue::addQueueItems Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: Preload queue cleared Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: info: Exploding uri music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac in service mpd Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: TypeError: Cannot read property 'then' of undefined Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2887:19) Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2685:21) Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1528:16) Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:252:25) Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:628:25) Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:600:19) Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:156:33) Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: at Socket.emit (events.js:400:28) Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Dec 12 11:54:03 ifi-zen-stream3 volumio[5477]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 12 11:54:04 ifi-zen-stream3 sudo[6135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-12 11:53 Dec 12 11:54:04 ifi-zen-stream3 sudo[6135]: 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"