-- Logs begin at Thu 2019-02-14 10:11:58 UTC, end at Thu 2025-12-18 05:53:11 UTC. --
Dec 18 05:52:01 ifi-zen-stream3 volumio[1461]: info: ++++--++++ getUiConfig: {"page":"audio_interface/alsa_controller"}
Dec 18 05:52:01 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 18 05:52:01 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Dec 18 05:52:01 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 18 05:52:01 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 18 05:52:01 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:01 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:01 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:01 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:01 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:01 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:01 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:01 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Dec 18 05:52:01 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: ++++--++++ callMethod: {"type":"controller","endpoint":"audio_interface/alsa_controller","method":"saveAlsaOptions","data":{"output_device":{"value":"5","label":"ZEN DAC 3 (UCA1)"}}}
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: Preparing to save Alsa Options, stopping services first
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioGetState
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 3
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPause
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pause
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 3
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stPlaybackTimer
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::servicePause
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 3
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::servicePause
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::pause
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand pause
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"ZEN DAC 3 (UCA1)"}}
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , forceDoP
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: ZEN DAC 3 (UCA1): Does not support DSD Native.
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: Ignoring Mixers Options
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: Device 5 does not have any Mixer Control Available
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: Restoring Previous Volume level: 100 false false
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: Updating Volume Controller Parameters: Device: 5 Name: ZEN DAC 3 (UCA1) Mixer: None Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 3
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: Preparing to generate the ALSA configuration file
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces state update: player
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand pause took 204 milliseconds
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::getState
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand status
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces state update: player
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::getState
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand status
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand status took 9 milliseconds
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand status took 6 milliseconds
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseState
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioGetState
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 3
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseState
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioGetState
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 3
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand playlistinfo took 7 milliseconds
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand playlistinfo took 6 milliseconds
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseTrackInfo
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseTrackInfo
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::pushState
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::servicePushState
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 3
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":13491,"duration":182,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2441 Kbps","isStreaming":false,"title":"Simple Symphony op. 4 - Boisterous Bourree 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac","trackType":"flac"}
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: verbose: CURRENT POSITION 3
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState stateService pause
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState currentStatus pause
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 3
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stPlaybackTimer
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::pushState
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::servicePushState
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 3
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":13491,"duration":182,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2441 Kbps","isStreaming":false,"title":"Simple Symphony op. 4 - Boisterous Bourree 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac","trackType":"flac"}
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: verbose: CURRENT POSITION 3
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState stateService pause
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState currentStatus pause
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 3
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stPlaybackTimer
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 62ms
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 59ms
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: wizard , refreshWizarOutputDevices
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: Asound.conf file written
Dec 18 05:52:03 ifi-zen-stream3 sudo[4660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Dec 18 05:52:03 ifi-zen-stream3 sudo[4660]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:03 ifi-zen-stream3 sudo[4660]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: No state is present for card rkifispdif
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: Found hardware: "rk-ifi-spdif" "" "" "" ""
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: Hardware is initialized using a generic method
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: No state is present for card rkifispdif
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: No state is present for card Z3UCA1
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: Found hardware: "USB-Audio" "USB Mixer" "USB20b1:0010" "" ""
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: Hardware is initialized using a generic method
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: No state is present for card Z3UCA1
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: Tidal connect: Output device has changed
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: Output device has changed, restarting MPD
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: Qobuz connect: Output device has changed
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: Roon Ready: Output device has changed
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: Spotify: Output device has changed
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: Tidal connect: Output device has changed
Dec 18 05:52:03 ifi-zen-stream3 volumio[1461]: info: Output device has changed, restarting MPD
Dec 18 05:52:03 ifi-zen-stream3 sudo[4665]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 18 05:52:03 ifi-zen-stream3 sudo[4665]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: Qobuz connect: Output device has changed
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: Roon Ready: Output device has changed
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: Spotify: Output device has changed
Dec 18 05:52:04 ifi-zen-stream3 sudo[4665]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 sudo[4667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 18 05:52:04 ifi-zen-stream3 sudo[4667]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:04 ifi-zen-stream3 sudo[4667]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: MPD Permissions set
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: MPD Permissions set
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: Starting RoonReady Sync
Dec 18 05:52:04 ifi-zen-stream3 sudo[4686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service
Dec 18 05:52:04 ifi-zen-stream3 sudo[4686]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: Starting RoonReady Sync
Dec 18 05:52:04 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer...
Dec 18 05:52:04 ifi-zen-stream3 sudo[4687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service
Dec 18 05:52:04 ifi-zen-stream3 sudo[4687]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:04 ifi-zen-stream3 sudo[4690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service
Dec 18 05:52:04 ifi-zen-stream3 sudo[4690]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:04 ifi-zen-stream3 node[513]: ConvSwitch: Drop client qobuz-connect
Dec 18 05:52:04 ifi-zen-stream3 node[529]: Closing connection with the client qobuz-connect
Dec 18 05:52:04 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Qobuz Connect Service...
Dec 18 05:52:04 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM
Dec 18 05:52:04 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded.
Dec 18 05:52:04 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Qobuz Connect Service.
Dec 18 05:52:04 ifi-zen-stream3 sudo[4695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service
Dec 18 05:52:04 ifi-zen-stream3 sudo[4695]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:04 ifi-zen-stream3 sudo[4686]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:04 ifi-zen-stream3 node[513]: ConvSwitch: Drop client roon-ready
Dec 18 05:52:04 ifi-zen-stream3 node[529]: Closing connection with the client roon-ready
Dec 18 05:52:04 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Roon Ready Service...
Dec 18 05:52:04 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM
Dec 18 05:52:04 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Succeeded.
Dec 18 05:52:04 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Roon Ready Service.
Dec 18 05:52:04 ifi-zen-stream3 sudo[4690]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:04 ifi-zen-stream3 systemd[1]: Started iFi Streamer Roon Ready Service.
Dec 18 05:52:04 ifi-zen-stream3 sudo[4695]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:04 ifi-zen-stream3 sudo[4687]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: RoonReady Started
Dec 18 05:52:04 ifi-zen-stream3 volumio[1461]: info: RoonReady Started
Dec 18 05:52:04 ifi-zen-stream3 play[4712]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input
Dec 18 05:52:04 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded.
Dec 18 05:52:04 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer.
Dec 18 05:52:05 ifi-zen-stream3 node[513]: ConvSwitch: Add client roon-ready
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: ConvSwitch: Get message: request:pause
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioStop
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stop
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::updateTrackBlock
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrackBlock
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stPlaybackTimer
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 3
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::serviceStop
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 3
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::serviceStop
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::stop
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand stop
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioStop
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stop
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces state update: player
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand stop took 13 milliseconds
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::getState
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand status
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand status took 2 milliseconds
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseState
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioGetState
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 3
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces state update: player
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::getState
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand status
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand playlistinfo took 9 milliseconds
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand status took 6 milliseconds
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseTrackInfo
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseState
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioGetState
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 3
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::pushState
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::servicePushState
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 3
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 3
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: 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 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac","trackType":"flac"}
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: verbose: CURRENT POSITION 3
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 42ms
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: ---------------------------- Client requests Start RoonReady PlaybackRoutine
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: Roon Ready playback start
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioStop
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stop
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: Roon Ready metadata receiver is on
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand playlistinfo took 34 milliseconds
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseTrackInfo
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::pushState
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::servicePushState
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 3
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 3
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: 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 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac","trackType":"flac"}
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: verbose: CURRENT POSITION 3
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 71ms
Dec 18 05:52:05 ifi-zen-stream3 sudo[4776]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service
Dec 18 05:52:05 ifi-zen-stream3 sudo[4776]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service...
Dec 18 05:52:05 ifi-zen-stream3 node[529]: Closing connection with the client tidal-connect
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded.
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service.
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service...
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM
Dec 18 05:52:05 ifi-zen-stream3 node[513]: ConvSwitch: Drop client tidal
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded.
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service.
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service.
Dec 18 05:52:05 ifi-zen-stream3 sudo[4776]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service.
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: Tidal Connect Service Started
Dec 18 05:52:05 ifi-zen-stream3 sudo[4780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service
Dec 18 05:52:05 ifi-zen-stream3 sudo[4780]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:05 ifi-zen-stream3 node[529]: A new connection has been established.
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service...
Dec 18 05:52:05 ifi-zen-stream3 node[529]: Closing connection with the client tidal-connect
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded.
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service.
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service...
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded.
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service.
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service.
Dec 18 05:52:05 ifi-zen-stream3 sudo[4780]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service.
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: Tidal Connect Service Started
Dec 18 05:52:05 ifi-zen-stream3 node[529]: A new connection has been established.
Dec 18 05:52:05 ifi-zen-stream3 sudo[4800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service
Dec 18 05:52:05 ifi-zen-stream3 sudo[4800]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:05 ifi-zen-stream3 systemd[1]: Started iFi Streamer Qobuz Connect Service.
Dec 18 05:52:05 ifi-zen-stream3 sudo[4800]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: Qobuz Connect Service Started
Dec 18 05:52:05 ifi-zen-stream3 sudo[4808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service
Dec 18 05:52:05 ifi-zen-stream3 sudo[4808]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:05 ifi-zen-stream3 sudo[4808]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:05 ifi-zen-stream3 volumio[1461]: info: Qobuz Connect Service Started
Dec 18 05:52:05 ifi-zen-stream3 play[4806]: 20251218 05:52:05.911 [4826.4826] DEBUG SampleApp: Starting sample application
Dec 18 05:52:05 ifi-zen-stream3 play[4806]: 20251218 05:52:05.911 [4826.4826] DEBUG SampleApp: Device Name: ZEN Stream3
Dec 18 05:52:05 ifi-zen-stream3 play[4806]: 20251218 05:52:05.911 [4826.4826] DEBUG SampleApp: Manufacturer: Sample manufacturer
Dec 18 05:52:05 ifi-zen-stream3 play[4806]: 20251218 05:52:05.911 [4826.4826] DEBUG SampleApp: Model: iFi Streamer
Dec 18 05:52:05 ifi-zen-stream3 play[4806]: 20251218 05:52:05.911 [4826.4826] DEBUG SampleApp: Serial Number: ifi:8a:98:30:dc:9b:23
Dec 18 05:52:05 ifi-zen-stream3 play[4806]: 20251218 05:52:05.911 [4826.4826] DEBUG SampleApp: Audio output device: volumio
Dec 18 05:52:05 ifi-zen-stream3 play[4806]: 20251218 05:52:05.912 [4826.4826] DEBUG SampleApp: Volume control device: default
Dec 18 05:52:05 ifi-zen-stream3 play[4806]: 20251218 05:52:05.912 [4826.4826] DEBUG SampleApp: Volume control element: Master
Dec 18 05:52:05 ifi-zen-stream3 play[4806]: 20251218 05:52:05.912 [4826.4826] DEBUG SampleApp: Local config server port: 8000
Dec 18 05:52:05 ifi-zen-stream3 play[4806]: 20251218 05:52:05.916 [4826.4826] ERROR SampleApp: Unable to find ALSA mixer element 'Master' on index 0
Dec 18 05:52:05 ifi-zen-stream3 play[4806]: 20251218 05:52:05.917 [4826.4826] DEBUG SampleApp: Maximum supported audio quality: HIRES_L3
Dec 18 05:52:05 ifi-zen-stream3 play[4806]: [Info] MetaClient: MetaClient SDK -- v1.02
Dec 18 05:52:05 ifi-zen-stream3 node[529]: A new connection has been established.
Dec 18 05:52:05 ifi-zen-stream3 play[4806]: [Info] MetaClient: MetaClientInit
Dec 18 05:52:05 ifi-zen-stream3 play[4806]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03
Dec 18 05:52:05 ifi-zen-stream3 node[513]: ConvSwitch: Add client qobuz-connect
Dec 18 05:52:06 ifi-zen-stream3 sudo[4830]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service
Dec 18 05:52:06 ifi-zen-stream3 sudo[4830]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: [Info] ConvSwitch: ConvSwitchInit
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.024 [4826.4826] DEBUG ActiveStateManager: [0xaaf9a030]: Creating new Active State Manager
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.024 [4826.4826] DEBUG NetworkActivityTracker: [0xaaf9a0a0]: Creating new Network Activity Tracker
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] DEBUG EndpointManager: [0xaaf9b018]: Creating Endpoint Manager
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] DEBUG PlaybackSessionManager: [0xaaf9b408]: Creating Playback Session Manager
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] DEBUG BackoffTimer: [0xaaf9b580]: Creating Backoff Timer
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] DEBUG MediaEngine: [0xaaf9b6a0]: Creating new Media Engine
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] DEBUG AudioRenderer: [0xaaf9b8c0]: Creating Audio Renderer
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] TRACE MediaEngineCommandSequencer: [0xaaf9ba18]: Creating Media Engine Command Sequencer
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] DEBUG PlaybackControlsManager: [0xaaf9ba78]: Creating new Playback Controls Manager
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] DEBUG VolumeManager: [0xaaf9bb08]: Creating new Volume Manager
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] DEBUG ProtocolHandler: [0xaaf9bde0]: Creating Protocol Handler
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] DEBUG MessageReceiver: [0xaaf9be80]: Creating Message Receiver
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] DEBUG RendererActivationController: [0xaaf9bff8]: Creating new Renderer Activation Controller
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] TRACE RendererActivationCommandSequencer: [0xaaf9c0a0]: Creating Renderer Activation Command Sequencer
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] DEBUG ReportingManager: [0xaaf9c1b0]: Creating new Reporting Manager
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] DEBUG StreamingEventReporter: [0xaaf9c1f8]: Creating Streaming Event Reporter
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] DEBUG BackoffTimer: [0xaaf9c2d8]: Creating Backoff Timer
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] DEBUG TokenExpiryController: [0xaaf9c3e8]: Creating Token Expiry Controller
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] DEBUG UserInactivityManager: [0xaaf9c438]: Creating new User Inactivity Manager
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] INFO VolumeManager: [0xaaf9bb08]: Setting new playback volume: 100
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] INFO VolumeManager: [0xaaf9bb08]: Setting new mute state: 1
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] DEBUG SampleApp: Qobuz Connect has been initialized
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.025 [4826.4826] TRACE SampleApp: Running event loop
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.026 [4826.4826] INFO QobuzConnect: [0xaaf9c4d8]: Client initialized!
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.026 [4826.4826] INFO SampleApp: Starting Avahi advertising, name: ZEN Stream3, service name: _qobuz-connect._tcp
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.040 [4826.4826] DEBUG SampleApp: Avahi client state changed: RUNNING
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.044 [4826.4826] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.050 [4826.4826] INFO LocalConfigManager: [0xaaf9b3e8]: Starting Local Configuration server
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.050 [4826.4826] INFO SampleApp: Starting Local configuration server
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.051 [4826.4826] INFO SampleApp: Playback mute state changed: 1
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.051 [4826.4826] ERROR SampleApp: Unable to set mute state, no ALSA volume element
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.052 [4826.4826] DEBUG SampleApp: Avahi entry group state changed: REGISTERING
Dec 18 05:52:06 ifi-zen-stream3 systemd[1]: mpd.socket: Succeeded.
Dec 18 05:52:06 ifi-zen-stream3 systemd[1]: Closed mpd.socket.
Dec 18 05:52:06 ifi-zen-stream3 sudo[4833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.062 [4826.4826] INFO SampleApp: Playback volume changed: 100
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.062 [4826.4826] ERROR SampleApp: Unable to set volume, no ALSA volume element
Dec 18 05:52:06 ifi-zen-stream3 sudo[4833]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:06 ifi-zen-stream3 systemd[1]: Stopping Music Player Daemon...
Dec 18 05:52:06 ifi-zen-stream3 systemd[1]: mpd.service: Succeeded.
Dec 18 05:52:06 ifi-zen-stream3 systemd[1]: Stopped Music Player Daemon.
Dec 18 05:52:06 ifi-zen-stream3 sudo[4830]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:06 ifi-zen-stream3 sudo[4833]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:06 ifi-zen-stream3 sudo[4838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service
Dec 18 05:52:06 ifi-zen-stream3 sudo[4838]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:06 ifi-zen-stream3 sudo[4841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service
Dec 18 05:52:06 ifi-zen-stream3 sudo[4841]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:06 ifi-zen-stream3 systemd[1]: Listening on mpd.socket.
Dec 18 05:52:06 ifi-zen-stream3 systemd[1]: Starting Music Player Daemon...
Dec 18 05:52:06 ifi-zen-stream3 systemd[1]: mpd.socket: Succeeded.
Dec 18 05:52:06 ifi-zen-stream3 systemd[1]: Closed mpd.socket.
Dec 18 05:52:06 ifi-zen-stream3 systemd[1]: Stopping mpd.socket.
Dec 18 05:52:06 ifi-zen-stream3 systemd[1]: mpd.socket: Socket service mpd.service already active, refusing.
Dec 18 05:52:06 ifi-zen-stream3 systemd[1]: Failed to listen on mpd.socket.
Dec 18 05:52:06 ifi-zen-stream3 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Dec 18 05:52:06 ifi-zen-stream3 systemd[1]: mpd.service: Succeeded.
Dec 18 05:52:06 ifi-zen-stream3 systemd[1]: Stopped Music Player Daemon.
Dec 18 05:52:06 ifi-zen-stream3 systemd[1]: Listening on mpd.socket.
Dec 18 05:52:06 ifi-zen-stream3 systemd[1]: Starting Music Player Daemon...
Dec 18 05:52:06 ifi-zen-stream3 sudo[4845]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 18 05:52:06 ifi-zen-stream3 sudo[4845]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:06 ifi-zen-stream3 sudo[4845]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: 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=149_1766037059882&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=149_1766037059881&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059883&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=149_1766037059883&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"}],"index":4}
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Preload queue cleared
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioReplaceandPlayItems
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::ClearQueue
Dec 18 05:52:06 ifi-zen-stream3 node[529]: A new connection has been established.
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stop
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::serviceStop
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::serviceStop
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioStop
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stop
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Roon Ready Stop
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::clearPlayQueue
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::saveQueue
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushQueue
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::addQueueItems
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::addQueueItems
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Preload queue cleared
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushQueue
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::saveQueue
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::updateTrackBlock
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrackBlock
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: ConvSwitch: Sent Play
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPlay
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::play index 4
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::addQueueItems
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::addQueueItems
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Preload queue cleared
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stop
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushQueue
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::saveQueue
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::play index undefined
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::updateTrackBlock
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrackBlock
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::startPlaybackTimer
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::clearAddPlayTracks USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand stop
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: error: MPD error: Error: This socket has been ended by the other party
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: error: This socket has been ended by the other party {"code":"EPIPE"}
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: error: MPD error: Error: This socket has been ended by the other party
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: error: This socket has been ended by the other party {"code":"EPIPE"}
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: error: MPD error: Error: This socket has been ended by the other party
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: error: This socket has been ended by the other party {"code":"EPIPE"}
Dec 18 05:52:06 ifi-zen-stream3 volumio[1461]: info: ConvSwitch: Get message: success
Dec 18 05:52:06 ifi-zen-stream3 play[4806]: 20251218 05:52:06.893 [4826.4826] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED
Dec 18 05:52:07 ifi-zen-stream3 sudo[4856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service
Dec 18 05:52:07 ifi-zen-stream3 sudo[4856]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:07 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Dec 18 05:52:07 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::getcurrentVolume
Dec 18 05:52:07 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioRetrievevolume
Dec 18 05:52:07 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume
Dec 18 05:52:07 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:07 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:07 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:07 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:07 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:07 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service...
Dec 18 05:52:07 ifi-zen-stream3 node[529]: Closing connection with the client spotify
Dec 18 05:52:07 ifi-zen-stream3 play[4347]: 2025-12-18 05:52:07.581 E esdk select error: 4 -> Interrupted system call
Dec 18 05:52:07 ifi-zen-stream3 play[4347]: 2025-12-18 05:52:07.582 I app Exiting with error = 0
Dec 18 05:52:07 ifi-zen-stream3 play[4347]: 2025-12-18 05:52:07.582 I api SpFree()
Dec 18 05:52:07 ifi-zen-stream3 play[4347]: 2025-12-18 05:52:07.582 I api SpFree [returned value: 0]
Dec 18 05:52:07 ifi-zen-stream3 play[4347]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03
Dec 18 05:52:07 ifi-zen-stream3 play[4347]: [Info] ConvSwitch: ConvSwitchInit
Dec 18 05:52:07 ifi-zen-stream3 play[4347]: [Info] MetaClient: MetaClient SDK -- v1.02
Dec 18 05:52:07 ifi-zen-stream3 play[4347]: [Info] MetaClient: MetaClientInit
Dec 18 05:52:07 ifi-zen-stream3 play[4347]: [Info] ConvSwitch: ConvSwitchExit
Dec 18 05:52:07 ifi-zen-stream3 play[4347]: [Info] MetaClient: MetaClientExit
Dec 18 05:52:07 ifi-zen-stream3 node[513]: ConvSwitch: Drop client spotify
Dec 18 05:52:07 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM
Dec 18 05:52:07 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded.
Dec 18 05:52:07 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service.
Dec 18 05:52:07 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service.
Dec 18 05:52:07 ifi-zen-stream3 sudo[4856]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:07 ifi-zen-stream3 volumio[1461]: info: Spotify Connect Service Started
Dec 18 05:52:07 ifi-zen-stream3 sudo[4863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service
Dec 18 05:52:07 ifi-zen-stream3 sudo[4863]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:07 ifi-zen-stream3 volumio[1461]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/TrondheimSolistene/DIVERTIMENTI/e602c289-bf96-42a1-894f-fe087f3926a9.jpg'
Dec 18 05:52:07 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service...
Dec 18 05:52:07 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM
Dec 18 05:52:07 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded.
Dec 18 05:52:07 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service.
Dec 18 05:52:07 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service.
Dec 18 05:52:07 ifi-zen-stream3 sudo[4863]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:07 ifi-zen-stream3 volumio[1461]: info: Spotify Connect Service Started
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: output: volumio mixer: hw:5
Dec 18 05:52:07 ifi-zen-stream3 node[513]: ConvSwitch: Add client spotify
Dec 18 05:52:07 ifi-zen-stream3 node[529]: A new connection has been established.
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.981 I api SpRegisterDebugCallbacks [returned value: 0]
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.982 I api SpInit(0xff9cbfd0, API v66)
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.982 I esdk eSDK version: HEAD-v3.166.69-g24821f73
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.983 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 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.983 I esdk Successfully registered dns callback: dns_lookup_callback
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.983 I download Using 128 kB for cache buffer
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.983 I download Using 621 kB for compressed audio buffer
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.983 I esdk Successfully registered error callback
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.996 I esdk Creating IPv4 socket (domain 2)
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.996 I zc webserver: service port 5566 (5566-5576) buffer size 4444
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.996 I zc Started ZeroConf service on port 5566 path /zc alias count 0
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.996 I esdk Creating IPv4 socket (domain 2)
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.996 I api SpInit [returned value: 0]
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.997 I api SpRegisterConnectionCallbacks(0xff9cbfb8, (nil))
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.997 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.997 I api SpRegisterConnectionCallbacks [returned value: 0]
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.997 I api SpRegisterPlaybackCallbacks(0xff9cbfa0, (nil))
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.997 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, -
Dec 18 05:52:07 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:07.997 I api SpRegisterPlaybackCallbacks [returned value: 0]
Dec 18 05:52:08 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:08.010 W app Couldn't find mixer for volume controls. (tried , SoftMaster)
Dec 18 05:52:08 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:08.010 I app Initialized!
Dec 18 05:52:08 ifi-zen-stream3 volumio[1461]: info: VolumeController::SetAlsaVolume100
Dec 18 05:52:08 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume
Dec 18 05:52:08 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:08 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:08 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:08 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:08 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:08 ifi-zen-stream3 node[513]: ConvSwitch: Add client tidal
Dec 18 05:52:08 ifi-zen-stream3 tidal_connect_application[4883]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi.
Dec 18 05:52:08 ifi-zen-stream3 tidal_connect_application[4883]: *** WARNING *** Please fix your application to use the native API of Avahi!
Dec 18 05:52:08 ifi-zen-stream3 tidal_connect_application[4883]: *** WARNING *** For more information see
Dec 18 05:52:08 ifi-zen-stream3 ifi_metadata[4794]: [Info] MetaClient: MetaClient SDK -- v1.02
Dec 18 05:52:08 ifi-zen-stream3 ifi_metadata[4794]: [Info] MetaClient: MetaClientInit
Dec 18 05:52:08 ifi-zen-stream3 ifi_metadata[4794]: Connected
Dec 18 05:52:09 ifi-zen-stream3 mpd[4847]: Dec 18 05:52 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Dec 18 05:52:09 ifi-zen-stream3 systemd[1]: Started Music Player Daemon.
Dec 18 05:52:09 ifi-zen-stream3 sudo[4838]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:09 ifi-zen-stream3 sudo[4841]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:09 ifi-zen-stream3 volumio[1461]: info: Restarted MPD.
Dec 18 05:52:09 ifi-zen-stream3 volumio[1461]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.socket mpd.service
Dec 18 05:52:09 ifi-zen-stream3 volumio[1461]: Job for mpd.socket failed.
Dec 18 05:52:09 ifi-zen-stream3 volumio[1461]: See "systemctl status mpd.socket" and "journalctl -xe" for details.
Dec 18 05:52:09 ifi-zen-stream3 volumio[1461]: error: MPD error: The expression evaluated to a falsy value:
Dec 18 05:52:09 ifi-zen-stream3 volumio[1461]: assert.ok(self.idling)
Dec 18 05:52:09 ifi-zen-stream3 volumio[1461]: error: The expression evaluated to a falsy value:
Dec 18 05:52:09 ifi-zen-stream3 volumio[1461]: assert.ok(self.idling)
Dec 18 05:52:09 ifi-zen-stream3 volumio[1461]: error: updateQueue error: null
Dec 18 05:52:09 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioStop
Dec 18 05:52:09 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stop
Dec 18 05:52:09 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:09 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer...
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: 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=149_1766037059882&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=149_1766037059881&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059883&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=149_1766037059883&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"}],"index":4}
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Preload queue cleared
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioReplaceandPlayItems
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::ClearQueue
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stop
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::clearPlayQueue
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::saveQueue
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushQueue
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::addQueueItems
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::addQueueItems
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Preload queue cleared
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushQueue
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::saveQueue
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::updateTrackBlock
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrackBlock
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: ConvSwitch: Sent Play
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPlay
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::play index 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::addQueueItems
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::addQueueItems
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Preload queue cleared
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stop
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushQueue
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::saveQueue
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::play index undefined
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::updateTrackBlock
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrackBlock
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::startPlaybackTimer
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::clearAddPlayTracks USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand stop
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: ConvSwitch: Get message: success
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand stop took 16 milliseconds
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand clear
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces system playlist update
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Ignoring MPD Status Update
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand clear took 5 milliseconds
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand add "USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac"
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces system playlist update
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Ignoring MPD Status Update
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: error: updateQueue error: null
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces system playlist update
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Ignoring MPD Status Update
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 14ms
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand add "USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac" took 10 milliseconds
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 8ms
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand play
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces system playlist update
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Ignoring MPD Status Update
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces state update: player
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 17ms
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand play took 13 milliseconds
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::getState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand status
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 15ms
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces state update: player
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::getState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand status
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand status took 46 milliseconds
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioGetState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces state update: player
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::getState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand status
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand status took 51 milliseconds
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand playlistinfo took 10 milliseconds
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioGetState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseTrackInfo
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::pushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::servicePushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"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 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: CURRENT POSITION 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState stateService play
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState currentStatus stop
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 82ms
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces state update: player
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::getState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand status
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand status took 23 milliseconds
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand playlistinfo took 15 milliseconds
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand status took 4 milliseconds
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioGetState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseTrackInfo
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioGetState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::pushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::servicePushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: STATE SERVICE {"status":"play","position":0,"seek":10,"duration":182,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"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 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: CURRENT POSITION 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState stateService play
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState currentStatus play
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Received an update from plugin. extracting info from payload
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 121ms
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand playlistinfo took 41 milliseconds
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand playlistinfo took 38 milliseconds
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseTrackInfo
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseTrackInfo
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::pushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::servicePushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: STATE SERVICE {"status":"play","position":0,"seek":992,"duration":182,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1504 Kbps","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 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: CURRENT POSITION 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState stateService play
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState currentStatus play
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Received an update from plugin. extracting info from payload
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::pushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::servicePushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: STATE SERVICE {"status":"play","position":0,"seek":992,"duration":182,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1504 Kbps","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 18 05:52:18 ifi-zen-stream3 volumio[1461]: verbose: CURRENT POSITION 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState stateService play
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState currentStatus play
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: Received an update from plugin. extracting info from payload
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 137ms
Dec 18 05:52:18 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 115ms
Dec 18 05:52:19 ifi-zen-stream3 volumio[1461]: info: MetaClient: Sent Meta
Dec 18 05:52:19 ifi-zen-stream3 volumio[1461]: info: MetaClient: Get message: success
Dec 18 05:52:21 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded.
Dec 18 05:52:21 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer.
Dec 18 05:52:21 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer...
Dec 18 05:52:21 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded.
Dec 18 05:52:21 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer.
Dec 18 05:52:25 ifi-zen-stream3 volumiologrotate[467]: ls: cannot access '/var/log/samba/log.wb-ZEN': No such file or directory
Dec 18 05:52:25 ifi-zen-stream3 volumiologrotate[467]: ls: cannot access 'STREAM3': No such file or directory
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: ++++--++++ pause
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPause
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pause
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stPlaybackTimer
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::servicePause
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::servicePause
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::pause
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand pause
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces state update: player
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand pause took 3 milliseconds
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::getState
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand status
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces state update: player
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::getState
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand status
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand status took 6 milliseconds
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand status took 3 milliseconds
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseState
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioGetState
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseState
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioGetState
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand playlistinfo took 5 milliseconds
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand playlistinfo took 3 milliseconds
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseTrackInfo
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseTrackInfo
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::pushState
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::servicePushState
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":16742,"duration":182,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2433 Kbps","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 18 05:52:34 ifi-zen-stream3 volumio[1461]: verbose: CURRENT POSITION 4
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState stateService pause
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState currentStatus pause
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stPlaybackTimer
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::pushState
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::servicePushState
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":16742,"duration":182,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2433 Kbps","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 18 05:52:34 ifi-zen-stream3 volumio[1461]: verbose: CURRENT POSITION 4
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState stateService pause
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState currentStatus pause
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stPlaybackTimer
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 65ms
Dec 18 05:52:34 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 62ms
Dec 18 05:52:38 ifi-zen-stream3 kernel: usb 4-1.3: USB disconnect, device number 6
Dec 18 05:52:38 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer...
Dec 18 05:52:38 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:38 ifi-zen-stream3 volumio[1461]: ---------------------------- USB Audio Device Detached
Dec 18 05:52:38 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach
Dec 18 05:52:38 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::Close All Modals sent
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Preparing to save Alsa Options, stopping services first
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioGetState
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPause
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pause
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Saving Audio Output to: {"disallowPush":false,"output_device":{"value":"0,0","label":"SPDIF"}}
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , forceDoP
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Found match in Cards Database: setting mixer for card SPDIF
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Ignoring Mixers Options
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Device 0,0 does not have any Mixer Control Available
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Restoring Previous Volume level: 100 false false
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Updating Volume Controller Parameters: Device: 0,0 Name: SPDIF Mixer: None Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:39 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded.
Dec 18 05:52:39 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer.
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Preparing to generate the ALSA configuration file
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: wizard , refreshWizarOutputDevices
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Asound.conf file written
Dec 18 05:52:39 ifi-zen-stream3 sudo[5323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Dec 18 05:52:39 ifi-zen-stream3 sudo[5323]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:39 ifi-zen-stream3 sudo[5323]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: No state is present for card rkifispdif
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: Found hardware: "rk-ifi-spdif" "" "" "" ""
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: Hardware is initialized using a generic method
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: No state is present for card rkifispdif
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Tidal connect: Output device has changed
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Output device has changed, restarting MPD
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Qobuz connect: Output device has changed
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Roon Ready: Output device has changed
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Spotify: Output device has changed
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Tidal connect: Output device has changed
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Output device has changed, restarting MPD
Dec 18 05:52:39 ifi-zen-stream3 sudo[5328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 18 05:52:39 ifi-zen-stream3 sudo[5328]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:39 ifi-zen-stream3 sudo[5328]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Qobuz connect: Output device has changed
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Roon Ready: Output device has changed
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: Spotify: Output device has changed
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: MPD Permissions set
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 sudo[5330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 sudo[5330]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:39 ifi-zen-stream3 sudo[5330]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 18 05:52:39 ifi-zen-stream3 volumio[1461]: info: MPD Permissions set
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: Starting RoonReady Sync
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: Starting RoonReady Sync
Dec 18 05:52:40 ifi-zen-stream3 sudo[5348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service
Dec 18 05:52:40 ifi-zen-stream3 sudo[5348]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:40 ifi-zen-stream3 sudo[5352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service
Dec 18 05:52:40 ifi-zen-stream3 sudo[5352]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:40 ifi-zen-stream3 sudo[5355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service
Dec 18 05:52:40 ifi-zen-stream3 sudo[5355]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:40 ifi-zen-stream3 node[513]: ConvSwitch: Drop client qobuz-connect
Dec 18 05:52:40 ifi-zen-stream3 node[529]: Closing connection with the client qobuz-connect
Dec 18 05:52:40 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Qobuz Connect Service...
Dec 18 05:52:40 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM
Dec 18 05:52:40 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded.
Dec 18 05:52:40 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Qobuz Connect Service.
Dec 18 05:52:40 ifi-zen-stream3 sudo[5359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service
Dec 18 05:52:40 ifi-zen-stream3 sudo[5359]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:40 ifi-zen-stream3 sudo[5348]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:40 ifi-zen-stream3 node[529]: Closing connection with the client roon-ready
Dec 18 05:52:40 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Roon Ready Service...
Dec 18 05:52:40 ifi-zen-stream3 node[513]: ConvSwitch: Drop client roon-ready
Dec 18 05:52:40 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM
Dec 18 05:52:40 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Succeeded.
Dec 18 05:52:40 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Roon Ready Service.
Dec 18 05:52:40 ifi-zen-stream3 sudo[5355]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:40 ifi-zen-stream3 systemd[1]: Started iFi Streamer Roon Ready Service.
Dec 18 05:52:40 ifi-zen-stream3 sudo[5352]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:40 ifi-zen-stream3 sudo[5359]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: RoonReady Started
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: RoonReady Started
Dec 18 05:52:40 ifi-zen-stream3 play[5362]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input
Dec 18 05:52:40 ifi-zen-stream3 node[513]: ConvSwitch: Add client roon-ready
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: ConvSwitch: Get message: request:pause
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioStop
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stop
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::updateTrackBlock
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrackBlock
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stPlaybackTimer
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::serviceStop
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::serviceStop
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::stop
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand stop
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioStop
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stop
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces state update: player
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand stop took 14 milliseconds
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::getState
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand status
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand status took 2 milliseconds
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseState
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioGetState
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces state update: player
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::getState
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand status
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand playlistinfo took 10 milliseconds
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand status took 7 milliseconds
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseTrackInfo
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseState
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioGetState
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::pushState
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::servicePushState
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: 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 18 05:52:40 ifi-zen-stream3 volumio[1461]: verbose: CURRENT POSITION 4
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 45ms
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: ---------------------------- Client requests Start RoonReady PlaybackRoutine
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: Roon Ready playback start
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioStop
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stop
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: Roon Ready metadata receiver is on
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand playlistinfo took 34 milliseconds
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseTrackInfo
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::pushState
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::servicePushState
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 4
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: 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 18 05:52:40 ifi-zen-stream3 volumio[1461]: verbose: CURRENT POSITION 4
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null
Dec 18 05:52:40 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 74ms
Dec 18 05:52:41 ifi-zen-stream3 sudo[5396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service
Dec 18 05:52:41 ifi-zen-stream3 sudo[5396]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service...
Dec 18 05:52:41 ifi-zen-stream3 node[529]: Closing connection with the client tidal-connect
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service...
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM
Dec 18 05:52:41 ifi-zen-stream3 node[513]: ConvSwitch: Drop client tidal
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service.
Dec 18 05:52:41 ifi-zen-stream3 sudo[5396]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service.
Dec 18 05:52:41 ifi-zen-stream3 sudo[5401]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service
Dec 18 05:52:41 ifi-zen-stream3 sudo[5401]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:41 ifi-zen-stream3 volumio[1461]: info: Tidal Connect Service Started
Dec 18 05:52:41 ifi-zen-stream3 node[529]: A new connection has been established.
Dec 18 05:52:41 ifi-zen-stream3 node[529]: Closing connection with the client tidal-connect
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service...
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service...
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service.
Dec 18 05:52:41 ifi-zen-stream3 sudo[5401]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service.
Dec 18 05:52:41 ifi-zen-stream3 node[529]: A new connection has been established.
Dec 18 05:52:41 ifi-zen-stream3 volumio[1461]: info: Tidal Connect Service Started
Dec 18 05:52:41 ifi-zen-stream3 sudo[5414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service
Dec 18 05:52:41 ifi-zen-stream3 sudo[5414]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Started iFi Streamer Qobuz Connect Service.
Dec 18 05:52:41 ifi-zen-stream3 sudo[5414]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:41 ifi-zen-stream3 volumio[1461]: info: Qobuz Connect Service Started
Dec 18 05:52:41 ifi-zen-stream3 sudo[5424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service
Dec 18 05:52:41 ifi-zen-stream3 sudo[5424]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:41 ifi-zen-stream3 sudo[5424]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:41 ifi-zen-stream3 volumio[1461]: info: Qobuz Connect Service Started
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.495 [5442.5442] DEBUG SampleApp: Starting sample application
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.496 [5442.5442] DEBUG SampleApp: Device Name: ZEN Stream3
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.496 [5442.5442] DEBUG SampleApp: Manufacturer: Sample manufacturer
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.496 [5442.5442] DEBUG SampleApp: Model: iFi Streamer
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.496 [5442.5442] DEBUG SampleApp: Serial Number: ifi:8a:98:30:dc:9b:23
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.496 [5442.5442] DEBUG SampleApp: Audio output device: volumio
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.496 [5442.5442] DEBUG SampleApp: Volume control device: default
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.496 [5442.5442] DEBUG SampleApp: Volume control element: Master
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.496 [5442.5442] DEBUG SampleApp: Local config server port: 8000
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.501 [5442.5442] ERROR SampleApp: Unable to find ALSA mixer element 'Master' on index 0
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.501 [5442.5442] DEBUG SampleApp: Maximum supported audio quality: HIRES_L3
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: [Info] MetaClient: MetaClient SDK -- v1.02
Dec 18 05:52:41 ifi-zen-stream3 node[529]: A new connection has been established.
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: [Info] MetaClient: MetaClientInit
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03
Dec 18 05:52:41 ifi-zen-stream3 node[513]: ConvSwitch: Add client qobuz-connect
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: [Info] ConvSwitch: ConvSwitchInit
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.607 [5442.5442] DEBUG ActiveStateManager: [0xab3ac098]: Creating new Active State Manager
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.608 [5442.5442] DEBUG NetworkActivityTracker: [0xab3ac108]: Creating new Network Activity Tracker
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.608 [5442.5442] DEBUG EndpointManager: [0xab3ad080]: Creating Endpoint Manager
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.608 [5442.5442] DEBUG PlaybackSessionManager: [0xab3ad470]: Creating Playback Session Manager
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.608 [5442.5442] DEBUG BackoffTimer: [0xab3ad5e8]: Creating Backoff Timer
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.608 [5442.5442] DEBUG MediaEngine: [0xab3ad708]: Creating new Media Engine
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.608 [5442.5442] DEBUG AudioRenderer: [0xab3ad928]: Creating Audio Renderer
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.608 [5442.5442] TRACE MediaEngineCommandSequencer: [0xab3ada80]: Creating Media Engine Command Sequencer
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.608 [5442.5442] DEBUG PlaybackControlsManager: [0xab3adae0]: Creating new Playback Controls Manager
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.608 [5442.5442] DEBUG VolumeManager: [0xab3adb70]: Creating new Volume Manager
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.608 [5442.5442] DEBUG ProtocolHandler: [0xab3ade48]: Creating Protocol Handler
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.608 [5442.5442] DEBUG MessageReceiver: [0xab3adee8]: Creating Message Receiver
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.608 [5442.5442] DEBUG RendererActivationController: [0xab3ae060]: Creating new Renderer Activation Controller
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.608 [5442.5442] TRACE RendererActivationCommandSequencer: [0xab3ae108]: Creating Renderer Activation Command Sequencer
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.609 [5442.5442] DEBUG ReportingManager: [0xab3ae218]: Creating new Reporting Manager
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.609 [5442.5442] DEBUG StreamingEventReporter: [0xab3ae260]: Creating Streaming Event Reporter
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.609 [5442.5442] DEBUG BackoffTimer: [0xab3ae340]: Creating Backoff Timer
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.609 [5442.5442] DEBUG TokenExpiryController: [0xab3ae450]: Creating Token Expiry Controller
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.609 [5442.5442] DEBUG UserInactivityManager: [0xab3ae4a0]: Creating new User Inactivity Manager
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.609 [5442.5442] INFO VolumeManager: [0xab3adb70]: Setting new playback volume: 100
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.609 [5442.5442] INFO VolumeManager: [0xab3adb70]: Setting new mute state: 1
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.609 [5442.5442] DEBUG SampleApp: Qobuz Connect has been initialized
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.609 [5442.5442] TRACE SampleApp: Running event loop
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.609 [5442.5442] INFO QobuzConnect: [0xab3ae540]: Client initialized!
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.609 [5442.5442] INFO SampleApp: Starting Avahi advertising, name: ZEN Stream3, service name: _qobuz-connect._tcp
Dec 18 05:52:41 ifi-zen-stream3 sudo[5446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service
Dec 18 05:52:41 ifi-zen-stream3 sudo[5446]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.627 [5442.5442] DEBUG SampleApp: Avahi client state changed: RUNNING
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.636 [5442.5442] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.643 [5442.5442] INFO LocalConfigManager: [0xab3ad450]: Starting Local Configuration server
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.643 [5442.5442] INFO SampleApp: Starting Local configuration server
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.644 [5442.5442] INFO SampleApp: Playback mute state changed: 1
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.644 [5442.5442] ERROR SampleApp: Unable to set mute state, no ALSA volume element
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.644 [5442.5442] DEBUG SampleApp: Avahi entry group state changed: REGISTERING
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.647 [5442.5442] INFO SampleApp: Playback volume changed: 100
Dec 18 05:52:41 ifi-zen-stream3 play[5423]: 20251218 05:52:41.647 [5442.5442] ERROR SampleApp: Unable to set volume, no ALSA volume element
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: mpd.socket: Succeeded.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Closed mpd.socket.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Stopping Music Player Daemon...
Dec 18 05:52:41 ifi-zen-stream3 sudo[5449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service
Dec 18 05:52:41 ifi-zen-stream3 sudo[5449]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: mpd.service: Succeeded.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Stopped Music Player Daemon.
Dec 18 05:52:41 ifi-zen-stream3 sudo[5446]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:41 ifi-zen-stream3 sudo[5449]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:41 ifi-zen-stream3 sudo[5454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service
Dec 18 05:52:41 ifi-zen-stream3 sudo[5454]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Listening on mpd.socket.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Starting Music Player Daemon...
Dec 18 05:52:41 ifi-zen-stream3 sudo[5457]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service
Dec 18 05:52:41 ifi-zen-stream3 sudo[5457]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: mpd.socket: Succeeded.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Closed mpd.socket.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Stopping mpd.socket.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: mpd.socket: Socket service mpd.service already active, refusing.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Failed to listen on mpd.socket.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: mpd.service: Succeeded.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Stopped Music Player Daemon.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Listening on mpd.socket.
Dec 18 05:52:41 ifi-zen-stream3 systemd[1]: Starting Music Player Daemon...
Dec 18 05:52:42 ifi-zen-stream3 sudo[5460]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 18 05:52:42 ifi-zen-stream3 sudo[5460]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:42 ifi-zen-stream3 sudo[5460]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:42 ifi-zen-stream3 node[529]: A new connection has been established.
Dec 18 05:52:42 ifi-zen-stream3 play[5423]: 20251218 05:52:42.638 [5442.5442] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED
Dec 18 05:52:43 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Dec 18 05:52:43 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::getcurrentVolume
Dec 18 05:52:43 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioRetrievevolume
Dec 18 05:52:43 ifi-zen-stream3 sudo[5474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service
Dec 18 05:52:43 ifi-zen-stream3 sudo[5474]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:43 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume
Dec 18 05:52:43 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:43 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:43 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:43 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:43 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:43.190 E esdk select error: 4 -> Interrupted system call
Dec 18 05:52:43 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:43.192 I app Exiting with error = 0
Dec 18 05:52:43 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:43.192 I api SpFree()
Dec 18 05:52:43 ifi-zen-stream3 play[4873]: 2025-12-18 05:52:43.193 I api SpFree [returned value: 0]
Dec 18 05:52:43 ifi-zen-stream3 play[4873]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03
Dec 18 05:52:43 ifi-zen-stream3 play[4873]: [Info] ConvSwitch: ConvSwitchInit
Dec 18 05:52:43 ifi-zen-stream3 play[4873]: [Info] MetaClient: MetaClient SDK -- v1.02
Dec 18 05:52:43 ifi-zen-stream3 play[4873]: [Info] MetaClient: MetaClientInit
Dec 18 05:52:43 ifi-zen-stream3 play[4873]: [Info] ConvSwitch: ConvSwitchExit
Dec 18 05:52:43 ifi-zen-stream3 play[4873]: [Info] MetaClient: MetaClientExit
Dec 18 05:52:43 ifi-zen-stream3 node[529]: Closing connection with the client spotify
Dec 18 05:52:43 ifi-zen-stream3 node[513]: ConvSwitch: Drop client spotify
Dec 18 05:52:43 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service...
Dec 18 05:52:43 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM
Dec 18 05:52:43 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded.
Dec 18 05:52:43 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service.
Dec 18 05:52:43 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service.
Dec 18 05:52:43 ifi-zen-stream3 sudo[5474]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:43 ifi-zen-stream3 volumio[1461]: info: Spotify Connect Service Started
Dec 18 05:52:43 ifi-zen-stream3 sudo[5477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service
Dec 18 05:52:43 ifi-zen-stream3 sudo[5477]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 18 05:52:43 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service...
Dec 18 05:52:43 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM
Dec 18 05:52:43 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded.
Dec 18 05:52:43 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service.
Dec 18 05:52:43 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service.
Dec 18 05:52:43 ifi-zen-stream3 sudo[5477]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:43 ifi-zen-stream3 volumio[1461]: info: Spotify Connect Service Started
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: output: volumio mixer: hw:0
Dec 18 05:52:43 ifi-zen-stream3 node[513]: ConvSwitch: Add client spotify
Dec 18 05:52:43 ifi-zen-stream3 node[529]: A new connection has been established.
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.530 I api SpRegisterDebugCallbacks [returned value: 0]
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.531 I api SpInit(0xff8acc60, API v66)
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.531 I esdk eSDK version: HEAD-v3.166.69-g24821f73
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.531 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 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.532 I esdk Successfully registered dns callback: dns_lookup_callback
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.532 I download Using 128 kB for cache buffer
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.532 I download Using 621 kB for compressed audio buffer
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.532 I esdk Successfully registered error callback
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.544 I esdk Creating IPv4 socket (domain 2)
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.544 I zc webserver: service port 5566 (5566-5576) buffer size 4444
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.544 I zc Started ZeroConf service on port 5566 path /zc alias count 0
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.544 I esdk Creating IPv4 socket (domain 2)
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.544 I api SpInit [returned value: 0]
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.545 I api SpRegisterConnectionCallbacks(0xff8acc48, (nil))
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.545 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.545 I api SpRegisterConnectionCallbacks [returned value: 0]
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.545 I api SpRegisterPlaybackCallbacks(0xff8acc30, (nil))
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.545 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, -
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.545 I api SpRegisterPlaybackCallbacks [returned value: 0]
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.551 W app Couldn't find mixer for volume controls. (tried , SoftMaster)
Dec 18 05:52:43 ifi-zen-stream3 play[5483]: 2025-12-18 05:52:43.551 I app Initialized!
Dec 18 05:52:43 ifi-zen-stream3 volumio[1461]: info: VolumeController::SetAlsaVolume100
Dec 18 05:52:43 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume
Dec 18 05:52:43 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:43 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:43 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:43 ifi-zen-stream3 node[513]: ConvSwitch: Add client tidal
Dec 18 05:52:43 ifi-zen-stream3 tidal_connect_application[5496]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi.
Dec 18 05:52:43 ifi-zen-stream3 tidal_connect_application[5496]: *** WARNING *** Please fix your application to use the native API of Avahi!
Dec 18 05:52:43 ifi-zen-stream3 tidal_connect_application[5496]: *** WARNING *** For more information see
Dec 18 05:52:43 ifi-zen-stream3 ifi_metadata[5410]: [Info] MetaClient: MetaClient SDK -- v1.02
Dec 18 05:52:43 ifi-zen-stream3 ifi_metadata[5410]: [Info] MetaClient: MetaClientInit
Dec 18 05:52:43 ifi-zen-stream3 ifi_metadata[5410]: Connected
Dec 18 05:52:44 ifi-zen-stream3 mpd[5462]: Dec 18 05:52 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Dec 18 05:52:44 ifi-zen-stream3 systemd[1]: Started Music Player Daemon.
Dec 18 05:52:44 ifi-zen-stream3 sudo[5457]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:44 ifi-zen-stream3 sudo[5454]: pam_unix(sudo:session): session closed for user root
Dec 18 05:52:44 ifi-zen-stream3 volumio[1461]: info: Restarted MPD.
Dec 18 05:52:44 ifi-zen-stream3 volumio[1461]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.socket mpd.service
Dec 18 05:52:44 ifi-zen-stream3 volumio[1461]: Job for mpd.socket failed.
Dec 18 05:52:44 ifi-zen-stream3 volumio[1461]: See "systemctl status mpd.socket" and "journalctl -xe" for details.
Dec 18 05:52:44 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer...
Dec 18 05:52:44 ifi-zen-stream3 volumio[1461]: error: MPD error: The expression evaluated to a falsy value:
Dec 18 05:52:44 ifi-zen-stream3 volumio[1461]: assert.ok(self.idling)
Dec 18 05:52:44 ifi-zen-stream3 volumio[1461]: error: The expression evaluated to a falsy value:
Dec 18 05:52:44 ifi-zen-stream3 volumio[1461]: assert.ok(self.idling)
Dec 18 05:52:44 ifi-zen-stream3 volumio[1461]: error: updateQueue error: null
Dec 18 05:52:45 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded.
Dec 18 05:52:45 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer.
Dec 18 05:52:45 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioStop
Dec 18 05:52:45 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stop
Dec 18 05:52:45 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::serviceStop
Dec 18 05:52:45 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::serviceStop
Dec 18 05:52:45 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioStop
Dec 18 05:52:45 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stop
Dec 18 05:52:45 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:45 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:45 ifi-zen-stream3 volumio[1461]: info: Roon Ready Stop
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ++++--++++ playItemsList: {"item":{"service":"mpd","type":"song","title":"Simple Symphony op. 4 - Boisterous Bourree (192 kHz)","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac","albumart":"/albumart?cacheid=149_1766037059882&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=149_1766037059881&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059883&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=149_1766037059883&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"}],"index":6}
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Preload queue cleared
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioReplaceandPlayItems
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::ClearQueue
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stop
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::clearPlayQueue
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::saveQueue
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushQueue
Dec 18 05:52:55 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer...
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::addQueueItems
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::addQueueItems
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Preload queue cleared
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushQueue
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::saveQueue
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::updateTrackBlock
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrackBlock
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ConvSwitch: Sent Play
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPlay
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::play index 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::addQueueItems
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::addQueueItems
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Preload queue cleared
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stop
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushQueue
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::saveQueue
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::play index undefined
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::updateTrackBlock
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrackBlock
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::startPlaybackTimer
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::clearAddPlayTracks USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand stop
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ++++--++++ playItemsList: {"item":{"service":"mpd","type":"song","title":"Simple Symphony op. 4 - Boisterous Bourree (192 kHz)","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac","albumart":"/albumart?cacheid=149_1766037059882&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=149_1766037059881&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059882&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=149_1766037059883&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=149_1766037059883&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"}],"index":6}
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Preload queue cleared
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioReplaceandPlayItems
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::ClearQueue
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stop
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::clearPlayQueue
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::saveQueue
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushQueue
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::addQueueItems
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::addQueueItems
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Preload queue cleared
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushQueue
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::saveQueue
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::updateTrackBlock
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrackBlock
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ConvSwitch: Sent Play
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPlay
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::play index 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::addQueueItems
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::addQueueItems
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Preload queue cleared
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::stop
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushQueue
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::saveQueue
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::play index undefined
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::updateTrackBlock
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrackBlock
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::startPlaybackTimer
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::clearAddPlayTracks USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand stop
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ConvSwitch: Get message: successsuccess
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand stop took 75 milliseconds
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand stop took 8 milliseconds
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand clear
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand clear
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces system playlist update
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Ignoring MPD Status Update
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces system playlist update
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Ignoring MPD Status Update
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand clear took 8 milliseconds
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand clear took 8 milliseconds
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand add "USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac"
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand add "USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac"
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces system playlist update
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Ignoring MPD Status Update
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: error: updateQueue error: null
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: error: updateQueue error: null
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces system playlist update
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Ignoring MPD Status Update
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces system playlist update
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Ignoring MPD Status Update
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 19ms
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 17ms
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand add "USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac" took 17 milliseconds
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand add "USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac" took 17 milliseconds
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 16ms
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand play
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand play
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces system playlist update
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Ignoring MPD Status Update
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces state update: player
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 28ms
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 27ms
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand play took 20 milliseconds
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand play took 19 milliseconds
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::getState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand status
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 19ms
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces state update: player
Dec 18 05:52:55 ifi-zen-stream3 kernel: wm8804 0-003b: wm8804_hw_params rate: 0x2ee00 format: 0x6
Dec 18 05:52:55 ifi-zen-stream3 kernel: clk_spdif_frac p_rate(491519999) is low than rate(24576000)*20, use integer or half-div
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::getState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand status
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand status took 17 milliseconds
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioGetState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces state update: player
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::getState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand status
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand status took 39 milliseconds
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioGetState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info:
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: ---------------------------- MPD announces state update: player
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::getState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand status
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand playlistinfo took 27 milliseconds
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand status took 23 milliseconds
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand playlistinfo took 20 milliseconds
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand status took 18 milliseconds
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseTrackInfo
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioGetState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseTrackInfo
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioGetState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::pushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::servicePushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Simple Symphony op. 4 - Boisterous Bourree (192 kHz)","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac","trackType":"flac"}
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: CURRENT POSITION 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState stateService play
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState currentStatus stop
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::pushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::servicePushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Simple Symphony op. 4 - Boisterous Bourree (192 kHz)","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac","trackType":"flac"}
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: CURRENT POSITION 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState stateService play
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState currentStatus play
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Received an update from plugin. extracting info from payload
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 122ms
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 119ms
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand playlistinfo took 44 milliseconds
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: sendMpdCommand playlistinfo took 38 milliseconds
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseTrackInfo
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: ControllerMpd::parseTrackInfo
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::pushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::servicePushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: STATE SERVICE {"status":"play","position":0,"seek":593,"duration":182,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3549 Kbps","isStreaming":false,"title":"Simple Symphony op. 4 - Boisterous Bourree (192 kHz)","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac","trackType":"flac"}
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: CURRENT POSITION 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState stateService play
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState currentStatus play
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Received an update from plugin. extracting info from payload
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ControllerMpd::pushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::servicePushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: STATE SERVICE {"status":"play","position":0,"seek":593,"duration":182,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3549 Kbps","isStreaming":false,"title":"Simple Symphony op. 4 - Boisterous Bourree (192 kHz)","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac","trackType":"flac"}
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: verbose: CURRENT POSITION 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState stateService play
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::syncState currentStatus play
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: Received an update from plugin. extracting info from payload
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreStateMachine::pushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CorePlayQueue::getTrack 6
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::volumioPushState
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 18 05:52:55 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 152ms
Dec 18 05:52:56 ifi-zen-stream3 volumio[1461]: info: ------------------------------ 144ms
Dec 18 05:52:56 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded.
Dec 18 05:52:56 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer.
Dec 18 05:52:56 ifi-zen-stream3 volumio[1461]: info: MetaClient: Sent Meta
Dec 18 05:52:56 ifi-zen-stream3 volumio[1461]: info: MetaClient: Get message: success
Dec 18 05:53:09 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer...
Dec 18 05:53:10 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded.
Dec 18 05:53:10 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer.
Dec 18 05:53:10 ifi-zen-stream3 volumio[1461]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 18 05:53:10 ifi-zen-stream3 volumio[1461]: Error: connect ETIMEDOUT 31.13.91.33:443
Dec 18 05:53:10 ifi-zen-stream3 volumio[1461]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Dec 18 05:53:10 ifi-zen-stream3 volumio[1461]: errno: -110,
Dec 18 05:53:10 ifi-zen-stream3 volumio[1461]: code: 'ETIMEDOUT',
Dec 18 05:53:10 ifi-zen-stream3 volumio[1461]: syscall: 'connect',
Dec 18 05:53:10 ifi-zen-stream3 volumio[1461]: address: '31.13.91.33',
Dec 18 05:53:10 ifi-zen-stream3 volumio[1461]: port: 443
Dec 18 05:53:10 ifi-zen-stream3 volumio[1461]: }
Dec 18 05:53:10 ifi-zen-stream3 volumio[1461]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 18 05:53:11 ifi-zen-stream3 sudo[5843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-18 05:52
Dec 18 05:53:11 ifi-zen-stream3 sudo[5843]: 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"