-- Logs begin at Thu 2019-02-14 10:11:58 UTC, end at Sat 2025-11-15 07:45:46 UTC. -- Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: ++++--++++ play: null Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: ConvSwitch: Sent Play Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPlay Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::play index undefined Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 5 Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::startPlaybackTimer Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 5 Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::resume Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand play Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: ConvSwitch: Get message: success Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand play took 35 milliseconds Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 10 milliseconds Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 11 milliseconds Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 5 Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 5 Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 5 Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: verbose: STATE SERVICE {"status":"play","position":0,"seek":14857,"duration":182,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1664 Kbps","isStreaming":false,"title":"Simple Symphony op. 4 - Boisterous Bourree 48kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac","trackType":"flac"} Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 5 Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState stateService play Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState currentStatus pause Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 5 Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 5 Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: verbose: STATE SERVICE {"status":"play","position":0,"seek":15109,"duration":182,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1543 Kbps","isStreaming":false,"title":"Simple Symphony op. 4 - Boisterous Bourree 48kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac","trackType":"flac"} Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 5 Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState stateService play Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState currentStatus play Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: Received an update from plugin. extracting info from payload Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 5 Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 5 Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 93ms Nov 15 07:44:05 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 88ms Nov 15 07:44:06 ifi-zen-stream3 volumio[1350]: info: MetaClient: Sent Meta Nov 15 07:44:06 ifi-zen-stream3 volumio[1350]: info: MetaClient: Get message: success Nov 15 07:44:09 ifi-zen-stream3 streamer-irq[1349]: unlink: /data/ifi-k2-mode Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: 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=908_1763192590636&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=908_1763192590634&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=908_1763192590635&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=908_1763192590635&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=908_1763192590635&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=908_1763192590635&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=908_1763192590635&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=908_1763192590636&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=908_1763192590636&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=908_1763192590636&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=908_1763192590636&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"}],"index":6} Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Preload queue cleared Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::ClearQueue Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stop Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stPlaybackTimer Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::updateTrackBlock Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrackBlock Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 5 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::serviceStop Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 5 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::serviceStop Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::stop Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand stop Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::clearPlayQueue Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::saveQueue Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushQueue Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::addQueueItems Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::addQueueItems Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Preload queue cleared Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushQueue Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::saveQueue Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::updateTrackBlock Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrackBlock Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ConvSwitch: Sent Play Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPlay Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::play index 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::addQueueItems Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::addQueueItems Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Preload queue cleared Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stop Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushQueue Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::saveQueue Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::play index undefined Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::updateTrackBlock Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrackBlock Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::startPlaybackTimer Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::clearAddPlayTracks USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand stop Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand stop took 74 milliseconds Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand stop took 11 milliseconds Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand clear Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ConvSwitch: Get message: success Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces system playlist update Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Ignoring MPD Status Update Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 13 milliseconds Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand clear took 11 milliseconds Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 7 milliseconds Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand add "USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac" Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 46ms Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces system playlist update Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Ignoring MPD Status Update Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: error: updateQueue error: null Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces system playlist update Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Ignoring MPD Status Update Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 50ms Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 41 milliseconds Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand add "USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac" took 42 milliseconds Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 11ms Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand play Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 73ms Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces system playlist update Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Ignoring MPD Status Update Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 30ms Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand play took 22 milliseconds Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 19ms Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/TrondheimSolistene/DIVERTIMENTI/7897e184-9c19-47bb-b593-a3fbd9520df7.jpg' Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 208 milliseconds Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 203 milliseconds Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 13 milliseconds Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: 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"} Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState stateService play Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState currentStatus stop Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: 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":"3087 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"} Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState stateService play Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState currentStatus play Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Received an update from plugin. extracting info from payload Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 269ms Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 271ms Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 49 milliseconds Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 4 milliseconds Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: 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":"3087 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"} Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState stateService play Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState currentStatus play Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Received an update from plugin. extracting info from payload Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 114ms Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 45 milliseconds Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47,"duration":182,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3209 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"} Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState stateService play Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState currentStatus play Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: Received an update from plugin. extracting info from payload Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:44:11 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:12 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 108ms Nov 15 07:44:12 ifi-zen-stream3 volumio[1350]: info: MetaClient: Sent Meta Nov 15 07:44:12 ifi-zen-stream3 volumio[1350]: info: MetaClient: Get message: success Nov 15 07:44:13 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Nov 15 07:44:13 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Nov 15 07:44:13 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Nov 15 07:44:16 ifi-zen-stream3 volumiologrotate[480]: ls: cannot access '/var/log/samba/log.wb-ZEN': No such file or directory Nov 15 07:44:16 ifi-zen-stream3 volumiologrotate[480]: ls: cannot access 'STREAM3': No such file or directory Nov 15 07:44:19 ifi-zen-stream3 streamer-irq[1349]: file inexistence, touch: /data/ifi-k2-mode Nov 15 07:44:19 ifi-zen-stream3 streamer-irq[1349]: had touch: /data/ifi-k2-mode Nov 15 07:44:24 ifi-zen-stream3 streamer-irq[1349]: unlink: /data/ifi-k2-mode Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: ++++--++++ pause Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPause Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pause Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stPlaybackTimer Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::servicePause Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePause Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pause Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand pause Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand pause took 17 milliseconds Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 7 milliseconds Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 3 milliseconds Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":20131,"duration":182,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5028 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"} Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 6 Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState stateService pause Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState currentStatus pause Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stPlaybackTimer Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":20131,"duration":182,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5028 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"} Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 6 Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState stateService pause Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState currentStatus pause Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stPlaybackTimer Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 67ms Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 60ms Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: ++++--++++ pause Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPause Nov 15 07:44:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pause Nov 15 07:44:38 ifi-zen-stream3 ntpd[948]: Soliciting pool server 108.59.2.24 Nov 15 07:44:41 ifi-zen-stream3 ntpd[948]: Soliciting pool server 111.230.189.174 Nov 15 07:44:42 ifi-zen-stream3 ntpd[948]: Soliciting pool server 119.28.183.184 Nov 15 07:44:43 ifi-zen-stream3 ntpd[948]: Soliciting pool server 84.16.73.33 Nov 15 07:44:49 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Nov 15 07:44:50 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Nov 15 07:44:50 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Nov 15 07:44:56 ifi-zen-stream3 kernel: usb 5-1.3: USB disconnect, device number 3 Nov 15 07:44:56 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Nov 15 07:44:56 ifi-zen-stream3 kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Nov 15 07:44:56 ifi-zen-stream3 kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=0x00 Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Partition removed: {"syspath":"/sys/devices/platform/usb@ff600000/ff600000.dwc3/xhci-hcd.0.auto/usb5/5-1/5-1.3/5-1.3:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-uuid/82C0-08B6 /dev/disk/by-id/usb-Samsung_Flash_Drive_0362025080001663-0:0-part1 /dev/disk/by-label/Samsung\\x20USB /dev/disk/by-path/platform-xhci-hcd.0.auto-usb-0:1.3:1.0-scsi-0:0:0:0-part1 /dev/disk/by-partuuid/099428c9-01","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/usb@ff600000/ff600000.dwc3/xhci-hcd.0.auto/usb5/5-1/5-1.3/5-1.3:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","ID_BUS":"usb","ID_FS_LABEL":"Samsung_USB","ID_FS_LABEL_ENC":"Samsung\\x20USB","ID_FS_TYPE":"exfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"82C0-08B6","ID_FS_UUID_ENC":"82C0-08B6","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"Flash_Drive","ID_MODEL_ENC":"Flash\\x20Drive\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"6300","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"128","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"125313123","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"099428c9-01","ID_PART_TABLE_TYPE":"dos","ID_PART_TABLE_UUID":"099428c9","ID_PATH":"platform-xhci-hcd.0.auto-usb-0:1.3:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-xhci-hcd_0_auto-usb-0_1_3_1_0-scsi-0_0_0_0","ID_REVISION":"1100","ID_SERIAL":"Samsung_Flash_Drive_0362025080001663-0:0","ID_SERIAL_SHORT":"0362025080001663","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"Samsung","ID_VENDOR_ENC":"Samsung\\x20","ID_VENDOR_ID":"04e8","MAJOR":"8","MINOR":"1","PARTN":"1","SEQNUM":"1748","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"7318818"} Nov 15 07:44:56 ifi-zen-stream3 sudo[4253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -lf /dev/sda1 Nov 15 07:44:56 ifi-zen-stream3 sudo[4253]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:44:56 ifi-zen-stream3 mount.exfat[1491]: non-zero reference counter (1) for '02 - Divertimento 192-24.flac' Nov 15 07:44:56 ifi-zen-stream3 mount.exfat[1491]: failed to write super block Nov 15 07:44:56 ifi-zen-stream3 systemd[1]: media-Samsung_USB.mount: Succeeded. Nov 15 07:44:56 ifi-zen-stream3 sudo[4253]: pam_unix(sudo:session): session closed for user root Nov 15 07:44:56 ifi-zen-stream3 kernel: usb 4-1.1: USB disconnect, device number 5 Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: ---------------------------- USB Audio Device Detached Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::Close All Modals sent Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Preparing to save Alsa Options, stopping services first Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPause Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pause Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Saving Audio Output to: {"disallowPush":false,"output_device":{"value":"0,0","label":"SPDIF"}} Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , forceDoP Nov 15 07:44:56 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Nov 15 07:44:56 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Found match in Cards Database: setting mixer for card SPDIF Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Ignoring Mixers Options Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Device 0,0 does not have any Mixer Control Available Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Restoring Previous Volume level: 100 false false Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioUpdateVolumeSettings Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Updating Volume Controller Parameters: Device: 0,0 Name: SPDIF Mixer: None Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Preparing to generate the ALSA configuration file Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: wizard , refreshWizarOutputDevices Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Asound.conf file written Nov 15 07:44:56 ifi-zen-stream3 sudo[4309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 15 07:44:56 ifi-zen-stream3 sudo[4309]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:44:56 ifi-zen-stream3 sudo[4309]: pam_unix(sudo:session): session closed for user root Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: No state is present for card rkifispdif Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: Found hardware: "rk-ifi-spdif" "" "" "" "" Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: Hardware is initialized using a generic method Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: No state is present for card rkifispdif Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Tidal connect: Output device has changed Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Output device has changed, restarting MPD Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Qobuz connect: Output device has changed Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Roon Ready: Output device has changed Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Spotify: Output device has changed Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Tidal connect: Output device has changed Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Output device has changed, restarting MPD Nov 15 07:44:56 ifi-zen-stream3 sudo[4314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 15 07:44:56 ifi-zen-stream3 sudo[4314]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Qobuz connect: Output device has changed Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Roon Ready: Output device has changed Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: Spotify: Output device has changed Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 sudo[4314]: pam_unix(sudo:session): session closed for user root Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 sudo[4316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 15 07:44:56 ifi-zen-stream3 sudo[4316]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:44:56 ifi-zen-stream3 sudo[4316]: pam_unix(sudo:session): session closed for user root Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: MPD Permissions set Nov 15 07:44:56 ifi-zen-stream3 volumio[1350]: info: MPD Permissions set Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: Starting RoonReady Sync Nov 15 07:44:57 ifi-zen-stream3 sudo[4337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Nov 15 07:44:57 ifi-zen-stream3 sudo[4337]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: Starting RoonReady Sync Nov 15 07:44:57 ifi-zen-stream3 sudo[4338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Nov 15 07:44:57 ifi-zen-stream3 sudo[4338]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:44:57 ifi-zen-stream3 sudo[4341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Nov 15 07:44:57 ifi-zen-stream3 sudo[4341]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:44:57 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Qobuz Connect Service... Nov 15 07:44:57 ifi-zen-stream3 node[501]: ConvSwitch: Drop client qobuz-connect Nov 15 07:44:57 ifi-zen-stream3 node[475]: Closing connection with the client qobuz-connect Nov 15 07:44:57 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM Nov 15 07:44:57 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded. Nov 15 07:44:57 ifi-zen-stream3 sudo[4344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Nov 15 07:44:57 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Qobuz Connect Service. Nov 15 07:44:57 ifi-zen-stream3 sudo[4344]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:44:57 ifi-zen-stream3 sudo[4337]: pam_unix(sudo:session): session closed for user root Nov 15 07:44:57 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Roon Ready Service... Nov 15 07:44:57 ifi-zen-stream3 node[501]: ConvSwitch: Drop client roon-ready Nov 15 07:44:57 ifi-zen-stream3 node[475]: Closing connection with the client roon-ready Nov 15 07:44:57 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM Nov 15 07:44:57 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Succeeded. Nov 15 07:44:57 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Roon Ready Service. Nov 15 07:44:57 ifi-zen-stream3 sudo[4341]: pam_unix(sudo:session): session closed for user root Nov 15 07:44:57 ifi-zen-stream3 systemd[1]: Started iFi Streamer Roon Ready Service. Nov 15 07:44:57 ifi-zen-stream3 sudo[4344]: pam_unix(sudo:session): session closed for user root Nov 15 07:44:57 ifi-zen-stream3 sudo[4338]: pam_unix(sudo:session): session closed for user root Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: RoonReady Started Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: RoonReady Started Nov 15 07:44:57 ifi-zen-stream3 play[4347]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Nov 15 07:44:57 ifi-zen-stream3 node[501]: ConvSwitch: Add client roon-ready Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: ConvSwitch: Get message: request:pause Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioStop Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stop Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::updateTrackBlock Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrackBlock Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stPlaybackTimer Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::serviceStop Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::serviceStop Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::stop Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand stop Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioStop Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stop Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand stop took 19 milliseconds Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: Roon Ready playback start Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioStop Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stop Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: Roon Ready metadata receiver is on Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 20 milliseconds Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 16 milliseconds Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:57 ifi-zen-stream3 kernel: usb 4-1.3: new full-speed USB device number 6 using xhci-hcd Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: 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 (192 kHz)","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac","trackType":"flac"} Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 6 Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: 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 (192 kHz)","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac","trackType":"flac"} Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 6 Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 80ms Nov 15 07:44:57 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 76ms Nov 15 07:44:58 ifi-zen-stream3 kernel: usb 4-1.3: not running at top speed; connect to a high speed hub Nov 15 07:44:58 ifi-zen-stream3 kernel: usb 4-1.3: New USB device found, idVendor=20b1, idProduct=0010 Nov 15 07:44:58 ifi-zen-stream3 kernel: usb 4-1.3: New USB device strings: Mfr=1, Product=8, SerialNumber=2 Nov 15 07:44:58 ifi-zen-stream3 kernel: usb 4-1.3: Product: ZEN DAC 3 (UCA1) Nov 15 07:44:58 ifi-zen-stream3 kernel: usb 4-1.3: Manufacturer: iFi (by AMR) Nov 15 07:44:58 ifi-zen-stream3 kernel: usb 4-1.3: SerialNumber: 005A Nov 15 07:44:58 ifi-zen-stream3 kernel: usb 4-1.3: Warning! Unlikely big volume range (=32512), cval->res is probably wrong. Nov 15 07:44:58 ifi-zen-stream3 kernel: usb 4-1.3: [10] FU [ZEN DAC 3 (UCA1) Playback Volume] ch = 1, val = -32512/0/1 Nov 15 07:44:58 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Nov 15 07:44:58 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc4-supply from device tree Nov 15 07:44:58 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Nov 15 07:44:58 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Nov 15 07:44:58 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc5-supply from device tree Nov 15 07:44:58 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Nov 15 07:44:58 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Nov 15 07:44:58 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Nov 15 07:44:58 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc4-supply from device tree Nov 15 07:44:58 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Nov 15 07:44:58 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Nov 15 07:44:58 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc5-supply from device tree Nov 15 07:44:58 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Nov 15 07:44:58 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Nov 15 07:44:58 ifi-zen-stream3 systemd-udevd[4250]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 5' failed with exit code 99. Nov 15 07:44:58 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:44:58 ifi-zen-stream3 volumio[1350]: ---------------------------- USB Audio Device Attached Nov 15 07:44:58 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Nov 15 07:44:58 ifi-zen-stream3 sudo[4387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Nov 15 07:44:58 ifi-zen-stream3 sudo[4387]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Nov 15 07:44:58 ifi-zen-stream3 node[475]: Closing connection with the client tidal-connect Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service... Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Nov 15 07:44:58 ifi-zen-stream3 node[501]: ConvSwitch: Drop client tidal Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service. Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service. Nov 15 07:44:58 ifi-zen-stream3 sudo[4387]: pam_unix(sudo:session): session closed for user root Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service. Nov 15 07:44:58 ifi-zen-stream3 sudo[4390]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Nov 15 07:44:58 ifi-zen-stream3 volumio[1350]: info: Tidal Connect Service Started Nov 15 07:44:58 ifi-zen-stream3 sudo[4390]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:44:58 ifi-zen-stream3 node[475]: A new connection has been established. Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Nov 15 07:44:58 ifi-zen-stream3 node[475]: Closing connection with the client tidal-connect Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service... Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service. Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service. Nov 15 07:44:58 ifi-zen-stream3 sudo[4390]: pam_unix(sudo:session): session closed for user root Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service. Nov 15 07:44:58 ifi-zen-stream3 volumio[1350]: info: Tidal Connect Service Started Nov 15 07:44:58 ifi-zen-stream3 node[475]: A new connection has been established. Nov 15 07:44:58 ifi-zen-stream3 sudo[4403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Nov 15 07:44:58 ifi-zen-stream3 sudo[4403]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: Started iFi Streamer Qobuz Connect Service. Nov 15 07:44:58 ifi-zen-stream3 sudo[4411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Nov 15 07:44:58 ifi-zen-stream3 sudo[4403]: pam_unix(sudo:session): session closed for user root Nov 15 07:44:58 ifi-zen-stream3 sudo[4411]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:44:58 ifi-zen-stream3 volumio[1350]: info: Qobuz Connect Service Started Nov 15 07:44:58 ifi-zen-stream3 sudo[4411]: pam_unix(sudo:session): session closed for user root Nov 15 07:44:58 ifi-zen-stream3 volumio[1350]: info: Qobuz Connect Service Started Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.734 [4433.4433] DEBUG SampleApp: Starting sample application Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.734 [4433.4433] DEBUG SampleApp: Device Name: ZEN Stream3 Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.734 [4433.4433] DEBUG SampleApp: Manufacturer: Sample manufacturer Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.735 [4433.4433] DEBUG SampleApp: Model: iFi Streamer Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.735 [4433.4433] DEBUG SampleApp: Serial Number: ifi:f2:b0:8f:da:d8:35 Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.735 [4433.4433] DEBUG SampleApp: Audio output device: volumio Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.735 [4433.4433] DEBUG SampleApp: Volume control device: default Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.735 [4433.4433] DEBUG SampleApp: Volume control element: Master Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.735 [4433.4433] DEBUG SampleApp: Local config server port: 8000 Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.740 [4433.4433] ERROR SampleApp: Unable to find ALSA mixer element 'Master' on index 0 Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.741 [4433.4433] DEBUG SampleApp: Maximum supported audio quality: HIRES_L3 Nov 15 07:44:58 ifi-zen-stream3 play[4415]: [Info] MetaClient: MetaClient SDK -- v1.02 Nov 15 07:44:58 ifi-zen-stream3 node[475]: A new connection has been established. Nov 15 07:44:58 ifi-zen-stream3 play[4415]: [Info] MetaClient: MetaClientInit Nov 15 07:44:58 ifi-zen-stream3 play[4415]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Nov 15 07:44:58 ifi-zen-stream3 node[501]: ConvSwitch: Add client qobuz-connect Nov 15 07:44:58 ifi-zen-stream3 sudo[4437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Nov 15 07:44:58 ifi-zen-stream3 sudo[4437]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:44:58 ifi-zen-stream3 play[4415]: [Info] ConvSwitch: ConvSwitchInit Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.848 [4433.4433] DEBUG ActiveStateManager: [0xab20b098]: Creating new Active State Manager Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.848 [4433.4433] DEBUG NetworkActivityTracker: [0xab20b108]: Creating new Network Activity Tracker Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.849 [4433.4433] DEBUG EndpointManager: [0xab20c080]: Creating Endpoint Manager Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.849 [4433.4433] DEBUG PlaybackSessionManager: [0xab20c470]: Creating Playback Session Manager Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.849 [4433.4433] DEBUG BackoffTimer: [0xab20c5e8]: Creating Backoff Timer Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.849 [4433.4433] DEBUG MediaEngine: [0xab20c708]: Creating new Media Engine Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.849 [4433.4433] DEBUG AudioRenderer: [0xab20c928]: Creating Audio Renderer Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.849 [4433.4433] TRACE MediaEngineCommandSequencer: [0xab20ca80]: Creating Media Engine Command Sequencer Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.849 [4433.4433] DEBUG PlaybackControlsManager: [0xab20cae0]: Creating new Playback Controls Manager Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.849 [4433.4433] DEBUG VolumeManager: [0xab20cb70]: Creating new Volume Manager Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.849 [4433.4433] DEBUG ProtocolHandler: [0xab20ce48]: Creating Protocol Handler Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.849 [4433.4433] DEBUG MessageReceiver: [0xab20cee8]: Creating Message Receiver Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.849 [4433.4433] DEBUG RendererActivationController: [0xab20d060]: Creating new Renderer Activation Controller Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.849 [4433.4433] TRACE RendererActivationCommandSequencer: [0xab20d108]: Creating Renderer Activation Command Sequencer Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.849 [4433.4433] DEBUG ReportingManager: [0xab20d218]: Creating new Reporting Manager Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.850 [4433.4433] DEBUG StreamingEventReporter: [0xab20d260]: Creating Streaming Event Reporter Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.850 [4433.4433] DEBUG BackoffTimer: [0xab20d340]: Creating Backoff Timer Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.850 [4433.4433] DEBUG TokenExpiryController: [0xab20d450]: Creating Token Expiry Controller Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.850 [4433.4433] DEBUG UserInactivityManager: [0xab20d4a0]: Creating new User Inactivity Manager Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.850 [4433.4433] INFO VolumeManager: [0xab20cb70]: Setting new playback volume: 100 Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.850 [4433.4433] INFO VolumeManager: [0xab20cb70]: Setting new mute state: 1 Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.850 [4433.4433] DEBUG SampleApp: Qobuz Connect has been initialized Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.850 [4433.4433] TRACE SampleApp: Running event loop Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.850 [4433.4433] INFO QobuzConnect: [0xab20d540]: Client initialized! Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.850 [4433.4433] INFO SampleApp: Starting Avahi advertising, name: ZEN Stream3, service name: _qobuz-connect._tcp Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.863 [4433.4433] DEBUG SampleApp: Avahi client state changed: RUNNING Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: mpd.socket: Succeeded. Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: Closed mpd.socket. Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.870 [4433.4433] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: Stopping Music Player Daemon... Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.882 [4433.4433] INFO LocalConfigManager: [0xab20c450]: Starting Local Configuration server Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.883 [4433.4433] INFO SampleApp: Starting Local configuration server Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.884 [4433.4433] INFO SampleApp: Playback mute state changed: 1 Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.884 [4433.4433] ERROR SampleApp: Unable to set mute state, no ALSA volume element Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.884 [4433.4433] DEBUG SampleApp: Avahi entry group state changed: REGISTERING Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.886 [4433.4433] INFO SampleApp: Playback volume changed: 100 Nov 15 07:44:58 ifi-zen-stream3 play[4415]: 20251115 07:44:58.886 [4433.4433] ERROR SampleApp: Unable to set volume, no ALSA volume element Nov 15 07:44:58 ifi-zen-stream3 sudo[4440]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Nov 15 07:44:58 ifi-zen-stream3 sudo[4440]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: mpd.service: Succeeded. Nov 15 07:44:58 ifi-zen-stream3 systemd[1]: Stopped Music Player Daemon. Nov 15 07:44:58 ifi-zen-stream3 sudo[4437]: pam_unix(sudo:session): session closed for user root Nov 15 07:44:59 ifi-zen-stream3 sudo[4440]: pam_unix(sudo:session): session closed for user root Nov 15 07:44:59 ifi-zen-stream3 sudo[4445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Nov 15 07:44:59 ifi-zen-stream3 sudo[4445]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:44:59 ifi-zen-stream3 systemd[1]: Listening on mpd.socket. Nov 15 07:44:59 ifi-zen-stream3 systemd[1]: Starting Music Player Daemon... Nov 15 07:44:59 ifi-zen-stream3 sudo[4448]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Nov 15 07:44:59 ifi-zen-stream3 sudo[4448]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:44:59 ifi-zen-stream3 systemd[1]: mpd.socket: Succeeded. Nov 15 07:44:59 ifi-zen-stream3 systemd[1]: Closed mpd.socket. Nov 15 07:44:59 ifi-zen-stream3 systemd[1]: Stopping mpd.socket. Nov 15 07:44:59 ifi-zen-stream3 systemd[1]: mpd.socket: Socket service mpd.service already active, refusing. Nov 15 07:44:59 ifi-zen-stream3 systemd[1]: Failed to listen on mpd.socket. Nov 15 07:44:59 ifi-zen-stream3 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Nov 15 07:44:59 ifi-zen-stream3 systemd[1]: mpd.service: Succeeded. Nov 15 07:44:59 ifi-zen-stream3 systemd[1]: Stopped Music Player Daemon. Nov 15 07:44:59 ifi-zen-stream3 systemd[1]: Listening on mpd.socket. Nov 15 07:44:59 ifi-zen-stream3 systemd[1]: Starting Music Player Daemon... Nov 15 07:44:59 ifi-zen-stream3 sudo[4455]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 15 07:44:59 ifi-zen-stream3 sudo[4455]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:44:59 ifi-zen-stream3 sudo[4455]: pam_unix(sudo:session): session closed for user root Nov 15 07:44:59 ifi-zen-stream3 node[475]: A new connection has been established. Nov 15 07:44:59 ifi-zen-stream3 play[4415]: 20251115 07:44:59.771 [4433.4433] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED Nov 15 07:45:00 ifi-zen-stream3 volumio[1350]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/Samsung_USB Nov 15 07:45:00 ifi-zen-stream3 sudo[4489]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Nov 15 07:45:00 ifi-zen-stream3 sudo[4489]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:00 ifi-zen-stream3 play[2983]: 2025-11-15 07:45:00.411 E esdk select error: 4 -> Interrupted system call Nov 15 07:45:00 ifi-zen-stream3 play[2983]: 2025-11-15 07:45:00.412 I app Exiting with error = 0 Nov 15 07:45:00 ifi-zen-stream3 play[2983]: 2025-11-15 07:45:00.413 I api SpFree() Nov 15 07:45:00 ifi-zen-stream3 play[2983]: 2025-11-15 07:45:00.413 I api SpFree [returned value: 0] Nov 15 07:45:00 ifi-zen-stream3 play[2983]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Nov 15 07:45:00 ifi-zen-stream3 play[2983]: [Info] ConvSwitch: ConvSwitchInit Nov 15 07:45:00 ifi-zen-stream3 play[2983]: [Info] MetaClient: MetaClient SDK -- v1.02 Nov 15 07:45:00 ifi-zen-stream3 play[2983]: [Info] MetaClient: MetaClientInit Nov 15 07:45:00 ifi-zen-stream3 play[2983]: [Info] ConvSwitch: ConvSwitchExit Nov 15 07:45:00 ifi-zen-stream3 play[2983]: [Info] MetaClient: MetaClientExit Nov 15 07:45:00 ifi-zen-stream3 node[501]: ConvSwitch: Drop client spotify Nov 15 07:45:00 ifi-zen-stream3 node[475]: Closing connection with the client spotify Nov 15 07:45:00 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service... Nov 15 07:45:00 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Nov 15 07:45:00 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Nov 15 07:45:00 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service. Nov 15 07:45:00 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service. Nov 15 07:45:00 ifi-zen-stream3 sudo[4493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Nov 15 07:45:00 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Nov 15 07:45:00 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::getcurrentVolume Nov 15 07:45:00 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioRetrievevolume Nov 15 07:45:00 ifi-zen-stream3 sudo[4493]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:00 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Nov 15 07:45:00 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:00 ifi-zen-stream3 sudo[4489]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:00 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:00 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:00 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:00 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service... Nov 15 07:45:00 ifi-zen-stream3 volumio[1350]: info: Spotify Connect Service Started Nov 15 07:45:00 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Nov 15 07:45:00 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Nov 15 07:45:00 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service. Nov 15 07:45:00 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service. Nov 15 07:45:00 ifi-zen-stream3 sudo[4493]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:00 ifi-zen-stream3 volumio[1350]: info: Spotify Connect Service Started Nov 15 07:45:00 ifi-zen-stream3 play[4497]: output: volumio mixer: hw:5 Nov 15 07:45:00 ifi-zen-stream3 node[501]: ConvSwitch: Add client spotify Nov 15 07:45:00 ifi-zen-stream3 node[475]: A new connection has been established. Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.756 I api SpRegisterDebugCallbacks [returned value: 0] Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.757 I api SpInit(0xffbef5b0, API v66) Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.757 I esdk eSDK version: HEAD-v3.166.69-g24821f73 Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.757 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 Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.758 I esdk Successfully registered dns callback: dns_lookup_callback Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.758 I download Using 128 kB for cache buffer Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.758 I download Using 621 kB for compressed audio buffer Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.758 I esdk Successfully registered error callback Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.770 I esdk Creating IPv4 socket (domain 2) Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.770 I zc webserver: service port 5566 (5566-5576) buffer size 4444 Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.770 I zc Started ZeroConf service on port 5566 path /zc alias count 0 Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.770 I esdk Creating IPv4 socket (domain 2) Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.771 I api SpInit [returned value: 0] Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.771 I api SpRegisterConnectionCallbacks(0xffbef598, (nil)) Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.771 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.771 I api SpRegisterConnectionCallbacks [returned value: 0] Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.771 I api SpRegisterPlaybackCallbacks(0xffbef580, (nil)) Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.771 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, - Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.771 I api SpRegisterPlaybackCallbacks [returned value: 0] Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.778 W app Couldn't find mixer for volume controls. (tried , SoftMaster) Nov 15 07:45:00 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:00.779 I app Initialized! Nov 15 07:45:00 ifi-zen-stream3 volumio[1350]: info: VolumeController::SetAlsaVolume100 Nov 15 07:45:00 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Nov 15 07:45:00 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:00 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:00 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:00 ifi-zen-stream3 node[501]: ConvSwitch: Add client tidal Nov 15 07:45:01 ifi-zen-stream3 tidal_connect_application[4511]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi. Nov 15 07:45:01 ifi-zen-stream3 tidal_connect_application[4511]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 15 07:45:01 ifi-zen-stream3 tidal_connect_application[4511]: *** WARNING *** For more information see Nov 15 07:45:01 ifi-zen-stream3 ifi_metadata[4402]: [Info] MetaClient: MetaClient SDK -- v1.02 Nov 15 07:45:01 ifi-zen-stream3 ifi_metadata[4402]: [Info] MetaClient: MetaClientInit Nov 15 07:45:01 ifi-zen-stream3 ifi_metadata[4402]: Connected Nov 15 07:45:01 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Nov 15 07:45:01 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Nov 15 07:45:01 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Nov 15 07:45:01 ifi-zen-stream3 kernel: usb 4-1.1: new high-speed USB device number 7 using xhci-hcd Nov 15 07:45:01 ifi-zen-stream3 kernel: usb 4-1.1: New USB device found, idVendor=04e8, idProduct=6300 Nov 15 07:45:01 ifi-zen-stream3 kernel: usb 4-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Nov 15 07:45:01 ifi-zen-stream3 kernel: usb 4-1.1: Product: Flash Drive Nov 15 07:45:01 ifi-zen-stream3 kernel: usb 4-1.1: Manufacturer: Samsung Nov 15 07:45:01 ifi-zen-stream3 kernel: usb 4-1.1: SerialNumber: 0362025080001663 Nov 15 07:45:01 ifi-zen-stream3 kernel: usb-storage 4-1.1:1.0: USB Mass Storage device detected Nov 15 07:45:01 ifi-zen-stream3 kernel: scsi host1: usb-storage 4-1.1:1.0 Nov 15 07:45:01 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Nov 15 07:45:01 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc4-supply from device tree Nov 15 07:45:01 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Nov 15 07:45:01 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Nov 15 07:45:01 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc5-supply from device tree Nov 15 07:45:01 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Nov 15 07:45:01 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Nov 15 07:45:02 ifi-zen-stream3 mpd[4459]: Nov 15 07:45 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 15 07:45:02 ifi-zen-stream3 systemd[1]: Started Music Player Daemon. Nov 15 07:45:02 ifi-zen-stream3 sudo[4448]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:02 ifi-zen-stream3 sudo[4445]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: info: Scanning removed location : "USB/Samsung_USB" Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: info: Restarted MPD. Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.socket mpd.service Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: Job for mpd.socket failed. Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: See "systemctl status mpd.socket" and "journalctl -xe" for details. Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: error: MPD error: The expression evaluated to a falsy value: Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: assert.ok(self.idling) Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: error: The expression evaluated to a falsy value: Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: assert.ok(self.idling) Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: error: updateQueue error: null Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioStop Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stop Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::serviceStop Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::serviceStop Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioStop Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stop Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:45:02 ifi-zen-stream3 volumio[1350]: info: Roon Ready Stop Nov 15 07:45:03 ifi-zen-stream3 kernel: scsi 1:0:0:0: Direct-Access Samsung Flash Drive 1100 PQ: 0 ANSI: 6 Nov 15 07:45:03 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio1-supply from device tree Nov 15 07:45:03 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc4-supply from device tree Nov 15 07:45:03 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc4-supply property in node /i2c@ff160000/rk805@18 failed Nov 15 07:45:03 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio2-supply from device tree Nov 15 07:45:03 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc5-supply from device tree Nov 15 07:45:03 ifi-zen-stream3 kernel: rk808 1-0018: Looking up vcc5-supply property in node /i2c@ff160000/rk805@18 failed Nov 15 07:45:03 ifi-zen-stream3 kernel: rockchip-iodomain ff100000.syscon:io-domains: Looking up vccio3-supply from device tree Nov 15 07:45:03 ifi-zen-stream3 kernel: sd 1:0:0:0: [sda] 125313283 512-byte logical blocks: (64.2 GB/59.8 GiB) Nov 15 07:45:03 ifi-zen-stream3 kernel: sd 1:0:0:0: [sda] Write Protect is off Nov 15 07:45:03 ifi-zen-stream3 kernel: sd 1:0:0:0: [sda] Mode Sense: 43 00 00 00 Nov 15 07:45:03 ifi-zen-stream3 kernel: sd 1:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Nov 15 07:45:03 ifi-zen-stream3 kernel: sda: sda1 Nov 15 07:45:03 ifi-zen-stream3 kernel: sd 1:0:0:0: [sda] Attached SCSI removable disk Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: Mounting Device Samsung_USB Nov 15 07:45:03 ifi-zen-stream3 sudo[4586]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Samsung_USB -o noatime Nov 15 07:45:03 ifi-zen-stream3 sudo[4586]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:03 ifi-zen-stream3 mount.exfat[4588]: volume was not unmounted cleanly Nov 15 07:45:03 ifi-zen-stream3 sudo[4586]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: WARN: volume was not unmounted cleanly. Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: Scanning new location : "USB/Samsung_USB" Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: update Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: update Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 14 milliseconds Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 11 milliseconds Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 10 milliseconds Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 7 milliseconds Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: Command Router : Notfying DB Updatetrue Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: Command Router : Notfying DB Updatetrue Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 176ms Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 170ms Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: MPD Database updated - AlbumList cache refreshed Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: database Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: update Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: MPD Database updated - AlbumList cache refreshed Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: database Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: update Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 33 milliseconds Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 30 milliseconds Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 29 milliseconds Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 22 milliseconds Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 19 milliseconds Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 18 milliseconds Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: Command Router : Notfying DB Updatefalse Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: Command Router : Notfying DB Updatefalse Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 6 Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 213ms Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 211ms Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 200ms Nov 15 07:45:03 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 200ms Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: 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=908_1763192590635&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=908_1763192590634&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=908_1763192590635&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=908_1763192590635&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=908_1763192590635&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=908_1763192590635&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=908_1763192590635&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=908_1763192590636&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=908_1763192590636&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=908_1763192590636&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=908_1763192590636&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"}],"index":4} Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Preload queue cleared Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::ClearQueue Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stop Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::clearPlayQueue Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::saveQueue Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushQueue Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::addQueueItems Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::addQueueItems Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Preload queue cleared Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushQueue Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::saveQueue Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::updateTrackBlock Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrackBlock Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: ConvSwitch: Sent Play Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPlay Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::play index 4 Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::addQueueItems Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::addQueueItems Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Preload queue cleared Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stop Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushQueue Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::saveQueue Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::play index undefined Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::updateTrackBlock Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrackBlock Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::startPlaybackTimer Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::clearAddPlayTracks USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand stop Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: ConvSwitch: Get message: success Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand stop took 8 milliseconds Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand clear Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces system playlist update Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Ignoring MPD Status Update Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand clear took 4 milliseconds Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand add "USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac" Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces system playlist update Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Ignoring MPD Status Update Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: error: updateQueue error: null Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces system playlist update Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Ignoring MPD Status Update Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 17ms Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand add "USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac" took 14 milliseconds Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 13ms Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand play Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces system playlist update Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Ignoring MPD Status Update Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 16ms Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand play took 13 milliseconds Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 13ms Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:45:13 ifi-zen-stream3 kernel: wm8804 0-003b: wm8804_hw_params rate: 0x17700 format: 0x6 Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 18 milliseconds Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 14 milliseconds Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:45:13 ifi-zen-stream3 kernel: dwmmc_rockchip ff520000.dwmmc: Unexpected interrupt latency Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 177 milliseconds Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 172 milliseconds Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 170 milliseconds Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 167 milliseconds Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: 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":"1095 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"} Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 4 Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState stateService play Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState currentStatus stop Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: STATE SERVICE {"status":"play","position":0,"seek":52,"duration":182,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1095 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"} Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 4 Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState stateService play Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState currentStatus play Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: Received an update from plugin. extracting info from payload Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 257ms Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 258ms Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 65 milliseconds Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 61 milliseconds Nov 15 07:45:13 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: verbose: STATE SERVICE {"status":"play","position":0,"seek":724,"duration":182,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1431 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"} Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 4 Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState stateService play Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState currentStatus play Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: Received an update from plugin. extracting info from payload Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: verbose: STATE SERVICE {"status":"play","position":0,"seek":761,"duration":182,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1431 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"} Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 4 Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState stateService play Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState currentStatus play Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: Received an update from plugin. extracting info from payload Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 349ms Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 330ms Nov 15 07:45:14 ifi-zen-stream3 volumio[1350]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/TrondheimSolistene/DIVERTIMENTI/7897e184-9c19-47bb-b593-a3fbd9520df7.jpg' Nov 15 07:45:15 ifi-zen-stream3 volumio[1350]: info: MetaClient: Sent Meta Nov 15 07:45:15 ifi-zen-stream3 volumio[1350]: info: MetaClient: Get message: success Nov 15 07:45:16 ifi-zen-stream3 volumiologrotate[480]: ls: cannot access '/var/log/samba/log.wb-ZEN': No such file or directory Nov 15 07:45:16 ifi-zen-stream3 volumiologrotate[480]: ls: cannot access 'STREAM3': No such file or directory Nov 15 07:45:23 ifi-zen-stream3 volumio[1350]: info: ++++--++++ getMenuItems Nov 15 07:45:23 ifi-zen-stream3 volumio[1350]: info: ++++--++++ getMenuItems Nov 15 07:45:24 ifi-zen-stream3 volumio[1350]: info: ++++--++++ getUiConfig: {"page":"audio_interface/alsa_controller"} Nov 15 07:45:24 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 15 07:45:24 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 15 07:45:24 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 07:45:24 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 15 07:45:24 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:45:24 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:45:24 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:45:24 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:45:24 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:45:24 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:45:24 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 15 07:45:24 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: ++++--++++ callMethod: {"type":"controller","endpoint":"audio_interface/alsa_controller","method":"saveAlsaOptions","data":{"output_device":{"value":"5","label":"ZEN DAC 3 (UCA1)"}}} Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: Preparing to save Alsa Options, stopping services first Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPause Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pause Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stPlaybackTimer Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::servicePause Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePause Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pause Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand pause Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"ZEN DAC 3 (UCA1)"}} Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , forceDoP Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: ZEN DAC 3 (UCA1): Does not support DSD Native. Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: Ignoring Mixers Options Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: Device 5 does not have any Mixer Control Available Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: Restoring Previous Volume level: 100 false false Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioUpdateVolumeSettings Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: Updating Volume Controller Parameters: Device: 5 Name: ZEN DAC 3 (UCA1) Mixer: None Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: Preparing to generate the ALSA configuration file Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand pause took 213 milliseconds Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 9 milliseconds Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 6 milliseconds Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":13744,"duration":182,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2408 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"} Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 4 Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState stateService pause Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState currentStatus pause Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stPlaybackTimer Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":13744,"duration":182,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2408 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"} Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 4 Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState stateService pause Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::syncState currentStatus pause Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stPlaybackTimer Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 65ms Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 61ms Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 15 07:45:26 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: wizard , refreshWizarOutputDevices Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: Asound.conf file written Nov 15 07:45:27 ifi-zen-stream3 sudo[4867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 15 07:45:27 ifi-zen-stream3 sudo[4867]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:27 ifi-zen-stream3 sudo[4867]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: No state is present for card rkifispdif Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: Found hardware: "rk-ifi-spdif" "" "" "" "" Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: Hardware is initialized using a generic method Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: No state is present for card rkifispdif Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: No state is present for card Z3UCA1 Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: Found hardware: "USB-Audio" "USB Mixer" "USB20b1:0010" "" "" Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: Hardware is initialized using a generic method Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: No state is present for card Z3UCA1 Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: Tidal connect: Output device has changed Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: Output device has changed, restarting MPD Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: Qobuz connect: Output device has changed Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: Roon Ready: Output device has changed Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: Spotify: Output device has changed Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: Tidal connect: Output device has changed Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: Output device has changed, restarting MPD Nov 15 07:45:27 ifi-zen-stream3 sudo[4872]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 15 07:45:27 ifi-zen-stream3 sudo[4872]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: Qobuz connect: Output device has changed Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: Roon Ready: Output device has changed Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: Spotify: Output device has changed Nov 15 07:45:27 ifi-zen-stream3 sudo[4872]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 sudo[4874]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 15 07:45:27 ifi-zen-stream3 sudo[4874]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:27 ifi-zen-stream3 sudo[4874]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: MPD Permissions set Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: MPD Permissions set Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: Starting RoonReady Sync Nov 15 07:45:27 ifi-zen-stream3 sudo[4896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Nov 15 07:45:27 ifi-zen-stream3 sudo[4896]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: Starting RoonReady Sync Nov 15 07:45:27 ifi-zen-stream3 sudo[4897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Nov 15 07:45:27 ifi-zen-stream3 sudo[4897]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:27 ifi-zen-stream3 sudo[4901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop ifi-streamer-qobuz-connect.service Nov 15 07:45:27 ifi-zen-stream3 sudo[4901]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:27 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Qobuz Connect Service... Nov 15 07:45:27 ifi-zen-stream3 node[501]: ConvSwitch: Drop client qobuz-connect Nov 15 07:45:27 ifi-zen-stream3 sudo[4903]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-roon-ready.service Nov 15 07:45:27 ifi-zen-stream3 node[475]: Closing connection with the client qobuz-connect Nov 15 07:45:27 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Roon Ready Service... Nov 15 07:45:27 ifi-zen-stream3 sudo[4903]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:27 ifi-zen-stream3 node[501]: ConvSwitch: Drop client roon-ready Nov 15 07:45:27 ifi-zen-stream3 node[475]: Closing connection with the client roon-ready Nov 15 07:45:27 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Nov 15 07:45:27 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Main process exited, code=killed, status=15/TERM Nov 15 07:45:27 ifi-zen-stream3 systemd[1]: ifi-streamer-roon-ready.service: Succeeded. Nov 15 07:45:27 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Roon Ready Service. Nov 15 07:45:27 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Main process exited, code=killed, status=15/TERM Nov 15 07:45:27 ifi-zen-stream3 systemd[1]: ifi-streamer-qobuz-connect.service: Succeeded. Nov 15 07:45:27 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Qobuz Connect Service. Nov 15 07:45:27 ifi-zen-stream3 sudo[4896]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:27 ifi-zen-stream3 systemd[1]: Started iFi Streamer Roon Ready Service. Nov 15 07:45:27 ifi-zen-stream3 sudo[4897]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: RoonReady Started Nov 15 07:45:27 ifi-zen-stream3 sudo[4903]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:27 ifi-zen-stream3 play[4919]: /usr/ifi/ifi-roonready-release/play: line 18: warning: command substitution: ignored null byte in input Nov 15 07:45:27 ifi-zen-stream3 sudo[4901]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:27 ifi-zen-stream3 volumio[1350]: info: RoonReady Started Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Nov 15 07:45:28 ifi-zen-stream3 node[501]: ConvSwitch: Add client roon-ready Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: ConvSwitch: Get message: request:pause Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioStop Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stop Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::updateTrackBlock Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrackBlock Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stPlaybackTimer Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::serviceStop Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::serviceStop Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::stop Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand stop Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioStop Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stop Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand stop took 13 milliseconds Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 2 milliseconds Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: ---------------------------- MPD announces state update: player Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::getState Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand status Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand status took 6 milliseconds Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseState Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioGetState Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: 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"} Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 4 Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 49ms Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: ---------------------------- Client requests Start RoonReady PlaybackRoutine Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: roon_ready , startRoonReadyPlayback Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: Roon Ready playback start Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioStop Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stop Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: Roon Ready metadata receiver is on Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: sendMpdCommand playlistinfo took 42 milliseconds Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::parseTrackInfo Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: ControllerMpd::pushState Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::servicePushState Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 4 Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: 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"} Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: verbose: CURRENT POSITION 4 Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: ------------------------------ 86ms Nov 15 07:45:28 ifi-zen-stream3 sudo[4971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Nov 15 07:45:28 ifi-zen-stream3 sudo[4971]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:28 ifi-zen-stream3 node[475]: Closing connection with the client tidal-connect Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service... Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Nov 15 07:45:28 ifi-zen-stream3 node[501]: ConvSwitch: Drop client tidal Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service. Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service. Nov 15 07:45:28 ifi-zen-stream3 sudo[4971]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service. Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: Tidal Connect Service Started Nov 15 07:45:28 ifi-zen-stream3 sudo[4974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-tidal-connect.service Nov 15 07:45:28 ifi-zen-stream3 sudo[4974]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:28 ifi-zen-stream3 node[475]: A new connection has been established. Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Metadata Service... Nov 15 07:45:28 ifi-zen-stream3 node[475]: Closing connection with the client tidal-connect Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Main process exited, code=killed, status=15/TERM Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-metadata.service: Succeeded. Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Metadata Service. Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Tidal Connect Service... Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Main process exited, code=killed, status=15/TERM Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: ifi-streamer-tidal-connect.service: Succeeded. Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Tidal Connect Service. Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Connect Service. Nov 15 07:45:28 ifi-zen-stream3 sudo[4974]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: Started iFi Streamer Tidal Metadata Service. Nov 15 07:45:28 ifi-zen-stream3 volumio[1350]: info: Tidal Connect Service Started Nov 15 07:45:28 ifi-zen-stream3 node[475]: A new connection has been established. Nov 15 07:45:28 ifi-zen-stream3 sudo[4994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Nov 15 07:45:28 ifi-zen-stream3 sudo[4994]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:28 ifi-zen-stream3 systemd[1]: Started iFi Streamer Qobuz Connect Service. Nov 15 07:45:28 ifi-zen-stream3 sudo[4994]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:29 ifi-zen-stream3 volumio[1350]: info: Qobuz Connect Service Started Nov 15 07:45:29 ifi-zen-stream3 sudo[4999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ifi-streamer-qobuz-connect.service Nov 15 07:45:29 ifi-zen-stream3 sudo[4999]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:29 ifi-zen-stream3 sudo[4999]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:29 ifi-zen-stream3 volumio[1350]: info: Qobuz Connect Service Started Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.150 [5016.5016] DEBUG SampleApp: Starting sample application Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.150 [5016.5016] DEBUG SampleApp: Device Name: ZEN Stream3 Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.150 [5016.5016] DEBUG SampleApp: Manufacturer: Sample manufacturer Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.150 [5016.5016] DEBUG SampleApp: Model: iFi Streamer Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.150 [5016.5016] DEBUG SampleApp: Serial Number: ifi:f2:b0:8f:da:d8:35 Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.150 [5016.5016] DEBUG SampleApp: Audio output device: volumio Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.150 [5016.5016] DEBUG SampleApp: Volume control device: default Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.150 [5016.5016] DEBUG SampleApp: Volume control element: Master Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.151 [5016.5016] DEBUG SampleApp: Local config server port: 8000 Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.156 [5016.5016] ERROR SampleApp: Unable to find ALSA mixer element 'Master' on index 0 Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.156 [5016.5016] DEBUG SampleApp: Maximum supported audio quality: HIRES_L3 Nov 15 07:45:29 ifi-zen-stream3 play[4996]: [Info] MetaClient: MetaClient SDK -- v1.02 Nov 15 07:45:29 ifi-zen-stream3 node[475]: A new connection has been established. Nov 15 07:45:29 ifi-zen-stream3 sudo[5019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Nov 15 07:45:29 ifi-zen-stream3 play[4996]: [Info] MetaClient: MetaClientInit Nov 15 07:45:29 ifi-zen-stream3 play[4996]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Nov 15 07:45:29 ifi-zen-stream3 sudo[5019]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:29 ifi-zen-stream3 node[501]: ConvSwitch: Add client qobuz-connect Nov 15 07:45:29 ifi-zen-stream3 systemd[1]: mpd.socket: Succeeded. Nov 15 07:45:29 ifi-zen-stream3 systemd[1]: Closed mpd.socket. Nov 15 07:45:29 ifi-zen-stream3 systemd[1]: Stopping Music Player Daemon... Nov 15 07:45:29 ifi-zen-stream3 sudo[5023]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop mpd.socket mpd.service Nov 15 07:45:29 ifi-zen-stream3 sudo[5023]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:29 ifi-zen-stream3 play[4996]: [Info] ConvSwitch: ConvSwitchInit Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.263 [5016.5016] DEBUG ActiveStateManager: [0xab505030]: Creating new Active State Manager Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.263 [5016.5016] DEBUG NetworkActivityTracker: [0xab5050a0]: Creating new Network Activity Tracker Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.265 [5016.5016] DEBUG EndpointManager: [0xab506018]: Creating Endpoint Manager Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] DEBUG PlaybackSessionManager: [0xab506408]: Creating Playback Session Manager Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] DEBUG BackoffTimer: [0xab506580]: Creating Backoff Timer Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] DEBUG MediaEngine: [0xab5066a0]: Creating new Media Engine Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] DEBUG AudioRenderer: [0xab5068c0]: Creating Audio Renderer Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] TRACE MediaEngineCommandSequencer: [0xab506a18]: Creating Media Engine Command Sequencer Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] DEBUG PlaybackControlsManager: [0xab506a78]: Creating new Playback Controls Manager Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] DEBUG VolumeManager: [0xab506b08]: Creating new Volume Manager Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] DEBUG ProtocolHandler: [0xab506de0]: Creating Protocol Handler Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] DEBUG MessageReceiver: [0xab506e80]: Creating Message Receiver Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] DEBUG RendererActivationController: [0xab506ff8]: Creating new Renderer Activation Controller Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] TRACE RendererActivationCommandSequencer: [0xab5070a0]: Creating Renderer Activation Command Sequencer Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] DEBUG ReportingManager: [0xab5071b0]: Creating new Reporting Manager Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] DEBUG StreamingEventReporter: [0xab5071f8]: Creating Streaming Event Reporter Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] DEBUG BackoffTimer: [0xab5072d8]: Creating Backoff Timer Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] DEBUG TokenExpiryController: [0xab5073e8]: Creating Token Expiry Controller Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] DEBUG UserInactivityManager: [0xab507438]: Creating new User Inactivity Manager Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] INFO VolumeManager: [0xab506b08]: Setting new playback volume: 100 Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] INFO VolumeManager: [0xab506b08]: Setting new mute state: 1 Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] DEBUG SampleApp: Qobuz Connect has been initialized Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] TRACE SampleApp: Running event loop Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] INFO QobuzConnect: [0xab5074d8]: Client initialized! Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.266 [5016.5016] INFO SampleApp: Starting Avahi advertising, name: ZEN Stream3, service name: _qobuz-connect._tcp Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.281 [5016.5016] DEBUG SampleApp: Avahi client state changed: RUNNING Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.284 [5016.5016] DEBUG SampleApp: Avahi entry group state changed: UNCOMMITED Nov 15 07:45:29 ifi-zen-stream3 systemd[1]: mpd.service: Succeeded. Nov 15 07:45:29 ifi-zen-stream3 systemd[1]: Stopped Music Player Daemon. Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.289 [5016.5016] INFO LocalConfigManager: [0xab5063e8]: Starting Local Configuration server Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.290 [5016.5016] INFO SampleApp: Starting Local configuration server Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.291 [5016.5016] INFO SampleApp: Playback mute state changed: 1 Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.291 [5016.5016] ERROR SampleApp: Unable to set mute state, no ALSA volume element Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.292 [5016.5016] DEBUG SampleApp: Avahi entry group state changed: REGISTERING Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.301 [5016.5016] INFO SampleApp: Playback volume changed: 100 Nov 15 07:45:29 ifi-zen-stream3 play[4996]: 20251115 07:45:29.301 [5016.5016] ERROR SampleApp: Unable to set volume, no ALSA volume element Nov 15 07:45:29 ifi-zen-stream3 sudo[5019]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:29 ifi-zen-stream3 sudo[5023]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:29 ifi-zen-stream3 sudo[5028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Nov 15 07:45:29 ifi-zen-stream3 sudo[5028]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:29 ifi-zen-stream3 systemd[1]: Listening on mpd.socket. Nov 15 07:45:29 ifi-zen-stream3 sudo[5031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.socket mpd.service Nov 15 07:45:29 ifi-zen-stream3 sudo[5031]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:29 ifi-zen-stream3 systemd[1]: Starting Music Player Daemon... Nov 15 07:45:29 ifi-zen-stream3 systemd[1]: mpd.socket: Succeeded. Nov 15 07:45:29 ifi-zen-stream3 systemd[1]: Closed mpd.socket. Nov 15 07:45:29 ifi-zen-stream3 systemd[1]: Stopping mpd.socket. Nov 15 07:45:29 ifi-zen-stream3 systemd[1]: mpd.socket: Socket service mpd.service already active, refusing. Nov 15 07:45:29 ifi-zen-stream3 systemd[1]: Failed to listen on mpd.socket. Nov 15 07:45:29 ifi-zen-stream3 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Nov 15 07:45:29 ifi-zen-stream3 systemd[1]: mpd.service: Succeeded. Nov 15 07:45:29 ifi-zen-stream3 systemd[1]: Stopped Music Player Daemon. Nov 15 07:45:29 ifi-zen-stream3 systemd[1]: Listening on mpd.socket. Nov 15 07:45:29 ifi-zen-stream3 systemd[1]: Starting Music Player Daemon... Nov 15 07:45:29 ifi-zen-stream3 sudo[5034]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 15 07:45:29 ifi-zen-stream3 sudo[5034]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:29 ifi-zen-stream3 sudo[5034]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:29 ifi-zen-stream3 node[475]: A new connection has been established. Nov 15 07:45:30 ifi-zen-stream3 play[4996]: 20251115 07:45:30.281 [5016.5016] DEBUG SampleApp: Avahi entry group state changed: ESTABLISHED Nov 15 07:45:30 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Nov 15 07:45:30 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::getcurrentVolume Nov 15 07:45:30 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioRetrievevolume Nov 15 07:45:30 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Nov 15 07:45:30 ifi-zen-stream3 sudo[5071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Nov 15 07:45:30 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:30 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:30 ifi-zen-stream3 sudo[5071]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:30 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:30 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:30 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:30.789 E esdk select error: 4 -> Interrupted system call Nov 15 07:45:30 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:30.791 I app Exiting with error = 0 Nov 15 07:45:30 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:30.791 I api SpFree() Nov 15 07:45:30 ifi-zen-stream3 play[4497]: 2025-11-15 07:45:30.792 I api SpFree [returned value: 0] Nov 15 07:45:30 ifi-zen-stream3 play[4497]: [Info] ConvSwitch: ConvSwitch SDK -- v1.03 Nov 15 07:45:30 ifi-zen-stream3 play[4497]: [Info] ConvSwitch: ConvSwitchInit Nov 15 07:45:30 ifi-zen-stream3 play[4497]: [Info] MetaClient: MetaClient SDK -- v1.02 Nov 15 07:45:30 ifi-zen-stream3 play[4497]: [Info] MetaClient: MetaClientInit Nov 15 07:45:30 ifi-zen-stream3 play[4497]: [Info] ConvSwitch: ConvSwitchExit Nov 15 07:45:30 ifi-zen-stream3 play[4497]: [Info] MetaClient: MetaClientExit Nov 15 07:45:30 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service... Nov 15 07:45:30 ifi-zen-stream3 node[501]: ConvSwitch: Drop client spotify Nov 15 07:45:30 ifi-zen-stream3 node[475]: Closing connection with the client spotify Nov 15 07:45:30 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Nov 15 07:45:30 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Nov 15 07:45:30 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service. Nov 15 07:45:30 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service. Nov 15 07:45:30 ifi-zen-stream3 sudo[5071]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:30 ifi-zen-stream3 volumio[1350]: info: Spotify Connect Service Started Nov 15 07:45:30 ifi-zen-stream3 sudo[5074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart ifi-streamer-spotify-connect.service Nov 15 07:45:30 ifi-zen-stream3 sudo[5074]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 15 07:45:30 ifi-zen-stream3 systemd[1]: Stopping iFi Streamer Spotify Connect Service... Nov 15 07:45:30 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Main process exited, code=killed, status=15/TERM Nov 15 07:45:30 ifi-zen-stream3 systemd[1]: ifi-streamer-spotify-connect.service: Succeeded. Nov 15 07:45:30 ifi-zen-stream3 systemd[1]: Stopped iFi Streamer Spotify Connect Service. Nov 15 07:45:30 ifi-zen-stream3 systemd[1]: Started iFi Streamer Spotify Connect Service. Nov 15 07:45:30 ifi-zen-stream3 sudo[5074]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:30 ifi-zen-stream3 volumio[1350]: info: Spotify Connect Service Started Nov 15 07:45:31 ifi-zen-stream3 play[5081]: output: volumio mixer: hw:5 Nov 15 07:45:31 ifi-zen-stream3 node[501]: ConvSwitch: Add client spotify Nov 15 07:45:31 ifi-zen-stream3 node[475]: A new connection has been established. Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.145 I api SpRegisterDebugCallbacks [returned value: 0] Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.145 I api SpInit(0xff8d79f0, API v66) Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.145 I esdk eSDK version: HEAD-v3.166.69-g24821f73 Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.146 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 Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.146 I esdk Successfully registered dns callback: dns_lookup_callback Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.147 I download Using 128 kB for cache buffer Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.147 I download Using 621 kB for compressed audio buffer Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.147 I esdk Successfully registered error callback Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.158 I esdk Creating IPv4 socket (domain 2) Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.159 I zc webserver: service port 5566 (5566-5576) buffer size 4444 Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.159 I zc Started ZeroConf service on port 5566 path /zc alias count 0 Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.159 I esdk Creating IPv4 socket (domain 2) Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.159 I api SpInit [returned value: 0] Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.160 I api SpRegisterConnectionCallbacks(0xff8d79d8, (nil)) Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.160 I esdk Successfully registered connection callbacks: on_notify, on_message, on_new_credentials Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.160 I api SpRegisterConnectionCallbacks [returned value: 0] Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.160 I api SpRegisterPlaybackCallbacks(0xff8d79c0, (nil)) Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.160 I esdk Successfully registered playback callbacks: on_notify, on_audio_data, on_seek, on_apply_volume, - Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.160 I api SpRegisterPlaybackCallbacks [returned value: 0] Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.167 W app Couldn't find mixer for volume controls. (tried , SoftMaster) Nov 15 07:45:31 ifi-zen-stream3 play[5081]: 2025-11-15 07:45:31.167 I app Initialized! Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: VolumeController::SetAlsaVolume100 Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveCurrentVolume Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::pushState Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushState Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 15 07:45:31 ifi-zen-stream3 node[501]: ConvSwitch: Add client tidal Nov 15 07:45:31 ifi-zen-stream3 tidal_connect_application[5094]: *** WARNING *** The program 'tidal_connect_application' uses the Apple Bonjour compatibility layer of Avahi. Nov 15 07:45:31 ifi-zen-stream3 tidal_connect_application[5094]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 15 07:45:31 ifi-zen-stream3 tidal_connect_application[5094]: *** WARNING *** For more information see Nov 15 07:45:31 ifi-zen-stream3 ifi_metadata[4984]: [Info] MetaClient: MetaClient SDK -- v1.02 Nov 15 07:45:31 ifi-zen-stream3 ifi_metadata[4984]: [Info] MetaClient: MetaClientInit Nov 15 07:45:31 ifi-zen-stream3 ifi_metadata[4984]: Connected Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: ++++--++++ playItemsList: {"item":{"service":"mpd","type":"song","title":"Simple Symphony op. 4 - Boisterous Bourree 88kHz","artist":"TrondheimSolistene","album":"DIVERTIMENTI","uri":"music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac","albumart":"/albumart?cacheid=908_1763192590635&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=908_1763192590634&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=908_1763192590635&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=908_1763192590635&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=908_1763192590635&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=908_1763192590635&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=908_1763192590635&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=908_1763192590636&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=908_1763192590636&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=908_1763192590636&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=908_1763192590636&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%E6%AD%8C%E6%9B%B2&icon=music&metadata=false"}],"index":3} Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Preload queue cleared Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::ClearQueue Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stop Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::serviceStop Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::serviceStop Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioStop Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stop Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Roon Ready Stop Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::clearPlayQueue Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::saveQueue Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushQueue Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::addQueueItems Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::addQueueItems Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Preload queue cleared Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(352kHz)Divertimento 352.8-24.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(48kHz)Divertimento 48-24.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/10 Sisters Of The Moon-Magenta.OFS.mqb.auth1.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushQueue Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::saveQueue Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::updateTrackBlock Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrackBlock Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: ConvSwitch: Sent Play Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPlay Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::play index 3 Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::addQueueItems Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::addQueueItems Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Preload queue cleared Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(96kHz)Divertimento 96-24.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/01 - Divertimento 48-24.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 192-24.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/02 - Divertimento 88-24.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/(176kHz)Tchaikovsky Hopak 176-24.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Adding Item to queue: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: Using cached record of: music-library/USB/Samsung_USB/歌曲/Carmen 44.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stop Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioPushQueue Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::saveQueue Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::play index undefined Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::updateTrackBlock Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrackBlock Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 3 Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::startPlaybackTimer Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: CorePlayQueue::getTrack 3 Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::clearAddPlayTracks USB/Samsung_USB/歌曲/(88kHz)Divertimento 88-24.flac Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: verbose: ControllerMpd::sendMpdCommand stop Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: error: MPD error: Error: This socket has been ended by the other party Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: error: This socket has been ended by the other party {"code":"EPIPE"} Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: error: MPD error: Error: This socket has been ended by the other party Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: error: This socket has been ended by the other party {"code":"EPIPE"} Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: error: MPD error: Error: This socket has been ended by the other party Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: error: This socket has been ended by the other party {"code":"EPIPE"} Nov 15 07:45:31 ifi-zen-stream3 volumio[1350]: info: ConvSwitch: Get message: success Nov 15 07:45:32 ifi-zen-stream3 mpd[5049]: Nov 15 07:45 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 15 07:45:32 ifi-zen-stream3 systemd[1]: Started Music Player Daemon. Nov 15 07:45:32 ifi-zen-stream3 sudo[5031]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:32 ifi-zen-stream3 sudo[5028]: pam_unix(sudo:session): session closed for user root Nov 15 07:45:32 ifi-zen-stream3 volumio[1350]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.socket mpd.service Nov 15 07:45:32 ifi-zen-stream3 volumio[1350]: Job for mpd.socket failed. Nov 15 07:45:32 ifi-zen-stream3 volumio[1350]: See "systemctl status mpd.socket" and "journalctl -xe" for details. Nov 15 07:45:32 ifi-zen-stream3 volumio[1350]: info: Restarted MPD. Nov 15 07:45:32 ifi-zen-stream3 volumio[1350]: error: MPD error: The expression evaluated to a falsy value: Nov 15 07:45:32 ifi-zen-stream3 volumio[1350]: assert.ok(self.idling) Nov 15 07:45:32 ifi-zen-stream3 volumio[1350]: error: The expression evaluated to a falsy value: Nov 15 07:45:32 ifi-zen-stream3 volumio[1350]: assert.ok(self.idling) Nov 15 07:45:32 ifi-zen-stream3 volumio[1350]: error: updateQueue error: null Nov 15 07:45:32 ifi-zen-stream3 volumio[1350]: info: CoreCommandRouter::volumioStop Nov 15 07:45:32 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::stop Nov 15 07:45:32 ifi-zen-stream3 volumio[1350]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 15 07:45:45 ifi-zen-stream3 ntpd[948]: Soliciting pool server 193.182.111.12 Nov 15 07:45:45 ifi-zen-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Nov 15 07:45:45 ifi-zen-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Nov 15 07:45:45 ifi-zen-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Nov 15 07:45:45 ifi-zen-stream3 volumio[1350]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 15 07:45:45 ifi-zen-stream3 volumio[1350]: Error: connect ETIMEDOUT 128.242.240.180:443 Nov 15 07:45:45 ifi-zen-stream3 volumio[1350]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Nov 15 07:45:45 ifi-zen-stream3 volumio[1350]: errno: -110, Nov 15 07:45:45 ifi-zen-stream3 volumio[1350]: code: 'ETIMEDOUT', Nov 15 07:45:45 ifi-zen-stream3 volumio[1350]: syscall: 'connect', Nov 15 07:45:45 ifi-zen-stream3 volumio[1350]: address: '128.242.240.180', Nov 15 07:45:45 ifi-zen-stream3 volumio[1350]: port: 443 Nov 15 07:45:45 ifi-zen-stream3 volumio[1350]: } Nov 15 07:45:45 ifi-zen-stream3 volumio[1350]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 15 07:45:46 ifi-zen-stream3 sudo[5247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-15 07:44 Nov 15 07:45:46 ifi-zen-stream3 sudo[5247]: 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"