-- Logs begin at Wed 2025-10-08 02:17:49 UTC, end at Sun 2026-01-25 11:39:58 UTC. -- Jan 25 11:38:01 ifi-neo-stream3 volumio[4836]: info: ++++--++++ getMyCollectionStats: null Jan 25 11:38:01 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 25 11:38:05 ifi-neo-stream3 volumio[4836]: info: ++++--++++ getMyCollectionStats: null Jan 25 11:38:05 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 25 11:38:06 ifi-neo-stream3 volumio[4836]: info: ++++--++++ browseLibrary: {"uri":"albums://"} Jan 25 11:38:06 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 25 11:38:06 ifi-neo-stream3 volumio[4836]: info: CURURI: albums:// Jan 25 11:38:06 ifi-neo-stream3 volumio[4836]: info: listAlbums - loading Albums from cache Jan 25 11:38:06 ifi-neo-stream3 volumio[4836]: info: ++++--++++ getQueue Jan 25 11:38:06 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::volumioGetQueue Jan 25 11:38:06 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::getQueue Jan 25 11:38:06 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getQueue Jan 25 11:38:06 ifi-neo-stream3 volumio[4836]: info: Preload queue cleared Jan 25 11:38:06 ifi-neo-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Jan 25 11:38:06 ifi-neo-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Jan 25 11:38:06 ifi-neo-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Jan 25 11:38:08 ifi-neo-stream3 volumio[4836]: info: ++++--++++ browseLibrary: {"uri":"artists://"} Jan 25 11:38:08 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 25 11:38:08 ifi-neo-stream3 volumio[4836]: info: CURURI: artists:// Jan 25 11:38:08 ifi-neo-stream3 volumio[4836]: info: Preload queue cleared Jan 25 11:38:10 ifi-neo-stream3 volumio[4836]: info: ++++--++++ browseLibrary: {"uri":"albums://"} Jan 25 11:38:10 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 25 11:38:10 ifi-neo-stream3 volumio[4836]: info: CURURI: albums:// Jan 25 11:38:10 ifi-neo-stream3 volumio[4836]: info: listAlbums - loading Albums from cache Jan 25 11:38:10 ifi-neo-stream3 volumio[4836]: info: Preload queue cleared Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: ++++--++++ playItemsList: {"item":{"service":"mpd","type":"folder","title":"The Optimist","artist":"Anathema","year":"2017","album":"","uri":"albums://Anathema/The%20Optimist","albumart":"/albumart?cacheid=80&web=Anathema/The%20Optimist/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FAK%2FAnathema%2FThe%20Optimist&icon=dot-circle-o&metadata=false"}} Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: Preload queue cleared Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::ClearQueue Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::stop Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::serviceStop Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: Received STOP, but no service to execute it Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::clearPlayQueue Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::saveQueue Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::volumioPushQueue Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::addQueueItems Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::addQueueItems Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: Preload queue cleared Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: Adding Item to queue: albums://Anathema/The%20Optimist Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: Exploding uri albums://Anathema/The%20Optimist in service mpd Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::volumioPushQueue Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::saveQueue Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::updateTrackBlock Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrackBlock Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: ConvSwitch: Sent Play Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::volumioPlay Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::play index 0 Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::stop Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::play index undefined Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 0 Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::startPlaybackTimer Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 0 Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/AK/Anathema/The Optimist/01 32.63N 117.14W.flac Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::sendMpdCommand stop Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: sendMpdCommand stop took 10 milliseconds Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::sendMpdCommand clear Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: ConvSwitch: Get message: success Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: ---------------------------- MPD announces system playlist update Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: Ignoring MPD Status Update Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: sendMpdCommand clear took 47 milliseconds Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/AK/Anathema/The Optimist/01 32.63N 117.14W.flac" Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: error: updateQueue error: null Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: ---------------------------- MPD announces system playlist update Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: Ignoring MPD Status Update Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: ------------------------------ 40ms Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: sendMpdCommand add "NAS/NAS/AK/Anathema/The Optimist/01 32.63N 117.14W.flac" took 34 milliseconds Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::sendMpdCommand play Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: ---------------------------- MPD announces state update: player Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: ------------------------------ 104ms Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: sendMpdCommand play took 97 milliseconds Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: ControllerMpd::getState Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::sendMpdCommand status Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: error: Service socket error: Error: This socket has been ended by the other party Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: New connection from ::ffff:127.0.0.1:50404 Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: ---------------------------- MPD announces state update: player Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: ControllerMpd::getState Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::sendMpdCommand status Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: sendMpdCommand status took 156 milliseconds Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::parseState Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::volumioGetState Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 0 Jan 25 11:38:19 ifi-neo-stream3 kernel: xmos_irq_handler: data&CRC verify rec_data: 0x3eb Jan 25 11:38:19 ifi-neo-stream3 kernel: xmos_irq_handler: rec data: 0x26f crc4: 0x7 Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: Connected to MPD server Jan 25 11:38:19 ifi-neo-stream3 kernel: rec data ack set xmos_status -> 1 Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: sendMpdCommand status took 27 milliseconds Jan 25 11:38:19 ifi-neo-stream3 kernel: rec data ack done set xmos_status -> 0 Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: sendMpdCommand playlistinfo took 15 milliseconds Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::parseState Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::volumioGetState Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 0 Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::parseTrackInfo Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: ControllerMpd::pushState Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::servicePushState Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 0 Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":77,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1414 Kbps","isStreaming":false,"title":"32.63N 117.14W","artist":"Anathema","album":"The Optimist","uri":"NAS/NAS/AK/Anathema/The Optimist/01 32.63N 117.14W.flac","trackType":"flac"} Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: verbose: CURRENT POSITION 0 Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::syncState stateService play Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::syncState currentStatus stop Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: ------------------------------ 211ms Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: info: sendMpdCommand playlistinfo took 63 milliseconds Jan 25 11:38:19 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::parseTrackInfo Jan 25 11:38:20 ifi-neo-stream3 volumio[4836]: info: ControllerMpd::pushState Jan 25 11:38:20 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::servicePushState Jan 25 11:38:20 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 0 Jan 25 11:38:20 ifi-neo-stream3 volumio[4836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":77,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1414 Kbps","isStreaming":false,"title":"32.63N 117.14W","artist":"Anathema","album":"The Optimist","uri":"NAS/NAS/AK/Anathema/The Optimist/01 32.63N 117.14W.flac","trackType":"flac"} Jan 25 11:38:20 ifi-neo-stream3 volumio[4836]: verbose: CURRENT POSITION 0 Jan 25 11:38:20 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::syncState stateService play Jan 25 11:38:20 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::syncState currentStatus play Jan 25 11:38:20 ifi-neo-stream3 volumio[4836]: info: Received an update from plugin. extracting info from payload Jan 25 11:38:20 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::pushState Jan 25 11:38:20 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 0 Jan 25 11:38:20 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 11:38:20 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::volumioPushState Jan 25 11:38:20 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 11:38:20 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::pushState Jan 25 11:38:20 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 0 Jan 25 11:38:20 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::volumioPushState Jan 25 11:38:20 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 11:38:20 ifi-neo-stream3 volumio[4836]: info: ------------------------------ 152ms Jan 25 11:38:20 ifi-neo-stream3 kernel: xmos_irq_handler: data&CRC verify rec_data: 0x26f Jan 25 11:38:20 ifi-neo-stream3 kernel: xmos_irq_handler: rec data: 0x162 crc4: 0x4 Jan 25 11:38:20 ifi-neo-stream3 kernel: rec data ack set xmos_status -> 1 Jan 25 11:38:20 ifi-neo-stream3 kernel: rec data ack done set xmos_status -> 0 Jan 25 11:38:21 ifi-neo-stream3 volumio[4836]: info: MetaClient: Sent Meta Jan 25 11:38:21 ifi-neo-stream3 node[488]: gxl:metadata_handler Jan 25 11:38:21 ifi-neo-stream3 node[488]: metadata.title changed Jan 25 11:38:21 ifi-neo-stream3 node[488]: metadata.album: http://127.0.0.1:3000/albumart?cacheid=80&web=Anathema/The%20Optimist/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FAK%2FAnathema%2FThe%20Optimist&metadata=false Jan 25 11:38:21 ifi-neo-stream3 node[488]: volumio Jan 25 11:38:21 ifi-neo-stream3 volumio[4836]: info: MetaClient: Get message: success Jan 25 11:38:22 ifi-neo-stream3 node[488]: Download data end Jan 25 11:39:06 ifi-neo-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Jan 25 11:39:06 ifi-neo-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Jan 25 11:39:06 ifi-neo-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 0 Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 1 Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: Prefetching next song Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: DOING PREFETCH IN MPD Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/AK/Anathema/The Optimist/02 Leaving It Behind.flac" Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: ---------------------------- MPD announces system playlist update Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: Ignoring MPD Status Update Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: sendMpdCommand add "NAS/NAS/AK/Anathema/The Optimist/02 Leaving It Behind.flac" took 36 milliseconds Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::sendMpdCommand consume 1 Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: ---------------------------- MPD announces state update: options Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: ------------------------------ 36ms Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: sendMpdCommand consume 1 took 25 milliseconds Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: ControllerMpd::getState Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::sendMpdCommand status Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: sendMpdCommand status took 7 milliseconds Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::parseState Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::volumioGetState Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 0 Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::parseTrackInfo Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: ControllerMpd::pushState Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::servicePushState Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 0 Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":72345,"duration":77,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1414 Kbps","isStreaming":false,"title":"32.63N 117.14W","artist":"Anathema","album":"The Optimist","uri":"NAS/NAS/AK/Anathema/The Optimist/01 32.63N 117.14W.flac","trackType":"flac"} Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: verbose: CURRENT POSITION 0 Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::syncState stateService play Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::syncState currentStatus play Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: Received an update from plugin. extracting info from payload Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::pushState Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 0 Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::volumioPushState Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::pushState Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 0 Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::volumioPushState Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 11:39:31 ifi-neo-stream3 volumio[4836]: info: ------------------------------ 129ms Jan 25 11:39:32 ifi-neo-stream3 node[488]: gxl:metadata_handler Jan 25 11:39:32 ifi-neo-stream3 volumio[4836]: info: MetaClient: Sent Meta Jan 25 11:39:32 ifi-neo-stream3 volumio[4836]: info: MetaClient: Get message: success Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::startPlaybackTimer Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 1 Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: ---------------------------- MPD announces system playlist update Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: Ignoring MPD Status Update Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: ---------------------------- MPD announces state update: player Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: ControllerMpd::getState Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::sendMpdCommand status Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: ------------------------------ 8ms Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: sendMpdCommand status took 5 milliseconds Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::parseState Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::volumioGetState Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 1 Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: verbose: ControllerMpd::parseTrackInfo Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: ControllerMpd::pushState Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::servicePushState Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 1 Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":268,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1414 Kbps","isStreaming":false,"title":"Leaving It Behind","artist":"Anathema","album":"The Optimist","uri":"NAS/NAS/AK/Anathema/The Optimist/02 Leaving It Behind.flac","trackType":"flac"} Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: verbose: CURRENT POSITION 1 Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::syncState stateService play Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::syncState currentStatus play Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: Received an update from plugin. extracting info from payload Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::pushState Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 1 Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::volumioPushState Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::pushState Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 1 Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::volumioPushState Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: ------------------------------ 56ms Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CoreStateMachine::pushState Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CorePlayQueue::getTrack 1 Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::volumioPushState Jan 25 11:39:35 ifi-neo-stream3 volumio[4836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 25 11:39:36 ifi-neo-stream3 node[488]: gxl:metadata_handler Jan 25 11:39:36 ifi-neo-stream3 node[488]: metadata.title changed Jan 25 11:39:36 ifi-neo-stream3 node[488]: metadata.album: http://127.0.0.1:3000/albumart?cacheid=80&web=Anathema/The%20Optimist/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FAK%2FAnathema%2FThe%20Optimist&metadata=false Jan 25 11:39:36 ifi-neo-stream3 node[488]: volumio Jan 25 11:39:36 ifi-neo-stream3 volumio[4836]: info: MetaClient: Sent Meta Jan 25 11:39:36 ifi-neo-stream3 volumio[4836]: info: MetaClient: Get message: success Jan 25 11:39:38 ifi-neo-stream3 node[488]: Download data end Jan 25 11:39:57 ifi-neo-stream3 volumio[4836]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 25 11:39:57 ifi-neo-stream3 systemd[1]: Starting Internet Detect for iFi Streamer... Jan 25 11:39:57 ifi-neo-stream3 volumio[4836]: TypeError: Cannot read property 'slice' of null Jan 25 11:39:57 ifi-neo-stream3 volumio[4836]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Jan 25 11:39:57 ifi-neo-stream3 volumio[4836]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Jan 25 11:39:57 ifi-neo-stream3 volumio[4836]: at Object.onceWrapper (events.js:520:26) Jan 25 11:39:57 ifi-neo-stream3 volumio[4836]: at ClientRequest.emit (events.js:400:28) Jan 25 11:39:57 ifi-neo-stream3 volumio[4836]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:647:27) Jan 25 11:39:57 ifi-neo-stream3 volumio[4836]: at HTTPParser.parserOnHeadersComplete (_http_common.js:127:17) Jan 25 11:39:57 ifi-neo-stream3 volumio[4836]: at TLSSocket.socketOnData (_http_client.js:515:22) Jan 25 11:39:57 ifi-neo-stream3 volumio[4836]: at TLSSocket.emit (events.js:400:28) Jan 25 11:39:57 ifi-neo-stream3 volumio[4836]: at addChunk (internal/streams/readable.js:293:12) Jan 25 11:39:57 ifi-neo-stream3 volumio[4836]: at readableAddChunk (internal/streams/readable.js:267:9) Jan 25 11:39:57 ifi-neo-stream3 volumio[4836]: at TLSSocket.Readable.push (internal/streams/readable.js:206:10) Jan 25 11:39:57 ifi-neo-stream3 volumio[4836]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Jan 25 11:39:57 ifi-neo-stream3 volumio[4836]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 25 11:39:57 ifi-neo-stream3 systemd[1]: ifi-system-internet.service: Succeeded. Jan 25 11:39:57 ifi-neo-stream3 systemd[1]: Started Internet Detect for iFi Streamer. Jan 25 11:39:58 ifi-neo-stream3 sudo[11899]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-25 11:38 Jan 25 11:39:58 ifi-neo-stream3 sudo[11899]: 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="b6b5fc9c726190e478d1307bf4816c8d6dfb5af2" VOLUMIO_FE_VERSION="72eb2349b07a12438c15cacc860e8ee2920f9fe3" VOLUMIO_FE3_VERSION="036bae4158ab56d58bb5146ed07152c149e8c38c" VOLUMIO_BE_VERSION="3aec3392bb3143c0e0dfe38428c557fb646b7d62" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="ifi" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 8 10:21:35 CST 2025" VOLUMIO_VERSION="0.01.2" VOLUMIO_HARDWARE="neo-stream3" VOLUMIO_DEVICENAME="NEO Stream3" VOLUMIO_HASH="e98645b625b553a5fa9d799f4d383f47"