-- Logs begin at Sat 2025-11-15 07:00:41 UTC, end at Sat 2026-01-10 15:36:33 UTC. -- Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: CorePlayQueue::getTrack 1 Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: CorePlayQueue::getTrack 2 Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: Prefetching next song Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: DOING PREFETCH IN MPD Jan 10 15:35:09 ifi-zen-stream volumio[16041]: verbose: ControllerMpd::sendMpdCommand add "USB/Extreme_Pro/Best Audiophile Voices VI (XRCD 2010) [FLAC]/03. Angela - First of May.flac" Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: Jan 10 15:35:09 ifi-zen-stream volumio[16041]: ---------------------------- MPD announces system playlist update Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: Ignoring MPD Status Update Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: sendMpdCommand add "USB/Extreme_Pro/Best Audiophile Voices VI (XRCD 2010) [FLAC]/03. Angela - First of May.flac" took 17 milliseconds Jan 10 15:35:09 ifi-zen-stream volumio[16041]: verbose: ControllerMpd::sendMpdCommand consume 1 Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: Jan 10 15:35:09 ifi-zen-stream volumio[16041]: ---------------------------- MPD announces state update: options Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: ------------------------------ 24ms Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: sendMpdCommand consume 1 took 12 milliseconds Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: ControllerMpd::getState Jan 10 15:35:09 ifi-zen-stream volumio[16041]: verbose: ControllerMpd::sendMpdCommand status Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: sendMpdCommand status took 5 milliseconds Jan 10 15:35:09 ifi-zen-stream volumio[16041]: verbose: ControllerMpd::parseState Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::volumioGetState Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: CorePlayQueue::getTrack 1 Jan 10 15:35:09 ifi-zen-stream volumio[16041]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 10 15:35:09 ifi-zen-stream volumio[16041]: verbose: ControllerMpd::parseTrackInfo Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: ControllerMpd::pushState Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::servicePushState Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: CorePlayQueue::getTrack 1 Jan 10 15:35:09 ifi-zen-stream volumio[16041]: verbose: STATE SERVICE {"status":"play","position":0,"seek":210974,"duration":216,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"701 Kbps","isStreaming":false,"title":"Spanish Harlem","artist":"Rebecca Pidgeon","album":"Best Audiophile Voices VI XRCD FLAC","uri":"USB/Extreme_Pro/Best Audiophile Voices VI (XRCD 2010) [FLAC]/02. Rebecca Pidgeon - Spanish Harlem.flac","trackType":"flac"} Jan 10 15:35:09 ifi-zen-stream volumio[16041]: verbose: CURRENT POSITION 1 Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: CoreStateMachine::syncState stateService play Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: CoreStateMachine::syncState currentStatus play Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: Received an update from plugin. extracting info from payload Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: CoreStateMachine::pushState Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: CorePlayQueue::getTrack 1 Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::volumioPushState Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: CoreStateMachine::pushState Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: CorePlayQueue::getTrack 1 Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::volumioPushState Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 15:35:09 ifi-zen-stream volumio[16041]: info: ------------------------------ 68ms Jan 10 15:35:10 ifi-zen-stream volumio[16041]: info: MetaClient: Sent Meta Jan 10 15:35:10 ifi-zen-stream volumio[16041]: info: MetaClient: Get message: success Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CoreStateMachine::startPlaybackTimer Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CorePlayQueue::getTrack 2 Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: Jan 10 15:35:14 ifi-zen-stream volumio[16041]: ---------------------------- MPD announces system playlist update Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: Ignoring MPD Status Update Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: Jan 10 15:35:14 ifi-zen-stream volumio[16041]: ---------------------------- MPD announces state update: player Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: ControllerMpd::getState Jan 10 15:35:14 ifi-zen-stream volumio[16041]: verbose: ControllerMpd::sendMpdCommand status Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: ------------------------------ 11ms Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: sendMpdCommand status took 6 milliseconds Jan 10 15:35:14 ifi-zen-stream volumio[16041]: verbose: ControllerMpd::parseState Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::volumioGetState Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CorePlayQueue::getTrack 2 Jan 10 15:35:14 ifi-zen-stream volumio[16041]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 10 15:35:14 ifi-zen-stream volumio[16041]: verbose: ControllerMpd::parseTrackInfo Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: ControllerMpd::pushState Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::servicePushState Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CorePlayQueue::getTrack 2 Jan 10 15:35:14 ifi-zen-stream volumio[16041]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":164,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"648 Kbps","isStreaming":false,"title":"First of May","artist":"Angela","album":"Best Audiophile Voices VI XRCD FLAC","uri":"USB/Extreme_Pro/Best Audiophile Voices VI (XRCD 2010) [FLAC]/03. Angela - First of May.flac","trackType":"flac"} Jan 10 15:35:14 ifi-zen-stream volumio[16041]: verbose: CURRENT POSITION 2 Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CoreStateMachine::syncState stateService play Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CoreStateMachine::syncState currentStatus play Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: Received an update from plugin. extracting info from payload Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CoreStateMachine::pushState Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CorePlayQueue::getTrack 2 Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::volumioPushState Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CoreStateMachine::pushState Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CorePlayQueue::getTrack 2 Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::volumioPushState Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: ------------------------------ 66ms Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CoreStateMachine::pushState Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CorePlayQueue::getTrack 2 Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::volumioPushState Jan 10 15:35:14 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 15:35:15 ifi-zen-stream volumio[16041]: info: MetaClient: Sent Meta Jan 10 15:35:15 ifi-zen-stream volumio[16041]: info: MetaClient: Get message: success Jan 10 15:35:24 ifi-zen-stream systemd[1]: Starting Internet Detect for iFi Streamer... Jan 10 15:35:24 ifi-zen-stream systemd[1]: ifi-system-internet.service: Succeeded. Jan 10 15:35:24 ifi-zen-stream systemd[1]: Started Internet Detect for iFi Streamer. Jan 10 15:36:09 ifi-zen-stream volumio[16041]: verbose: New Socket.io Connection to 192.168.1.54 from 192.168.1.47 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 2 Jan 10 15:36:09 ifi-zen-stream systemd[1]: Starting Internet Detect for iFi Streamer... Jan 10 15:36:09 ifi-zen-stream volumio[16041]: info: ++++--++++ getState Jan 10 15:36:09 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::volumioGetState Jan 10 15:36:09 ifi-zen-stream volumio[16041]: info: CorePlayQueue::getTrack 2 Jan 10 15:36:09 ifi-zen-stream systemd[1]: ifi-system-internet.service: Succeeded. Jan 10 15:36:09 ifi-zen-stream systemd[1]: Started Internet Detect for iFi Streamer. Jan 10 15:36:09 ifi-zen-stream volumio[16041]: info: ++++--++++ getMultiRoomDevices: null Jan 10 15:36:09 ifi-zen-stream volumio[16041]: info: ++++--++++ getMultiroom: null Jan 10 15:36:09 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 10 15:36:09 ifi-zen-stream volumio[16041]: error: Could not retrieve plugin audio_interface multiroom Jan 10 15:36:09 ifi-zen-stream volumio[16041]: info: ++++--++++ listPlaylist: null Jan 10 15:36:09 ifi-zen-stream volumio[16041]: info: Listing playlists Jan 10 15:36:13 ifi-zen-stream volumio[16041]: info: ++++--++++ getQueue Jan 10 15:36:13 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::volumioGetQueue Jan 10 15:36:13 ifi-zen-stream volumio[16041]: info: CoreStateMachine::getQueue Jan 10 15:36:13 ifi-zen-stream volumio[16041]: info: CorePlayQueue::getQueue Jan 10 15:36:14 ifi-zen-stream volumio[16041]: info: ++++--++++ getBrowseSources: null Jan 10 15:36:14 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 10 15:36:14 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::volumioGetVisibleSources Jan 10 15:36:14 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 15:36:24 ifi-zen-stream systemd[1]: Starting Internet Detect for iFi Streamer... Jan 10 15:36:24 ifi-zen-stream systemd[1]: ifi-system-internet.service: Succeeded. Jan 10 15:36:24 ifi-zen-stream systemd[1]: Started Internet Detect for iFi Streamer. Jan 10 15:36:24 ifi-zen-stream volumio[16041]: info: ++++--++++ search: {"type":"any","value":"Su"} Jan 10 15:36:24 ifi-zen-stream volumio[16041]: Searching all installed plugins Jan 10 15:36:24 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 15:36:24 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: , search Jan 10 15:36:24 ifi-zen-stream volumio[16041]: error: Could not retrieve plugin Jan 10 15:36:24 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jan 10 15:36:24 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Jan 10 15:36:24 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Jan 10 15:36:24 ifi-zen-stream volumio[16041]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Jan 10 15:36:24 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jan 10 15:36:24 ifi-zen-stream volumio[16041]: info: search in webradio selection! Jan 10 15:36:25 ifi-zen-stream volumio[16041]: (node:16041) UnhandledPromiseRejectionWarning: Error: Start tag expected, '<' not found Jan 10 15:36:25 ifi-zen-stream volumio[16041]: at Object.module.exports.fromXml (/volumio/node_modules/libxmljs/lib/document.js:168:21) Jan 10 15:36:25 ifi-zen-stream volumio[16041]: at /volumio/app/plugins/music_service/webradio/index.js:967:31 Jan 10 15:36:25 ifi-zen-stream volumio[16041]: at runMicrotasks () Jan 10 15:36:25 ifi-zen-stream volumio[16041]: at processTicksAndRejections (internal/process/task_queues.js:95:5) Jan 10 15:36:25 ifi-zen-stream volumio[16041]: (Use `node --trace-warnings ...` to show where the warning was created) Jan 10 15:36:25 ifi-zen-stream volumio[16041]: (node:16041) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 1) Jan 10 15:36:25 ifi-zen-stream volumio[16041]: (node:16041) [DEP0018] DeprecationWarning: Unhandled promise rejections are deprecated. In the future, promise rejections that are not handled will terminate the Node.js process with a non-zero exit code. Jan 10 15:36:26 ifi-zen-stream volumio[16041]: info: ++++--++++ search: {"type":"any","value":"Sud"} Jan 10 15:36:26 ifi-zen-stream volumio[16041]: Searching all installed plugins Jan 10 15:36:26 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 15:36:26 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: , search Jan 10 15:36:26 ifi-zen-stream volumio[16041]: error: Could not retrieve plugin Jan 10 15:36:26 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jan 10 15:36:26 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Jan 10 15:36:26 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Jan 10 15:36:26 ifi-zen-stream volumio[16041]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Jan 10 15:36:26 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jan 10 15:36:26 ifi-zen-stream volumio[16041]: info: search in webradio selection! Jan 10 15:36:29 ifi-zen-stream volumio[16041]: error: Search in plugin webradio timed out Jan 10 15:36:29 ifi-zen-stream volumio[16041]: info: All search sources collected, pushing search results Jan 10 15:36:30 ifi-zen-stream volumio[16041]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Susan%20Wong/d1a269b3-ffc9-483f-ada1-008ef6d1f4aa.jpg' Jan 10 15:36:30 ifi-zen-stream volumio[16041]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Air%20Supply/79fd4153-83e3-4c18-8ee4-b13523042658.jpg' Jan 10 15:36:31 ifi-zen-stream volumio[16041]: info: ++++--++++ search: {"type":"any","value":"Sudge"} Jan 10 15:36:31 ifi-zen-stream volumio[16041]: Searching all installed plugins Jan 10 15:36:31 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 15:36:31 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: , search Jan 10 15:36:31 ifi-zen-stream volumio[16041]: error: Could not retrieve plugin Jan 10 15:36:31 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jan 10 15:36:31 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Jan 10 15:36:31 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Jan 10 15:36:31 ifi-zen-stream volumio[16041]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Jan 10 15:36:31 ifi-zen-stream volumio[16041]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jan 10 15:36:31 ifi-zen-stream volumio[16041]: info: search in webradio selection! Jan 10 15:36:31 ifi-zen-stream volumio[16041]: error: Search in plugin webradio timed out Jan 10 15:36:31 ifi-zen-stream volumio[16041]: info: All search sources collected, pushing search results Jan 10 15:36:33 ifi-zen-stream volumio[16041]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 15:36:33 ifi-zen-stream volumio[16041]: Error: connect ECONNREFUSED 151.101.194.53:443 Jan 10 15:36:33 ifi-zen-stream volumio[16041]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jan 10 15:36:33 ifi-zen-stream volumio[16041]: errno: -111, Jan 10 15:36:33 ifi-zen-stream volumio[16041]: code: 'ECONNREFUSED', Jan 10 15:36:33 ifi-zen-stream volumio[16041]: syscall: 'connect', Jan 10 15:36:33 ifi-zen-stream volumio[16041]: address: '151.101.194.53', Jan 10 15:36:33 ifi-zen-stream volumio[16041]: port: 443 Jan 10 15:36:33 ifi-zen-stream volumio[16041]: } Jan 10 15:36:33 ifi-zen-stream volumio[16041]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 15:36:33 ifi-zen-stream sudo[20640]: volumio : unable to resolve host ifi-zen-stream Jan 10 15:36:33 ifi-zen-stream sudo[20640]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jan 10 15:36:33 ifi-zen-stream sudo[20640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-10 15:35 Jan 10 15:36:33 ifi-zen-stream sudo[20640]: 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"