-- Logs begin at Sat 2025-11-15 15:00:41 CST, end at Fri 2026-10-02 13:53:13 CST. -- Oct 02 13:52:04 ifi-zen-stream volumio[1373]: info: ++++--++++ browseLibrary: {"uri":"artists://"} Oct 02 13:52:04 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 02 13:52:04 ifi-zen-stream volumio[1373]: info: CURURI: artists:// Oct 02 13:52:04 ifi-zen-stream volumio[1373]: info: Preload queue cleared Oct 02 13:52:09 ifi-zen-stream kernel: start_addr=(0x8000), end_addr=(0x10000), buffer_size=(0x8000), smp_number_max=(4096) Oct 02 13:52:16 ifi-zen-stream nmbd[751]: [2026/10/02 13:52:16.912469, 0] ../source3/libsmb/nmblib.c:917(send_udp) Oct 02 13:52:16 ifi-zen-stream nmbd[751]: Packet send failed to 169.254.255.255(138) ERRNO=Invalid argument Oct 02 13:52:18 ifi-zen-stream systemd[1]: Starting Internet Detect for iFi Streamer... Oct 02 13:52:19 ifi-zen-stream kernel: start_addr=(0x8000), end_addr=(0x10000), buffer_size=(0x8000), smp_number_max=(4096) Oct 02 13:52:19 ifi-zen-stream volumio[1373]: info: ++++--++++ browseLibrary: {"uri":"genres://"} Oct 02 13:52:19 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 02 13:52:19 ifi-zen-stream volumio[1373]: info: CURURI: genres:// Oct 02 13:52:19 ifi-zen-stream volumio[1373]: info: Preload queue cleared Oct 02 13:52:24 ifi-zen-stream volumio[1373]: info: ++++--++++ browseLibrary: {"uri":"upnp"} Oct 02 13:52:24 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 02 13:52:24 ifi-zen-stream volumio[1373]: info: Preload queue cleared Oct 02 13:52:27 ifi-zen-stream volumio[1373]: info: ++++--++++ browseLibrary: {"uri":"upnp/http://192.168.1.22:8333/ctl/ContentDir@0","prevUri":"upnp"} Oct 02 13:52:27 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 02 13:52:27 ifi-zen-stream volumio[1373]: info: Preload queue cleared Oct 02 13:52:29 ifi-zen-stream kernel: start_addr=(0x8000), end_addr=(0x10000), buffer_size=(0x8000), smp_number_max=(4096) Oct 02 13:52:30 ifi-zen-stream volumio[1373]: info: ++++--++++ browseLibrary: {"uri":"upnp/folder/http://192.168.1.22:8333/ctl/ContentDir@1","prevUri":"upnp/http://192.168.1.22:8333/ctl/ContentDir@0"} Oct 02 13:52:30 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 02 13:52:30 ifi-zen-stream systemd[1]: ifi-system-internet.service: Succeeded. Oct 02 13:52:30 ifi-zen-stream systemd[1]: Started Internet Detect for iFi Streamer. Oct 02 13:52:30 ifi-zen-stream systemd[1]: Starting Internet Detect for iFi Streamer... Oct 02 13:52:30 ifi-zen-stream systemd[1]: ifi-system-internet.service: Succeeded. Oct 02 13:52:30 ifi-zen-stream systemd[1]: Started Internet Detect for iFi Streamer. Oct 02 13:52:31 ifi-zen-stream volumio[1373]: info: Preload queue cleared Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: ++++--++++ playItemsList: {"item":{"service":"upnp_browser","type":"folder","title":"All Music","artist":"","albumart":"/albumart?cacheid=139_1790920351126&web=/All%20Music/extralarge&path=http%3A%2F%2F192.168.1.22%3A8333%2Fctl%2FContentDir%401%244&icon=folder-o&metadata=false","album":"","uri":"upnp/folder/http://192.168.1.22:8333/ctl/ContentDir@1$4"}} Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: Preload queue cleared Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreStateMachine::ClearQueue Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreStateMachine::stop Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreStateMachine::stPlaybackTimer Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreStateMachine::updateTrackBlock Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrackBlock Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreStateMachine::pushState Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrack 0 Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioPushState Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreStateMachine::serviceStop Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrack 0 Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::serviceStop Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: ControllerMpd::stop Oct 02 13:52:32 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand stop Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CorePlayQueue::clearPlayQueue Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CorePlayQueue::saveQueue Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioPushQueue Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreStateMachine::addQueueItems Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CorePlayQueue::addQueueItems Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: Preload queue cleared Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: Adding Item to queue: upnp/folder/http://192.168.1.22:8333/ctl/ContentDir@1$4 Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: Exploding uri upnp/folder/http://192.168.1.22:8333/ctl/ContentDir@1$4 in service upnp_browser Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: sendMpdCommand stop took 60 milliseconds Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: Oct 02 13:52:32 ifi-zen-stream volumio[1373]: ---------------------------- MPD announces state update: player Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: ControllerMpd::getState Oct 02 13:52:32 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: sendMpdCommand status took 5 milliseconds Oct 02 13:52:32 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::parseState Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioGetState Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrack 0 Oct 02 13:52:32 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 02 13:52:32 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::parseTrackInfo Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: ControllerMpd::pushState Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::servicePushState Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreStateMachine::pushState Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrack 0 Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioPushState Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrack 0 Oct 02 13:52:32 ifi-zen-stream volumio[1373]: 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":"01.天鵝","artist":"《真空管HIFI录音-大提琴》","album":"真空管HIFI录音-大提琴","uri":"USB/7C51-CB7B/ABC唱片《真空管HIFI录音-大提琴》/01.天鵝.flac","trackType":"flac"} Oct 02 13:52:32 ifi-zen-stream volumio[1373]: verbose: CURRENT POSITION 0 Oct 02 13:52:32 ifi-zen-stream volumio[1373]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Oct 02 13:52:32 ifi-zen-stream volumio[1373]: info: ------------------------------ 47ms Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioPushQueue Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: CorePlayQueue::saveQueue Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: CoreStateMachine::updateTrackBlock Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrackBlock Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: ConvSwitch: Sent Play Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioPlay Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: CoreStateMachine::play index 0 Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: CoreStateMachine::stop Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: CoreStateMachine::play index undefined Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrack 0 Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: CoreStateMachine::startPlaybackTimer Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrack 0 Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: [1790920353684] ControllerUPNPBrowser::clearAddPlayTrack Oct 02 13:52:33 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand stop Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: ConvSwitch: Get message: success Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: sendMpdCommand stop took 36 milliseconds Oct 02 13:52:33 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand clear Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: Oct 02 13:52:33 ifi-zen-stream volumio[1373]: ---------------------------- MPD announces system playlist update Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: Ignoring MPD Status Update Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: sendMpdCommand clear took 22 milliseconds Oct 02 13:52:33 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.22:8333/MediaItems/86037.mp3" Oct 02 13:52:33 ifi-zen-stream volumio[1373]: error: updateQueue error: null Oct 02 13:52:33 ifi-zen-stream volumio[1373]: info: ------------------------------ 19ms Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: ++++--++++ playItemsList: {"item":{"service":"upnp_browser","type":"folder","title":"All Music","artist":"","albumart":"/albumart?cacheid=139_1790920351126&web=/All%20Music/extralarge&path=http%3A%2F%2F192.168.1.22%3A8333%2Fctl%2FContentDir%401%244&icon=folder-o&metadata=false","album":"","uri":"upnp/folder/http://192.168.1.22:8333/ctl/ContentDir@1$4"}} Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: Preload queue cleared Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::ClearQueue Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::stop Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CorePlayQueue::clearPlayQueue Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CorePlayQueue::saveQueue Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioPushQueue Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::addQueueItems Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CorePlayQueue::addQueueItems Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: Preload queue cleared Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: Adding Item to queue: upnp/folder/http://192.168.1.22:8333/ctl/ContentDir@1$4 Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: Using cached record of: upnp/folder/http://192.168.1.22:8333/ctl/ContentDir@1$4 Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioPushQueue Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CorePlayQueue::saveQueue Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::updateTrackBlock Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrackBlock Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: ConvSwitch: Sent Play Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioPlay Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::play index 0 Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::stop Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::play index undefined Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrack 0 Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::startPlaybackTimer Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrack 0 Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: [1790920354368] ControllerUPNPBrowser::clearAddPlayTrack Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand stop Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: ConvSwitch: Get message: success Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.22:8333/MediaItems/86037.mp3" Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: sendMpdCommand stop took 55 milliseconds Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand clear Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: Oct 02 13:52:34 ifi-zen-stream volumio[1373]: ---------------------------- MPD announces system playlist update Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: Ignoring MPD Status Update Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: Oct 02 13:52:34 ifi-zen-stream volumio[1373]: ---------------------------- MPD announces system playlist update Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: Ignoring MPD Status Update Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: sendMpdCommand add "http://192.168.1.22:8333/MediaItems/86037.mp3" took 8 milliseconds Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: sendMpdCommand clear took 7 milliseconds Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand play Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.22:8333/MediaItems/86037.mp3" Oct 02 13:52:34 ifi-zen-stream volumio[1373]: error: updateQueue error: null Oct 02 13:52:34 ifi-zen-stream volumio[1373]: error: updateQueue error: null Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: ------------------------------ 16ms Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: ------------------------------ 15ms Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: sendMpdCommand play took 10 milliseconds Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.22:8333/MediaItems/86037.mp3" Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: Oct 02 13:52:34 ifi-zen-stream volumio[1373]: ---------------------------- MPD announces system playlist update Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: Ignoring MPD Status Update Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: sendMpdCommand add "http://192.168.1.22:8333/MediaItems/86037.mp3" took 3 milliseconds Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand play Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: ------------------------------ 6ms Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: sendMpdCommand play took 3 milliseconds Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: Oct 02 13:52:34 ifi-zen-stream volumio[1373]: ---------------------------- MPD announces state update: player Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: ControllerMpd::getState Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: Oct 02 13:52:34 ifi-zen-stream volumio[1373]: ---------------------------- MPD announces state update: player Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: ControllerMpd::getState Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: sendMpdCommand status took 33 milliseconds Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::parseState Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioGetState Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: sendMpdCommand status took 30 milliseconds Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::parseState Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioGetState Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::parseTrackInfo Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: ControllerMpd::pushState Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::servicePushState Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrack 0 Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: STATE SERVICE {"status":"play","position":0,"seek":571,"duration":537,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"86037.mp3","artist":null,"album":null,"uri":"http://192.168.1.22:8333/MediaItems/86037.mp3","trackType":"mp3"} Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: CURRENT POSITION 0 Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::syncState stateService play Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::syncState currentStatus stop Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: ------------------------------ 106ms Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: sendMpdCommand playlistinfo took 27 milliseconds Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::parseTrackInfo Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: ControllerMpd::pushState Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::servicePushState Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrack 0 Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":537,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"86037.mp3","artist":null,"album":null,"uri":"http://192.168.1.22:8333/MediaItems/86037.mp3","trackType":"mp3"} Oct 02 13:52:34 ifi-zen-stream volumio[1373]: verbose: CURRENT POSITION 0 Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::syncState stateService play Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::syncState currentStatus play Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: Received an update from plugin. extracting info from payload Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::pushState Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioPushState Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreStateMachine::pushState Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioPushState Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 13:52:34 ifi-zen-stream volumio[1373]: info: ------------------------------ 175ms Oct 02 13:52:35 ifi-zen-stream volumio[1373]: info: MetaClient: Sent Meta Oct 02 13:52:35 ifi-zen-stream volumio[1373]: info: MetaClient: Get message: success Oct 02 13:52:40 ifi-zen-stream kernel: start_addr=(0x8000), end_addr=(0x10000), buffer_size=(0x8000), smp_number_max=(4096) Oct 02 13:52:40 ifi-zen-stream systemd[1]: Starting Internet Detect for iFi Streamer... Oct 02 13:52:42 ifi-zen-stream volumio[1373]: info: ++++--++++ browseLibrary: {"uri":"upnp/folder/http://192.168.1.22:8333/ctl/ContentDir@1$6","prevUri":"upnp/folder/http://192.168.1.22:8333/ctl/ContentDir@1"} Oct 02 13:52:42 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 02 13:52:42 ifi-zen-stream volumio[1373]: info: Preload queue cleared Oct 02 13:52:44 ifi-zen-stream wpa_supplicant[6676]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="HUAWEI-1B9LX6_5G" Oct 02 13:52:44 ifi-zen-stream wpa_supplicant[6676]: wlan0: Trying to associate with c2:76:df:fa:e5:5f (SSID='HUAWEI-1B9LX6_5G' freq=5220 MHz) Oct 02 13:52:44 ifi-zen-stream wpa_supplicant[6676]: wlan0: Associated with c2:76:df:fa:e5:5f Oct 02 13:52:44 ifi-zen-stream wpa_supplicant[6676]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: ++++--++++ playItemsList: {"item":{"service":"upnp_browser","type":"folder","title":"Alain Souchon","artist":"","albumart":"/albumart?cacheid=139_1790920362889&web=Alain%20Souchon//extralarge&path=http%3A%2F%2F192.168.1.22%3A8333%2Fctl%2FContentDir%401%246%241C&icon=users&metadata=false","album":"","uri":"upnp/folder/http://192.168.1.22:8333/ctl/ContentDir@1$6$1C"}} Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: Preload queue cleared Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreStateMachine::ClearQueue Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreStateMachine::stop Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreStateMachine::stPlaybackTimer Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreStateMachine::updateTrackBlock Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrackBlock Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreStateMachine::pushState Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrack 0 Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioPushState Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreStateMachine::serviceStop Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrack 0 Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::serviceStop Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: [1790920369395] ControllerUPNPBrowser::stop Oct 02 13:52:49 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand stop Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CorePlayQueue::clearPlayQueue Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CorePlayQueue::saveQueue Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioPushQueue Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreStateMachine::addQueueItems Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CorePlayQueue::addQueueItems Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: Preload queue cleared Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: Adding Item to queue: upnp/folder/http://192.168.1.22:8333/ctl/ContentDir@1$6$1C Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: Exploding uri upnp/folder/http://192.168.1.22:8333/ctl/ContentDir@1$6$1C in service upnp_browser Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioPushQueue Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CorePlayQueue::saveQueue Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreStateMachine::updateTrackBlock Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrackBlock Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: ConvSwitch: Sent Play Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioPlay Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreStateMachine::play index 0 Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreStateMachine::stop Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreStateMachine::play index undefined Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrack 0 Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: Oct 02 13:52:49 ifi-zen-stream volumio[1373]: ---------------------------- MPD announces state update: player Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: sendMpdCommand stop took 67 milliseconds Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: ControllerMpd::getState Oct 02 13:52:49 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand status Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: ConvSwitch: Get message: success Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: sendMpdCommand status took 9 milliseconds Oct 02 13:52:49 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::parseState Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioGetState Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrack 0 Oct 02 13:52:49 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 02 13:52:49 ifi-zen-stream volumio[1373]: verbose: ControllerMpd::parseTrackInfo Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: ControllerMpd::pushState Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::servicePushState Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreStateMachine::pushState Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrack 0 Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::volumioPushState Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: CorePlayQueue::getTrack 0 Oct 02 13:52:49 ifi-zen-stream volumio[1373]: 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":"86037.mp3","artist":null,"album":null,"uri":"http://192.168.1.22:8333/MediaItems/86037.mp3","trackType":"mp3"} Oct 02 13:52:49 ifi-zen-stream volumio[1373]: verbose: CURRENT POSITION 0 Oct 02 13:52:49 ifi-zen-stream volumio[1373]: error: ControllerMpd::pushError: TypeError: Cannot read property 'indexOf' of null Oct 02 13:52:49 ifi-zen-stream volumio[1373]: info: ------------------------------ 50ms Oct 02 13:52:52 ifi-zen-stream volumio[1373]: info: ++++--++++ browseLibrary: {"uri":"upnp/folder/http://192.168.1.22:8333/ctl/ContentDir@1$6$1C","prevUri":"upnp/folder/http://192.168.1.22:8333/ctl/ContentDir@1$6"} Oct 02 13:52:52 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 02 13:52:52 ifi-zen-stream volumio[1373]: info: Preload queue cleared Oct 02 13:52:52 ifi-zen-stream systemd[1]: ifi-system-internet.service: Succeeded. Oct 02 13:52:52 ifi-zen-stream systemd[1]: Started Internet Detect for iFi Streamer. Oct 02 13:52:52 ifi-zen-stream systemd[1]: Starting Internet Detect for iFi Streamer... Oct 02 13:52:54 ifi-zen-stream wpa_supplicant[6676]: wlan0: Authentication with c2:76:df:fa:e5:5f timed out. Oct 02 13:52:54 ifi-zen-stream wpa_supplicant[6676]: wlan0: CTRL-EVENT-DISCONNECTED bssid=c2:76:df:fa:e5:5f reason=3 locally_generated=1 Oct 02 13:52:54 ifi-zen-stream wpa_supplicant[6676]: wlan0: WPA: 4-Way Handshake failed - pre-shared key may be incorrect Oct 02 13:52:54 ifi-zen-stream wpa_supplicant[6676]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="HUAWEI-1B9LX6_5G" auth_failures=8 duration=116 reason=WRONG_KEY Oct 02 13:52:54 ifi-zen-stream wpa_supplicant[6676]: nl80211: Failed to open /proc/sys/net/ipv4/conf/wlan0/drop_unicast_in_l2_multicast: No such file or directory Oct 02 13:52:54 ifi-zen-stream wpa_supplicant[6676]: nl80211: Failed to set IPv4 unicast in multicast filter Oct 02 13:52:54 ifi-zen-stream wpa_supplicant[6676]: nl80211: Failed to open /proc/sys/net/ipv4/conf/wlan0/drop_unicast_in_l2_multicast: No such file or directory Oct 02 13:52:54 ifi-zen-stream wpa_supplicant[6676]: nl80211: Failed to set IPv4 unicast in multicast filter Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: World regulatory domain updated: Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: DFS Master region: unset Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz, 92000 KHz AUTO), (N/A, 2000 mBm), (N/A) Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A) Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s) Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A) Oct 02 13:52:54 ifi-zen-stream wpa_supplicant[6676]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: Regulatory domain changed to country: CN Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: DFS Master region: FCC Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2300 mBm), (N/A) Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2300 mBm), (0 s) Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 3000 mBm), (N/A) Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: (57240000 KHz - 59400000 KHz @ 2160000 KHz), (N/A, 2800 mBm), (N/A) Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: (59400000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4400 mBm), (N/A) Oct 02 13:52:54 ifi-zen-stream kernel: cfg80211: (63720000 KHz - 65880000 KHz @ 2160000 KHz), (N/A, 2800 mBm), (N/A) Oct 02 13:52:54 ifi-zen-stream wpa_supplicant[6676]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=CN Oct 02 13:52:56 ifi-zen-stream volumiologrotate[428]: ls: cannot access '/var/log/samba/log.wb-ZEN': No such file or directory Oct 02 13:52:56 ifi-zen-stream volumiologrotate[428]: ls: cannot access 'STREAM': No such file or directory Oct 02 13:52:57 ifi-zen-stream volumio[1373]: info: ++++--++++ browseLibrary: {"uri":"artists://"} Oct 02 13:52:57 ifi-zen-stream volumio[1373]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 02 13:52:57 ifi-zen-stream volumio[1373]: info: CURURI: artists:// Oct 02 13:52:57 ifi-zen-stream volumio[1373]: info: Preload queue cleared Oct 02 13:53:04 ifi-zen-stream kernel: start_addr=(0x8000), end_addr=(0x10000), buffer_size=(0x8000), smp_number_max=(4096) Oct 02 13:53:04 ifi-zen-stream systemd[1]: ifi-system-internet.service: Succeeded. Oct 02 13:53:04 ifi-zen-stream systemd[1]: Started Internet Detect for iFi Streamer. Oct 02 13:53:04 ifi-zen-stream systemd[1]: Starting Internet Detect for iFi Streamer... Oct 02 13:53:05 ifi-zen-stream systemd[1]: ifi-system-internet.service: Succeeded. Oct 02 13:53:05 ifi-zen-stream systemd[1]: Started Internet Detect for iFi Streamer. Oct 02 13:53:13 ifi-zen-stream volumio[1373]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 13:53:13 ifi-zen-stream volumio[1373]: Error: connect ETIMEDOUT 69.63.176.15:443 Oct 02 13:53:13 ifi-zen-stream volumio[1373]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Oct 02 13:53:13 ifi-zen-stream volumio[1373]: errno: -110, Oct 02 13:53:13 ifi-zen-stream volumio[1373]: code: 'ETIMEDOUT', Oct 02 13:53:13 ifi-zen-stream volumio[1373]: syscall: 'connect', Oct 02 13:53:13 ifi-zen-stream volumio[1373]: address: '69.63.176.15', Oct 02 13:53:13 ifi-zen-stream volumio[1373]: port: 443 Oct 02 13:53:13 ifi-zen-stream volumio[1373]: } Oct 02 13:53:13 ifi-zen-stream volumio[1373]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 13:53:13 ifi-zen-stream sudo[11501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-02 13:52 Oct 02 13:53:13 ifi-zen-stream sudo[11501]: 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:05:02 CST 2025" VOLUMIO_VERSION="3.00.6" VOLUMIO_HARDWARE="zen-stream" VOLUMIO_DEVICENAME="ZEN Stream" VOLUMIO_HASH="3350ed41a04d50b70f39bebb8e49f746"